[11:28:08.088] New invocation is queued and will start shortly
[11:28:09.255] Starting the invocation (attempt 1)
[11:28:09.315] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:28:09.315] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:28:09.315] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020391538435892640",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c0acfe98594233ae5652f623db805e5d6cfe7cdd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9020391538435892640",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/c0acfe98594233ae5652f623db805e5d6cfe7cdd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c0acfe98594233ae5652f623db805e5d6cfe7cdd",
"gitiles_ref:refs/heads/master"
]
}
[11:28:10.134] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613647689405550",
"id": "8854961476392234896",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c0acfe98594233ae5652f623db805e5d6cfe7cdd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613647689775815",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45526",
"builder:linux-chromeos-rel",
"buildset:commit/git/c0acfe98594233ae5652f623db805e5d6cfe7cdd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c0acfe98594233ae5652f623db805e5d6cfe7cdd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020391538435892640",
"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/8854961476392234896/+/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": "1613647689775937",
"url": "https://ci.chromium.org/b/8854961476392234896",
"utcnow_ts": "1613647690117832"
}
}
[11:28:10.135] Task URL: https://ci.chromium.org/b/8854961476392234896
[11:28:10.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:2:0) after 1m0s
[11:28:14.454] Received PubSub notification, asking Buildbucket for the build status
[11:28:14.523] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:10.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:2:0)
[11:29:10.185] Timer tick, asking Buildbucket for the build status
[11:29:10.391] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:10.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:4:0) after 1m0s
[11:30:10.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:4:0)
[11:30:10.394] Timer tick, asking Buildbucket for the build status
[11:30:10.660] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:10.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:5:0) after 1m0s
[11:31:10.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:5:0)
[11:31:10.682] Timer tick, asking Buildbucket for the build status
[11:31:10.812] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:10.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:6:0) after 1m0s
[11:32:10.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:6:0)
[11:32:10.857] Timer tick, asking Buildbucket for the build status
[11:32:10.957] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:10.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:7:0) after 1m0s
[11:33:10.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:7:0)
[11:33:10.994] Timer tick, asking Buildbucket for the build status
[11:33:11.116] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:11.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:8:0) after 1m0s
[11:34:11.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:8:0)
[11:34:11.133] Timer tick, asking Buildbucket for the build status
[11:34:11.235] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:11.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:9:0) after 1m0s
[11:35:11.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:9:0)
[11:35:11.256] Timer tick, asking Buildbucket for the build status
[11:35:11.341] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:11.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:10:0) after 1m0s
[11:36:11.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:10:0)
[11:36:11.395] Timer tick, asking Buildbucket for the build status
[11:36:11.478] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:11.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:11:0) after 1m0s
[11:37:11.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:11:0)
[11:37:11.498] Timer tick, asking Buildbucket for the build status
[11:37:11.676] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:11.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:12:0) after 1m0s
[11:38:11.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:12:0)
[11:38:11.746] Timer tick, asking Buildbucket for the build status
[11:38:11.840] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:11.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:13:0) after 1m0s
[11:39:11.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:13:0)
[11:39:11.857] Timer tick, asking Buildbucket for the build status
[11:39:11.936] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:11.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:14:0) after 1m0s
[11:40:11.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:14:0)
[11:40:11.954] Timer tick, asking Buildbucket for the build status
[11:40:12.110] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:12.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:15:0) after 1m0s
[11:41:12.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:15:0)
[11:41:12.126] Timer tick, asking Buildbucket for the build status
[11:41:12.420] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:12.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:16:0) after 1m0s
[11:42:12.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:16:0)
[11:42:12.543] Timer tick, asking Buildbucket for the build status
[11:42:12.636] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:12.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:17:0) after 1m0s
[11:43:12.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:17:0)
[11:43:12.690] Timer tick, asking Buildbucket for the build status
[11:43:12.793] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:12.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:18:0) after 1m0s
[11:44:12.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:18:0)
[11:44:12.822] Timer tick, asking Buildbucket for the build status
[11:44:12.915] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:12.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:19:0) after 1m0s
[11:45:12.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:19:0)
[11:45:12.893] Timer tick, asking Buildbucket for the build status
[11:45:12.974] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:12.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:20:0) after 1m0s
[11:46:13.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:20:0)
[11:46:13.006] Timer tick, asking Buildbucket for the build status
[11:46:13.115] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:13.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:21:0) after 1m0s
[11:47:13.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:21:0)
[11:47:13.182] Timer tick, asking Buildbucket for the build status
[11:47:13.266] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:13.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:22:0) after 1m0s
[11:48:13.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:22:0)
[11:48:13.312] Timer tick, asking Buildbucket for the build status
[11:48:13.402] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:13.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:23:0) after 1m0s
[11:49:13.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:23:0)
[11:49:13.409] Timer tick, asking Buildbucket for the build status
[11:49:13.492] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:13.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:24:0) after 1m0s
[11:50:13.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:24:0)
[11:50:13.617] Timer tick, asking Buildbucket for the build status
[11:50:13.702] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:13.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:25:0) after 1m0s
[11:51:13.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:25:0)
[11:51:13.805] Timer tick, asking Buildbucket for the build status
[11:51:13.892] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:13.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:26:0) after 1m0s
[11:52:13.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:26:0)
[11:52:13.979] Timer tick, asking Buildbucket for the build status
[11:52:14.107] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:14.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:27:0) after 1m0s
[11:53:14.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:27:0)
[11:53:14.491] Timer tick, asking Buildbucket for the build status
[11:53:14.803] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:14.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:28:0) after 1m0s
[11:54:14.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:28:0)
[11:54:14.852] Timer tick, asking Buildbucket for the build status
[11:54:15.118] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:15.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:29:0) after 1m0s
[11:55:15.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:29:0)
[11:55:15.205] Timer tick, asking Buildbucket for the build status
[11:55:15.378] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:15.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:30:0) after 1m0s
[11:56:15.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:30:0)
[11:56:15.501] Timer tick, asking Buildbucket for the build status
[11:56:15.744] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:15.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:31:0) after 1m0s
[11:57:15.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:31:0)
[11:57:15.766] Timer tick, asking Buildbucket for the build status
[11:57:16.025] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:16.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:32:0) after 1m0s
[11:58:16.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:32:0)
[11:58:16.075] Timer tick, asking Buildbucket for the build status
[11:58:16.172] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:16.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:33:0) after 1m0s
[11:59:16.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:33:0)
[11:59:16.232] Timer tick, asking Buildbucket for the build status
[11:59:16.365] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:16.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:34:0) after 1m0s
[12:00:16.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:34:0)
[12:00:16.477] Timer tick, asking Buildbucket for the build status
[12:00:16.562] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:16.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:35:0) after 1m0s
[12:01:16.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:35:0)
[12:01:16.677] Timer tick, asking Buildbucket for the build status
[12:01:16.758] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:16.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:36:0) after 1m0s
[12:02:16.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:36:0)
[12:02:16.823] Timer tick, asking Buildbucket for the build status
[12:02:16.916] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:16.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:37:0) after 1m0s
[12:03:16.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:37:0)
[12:03:16.978] Timer tick, asking Buildbucket for the build status
[12:03:17.468] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:17.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:38:0) after 1m0s
[12:04:17.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:38:0)
[12:04:17.529] Timer tick, asking Buildbucket for the build status
[12:04:17.616] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:17.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:39:0) after 1m0s
[12:05:17.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:39:0)
[12:05:17.692] Timer tick, asking Buildbucket for the build status
[12:05:17.808] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:17.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:40:0) after 1m0s
[12:06:17.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:40:0)
[12:06:17.913] Timer tick, asking Buildbucket for the build status
[12:06:18.064] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:18.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:41:0) after 1m0s
[12:07:18.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:41:0)
[12:07:18.126] Timer tick, asking Buildbucket for the build status
[12:07:18.205] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:18.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:42:0) after 1m0s
[12:08:18.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:42:0)
[12:08:18.304] Timer tick, asking Buildbucket for the build status
[12:08:18.443] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:18.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:43:0) after 1m0s
[12:09:18.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:43:0)
[12:09:18.611] Timer tick, asking Buildbucket for the build status
[12:09:18.691] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:18.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:44:0) after 1m0s
[12:10:18.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:44:0)
[12:10:18.867] Timer tick, asking Buildbucket for the build status
[12:10:18.953] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:18.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:45:0) after 1m0s
[12:11:19.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:45:0)
[12:11:19.039] Timer tick, asking Buildbucket for the build status
[12:11:19.309] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:19.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:46:0) after 1m0s
[12:12:19.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:46:0)
[12:12:19.329] Timer tick, asking Buildbucket for the build status
[12:12:19.440] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:19.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:47:0) after 1m0s
[12:13:19.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:47:0)
[12:13:19.523] Timer tick, asking Buildbucket for the build status
[12:13:19.825] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:19.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:48:0) after 1m0s
[12:14:19.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:48:0)
[12:14:19.893] Timer tick, asking Buildbucket for the build status
[12:14:20.039] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:20.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:49:0) after 1m0s
[12:15:20.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:49:0)
[12:15:20.096] Timer tick, asking Buildbucket for the build status
[12:15:20.723] Build 8854961476392234896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:20.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9020391538435892640:50:0) after 1m0s
[12:15:26.890] Received PubSub notification, asking Buildbucket for the build status
[12:15:27.126] Build 8854961476392234896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:15:27.126] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613650524771360",
"created_by": "project:chromium",
"created_ts": "1613647689405550",
"id": "8854961476392234896",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c0acfe98594233ae5652f623db805e5d6cfe7cdd\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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\": \"c0acfe98594233ae5652f623db805e5d6cfe7cdd\", \"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-166-b6ag\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45526, \"got_angle_revision\": \"0fa6c307ac7855a10ff95b661ca827add56e1576\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"c0acfe98594233ae5652f623db805e5d6cfe7cdd\", \"got_revision_cp\": \"refs/heads/master@{#855207}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"b3177eb449cae97d92b18ffafe20dfcfce23683e\", \"got_v8_revision\": \"3fe2e9ec96b8da49a7cdeb2353c041ea3687ae2d\", \"got_v8_revision_cp\": \"refs/heads/9.0.211@{#1}\", \"got_webrtc_revision\": \"86d37256c9a7411ff53ce6b3d3d39d1c41358288\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33292}\", \"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\": \"c0acfe98594233ae5652f623db805e5d6cfe7cdd\", \"swarm_hashes_refs/heads/master(at){#855207}_without_patch\": {\"absl_hardening_tests\": \"f1cc827bd2d06bc74d9371042178cbd0096107a5\", \"accessibility_unittests\": \"7fcb239c1dc65a20f8459bf31585c51adcb0610a\", \"angle_unittests\": \"8444e441c6bb8a2a47f4dad6d755e2a4addcbf61\", \"app_list_unittests\": \"27ee97b2d748c01c3c7e55666029bd171c2ef17a\", \"app_shell_unittests\": \"08d17b7bec154ba4b94651045458b9ed96d589b2\", \"ash_unittests\": \"d8276051712fa3aa0d6d75652f50fc31d88254e3\", \"aura_unittests\": \"1819137f528dc55e7c4f2cdfb12e1c60f6faa6ed\", \"base_unittests\": \"72bd446a16518d4cfeaea63b6445102ed6d53137\", \"base_util_unittests\": \"3242eda11717254ef339adba6ab0e665f01caeaf\", \"blink_common_unittests\": \"5be1b91f0f64943cd15333f8aab21940addcd529\", \"blink_fuzzer_unittests\": \"d5f52bd70a76a26b43e85130c180c66c0f37b23b\", \"blink_heap_unittests\": \"2cf5b345debb88eb6ea6d189f6436e24b064b7e9\", \"blink_platform_unittests\": \"c5094d041c29eda7b60977aaf538dd418e645e7b\", \"blink_unittests\": \"e89a462eb9ae9c8e5fbdf7ac4f72a32fb64c6bd7\", \"boringssl_crypto_tests\": \"98057488342051870d6a11a6f92806c766f3313b\", \"boringssl_ssl_tests\": \"884c9fdedf5e63e11f30774df30d26c96caab268\", \"browser_tests\": \"63b785811c0f6e1039098acc05ec3a6192277fa7\", \"capture_unittests\": \"2684994f3ebc31dbfb91035ffa79f46bb275cb78\", \"cast_unittests\": \"796f49eef7ca432125c1e48490d98f769acdc886\", \"cc_unittests\": \"9475010f78887b12c195b9ee27a1201f9444aa0b\", \"chrome_app_unittests\": \"97f64b833d282d973d9ac5255b33476aa0e587cd\", \"chromedriver_unittests\": \"753679734ca081884d4bd4103bc9220251a4c862\", \"chromeos_components_unittests\": \"f775ea092abaea3fb33d36735204ec0b7f9e6494\", \"chromeos_unittests\": \"78cff334598ccd9ece55085d7478c4bf4ca050e0\", \"components_browsertests\": \"87112d19b38f7cb1cdfd19be6594f2e62cd4c66e\", \"components_unittests\": \"4b9eb8baf10cb8dd406725361dcdafbf163196c5\", \"compositor_unittests\": \"65cb7f3240e349f0963342525f12b0304eaa77f4\", \"content_browsertests\": \"e2b85798d2fec3a99202ce2f3297b342bc4b99c5\", \"content_unittests\": \"9af67cf7c6335f31d47a54bba3696adf118ad74e\", \"crashpad_tests\": \"70dd34962cd8ec791b0562c84d2f9a778b28e2ab\", \"crypto_unittests\": \"365639d9d6f8fa0280975fb85a338c1d63e10dfa\", \"dbus_unittests\": \"25f79c2d369678d45bee48a5b575149c4a26273e\", \"device_unittests\": \"a1254351fe237cd80862a148a80f71faf8941fe3\", \"display_unittests\": \"377914f11fd787a4759f3f4715e3e96223c1af39\", \"events_unittests\": \"b500d4c0136890a51a131a16de57d69a192d302c\", \"exo_unittests\": \"d1f9e4ac791a0bedaf894d191336012a5c575be8\", \"extensions_browsertests\": \"fa45f0006f0ecdd08f1110ba08494b8dd6198a7a\", \"extensions_unittests\": \"fcdbb18e4e8d15bf8012a2cad7314de3150ec148\", \"filesystem_service_unittests\": \"29636a4d6e64e066b3e0e0ae346cf95d53c093b5\", \"gcm_unit_tests\": \"c90e24a3ed2479ce0c1193f25b005000929dcc15\", \"gfx_unittests\": \"434013144b39e950814f789666367ee5522c47ea\", \"gin_unittests\": \"f2505f532d4ca40c53d093eb636169b67263870d\", \"gl_unittests_ozone\": \"27d05bb481938a0f27a21f4d4a131f6f210ca4f6\", \"google_apis_unittests\": \"e4646d08a1e484a9c529688928dd862d95c6dc3c\", \"gpu_unittests\": \"3fdb4a4ab0772ac54ce67d0430a7a3cbafe323e7\", \"gwp_asan_unittests\": \"254b7ca3f0e785e5b27712fa869d1299d6974c58\", \"interactive_ui_tests\": \"d31f55a83d001b7956af02c769b4665d38766671\", \"ipc_tests\": \"c1b6bb2037d3236c590d1e848253d379bd43a488\", \"jingle_unittests\": \"3aa90f135efbe42a921a4cb19a90d7b1f4544079\", \"keyboard_unittests\": \"5108bfc278845c10796af5168a370e09cd478810\", \"latency_unittests\": \"22261c031a156378e42423e78bca132a28205721\", \"libjingle_xmpp_unittests\": \"2735260156c956df9d4a567212e9fa4035eeba19\", \"liburlpattern_unittests\": \"7078fa3405836aa1ac1b977fd659179e10309f92\", \"media_blink_unittests\": \"224d6b35883488869d45a293f2cc73b60ef00692\", \"media_unittests\": \"4b0c2883942c94c4b215b58fbeb57811fa8af717\", \"message_center_unittests\": \"0dcf8e3582e6b35ed5aa7fd45fcd3772d3e51a87\", \"midi_unittests\": \"729122b9102eda20700f036ccf83f0e36c301624\", \"mojo_core_unittests\": \"1b895b5f7bcf75f6723175717a939ba69ca3dc73\", \"mojo_unittests\": \"e08ee0ca942550edc7393b9aa8c87939e4cbad09\", \"nacl_helper_nonsfi_unittests\": \"8dcc87c5c4130b57c62d652bf35eca89af6b6ac7\", \"nacl_loader_unittests\": \"d8d050e0d8c09befcfac82215cf6fe8d3838a2b1\", \"native_theme_unittests\": \"952a0f9363192aee0805ece0220bc2f3b5f3a829\", \"net_unittests\": \"8bc7ac321d31b6ab652320e37d912c7d66e59073\", \"ozone_gl_unittests\": \"f0bec4a346f773481d4a2bca1a89e332f3ef8f06\", \"ozone_unittests\": \"4fc47598052efdaffe4b4d2003bc4ad7a19254af\", \"ozone_x11_unittests\": \"49e7b3827c84b64b991b880b48e15c55cd2c3886\", \"pdf_unittests\": \"54e2de9498e837f9b9b7fb0a196a5dbe207bd75f\", \"perfetto_unittests\": \"8b99151bdeeef787bfc41a283f8d385a24fd7c06\", \"ppapi_unittests\": \"4b370f66ea3e1996052310615058a4f87a4dae57\", \"printing_unittests\": \"146f16bf60fa2c211faf49f9d64a56d0a46f754f\", \"remoting_unittests\": \"99aae5756b7960565ceed5459e00f13addc703a0\", \"sandbox_linux_unittests\": \"f8018c7eafe873623a2df79e5d3ae85572603468\", \"service_manager_unittests\": \"683cb801af3afccc93c59ef799683796a888652f\", \"services_unittests\": \"a26de559d4b17cc628b504c7daa14f61083477e2\", \"shell_dialogs_unittests\": \"a4a6971ed7b15f00ed449742c2ad748f8f4516d2\", \"shell_encryption_unittests\": \"5cbc6a353981f89e8a415172424e03bc4a2f2262\", \"skia_unittests\": \"fa0e36ec5b682218775b57a236602efa1c776a88\", \"snapshot_unittests\": \"41725f125accb2633ba064cea498a0807102718b\", \"sql_unittests\": \"25cb186e495f9443d5e3a05c8d98d29213999b1a\", \"storage_unittests\": \"0dc307be440675df254a049cd839bb841eea2052\", \"sync_integration_tests\": \"de80d9000fd962a8ff5b256ce0774dca732f3ed3\", \"traffic_annotation_auditor_unittests\": \"b23cd96ae9f1f57fbded402b4be41ab5f46c961d\", \"ui_base_unittests\": \"8af796b7b574e102a8506a139643f02421274af9\", \"ui_chromeos_unittests\": \"6078293bf27fe9030bca9c2a9a1701fb11e778f0\", \"ui_touch_selection_unittests\": \"01293b104c3b814033a02bef89e517924287cc5f\", \"unit_tests\": \"1e4ffc782c151d52c1e49ee876a2b6b91ac4e779\", \"url_unittests\": \"23222e4a54e9b6f4a8724cff8e5a353b0a6a50d8\", \"usage_time_limit_unittests\": \"ddfbca6c3a7d37bb794819498807bb231b9f38ad\", \"views_unittests\": \"c9957cd11683b3fdb173200f3938f9ec95a7b1bf\", \"viz_unittests\": \"d3382359457e96da1b3529391b56a67e11473e49\", \"wayland_client_perftests\": \"a520d049887a90d22a4b643d7977f7a00e806bb7\", \"wm_unittests\": \"3484693d8fcf3a604d7b49fe218ac035536c1a94\", \"wtf_unittests\": \"64a0b6ab343121b51ed7939b4366c3dab4e59909\", \"zlib_unittests\": \"1211e596aa34b5af02db91cc86789a70f8682401\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_1267e646917891f5f926cdb94ab3368f0c9399d68d76518d691afb23f68811c9_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_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-166-b6ag\"], \"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\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613647693801886",
"status": "COMPLETED",
"status_changed_ts": "1613650525273546",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45526",
"builder:linux-chromeos-rel",
"buildset:commit/git/c0acfe98594233ae5652f623db805e5d6cfe7cdd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c0acfe98594233ae5652f623db805e5d6cfe7cdd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020391538435892640",
"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/8854961476392234896/+/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:51cdb74214eb6310",
"user_agent:luci-scheduler"
],
"updated_ts": "1613650525277871",
"url": "https://ci.chromium.org/b/8854961476392234896",
"utcnow_ts": "1613650527110170"
}
}
[12:15:27.126] Invocation finished in 47m19.052899332s with status SUCCEEDED