[22:30:16.619] New invocation is queued and will start shortly
[22:30:17.683] Starting the invocation (attempt 1)
[22:30:17.717] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:30:17.717] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:30:17.717] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023158386011356272",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9b9176855abe2dddf472e8fed16ac8b8bec706ab\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9023158386011356272",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/9b9176855abe2dddf472e8fed16ac8b8bec706ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b9176855abe2dddf472e8fed16ac8b8bec706ab",
"gitiles_ref:refs/heads/master"
]
}
[22:30:19.178] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611009017834868",
"id": "8857728324074345680",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b9176855abe2dddf472e8fed16ac8b8bec706ab\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611009018828396",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44711",
"builder:linux-chromeos-rel",
"buildset:commit/git/9b9176855abe2dddf472e8fed16ac8b8bec706ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b9176855abe2dddf472e8fed16ac8b8bec706ab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023158386011356272",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857728324074345680/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1611009018828716",
"url": "https://ci.chromium.org/b/8857728324074345680",
"utcnow_ts": "1611009019126661"
}
}
[22:30:19.178] Task URL: https://ci.chromium.org/b/8857728324074345680
[22:30:19.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:2:0) after 1m0s
[22:30:30.543] Received PubSub notification, asking Buildbucket for the build status
[22:30:30.645] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:19.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:2:0)
[22:31:19.219] Timer tick, asking Buildbucket for the build status
[22:31:19.512] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:19.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:4:0) after 1m0s
[22:32:19.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:4:0)
[22:32:19.517] Timer tick, asking Buildbucket for the build status
[22:32:19.751] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:19.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:5:0) after 1m0s
[22:33:19.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:5:0)
[22:33:19.772] Timer tick, asking Buildbucket for the build status
[22:33:19.850] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:19.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:6:0) after 1m0s
[22:34:19.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:6:0)
[22:34:19.885] Timer tick, asking Buildbucket for the build status
[22:34:20.098] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:20.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:7:0) after 1m0s
[22:35:20.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:7:0)
[22:35:20.087] Timer tick, asking Buildbucket for the build status
[22:35:20.267] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:20.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:8:0) after 1m0s
[22:36:20.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:8:0)
[22:36:20.350] Timer tick, asking Buildbucket for the build status
[22:36:20.455] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:20.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:9:0) after 1m0s
[22:37:20.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:9:0)
[22:37:20.475] Timer tick, asking Buildbucket for the build status
[22:37:20.538] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:20.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:10:0) after 1m0s
[22:38:20.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:10:0)
[22:38:20.646] Timer tick, asking Buildbucket for the build status
[22:38:20.816] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:20.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:11:0) after 1m0s
[22:39:20.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:11:0)
[22:39:20.886] Timer tick, asking Buildbucket for the build status
[22:39:20.971] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:20.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:12:0) after 1m0s
[22:40:21.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:12:0)
[22:40:21.041] Timer tick, asking Buildbucket for the build status
[22:40:21.194] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:21.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:13:0) after 1m0s
[22:41:21.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:13:0)
[22:41:21.218] Timer tick, asking Buildbucket for the build status
[22:41:21.321] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:21.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:14:0) after 1m0s
[22:42:21.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:14:0)
[22:42:21.352] Timer tick, asking Buildbucket for the build status
[22:42:21.511] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:21.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:15:0) after 1m0s
[22:43:21.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:15:0)
[22:43:21.515] Timer tick, asking Buildbucket for the build status
[22:43:21.587] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:21.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:16:0) after 1m0s
[22:44:21.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:16:0)
[22:44:21.705] Timer tick, asking Buildbucket for the build status
[22:44:22.066] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:22.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:17:0) after 1m0s
[22:45:22.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:17:0)
[22:45:22.083] Timer tick, asking Buildbucket for the build status
[22:45:22.482] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:22.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:18:0) after 1m0s
[22:46:22.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:18:0)
[22:46:22.501] Timer tick, asking Buildbucket for the build status
[22:46:22.554] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:22.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:19:0) after 1m0s
[22:47:22.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:19:0)
[22:47:22.635] Timer tick, asking Buildbucket for the build status
[22:47:22.754] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:22.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:20:0) after 1m0s
[22:48:22.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:20:0)
[22:48:22.851] Timer tick, asking Buildbucket for the build status
[22:48:23.095] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:23.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:21:0) after 1m0s
[22:49:23.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:21:0)
[22:49:23.118] Timer tick, asking Buildbucket for the build status
[22:49:23.408] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:23.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:22:0) after 1m0s
[22:50:23.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:22:0)
[22:50:23.436] Timer tick, asking Buildbucket for the build status
[22:50:23.547] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:23.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:23:0) after 1m0s
[22:51:23.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:23:0)
[22:51:23.573] Timer tick, asking Buildbucket for the build status
[22:51:23.708] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:23.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:24:0) after 1m0s
[22:52:23.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:24:0)
[22:52:23.735] Timer tick, asking Buildbucket for the build status
[22:52:23.814] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:23.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:25:0) after 1m0s
[22:53:23.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:25:0)
[22:53:23.883] Timer tick, asking Buildbucket for the build status
[22:53:24.165] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:24.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:26:0) after 1m0s
[22:54:24.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:26:0)
[22:54:24.185] Timer tick, asking Buildbucket for the build status
[22:54:25.617] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:25.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:27:0) after 1m0s
[22:55:26.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:27:0)
[22:55:26.368] Timer tick, asking Buildbucket for the build status
[22:55:26.608] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:26.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:28:0) after 1m0s
[22:56:26.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:28:0)
[22:56:26.657] Timer tick, asking Buildbucket for the build status
[22:56:26.732] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:26.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:29:0) after 1m0s
[22:57:26.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:29:0)
[22:57:26.801] Timer tick, asking Buildbucket for the build status
[22:57:27.103] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:27.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:30:0) after 1m0s
[22:58:27.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:30:0)
[22:58:27.114] Timer tick, asking Buildbucket for the build status
[22:58:27.177] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:27.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:31:0) after 1m0s
[22:59:27.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:31:0)
[22:59:27.185] Timer tick, asking Buildbucket for the build status
[22:59:27.240] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:27.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:32:0) after 1m0s
[23:00:27.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:32:0)
[23:00:27.298] Timer tick, asking Buildbucket for the build status
[23:00:27.691] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:27.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:33:0) after 1m0s
[23:01:27.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:33:0)
[23:01:27.763] Timer tick, asking Buildbucket for the build status
[23:01:28.034] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:28.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:34:0) after 1m0s
[23:02:28.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:34:0)
[23:02:28.072] Timer tick, asking Buildbucket for the build status
[23:02:28.132] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:28.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:35:0) after 1m0s
[23:03:28.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:35:0)
[23:03:28.137] Timer tick, asking Buildbucket for the build status
[23:03:28.200] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:28.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:36:0) after 1m0s
[23:04:28.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:36:0)
[23:04:28.215] Timer tick, asking Buildbucket for the build status
[23:04:28.336] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:28.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:37:0) after 1m0s
[23:05:28.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:37:0)
[23:05:28.322] Timer tick, asking Buildbucket for the build status
[23:05:28.439] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:28.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:38:0) after 1m0s
[23:06:28.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:38:0)
[23:06:28.636] Timer tick, asking Buildbucket for the build status
[23:06:28.728] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:28.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:39:0) after 1m0s
[23:07:28.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:39:0)
[23:07:28.812] Timer tick, asking Buildbucket for the build status
[23:07:29.841] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:29.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:40:0) after 1m0s
[23:08:30.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:40:0)
[23:08:30.000] Timer tick, asking Buildbucket for the build status
[23:08:30.339] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:30.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:41:0) after 1m0s
[23:09:30.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:41:0)
[23:09:30.421] Timer tick, asking Buildbucket for the build status
[23:09:30.876] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:30.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:42:0) after 1m0s
[23:10:30.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:42:0)
[23:10:30.938] Timer tick, asking Buildbucket for the build status
[23:10:31.517] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:31.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:43:0) after 1m0s
[23:11:31.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:43:0)
[23:11:31.550] Timer tick, asking Buildbucket for the build status
[23:11:31.650] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:31.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:44:0) after 1m0s
[23:12:31.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:44:0)
[23:12:31.682] Timer tick, asking Buildbucket for the build status
[23:12:31.814] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:31.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:45:0) after 1m0s
[23:13:31.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:45:0)
[23:13:31.847] Timer tick, asking Buildbucket for the build status
[23:13:32.015] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:32.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:46:0) after 1m0s
[23:14:32.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:46:0)
[23:14:32.019] Timer tick, asking Buildbucket for the build status
[23:14:32.151] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:32.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:47:0) after 1m0s
[23:15:32.208] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:47:0)
[23:15:32.208] Timer tick, asking Buildbucket for the build status
[23:15:32.509] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:32.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:48:0) after 1m0s
[23:16:32.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:48:0)
[23:16:32.655] Timer tick, asking Buildbucket for the build status
[23:16:32.763] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:32.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:49:0) after 1m0s
[23:17:33.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:49:0)
[23:17:33.001] Timer tick, asking Buildbucket for the build status
[23:17:33.445] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:33.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:50:0) after 1m0s
[23:18:33.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:50:0)
[23:18:33.617] Timer tick, asking Buildbucket for the build status
[23:18:34.039] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:34.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:51:0) after 1m0s
[23:19:34.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:51:0)
[23:19:34.149] Timer tick, asking Buildbucket for the build status
[23:19:34.249] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:34.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:52:0) after 1m0s
[23:20:34.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:52:0)
[23:20:34.308] Timer tick, asking Buildbucket for the build status
[23:20:34.777] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:34.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:53:0) after 1m0s
[23:21:34.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:53:0)
[23:21:34.807] Timer tick, asking Buildbucket for the build status
[23:21:34.926] Build 8857728324074345680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:34.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023158386011356272:54:0) after 1m0s
[23:21:55.542] Received PubSub notification, asking Buildbucket for the build status
[23:21:55.694] Build 8857728324074345680: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:21:55.694] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611012114016607",
"created_by": "project:chromium",
"created_ts": "1611009017834868",
"failure_reason": "BUILD_FAILURE",
"id": "8857728324074345680",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b9176855abe2dddf472e8fed16ac8b8bec706ab\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FileSystemProviderApiTest.Unmount\\n\\n- DemoSetupArcSupportedTest.OfflineSetupFlowSuccess\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"9b9176855abe2dddf472e8fed16ac8b8bec706ab\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-47-zair\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44711, \"got_angle_revision\": \"679d118787e7dab0cfddc0d7339700539155990a\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"9b9176855abe2dddf472e8fed16ac8b8bec706ab\", \"got_revision_cp\": \"refs/heads/master@{#844620}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"e02dfe6cf35d7b3724c84b162c628b2c960bd9c7\", \"got_v8_revision_cp\": \"refs/heads/9.0.5@{#1}\", \"got_webrtc_revision\": \"12971a22d265c7ba1c3c388f5d487580939a1162\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33014}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b9176855abe2dddf472e8fed16ac8b8bec706ab\", \"swarm_hashes_refs/heads/master(at){#844620}_without_patch\": {\"absl_hardening_tests\": \"51a9da70fe4012182270fa89f052e1535d84932b\", \"accessibility_unittests\": \"0d1567f8a2e1ba2edf139d48f8bee3f9fc62be32\", \"angle_unittests\": \"0b732e60bea425e24aa8a2495d61c1bd6a172c76\", \"app_list_unittests\": \"863701598896e85d4960ec04cc33365d5f2fa343\", \"app_shell_unittests\": \"112262feb62b76f3a977bc5d6368ae6916a167a2\", \"ash_unittests\": \"ec2d85aaf79b7875a51688efa42a4106ae6bc897\", \"aura_unittests\": \"e842b2b3a26809346e19019ba3278343ec7a971f\", \"base_unittests\": \"8287d2cc2484ff57824983d4530c16ce51516b69\", \"base_util_unittests\": \"7ec597bc0e78cd19f8b4cc24385be5bdf44f92e1\", \"blink_common_unittests\": \"bd39e795d14deab20df886ec17c99dde39b068c8\", \"blink_fuzzer_unittests\": \"fef1069e6e6865fdd6851bad673bd52aff473861\", \"blink_heap_unittests\": \"dfeddbed251710e291746d7fea359226c13b5a2a\", \"blink_platform_unittests\": \"a8ed75f44e4fc8f77d7114ca700028ae95191750\", \"blink_unittests\": \"419d60a06b0c53cf2260fe1250530e8965a8f792\", \"boringssl_crypto_tests\": \"8a12e71653353526bfdb290413d25ff24339ab30\", \"boringssl_ssl_tests\": \"5075805217708b97f7bceb5d55738ef062d573cd\", \"browser_tests\": \"0c3bd14db5b0ba7279510153a66054582c1b9f33\", \"capture_unittests\": \"9fcd274e9ec18ce0f77a9d69639e21ba65af01bb\", \"cast_unittests\": \"50cbc7d9d4291a3355a16da4198230ebf5e00818\", \"cc_unittests\": \"896454bdb0de9d4e22ee43a4eb653b8d20ba1644\", \"chrome_app_unittests\": \"25defa7b660814e3abb6af262c53c4f5782f4b34\", \"chromedriver_unittests\": \"dd678d605c73dfb613104bc9d6abf5c2fbe9fffb\", \"chromeos_components_unittests\": \"1a9a44b919a5d59285cba5dd89028a2a08f5eec0\", \"chromeos_unittests\": \"9a4affa663582b432680cc589bfa36119623f87b\", \"components_browsertests\": \"df03a190f5bf981c57d5e401f8df95c3fc983dad\", \"components_unittests\": \"5eb265dd53ad15e98bc8537ee7875697fef26c33\", \"compositor_unittests\": \"4ab66aca9bfce3cd22c2d1054ae6c42285d4b776\", \"content_browsertests\": \"4157cb8ea3a5b667c0eba78e1c5e2cae140e53f8\", \"content_unittests\": \"9b4adcc0b197c8be6cab26b5814145e8de536260\", \"crashpad_tests\": \"50c1807b31f43a63334ff760cf130ddac4892322\", \"crypto_unittests\": \"791d786c257bf6bbe0307214054d11874cac86cf\", \"dbus_unittests\": \"f6247f5b82f2b424280445131ad72aee9dafdb77\", \"device_unittests\": \"f9520cda27fe355d963be1140d0fa7708b4787c4\", \"display_unittests\": \"6635d911fa3bf0b4cbe1e60a659674905c5acb44\", \"events_unittests\": \"e6a6a5c8c0d71338c783934815173258981484da\", \"exo_unittests\": \"ef0879f5ec431d30f23803e347652faca4c68b5e\", \"extensions_browsertests\": \"e73198eed0395f08a1503e5c6522e6172b131b4b\", \"extensions_unittests\": \"a8e1c6eba129e638ddc26a1f57efc34a66b8b228\", \"filesystem_service_unittests\": \"f5d91543c4de065bd93485cbe783b981e97c46fc\", \"gcm_unit_tests\": \"7a8e8b853771cf7cfac2630613fb16941e13efd1\", \"gfx_unittests\": \"c79d2dbd79c73163f268d2f1051a3f62c497058d\", \"gin_unittests\": \"4e651b2464b202c1be8f8b34f8d7cd5bc0a9798c\", \"gl_unittests_ozone\": \"05ecb91e387628f0858f33f285f6adc5d26803e6\", \"google_apis_unittests\": \"84291be4058e56600e2524f1514ba8f3d4337cf1\", \"gpu_unittests\": \"e6befa19fa87919c4bb8d385597163d24e638c24\", \"gwp_asan_unittests\": \"460723265acca271e9acd43ee4303e347714b584\", \"interactive_ui_tests\": \"7ff9c0e40eba4519d5a1735a24edb52756b6177e\", \"ipc_tests\": \"6fdeddad28857c8fdfc64c065c8a01308d988dee\", \"jingle_unittests\": \"a62f10af52891e0d3ac3cd659411da6ad40b4dbd\", \"keyboard_unittests\": \"a2cff2129355a7eb6e8d7575db2375bdb5dcaec3\", \"latency_unittests\": \"c97b7efe96c6f822ddd33e86c3b2f37b7bae97cc\", \"libjingle_xmpp_unittests\": \"2e7477cc063c0f9d24b815375dbbcefed0046585\", \"liburlpattern_unittests\": \"8083b9c5ec47e23ac76beabd27bd1cd0e97ba4c7\", \"media_blink_unittests\": \"01aa17deebf3bc6e3af7ceadd1e0af486362e930\", \"media_unittests\": \"f5073538dd1419a3a1dd7945a9bdcc2c58fe3124\", \"message_center_unittests\": \"ab7e184cadc030192dd6c1b6cbc077b1beeb9b26\", \"midi_unittests\": \"b2aaf46ba956cb98146d8989a85f7351937a4c1d\", \"mojo_core_unittests\": \"1ac58800a3e77cc044feff845fa4b3f0302cf424\", \"mojo_unittests\": \"07d9e262d9d9d306ae5046f1af4fe0031f58edb7\", \"nacl_helper_nonsfi_unittests\": \"92cb83718c489f4e6ae2461185ece6c293a01638\", \"nacl_loader_unittests\": \"fdbaa24a2a3d5536f6e379a5e0553dfff44a4e2c\", \"native_theme_unittests\": \"0c43132be3661560ead2dabaceb8d75c91d483fd\", \"net_unittests\": \"295339ee52ee54787e653b7d7ba91a7c52e250ed\", \"ozone_gl_unittests\": \"3885e1930f3591923a92de17a8af0ba81fee57a4\", \"ozone_unittests\": \"a064a948d7ebdc8eadaab1b4f0409eebbf74ec28\", \"ozone_x11_unittests\": \"9a2a9a2b952eedbb2d2603361f5ea1e248dd8848\", \"pdf_unittests\": \"bd44912151ed19ec0a7ef1112d0df18f2c3a987e\", \"perfetto_unittests\": \"88668f556b0c3bdff8c350268dc9e034d8ae543d\", \"ppapi_unittests\": \"c855c1a285ffa6a8e95d9e96c4333d660077e26e\", \"printing_unittests\": \"f123a7f596c82506417407c2c2e721c3d0f37d88\", \"remoting_unittests\": \"2bf3f98f41ffe0f2ec9d4ac0b09a636cc83ddb37\", \"sandbox_linux_unittests\": \"12efb0b4d39b1166370ac6af51e525274334370d\", \"service_manager_unittests\": \"b6f1bb33baed70481b0bfc528b54ab199bf40b97\", \"services_unittests\": \"dcd8023d204723d331f99e5600741bdf6ccf1127\", \"shell_dialogs_unittests\": \"1acb8472653c92dae952e7baa335eb8940cef325\", \"shell_encryption_unittests\": \"e968576fc71604637ce94a5bca3cde5f4ca4e9cf\", \"skia_unittests\": \"f3ed7986b2357017de715d9d3c7a33b0989618c8\", \"snapshot_unittests\": \"558c2975f290cc7011d546d466845d5528a30cbd\", \"sql_unittests\": \"65120ac2d14c31ab154190e6fd95143e2834ffa1\", \"storage_unittests\": \"23f8aa7c18fe0e15648c4f9f47c08b4b67185784\", \"sync_integration_tests\": \"a02c4a3c5a5624639efde9e6e396d55fe9ef7743\", \"traffic_annotation_auditor_unittests\": \"2f00cc71acc309190108d2b234aaaed2876a84ef\", \"ui_base_unittests\": \"e6a511a4b905c9e09e88f6893c63d46aee8e925e\", \"ui_chromeos_unittests\": \"bf983c8faabc5e6c016aff5ea71c60441fe8d5ff\", \"ui_touch_selection_unittests\": \"a20275fc5e907777d80052d91022273e4cf0d98a\", \"unit_tests\": \"25796ffb0ace6713bb6b6f9a4497af0e657db58c\", \"url_unittests\": \"741f2508d0e00930803332b484066d1e014b4fc4\", \"usage_time_limit_unittests\": \"e995ef73aa118d029aad47d74d31425509048c39\", \"views_unittests\": \"83e98617ae19aa31950bbd132ad5263c352ceea0\", \"viz_unittests\": \"54ad26da81f227799404f78806c6a4981b427fc9\", \"wayland_client_perftests\": \"30aec329a469e0742ae1de339d03c7c25bb9ea9d\", \"wm_unittests\": \"230c98071d32f35c7f725cc9d262565da8a7c78a\", \"wtf_unittests\": \"a335b89b19d31c945660e6c5e469398c40e946d8\", \"zlib_unittests\": \"d0c100301ef70f8170f88141794374d92a1012f9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_847b8249ec8334f5a90b5e0f1190646f2316bd1dfca5c1d0952633ff4ae3048f_v2\", \"builder_8c23a72064650b4b1d9380637a287eed4ae2e2a2092116afea022d28ee09b5dd_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_e9d7d0a19fc068adf341a224b6eb4c464e3f53ed9d47979ef0c80d8aa2ba711c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-47-zair\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- FileSystemProviderApiTest.Unmount\\n\\n- DemoSetupArcSupportedTest.OfflineSetupFlowSuccess\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611009029843102",
"status": "COMPLETED",
"status_changed_ts": "1611009030124920",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44711",
"builder:linux-chromeos-rel",
"buildset:commit/git/9b9176855abe2dddf472e8fed16ac8b8bec706ab",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b9176855abe2dddf472e8fed16ac8b8bec706ab",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023158386011356272",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857728324074345680/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:51307056f3c91f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611012114939224",
"url": "https://ci.chromium.org/b/8857728324074345680",
"utcnow_ts": "1611012115684425"
}
}
[23:21:55.694] Invocation finished in 51m39.091156382s with status FAILED