See <https://ci-beam.apache.org/job/beam_LoadTests_Java_ParDo_Dataflow_V2_Streaming_Java17/433/display/redirect>
Changes: ------------------------------------------ [...truncated 301.92 KB...] > Task :runners:java-fn-execution:classes UP-TO-DATE > Task :runners:java-fn-execution:jar UP-TO-DATE > Task :sdks:java:expansion-service:compileJava UP-TO-DATE > Task :sdks:java:expansion-service:classes UP-TO-DATE > Task :sdks:java:expansion-service:jar UP-TO-DATE > Task :sdks:java:io:kafka:compileJava UP-TO-DATE > Task :sdks:java:io:kafka:classes UP-TO-DATE > Task :sdks:java:io:kafka:jar UP-TO-DATE > Task :sdks:java:container:java17:copySdkHarnessLauncher Execution optimizations have been disabled for task ':sdks:java:container:java17:copySdkHarnessLauncher' to ensure correctness due to the following reasons: - Gradle detected a problem with the following location: '<https://ci-beam.apache.org/job/beam_LoadTests_Java_ParDo_Dataflow_V2_Streaming_Java17/ws/src/sdks/java/container/build/target'.> Reason: Task ':sdks:java:container:java17:copySdkHarnessLauncher' uses this output of task ':sdks:java:container:downloadCloudProfilerAgent' without declaring an explicit or implicit dependency. This can lead to incorrect results being produced, depending on what order the tasks are executed. Please refer to https://docs.gradle.org/7.5.1/userguide/validation_problems.html#implicit_dependency for more details about this problem. - Gradle detected a problem with the following location: '<https://ci-beam.apache.org/job/beam_LoadTests_Java_ParDo_Dataflow_V2_Streaming_Java17/ws/src/sdks/java/container/build/target'.> Reason: Task ':sdks:java:container:java17:copySdkHarnessLauncher' uses this output of task ':sdks:java:container:pullLicenses' without declaring an explicit or implicit dependency. This can lead to incorrect results being produced, depending on what order the tasks are executed. Please refer to https://docs.gradle.org/7.5.1/userguide/validation_problems.html#implicit_dependency for more details about this problem. > Task :sdks:java:extensions:google-cloud-platform-core:compileJava UP-TO-DATE > Task :sdks:java:extensions:google-cloud-platform-core:classes UP-TO-DATE > Task :sdks:java:extensions:google-cloud-platform-core:jar UP-TO-DATE > Task :sdks:java:container:java17:copyDockerfileDependencies UP-TO-DATE > Task :sdks:java:io:google-cloud-platform:compileJava UP-TO-DATE > Task :sdks:java:io:google-cloud-platform:classes UP-TO-DATE > Task :sdks:java:io:google-cloud-platform:jar UP-TO-DATE > Task :sdks:java:testing:load-tests:compileJava UP-TO-DATE > Task :sdks:java:testing:load-tests:classes UP-TO-DATE > Task :sdks:java:testing:load-tests:jar UP-TO-DATE > Task :runners:google-cloud-dataflow-java:compileJava UP-TO-DATE > Task :runners:google-cloud-dataflow-java:classes UP-TO-DATE > Task :runners:google-cloud-dataflow-java:jar UP-TO-DATE > Task :sdks:java:container:java17:dockerPrepare > Task :sdks:java:container:java17:docker > Task :runners:google-cloud-dataflow-java:buildAndPushDockerJavaContainer 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] 9b4419270e5d: Preparing c95bc45e050e: Preparing c71c5349162f: Preparing c43253195d19: Preparing 7591c63938f6: Preparing 402cf448fc89: Preparing d8a6a863dea7: Preparing a6553900cd07: Preparing ce7844481ed5: Preparing 0c0c564aebdc: Preparing cd531ed08613: Preparing 3a22f1a43bfa: Preparing bad4d31c1dc5: Preparing 0d80aba316e0: Preparing 3b5cff115cd8: Preparing 67022d0f9ed9: Preparing 4cf6b33083da: Preparing 2428b038926e: Preparing 2b1193862943: Preparing c5ff2d88f679: Preparing 402cf448fc89: Waiting d8a6a863dea7: Waiting cd531ed08613: Waiting 3b5cff115cd8: Waiting a6553900cd07: Waiting 67022d0f9ed9: Waiting bad4d31c1dc5: Waiting ce7844481ed5: Waiting 0d80aba316e0: Waiting 4cf6b33083da: Waiting 0c0c564aebdc: Waiting 2428b038926e: Waiting c5ff2d88f679: Waiting 3a22f1a43bfa: Waiting c71c5349162f: Pushed 7591c63938f6: Pushed c43253195d19: Pushed c95bc45e050e: Pushed 9b4419270e5d: Pushed d8a6a863dea7: Pushed a6553900cd07: Pushed 0c0c564aebdc: Pushed 402cf448fc89: Pushed 3a22f1a43bfa: Pushed cd531ed08613: Pushed ce7844481ed5: Pushed 4cf6b33083da: Layer already exists 2428b038926e: Layer already exists 2b1193862943: Layer already exists c5ff2d88f679: Layer already exists bad4d31c1dc5: Pushed 0d80aba316e0: Pushed 3b5cff115cd8: Pushed 67022d0f9ed9: Pushed 20230227124608: digest: sha256:fc3d2f573ea8cc67823a5389299e97912b353aa23b089166a25bcee15d3683f9 size: 4506 > Task :sdks:java:testing:load-tests:run Feb 27, 2023 12:46:31 PM org.apache.beam.runners.dataflow.options.DataflowPipelineOptions$StagingLocationFactory create INFO: No stagingLocation provided, falling back to gcpTempLocation Feb 27, 2023 12:46:31 PM org.apache.beam.runners.dataflow.DataflowRunner fromOptions INFO: PipelineOptions.filesToStage was not specified. Defaulting to files from the classpath: will stage 233 files. Enable logging at DEBUG level to see which files will be staged. Feb 27, 2023 12:46:32 PM org.apache.beam.sdk.Pipeline validate WARNING: The following transforms do not have stable unique names: ParDo(TimeMonitor) Feb 27, 2023 12:46:32 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. Feb 27, 2023 12:46:34 PM org.apache.beam.runners.dataflow.util.PackageUtil stageClasspathElements INFO: Uploading 233 files from PipelineOptions.filesToStage to staging location to prepare for execution. Feb 27, 2023 12:46:34 PM org.apache.beam.runners.dataflow.util.PackageUtil stageClasspathElements INFO: Staging files complete: 233 files cached, 0 files newly uploaded in 0 seconds Feb 27, 2023 12:46:35 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Staging portable pipeline proto to gs://temp-storage-for-perf-tests/loadtests/staging/ Feb 27, 2023 12:46:35 PM org.apache.beam.runners.dataflow.util.PackageUtil tryStagePackage INFO: Uploading <99998 bytes, hash 3fbd0d16c3ed15dd31e4dbef90ea1481c93ce67b5662e13303baefc30f063aec> to gs://temp-storage-for-perf-tests/loadtests/staging/pipeline-P70NFsPtFd0x5NvvkOoUgck85ntWYuEzA7rvww8GOuw.pb Feb 27, 2023 12:46:36 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Read input/DataflowRunner.StreamingUnboundedRead.ReadWithIds as step s1 Feb 27, 2023 12:46:36 PM org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource split INFO: Split into 20 bundles: [SyntheticUnboundedSource{startOffset=0, endOffset=1000000}, SyntheticUnboundedSource{startOffset=1000000, endOffset=2000000}, SyntheticUnboundedSource{startOffset=2000000, endOffset=3000000}, SyntheticUnboundedSource{startOffset=3000000, endOffset=4000000}, SyntheticUnboundedSource{startOffset=4000000, endOffset=5000000}, SyntheticUnboundedSource{startOffset=5000000, endOffset=6000000}, SyntheticUnboundedSource{startOffset=6000000, endOffset=7000000}, SyntheticUnboundedSource{startOffset=7000000, endOffset=8000000}, SyntheticUnboundedSource{startOffset=8000000, endOffset=9000000}, SyntheticUnboundedSource{startOffset=9000000, endOffset=10000000}, SyntheticUnboundedSource{startOffset=10000000, endOffset=11000000}, SyntheticUnboundedSource{startOffset=11000000, endOffset=12000000}, SyntheticUnboundedSource{startOffset=12000000, endOffset=13000000}, SyntheticUnboundedSource{startOffset=13000000, endOffset=14000000}, SyntheticUnboundedSource{startOffset=14000000, endOffset=15000000}, SyntheticUnboundedSource{startOffset=15000000, endOffset=16000000}, SyntheticUnboundedSource{startOffset=16000000, endOffset=17000000}, SyntheticUnboundedSource{startOffset=17000000, endOffset=18000000}, SyntheticUnboundedSource{startOffset=18000000, endOffset=19000000}, SyntheticUnboundedSource{startOffset=19000000, endOffset=20000000}] Feb 27, 2023 12:46:36 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Read input/StripIds as step s2 Feb 27, 2023 12:46:36 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding ParDo(TimeMonitor) as step s3 Feb 27, 2023 12:46:36 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding ParDo(ByteMonitor) as step s4 Feb 27, 2023 12:46:36 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Step: 0 as step s5 Feb 27, 2023 12:46:36 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding ParDo(TimeMonitor)2 as step s6 Feb 27, 2023 12:46:36 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Dataflow SDK version: 2.47.0-SNAPSHOT Feb 27, 2023 12:46:37 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/2023-02-27_04_46_37-428948317747948847?project=apache-beam-testing Feb 27, 2023 12:46:37 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Submitted job: 2023-02-27_04_46_37-428948317747948847 Feb 27, 2023 12:46:37 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 2023-02-27_04_46_37-428948317747948847 Feb 27, 2023 12:46:43 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process WARNING: 2023-02-27T12:46:42.368Z: 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: load0tests0java170dataflow0v20streaming0pardo04-jenkins-02-fn08. 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 Feb 27, 2023 12:46:50 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:49.938Z: Worker configuration: e2-standard-2 in us-central1-f. Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.489Z: Expanding SplittableParDo operations into optimizable parts. Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.513Z: Expanding CollectionToSingleton operations into optimizable parts. Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.556Z: Expanding CoGroupByKey operations into optimizable parts. Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.583Z: Expanding SplittableProcessKeyed operations into optimizable parts. Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.598Z: Expanding GroupByKey operations into streaming Read/Write steps Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.621Z: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.679Z: Fusing adjacent ParDo, Read, Write, and Flatten operations Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.700Z: Fusing consumer Read input/ParDo(OutputSingleSource)/ParMultiDo(OutputSingleSource) into Read input/Impulse Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.754Z: Fusing consumer Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/PairWithRestriction into Read input/ParDo(OutputSingleSource)/ParMultiDo(OutputSingleSource) Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.774Z: Fusing consumer Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/SplitWithSizing into Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/PairWithRestriction Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.796Z: Fusing consumer Read input/ParDo(StripIds)/ParMultiDo(StripIds) into Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/ProcessElementAndRestrictionWithSizing Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.819Z: Fusing consumer ParDo(TimeMonitor)/ParMultiDo(TimeMonitor) into Read input/ParDo(StripIds)/ParMultiDo(StripIds) Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.845Z: Fusing consumer ParDo(ByteMonitor)/ParMultiDo(ByteMonitor) into ParDo(TimeMonitor)/ParMultiDo(TimeMonitor) Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.866Z: Fusing consumer Step: 0/ParMultiDo(CounterOperation) into ParDo(ByteMonitor)/ParMultiDo(ByteMonitor) Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.892Z: Fusing consumer ParDo(TimeMonitor)2/ParMultiDo(TimeMonitor) into Step: 0/ParMultiDo(CounterOperation) Feb 27, 2023 12:46:52 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:51.969Z: Running job using Streaming Engine Feb 27, 2023 12:46:53 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:46:53.178Z: Starting 5 ****s in us-central1-f... Feb 27, 2023 12:47:11 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:47:10.419Z: 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 Feb 27, 2023 12:47:31 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:47:31.664Z: 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. Feb 27, 2023 12:48:28 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:48:27.902Z: Workers have started successfully. Feb 27, 2023 12:48:28 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:48:28.351Z: All ****s have finished the startup processes and began to receive work requests. Feb 27, 2023 12:51:05 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:51:03.938Z: Cleaning up. Feb 27, 2023 12:51:05 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:51:04.026Z: Stopping **** pool... Feb 27, 2023 12:51:05 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:51:04.084Z: Stopping **** pool... Feb 27, 2023 12:53:15 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:53:14.875Z: 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. Feb 27, 2023 12:53:15 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-02-27T12:53:14.915Z: Worker pool stopped. Feb 27, 2023 12:53:20 PM org.apache.beam.runners.dataflow.DataflowPipelineJob logTerminalState INFO: Job 2023-02-27_04_46_37-428948317747948847 finished with status DONE. Load test results for test (ID): 2d71a385-a5ef-484a-811b-8aa69c63e51e and timestamp: 2023-02-27T12:46:32.269000000Z: Metric: Value: dataflow_v2_java17_runtime_sec 35.143 dataflow_v2_java17_total_bytes_count 1.999998E9 > Task :runners:google-cloud-dataflow-java:cleanUpDockerJavaImages Untagged: us.gcr.io/apache-beam-testing/java-postcommit-it/java:20230227124608 Untagged: us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:fc3d2f573ea8cc67823a5389299e97912b353aa23b089166a25bcee15d3683f9 WARNING: Successfully resolved tag to sha256, but it is recommended to use sha256 directly. Tag: [us.gcr.io/apache-beam-testing/java-postcommit-it/java:20230227124608] - referencing digest: [us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:fc3d2f573ea8cc67823a5389299e97912b353aa23b089166a25bcee15d3683f9] Deleted [[us.gcr.io/apache-beam-testing/java-postcommit-it/java:20230227124608] (referencing [us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:fc3d2f573ea8cc67823a5389299e97912b353aa23b089166a25bcee15d3683f9])]. Removing untagged image us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:44b969fdb2e61b6723621e6f328936e08d3e0caa5d04e946905cfde82c74151a Digests: - us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:44b969fdb2e61b6723621e6f328936e08d3e0caa5d04e946905cfde82c74151a ERROR: (gcloud.container.images.delete) Not found: response: {'docker-distribution-api-version': 'registry/2.0', 'content-type': 'application/json', 'content-encoding': 'gzip', 'date': 'Mon, 27 Feb 2023 12:53:44 GMT', 'server': 'Docker Registry', 'cache-control': 'private', 'x-xss-protection': '0', 'x-frame-options': 'SAMEORIGIN', 'transfer-encoding': 'chunked', 'status': 404} Failed to compute blob liveness for manifest: 'sha256:44b969fdb2e61b6723621e6f328936e08d3e0caa5d04e946905cfde82c74151a': None > Task :runners:google-cloud-dataflow-java:cleanUpDockerJavaImages FAILED FAILURE: Build failed with an exception. * Where: Build file '<https://ci-beam.apache.org/job/beam_LoadTests_Java_ParDo_Dataflow_V2_Streaming_Java17/ws/src/runners/google-cloud-dataflow-java/build.gradle'> line: 306 * What went wrong: Execution failed for task ':runners:google-cloud-dataflow-java:cleanUpDockerJavaImages'. > Process 'command './scripts/cleanup_untagged_gcr_images.sh'' 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. * Get more help at https://help.gradle.org Deprecated Gradle features were used in this build, making it incompatible with Gradle 8.0. You can use '--warning-mode all' to show the individual deprecation warnings and determine if they come from your own scripts or plugins. See https://docs.gradle.org/7.5.1/userguide/command_line_interface.html#sec:command_line_warnings Execution optimizations have been disabled for 1 invalid unit(s) of work during this build to ensure correctness. Please consult deprecation warnings for more details. BUILD FAILED in 7m 50s 111 actionable tasks: 9 executed, 102 up-to-date Publishing build scan... https://gradle.com/s/otwfrsihjbw76 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]
