See <https://ci-beam.apache.org/job/beam_LoadTests_Java_GBK_Dataflow_V2_Streaming_Java11/18/display/redirect>
Changes: ------------------------------------------ [...truncated 66.92 KB...] Jul 05, 2021 12:11:53 PM org.apache.beam.runners.dataflow.util.PackageUtil stageClasspathElements INFO: Uploading 190 files from PipelineOptions.filesToStage to staging location to prepare for execution. Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.util.PackageUtil stageClasspathElements INFO: Staging files complete: 190 files cached, 0 files newly uploaded in 2 seconds Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Read input/DataflowRunner.StreamingUnboundedRead.ReadWithIds as step s1 Jul 05, 2021 12:11:56 PM org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource split INFO: Split into 20 bundles of sizes: [org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@561b61ed, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@654c7d2d, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@26cb5207, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@15400fff, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@18d910b3, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@1e7ab390, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@625d9132, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@77774571, org.apache.beam.sdk.io.synthetic.SyntheticUnboundedSource@277b8fa4, 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] Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Read input/StripIds as step s2 Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Collect start time metrics as step s3 Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Total bytes monitor as step s4 Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Window.Into()/Window.Assign as step s5 Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Group by key (0) as step s6 Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Ungroup and reiterate (0) as step s7 Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.DataflowPipelineTranslator$Translator addStep INFO: Adding Collect end time metrics (0) as step s8 Jul 05, 2021 12:11:56 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Dataflow SDK version: 2.32.0-SNAPSHOT Jul 05, 2021 12:11:57 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-07-05_05_11_56-10586499665341353309?project=apache-beam-testing Jul 05, 2021 12:11:57 PM org.apache.beam.runners.dataflow.DataflowRunner run INFO: Submitted job: 2021-07-05_05_11_56-10586499665341353309 Jul 05, 2021 12:11:57 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-07-05_05_11_56-10586499665341353309 Jul 05, 2021 12:12:02 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process WARNING: 2021-07-05T12:12:01.997Z: 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-0705-dn6g. 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 Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:05.262Z: Worker configuration: n1-standard-2 in us-central1-f. Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:05.752Z: Expanding SplittableParDo operations into optimizable parts. Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:05.780Z: Expanding CollectionToSingleton operations into optimizable parts. Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:05.849Z: Expanding CoGroupByKey operations into optimizable parts. Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:05.926Z: Expanding SplittableProcessKeyed operations into optimizable parts. Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:05.956Z: Expanding GroupByKey operations into streaming Read/Write steps Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.026Z: Lifting ValueCombiningMappingFns into MergeBucketsMappingFns Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.120Z: Fusing adjacent ParDo, Read, Write, and Flatten operations Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.147Z: Fusing consumer Read input/ParDo(OutputSingleSource)/ParMultiDo(OutputSingleSource) into Read input/Impulse Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.190Z: Fusing consumer Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/PairWithRestriction into Read input/ParDo(OutputSingleSource)/ParMultiDo(OutputSingleSource) Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.219Z: Fusing consumer Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/SplitWithSizing into Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/PairWithRestriction Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.249Z: Fusing consumer Read input/ParDo(StripIds)/ParMultiDo(StripIds) into Read-input-ParDo-UnboundedSourceAsSDFWrapper--ParMultiDo-UnboundedSourceAsSDFWrapper-/ProcessElementAndRestrictionWithSizing Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.284Z: Fusing consumer Collect start time metrics/ParMultiDo(TimeMonitor) into Read input/ParDo(StripIds)/ParMultiDo(StripIds) Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.320Z: Fusing consumer Total bytes monitor/ParMultiDo(ByteMonitor) into Collect start time metrics/ParMultiDo(TimeMonitor) Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.355Z: Fusing consumer Window.Into()/Window.Assign into Total bytes monitor/ParMultiDo(ByteMonitor) Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.406Z: Fusing consumer Group by key (0)/WriteStream into Window.Into()/Window.Assign Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.441Z: Fusing consumer Group by key (0)/MergeBuckets into Group by key (0)/ReadStream Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.475Z: Fusing consumer Ungroup and reiterate (0)/ParMultiDo(UngroupAndReiterate) into Group by key (0)/MergeBuckets Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.501Z: Fusing consumer Collect end time metrics (0)/ParMultiDo(TimeMonitor) into Ungroup and reiterate (0)/ParMultiDo(UngroupAndReiterate) Jul 05, 2021 12:12:08 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:06.810Z: Starting 5 ****s in us-central1-f... Jul 05, 2021 12:12:16 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:12:16.224Z: 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 Jul 05, 2021 12:13:29 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:13:28.462Z: Workers have started successfully. Jul 05, 2021 12:13:29 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T12:13:28.498Z: Workers have started successfully. Jul 05, 2021 1:05:31 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process SEVERE: 2021-07-05T13:05:30.613Z: generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 generic::aborted: SDK harness sdk-0-0 disconnected. generic::aborted: SDK harness sdk-0-0 disconnected. passed through: ==> dist_proc/dax/workflow/****/fnapi_service.cc:631 Jul 05, 2021 3:44:02 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process SEVERE: 2021-07-05T15:43:59.519Z: generic::internal: Current work item is no longer valid on backend. The work has already completed or will be retried. This is expected during autoscaling events. Jul 05, 2021 4:00:35 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T16:00:34.733Z: Cancel request is committed for workflow job: 2021-07-05_05_11_56-10586499665341353309. Jul 05, 2021 4:00:35 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T16:00:34.812Z: Cleaning up. Jul 05, 2021 4:00:35 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T16:00:34.970Z: Stopping **** pool... Jul 05, 2021 4:00:35 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T16:00:35.032Z: Stopping **** pool... Jul 05, 2021 4:01:32 PM org.apache.beam.runners.dataflow.util.MonitoringUtil$LoggingHandler process INFO: 2021-07-05T16:01:31.556Z: Worker pool stopped. Jul 05, 2021 4:01:37 PM org.apache.beam.runners.dataflow.DataflowPipelineJob logTerminalState INFO: Job 2021-07-05_05_11_56-10586499665341353309 finished with status CANCELLED. Load test results for test (ID): bfab597a-e9e9-4bcd-8cdd-baac845f05ed and timestamp: 2021-07-05T12:11:47.681000000Z: Metric: Value: dataflow_v2_java11_runtime_sec 13586.562 dataflow_v2_java11_total_bytes_count 3.950137909E10 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:20210705120612 Untagged: us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:632cc9e82d59e2ed1162e934058a8d86c23178c3ef3998d44f3ac21be1876c8c Digests: - us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:632cc9e82d59e2ed1162e934058a8d86c23178c3ef3998d44f3ac21be1876c8c Associated tags: - 20210705120612 Tags: - us.gcr.io/apache-beam-testing/java-postcommit-it/java:20210705120612 Deleted [us.gcr.io/apache-beam-testing/java-postcommit-it/java:20210705120612]. Deleted [us.gcr.io/apache-beam-testing/java-postcommit-it/java@sha256:632cc9e82d59e2ed1162e934058a8d86c23178c3ef3998d44f3ac21be1876c8c]. 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 55m 53s 104 actionable tasks: 74 executed, 28 from cache, 2 up-to-date Publishing build scan... https://gradle.com/s/mcc63liion7s2 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]
