See <https://ci-beam.apache.org/job/beam_LoadTests_Java_GBK_Dataflow_Batch/1690/display/redirect>
Changes: ------------------------------------------ [...truncated 63.68 KB...] > Task :sdks:java:core:generateGrammarSource UP-TO-DATE > Task :runners:google-cloud-dataflow-java:processResources UP-TO-DATE > Task :sdks:java:io:kafka:createCheckerFrameworkManifest UP-TO-DATE > Task :sdks:java:core:processResources UP-TO-DATE > Task :sdks:java:extensions:arrow:createCheckerFrameworkManifest UP-TO-DATE > Task :sdks:java:io:google-cloud-platform:createCheckerFrameworkManifest > UP-TO-DATE > Task :sdks:java:extensions:protobuf:createCheckerFrameworkManifest UP-TO-DATE > Task :sdks:java:io:kafka:processResources NO-SOURCE > Task :runners:google-cloud-dataflow-java:****:createCheckerFrameworkManifest > UP-TO-DATE > Task :sdks:java:extensions:arrow:processResources NO-SOURCE > Task :sdks:java:io:google-cloud-platform:processResources NO-SOURCE > Task :sdks:java:extensions:protobuf:extractProto UP-TO-DATE > Task > :runners:google-cloud-dataflow-java:****:windmill:createCheckerFrameworkManifest > UP-TO-DATE > Task :sdks:java:io:kinesis:createCheckerFrameworkManifest UP-TO-DATE > Task :runners:google-cloud-dataflow-java:****:processResources UP-TO-DATE > Task :sdks:java:io:synthetic:createCheckerFrameworkManifest UP-TO-DATE > Task :sdks:java:io:kinesis:processResources NO-SOURCE > Task :sdks:java:extensions:protobuf:processResources NO-SOURCE > Task :sdks:java:testing:load-tests:createCheckerFrameworkManifest UP-TO-DATE > Task :sdks:java:io:synthetic:processResources NO-SOURCE > Task :sdks:java:testing:test-utils:createCheckerFrameworkManifest UP-TO-DATE > Task :sdks:java:testing:load-tests:processResources NO-SOURCE > Task :sdks:java:testing:test-utils:processResources NO-SOURCE > Task :model:pipeline:extractIncludeProto UP-TO-DATE > Task :model:pipeline:extractProto UP-TO-DATE > Task :runners:google-cloud-dataflow-java:****:windmill:extractIncludeProto > UP-TO-DATE > Task :runners:google-cloud-dataflow-java:****:windmill:extractProto UP-TO-DATE > Task :sdks:java:transform-service:launcher:compileJava UP-TO-DATE > Task :sdks:java:transform-service:launcher:processResources UP-TO-DATE > Task :sdks:java:transform-service:launcher:classes UP-TO-DATE > Task :sdks:java:transform-service:launcher:jar UP-TO-DATE > Task :model:pipeline:generateProto UP-TO-DATE > Task :runners:google-cloud-dataflow-java:****:windmill:generateProto > UP-TO-DATE > Task :sdks:java:transform-service:launcher:shadowJar UP-TO-DATE > Task :runners:google-cloud-dataflow-java:****:windmill:compileJava UP-TO-DATE > Task :runners:google-cloud-dataflow-java:****:windmill:processResources > UP-TO-DATE > Task :runners:google-cloud-dataflow-java:****:windmill:classes UP-TO-DATE > Task :runners:google-cloud-dataflow-java:****:windmill:shadowJar UP-TO-DATE > Task :model:pipeline:compileJava UP-TO-DATE > Task :model:pipeline:processResources UP-TO-DATE > Task :model:pipeline:classes UP-TO-DATE > Task :model:pipeline:jar UP-TO-DATE > Task :model:pipeline:shadowJar UP-TO-DATE > Task :model:fn-execution:extractIncludeProto UP-TO-DATE > Task :model:job-management:extractIncludeProto UP-TO-DATE > Task :model:job-management:generateProto UP-TO-DATE > Task :model:fn-execution:generateProto UP-TO-DATE > Task :model:job-management:compileJava UP-TO-DATE > Task :model:job-management:classes UP-TO-DATE > Task :model:fn-execution:compileJava UP-TO-DATE > Task :model:fn-execution:classes UP-TO-DATE > Task :model:job-management:shadowJar UP-TO-DATE > Task :model:fn-execution:shadowJar UP-TO-DATE > Task :sdks:java:core:compileJava UP-TO-DATE > Task :sdks:java:core:classes UP-TO-DATE > Task :sdks:java:core:shadowJar UP-TO-DATE > Task :sdks:java:extensions:protobuf:extractIncludeProto UP-TO-DATE > Task :sdks:java:extensions:arrow:compileJava UP-TO-DATE > Task :sdks:java:extensions:arrow:classes UP-TO-DATE > Task :sdks:java:extensions:protobuf:generateProto NO-SOURCE > Task :sdks:java:extensions:arrow:jar UP-TO-DATE > Task :sdks:java:io:synthetic:compileJava UP-TO-DATE > Task :sdks:java:io:synthetic:classes UP-TO-DATE > Task :sdks:java:io:synthetic:jar UP-TO-DATE > Task :sdks:java:extensions:protobuf:compileJava UP-TO-DATE > Task :sdks:java:io:kinesis:compileJava UP-TO-DATE > Task :sdks:java:extensions:protobuf:classes UP-TO-DATE > Task :sdks:java:io:kinesis:classes UP-TO-DATE > Task :sdks:java:extensions:protobuf:jar UP-TO-DATE > Task :sdks:java:testing:test-utils:compileJava UP-TO-DATE > Task :sdks:java:fn-execution:compileJava UP-TO-DATE > Task :sdks:java:testing:test-utils:classes UP-TO-DATE > Task :sdks:java:fn-execution:classes UP-TO-DATE > Task :sdks:java:io:kinesis:jar UP-TO-DATE > Task :sdks:java:fn-execution:jar UP-TO-DATE > Task :sdks:java:extensions:avro:compileJava UP-TO-DATE > Task :sdks:java:extensions:avro:classes UP-TO-DATE > Task :sdks:java:testing:test-utils:jar UP-TO-DATE > Task :sdks:java:extensions:avro:jar UP-TO-DATE > Task :runners:core-construction-java:compileJava UP-TO-DATE > Task :runners:core-construction-java:classes UP-TO-DATE > Task :runners:core-construction-java:jar UP-TO-DATE > Task :runners:core-java:compileJava UP-TO-DATE > Task :runners:core-java:classes UP-TO-DATE > Task :runners:core-java:jar UP-TO-DATE > 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:harness:compileJava UP-TO-DATE > Task :sdks:java:harness:classes UP-TO-DATE > Task :sdks:java:harness:jar UP-TO-DATE > Task :sdks:java:harness:shadowJar UP-TO-DATE > Task :runners:java-fn-execution:compileJava UP-TO-DATE > 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: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 :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:****:shadowJar UP-TO-DATE > Task :sdks:java:testing:load-tests:run Oct 17, 2023 10:22:29 AM org.apache.beam.runners.dataflow.DataflowRunner validateSdkContainerImageOptions WARNING: Prefer --sdkContainerImage over deprecated legacy option --****HarnessContainerImage. Oct 17, 2023 10:22:30 AM org.apache.beam.runners.dataflow.options.DataflowPipelineOptions$StagingLocationFactory create INFO: No stagingLocation provided, falling back to gcpTempLocation Oct 17, 2023 10:22:31 AM org.apache.beam.runners.dataflow.DataflowRunner fromOptions INFO: PipelineOptions.filesToStage was not specified. Defaulting to files from the classpath: will stage 231 files. Enable logging at DEBUG level to see which files will be staged. Oct 17, 2023 10:22:32 AM 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. Oct 17, 2023 10:22:34 AM org.apache.beam.runners.dataflow.util.PackageUtil stageClasspathElements INFO: Uploading 232 files from PipelineOptions.filesToStage to staging location to prepare for execution. Oct 17, 2023 10:22:34 AM org.apache.beam.runners.dataflow.util.PackageUtil$PackageAttributes forFileToStage INFO: Staging custom dataflow-****.jar as beam-runners-google-cloud-dataflow-java-legacy-****-2.52.0-SNAPSHOT-owgpwIhSjSeF5yG8wvGuXVAGVFVj2JVv657q-DVZqk8.jar Oct 17, 2023 10:22:34 AM org.apache.beam.runners.dataflow.util.PackageUtil stageClasspathElements INFO: Staging files complete: 232 files cached, 0 files newly uploaded in 0 seconds Oct 17, 2023 10:22:34 AM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Staging portable pipeline proto to gs://temp-storage-for-perf-tests/loadtests/staging/ Oct 17, 2023 10:22:34 AM org.apache.beam.runners.dataflow.util.PackageUtil tryStagePackage INFO: Uploading <98794 bytes, hash daa645ba0224577fed2e01527e9cd1948c51a1d36ac1abc3bd9f84aa715f42ca> to gs://temp-storage-for-perf-tests/loadtests/staging/pipeline-2qZFugIkV3_tLgFSfpzRlIxRodNqwavDvZ-EqnFfQso.pb Oct 17, 2023 10:22:36 AM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Read input as step s1 Oct 17, 2023 10:22:36 AM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Collect start time metrics as step s2 Oct 17, 2023 10:22:36 AM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Total bytes monitor as step s3 Oct 17, 2023 10:22:36 AM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Window.Into()/Window.Assign as step s4 Oct 17, 2023 10:22:36 AM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Group by key (0) as step s5 Oct 17, 2023 10:22:36 AM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Ungroup and reiterate (0) as step s6 Oct 17, 2023 10:22:36 AM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Collect end time metrics (0) as step s7 Oct 17, 2023 10:22:36 AM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Dataflow SDK version: 2.52.0-SNAPSHOT Oct 17, 2023 10:22:37 AM 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-10-17_03_22_37-181684193704004681?project=apache-beam-testing Oct 17, 2023 10:22:37 AM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Submitted job: 2023-10-17_03_22_37-181684193704004681 Oct 17, 2023 10:22:37 AM 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-10-17_03_22_37-181684193704004681 Oct 17, 2023 10:22:40 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process WARNING: 2023-10-17T10:22:39.909Z: 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: load0tests0java0dataflow0batch0gbk02-jenkins-1017102231-be-fwtc. 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 Oct 17, 2023 10:22:47 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:46.895Z: Worker configuration: e2-standard-2 in us-central1-b. Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:48.705Z: Expanding CoGroupByKey operations into optimizable parts. Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:48.753Z: Expanding GroupByKey operations into optimizable parts. Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:48.778Z: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:48.866Z: Fusing adjacent ParDo, Read, Write, and Flatten operations Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:48.889Z: Fusing consumer Collect start time metrics into Read input Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:48.910Z: Fusing consumer Total bytes monitor into Collect start time metrics Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:48.934Z: Fusing consumer Window.Into()/Window.Assign into Total bytes monitor Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:48.955Z: Fusing consumer Group by key (0)/Reify into Window.Into()/Window.Assign Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:48.980Z: Fusing consumer Group by key (0)/Write into Group by key (0)/Reify Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:49.003Z: Fusing consumer Group by key (0)/GroupByWindow into Group by key (0)/Read Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:49.025Z: Fusing consumer Ungroup and reiterate (0) into Group by key (0)/GroupByWindow Oct 17, 2023 10:22:49 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:49.044Z: Fusing consumer Collect end time metrics (0) into Ungroup and reiterate (0) Oct 17, 2023 10:22:52 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:49.333Z: Executing operation Group by key (0)/Create Oct 17, 2023 10:22:52 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:49.405Z: Starting 5 ****s in us-central1-b... Oct 17, 2023 10:22:52 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:50.022Z: Finished operation Group by key (0)/Create Oct 17, 2023 10:22:59 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:22:58.559Z: Executing operation Read input+Collect start time metrics+Total bytes monitor+Window.Into()/Window.Assign+Group by key (0)/Reify+Group by key (0)/Write Oct 17, 2023 10:23:17 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:23:15.886Z: 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 Oct 17, 2023 10:42:00 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process WARNING: 2023-10-17T10:41:59.910Z: Autoscaling: Startup of the **** pool in zone us-central1-b reached 4 ****s, but the goal was 5 ****s. The service will retry. Please refer to https://cloud.google.com/dataflow/docs/guides/common-errors#****-pool-failure for help troubleshooting. INTERNAL_ERROR: Instance 'load0tests0java0dataflow0-10170322-ws5v-harness-m0cg' creation failed: Internal error. Please try again or contact Google Support. (Code: '-4540590329430740516') Oct 17, 2023 10:55:01 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process SEVERE: 2023-10-17T10:54:59.719Z: Startup of the **** pool in zone us-central1-b failed to bring up any of the desired 5 ****s. Please refer to https://cloud.google.com/dataflow/docs/guides/common-errors#****-pool-failure for help troubleshooting. INTERNAL_ERROR: Instance 'load0tests0java0dataflow0-10170322-ws5v-harness-qd1v' creation failed: Internal error. Please try again or contact Google Support. (Code: '-4540590329430740516') Oct 17, 2023 10:55:01 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process SEVERE: 2023-10-17T10:54:59.750Z: Workflow failed. Oct 17, 2023 10:55:01 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:54:59.905Z: Finished operation Read input+Collect start time metrics+Total bytes monitor+Window.Into()/Window.Assign+Group by key (0)/Reify+Group by key (0)/Write Oct 17, 2023 10:55:01 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:54:59.994Z: Cleaning up. Oct 17, 2023 10:55:01 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:55:00.094Z: Stopping **** pool... Oct 17, 2023 10:55:22 AM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2023-10-17T10:55:21.590Z: Worker pool stopped. Oct 17, 2023 10:55:57 AM org.apache.beam.runners.dataflow.DataflowPipelineJob logTerminalState INFO: Job 2023-10-17_03_22_37-181684193704004681 failed with status FAILED. Oct 17, 2023 10:55:58 AM org.apache.beam.sdk.testutils.metrics.MetricsReader getCounterMetric SEVERE: Failed to get metric totalBytes.count, from namespace gbk Load test results for test (ID): 23eb66bc-40ea-42f9-a4da-cb75cca9ba5d and timestamp: 2023-10-17T10:22:31.773000000Z: Metric: Value: dataflow_runtime_sec 0.0 dataflow_total_bytes_count -1.0 Exception in thread "main" java.lang.RuntimeException: Invalid job state: FAILED. at org.apache.beam.sdk.loadtests.JobFailure.handleFailure(JobFailure.java:51) at org.apache.beam.sdk.loadtests.LoadTest.run(LoadTest.java:139) 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 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. > Get more help at https://help.gradle.org. Deprecated Gradle features were used in this build, making it incompatible with Gradle 9.0. You can use '--warning-mode all' to show the individual deprecation warnings and determine if they come from your own scripts or plugins. For more on this, please refer to https://docs.gradle.org/8.3/userguide/command_line_interface.html#sec:command_line_warnings in the Gradle documentation. BUILD FAILED in 33m 51s 103 actionable tasks: 1 executed, 102 up-to-date Publishing build scan... https://ge.apache.org/s/be6vfho47gsqe 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]
