[16:06:25.606] New invocation is queued and will start shortly
[16:06:26.743] Starting the invocation (attempt 1)
[16:06:26.823] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:06:26.826] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:06:26.826] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023544923654903904",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0e5f8e29d72d7eaaa060a867c656c13c8c49a225\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9023544923654903904",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/0e5f8e29d72d7eaaa060a867c656c13c8c49a225",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0e5f8e29d72d7eaaa060a867c656c13c8c49a225",
"gitiles_ref:refs/heads/master"
]
}
[16:06:27.998] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610640387022349",
"id": "8858114861496509424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0e5f8e29d72d7eaaa060a867c656c13c8c49a225\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610640387668124",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44601",
"builder:linux-chromeos-rel",
"buildset:commit/git/0e5f8e29d72d7eaaa060a867c656c13c8c49a225",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0e5f8e29d72d7eaaa060a867c656c13c8c49a225",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023544923654903904",
"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/8858114861496509424/+/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": "1610640387668258",
"url": "https://ci.chromium.org/b/8858114861496509424",
"utcnow_ts": "1610640387977592"
}
}
[16:06:27.998] Task URL: https://ci.chromium.org/b/8858114861496509424
[16:06:27.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:2:0) after 1m0s
[16:06:31.641] Received PubSub notification, asking Buildbucket for the build status
[16:06:31.749] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:28.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:2:0)
[16:07:28.026] Timer tick, asking Buildbucket for the build status
[16:07:28.143] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:28.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:4:0) after 1m0s
[16:08:28.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:4:0)
[16:08:28.161] Timer tick, asking Buildbucket for the build status
[16:08:28.325] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:28.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:5:0) after 1m0s
[16:09:28.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:5:0)
[16:09:28.385] Timer tick, asking Buildbucket for the build status
[16:09:28.707] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:28.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:6:0) after 1m0s
[16:10:28.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:6:0)
[16:10:28.737] Timer tick, asking Buildbucket for the build status
[16:10:29.205] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:29.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:7:0) after 1m0s
[16:11:29.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:7:0)
[16:11:29.285] Timer tick, asking Buildbucket for the build status
[16:11:29.675] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:29.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:8:0) after 1m0s
[16:12:29.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:8:0)
[16:12:29.718] Timer tick, asking Buildbucket for the build status
[16:12:29.815] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:29.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:9:0) after 1m0s
[16:13:29.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:9:0)
[16:13:29.811] Timer tick, asking Buildbucket for the build status
[16:13:30.003] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:30.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:10:0) after 1m0s
[16:14:30.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:10:0)
[16:14:30.097] Timer tick, asking Buildbucket for the build status
[16:14:30.160] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:30.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:11:0) after 1m0s
[16:15:30.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:11:0)
[16:15:30.209] Timer tick, asking Buildbucket for the build status
[16:15:30.278] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:30.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:12:0) after 1m0s
[16:16:30.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:12:0)
[16:16:30.351] Timer tick, asking Buildbucket for the build status
[16:16:30.468] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:30.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:13:0) after 1m0s
[16:17:30.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:13:0)
[16:17:30.492] Timer tick, asking Buildbucket for the build status
[16:17:30.570] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:30.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:14:0) after 1m0s
[16:18:30.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:14:0)
[16:18:30.591] Timer tick, asking Buildbucket for the build status
[16:18:30.732] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:30.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:15:0) after 1m0s
[16:19:30.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:15:0)
[16:19:30.761] Timer tick, asking Buildbucket for the build status
[16:19:30.861] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:30.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:16:0) after 1m0s
[16:20:31.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:16:0)
[16:20:31.066] Timer tick, asking Buildbucket for the build status
[16:20:31.150] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:31.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:17:0) after 1m0s
[16:21:31.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:17:0)
[16:21:31.209] Timer tick, asking Buildbucket for the build status
[16:21:31.304] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:31.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:18:0) after 1m0s
[16:22:31.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:18:0)
[16:22:31.360] Timer tick, asking Buildbucket for the build status
[16:22:31.464] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:31.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:19:0) after 1m0s
[16:23:31.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:19:0)
[16:23:31.515] Timer tick, asking Buildbucket for the build status
[16:23:31.608] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:31.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:20:0) after 1m0s
[16:24:31.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:20:0)
[16:24:31.769] Timer tick, asking Buildbucket for the build status
[16:24:32.104] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:32.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:21:0) after 1m0s
[16:25:32.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:21:0)
[16:25:32.232] Timer tick, asking Buildbucket for the build status
[16:25:32.308] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:32.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:22:0) after 1m0s
[16:26:32.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:22:0)
[16:26:32.361] Timer tick, asking Buildbucket for the build status
[16:26:32.767] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:32.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:23:0) after 1m0s
[16:27:32.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:23:0)
[16:27:32.773] Timer tick, asking Buildbucket for the build status
[16:27:33.176] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:33.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:24:0) after 1m0s
[16:28:33.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:24:0)
[16:28:33.269] Timer tick, asking Buildbucket for the build status
[16:28:33.451] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:33.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:25:0) after 1m0s
[16:29:33.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:25:0)
[16:29:33.483] Timer tick, asking Buildbucket for the build status
[16:29:33.558] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:33.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:26:0) after 1m0s
[16:30:33.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:26:0)
[16:30:33.691] Timer tick, asking Buildbucket for the build status
[16:30:33.903] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:33.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:27:0) after 1m0s
[16:31:33.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:27:0)
[16:31:33.977] Timer tick, asking Buildbucket for the build status
[16:31:34.171] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:34.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:28:0) after 1m0s
[16:32:34.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:28:0)
[16:32:34.285] Timer tick, asking Buildbucket for the build status
[16:32:34.438] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:34.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:29:0) after 1m0s
[16:33:34.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:29:0)
[16:33:34.490] Timer tick, asking Buildbucket for the build status
[16:33:34.560] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:34.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:30:0) after 1m0s
[16:34:34.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:30:0)
[16:34:34.643] Timer tick, asking Buildbucket for the build status
[16:34:34.927] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:34.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:31:0) after 1m0s
[16:35:34.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:31:0)
[16:35:34.970] Timer tick, asking Buildbucket for the build status
[16:35:35.174] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:35.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:32:0) after 1m0s
[16:36:35.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:32:0)
[16:36:35.207] Timer tick, asking Buildbucket for the build status
[16:36:35.316] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:35.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:33:0) after 1m0s
[16:37:35.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:33:0)
[16:37:35.296] Timer tick, asking Buildbucket for the build status
[16:37:35.398] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:35.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:34:0) after 1m0s
[16:38:35.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:34:0)
[16:38:35.504] Timer tick, asking Buildbucket for the build status
[16:38:35.662] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:35.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:35:0) after 1m0s
[16:39:35.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:35:0)
[16:39:35.780] Timer tick, asking Buildbucket for the build status
[16:39:35.902] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:35.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:36:0) after 1m0s
[16:40:35.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:36:0)
[16:40:35.899] Timer tick, asking Buildbucket for the build status
[16:40:36.783] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:36.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:37:0) after 1m0s
[16:41:36.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:37:0)
[16:41:36.829] Timer tick, asking Buildbucket for the build status
[16:41:36.945] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:36.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:38:0) after 1m0s
[16:42:37.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:38:0)
[16:42:37.019] Timer tick, asking Buildbucket for the build status
[16:42:37.141] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:37.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:39:0) after 1m0s
[16:43:37.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:39:0)
[16:43:37.142] Timer tick, asking Buildbucket for the build status
[16:43:37.272] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:37.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:40:0) after 1m0s
[16:44:37.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:40:0)
[16:44:37.307] Timer tick, asking Buildbucket for the build status
[16:44:37.481] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:37.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:41:0) after 1m0s
[16:45:37.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:41:0)
[16:45:37.480] Timer tick, asking Buildbucket for the build status
[16:45:37.715] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:37.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:42:0) after 1m0s
[16:46:37.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:42:0)
[16:46:37.788] Timer tick, asking Buildbucket for the build status
[16:46:38.104] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:38.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:43:0) after 1m0s
[16:47:38.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:43:0)
[16:47:38.134] Timer tick, asking Buildbucket for the build status
[16:47:38.556] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:38.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:44:0) after 1m0s
[16:48:38.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:44:0)
[16:48:38.579] Timer tick, asking Buildbucket for the build status
[16:48:38.842] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:38.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:45:0) after 1m0s
[16:49:38.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:45:0)
[16:49:38.848] Timer tick, asking Buildbucket for the build status
[16:49:39.203] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:39.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:46:0) after 1m0s
[16:50:39.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:46:0)
[16:50:39.306] Timer tick, asking Buildbucket for the build status
[16:50:39.459] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:39.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:47:0) after 1m0s
[16:51:39.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:47:0)
[16:51:39.541] Timer tick, asking Buildbucket for the build status
[16:51:39.732] Build 8858114861496509424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:39.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023544923654903904:48:0) after 1m0s
[16:52:04.978] Received PubSub notification, asking Buildbucket for the build status
[16:52:05.067] Build 8858114861496509424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:52:05.067] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610643124250556",
"created_by": "project:chromium",
"created_ts": "1610640387022349",
"id": "8858114861496509424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0e5f8e29d72d7eaaa060a867c656c13c8c49a225\"}}",
"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\": \"0e5f8e29d72d7eaaa060a867c656c13c8c49a225\", \"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-east1-d-8-7-gais\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44601, \"got_angle_revision\": \"72c58a865b57e4a81334d82b1b7af302b5b579d9\", \"got_dawn_revision\": \"247f511f198f901ce3eb0344f355f53bf9ffe59d\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"0e5f8e29d72d7eaaa060a867c656c13c8c49a225\", \"got_revision_cp\": \"refs/heads/master@{#843551}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"5255c465bbbab020b2fa98f818a705e764865869\", \"got_v8_revision\": \"c80a50a3c4de747d61e044cea6f94223016110d2\", \"got_v8_revision_cp\": \"refs/heads/8.9.273@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"0e5f8e29d72d7eaaa060a867c656c13c8c49a225\", \"swarm_hashes_refs/heads/master(at){#843551}_without_patch\": {\"absl_hardening_tests\": \"9781adecc6ab2942ee7069507629bb7621a257e4\", \"accessibility_unittests\": \"5c391ac02ace23e5d67f3ac87316f67e22570453\", \"angle_unittests\": \"0e9f1b6c655ac116970dd7578a4a0cb648ffb274\", \"app_list_unittests\": \"1ca4f416c270feecbf85f4b6d287973882e01e1d\", \"app_shell_unittests\": \"10cf3e09e43f61357482a48ba4cf9a0f3b153dcc\", \"ash_unittests\": \"f725a3e8543e2f89f61b8e803c3577053903aae8\", \"aura_unittests\": \"bde7893beb904b47692cd33c2a8e5fa4123c04fe\", \"base_unittests\": \"4a99aa733942a21cbfcd31dd9e137942545c9d5d\", \"base_util_unittests\": \"625013b7fef875354f4b5b16c3d23bc85719b73f\", \"blink_common_unittests\": \"2691e605de124474c2772d8f78957d03b03b81e0\", \"blink_fuzzer_unittests\": \"acaa9b98f8f72405de00ac807ac0db8ee972716c\", \"blink_heap_unittests\": \"e3965c8d1aed24f83bed1c964834b1bed3f09b41\", \"blink_platform_unittests\": \"c257907e4601b7147fc0d91fbadf61132b92a6fb\", \"blink_unittests\": \"06c217228146f8c268fda193670c54256391fa3e\", \"boringssl_crypto_tests\": \"46de060c5badc27e54041e0c68d7f88c75d5411f\", \"boringssl_ssl_tests\": \"9b69b3aeb9bb9c0f188b84df821669e5c88b5625\", \"browser_tests\": \"d9cfe59dfda5b210db0bb7d6ab6a83a6beccb6ac\", \"capture_unittests\": \"48bac6f0ea1c2c3e8b039eeae2b6de20869a09af\", \"cast_unittests\": \"2d53faefcc12fcaa373422e7c5d292034c721b91\", \"cc_unittests\": \"29a8ba96b97b978476ad77636a6722b931c7a60f\", \"chrome_app_unittests\": \"0298daefbe48ffb90f33c0a8808a6741fc21c9f0\", \"chromedriver_unittests\": \"6cdcc7ed7481cc0b8ec58cfc2d30aff719859b44\", \"chromeos_components_unittests\": \"81edf9d931e437263bf4e26a13e302ed2fdb9b41\", \"chromeos_unittests\": \"8f26dd60a9d4f80a2af079b6da58fc442be3d5d7\", \"components_browsertests\": \"4bfcf2b603e03f104528e2d7db18fe7cd4b192ef\", \"components_unittests\": \"3553b4be97d48123f7399c39e41cc9feb60bd376\", \"compositor_unittests\": \"ec6f4628d399a3423c3ba9d4f1b3277bd7a4038d\", \"content_browsertests\": \"3bc385c7c703bec88f710a316daf84533c180df5\", \"content_unittests\": \"3605646ea5961745df3bf69e30578703d309b309\", \"crashpad_tests\": \"e66fad34a18de2cda13240b99f63016e792cb2b8\", \"crypto_unittests\": \"c6cc78506568431d76a2ee575c3784d75471d2e4\", \"dbus_unittests\": \"812c415a34081cebe02cdce3c19eb9a6f9e639d7\", \"device_unittests\": \"f3a7db3ca95a2b987e8ab5ba5227ded2710c752c\", \"display_unittests\": \"ad44a3ea0fd8de638a36b097361e72c4218f41af\", \"events_unittests\": \"2fd574f49255b8dd2e98d1e9356caa22fa2d610a\", \"exo_unittests\": \"e96dea588e84c004a7aa3fc8edc85c0e5a5bfc84\", \"extensions_browsertests\": \"3f9496712bec616e34f27d79d684cf14799044b6\", \"extensions_unittests\": \"437a83bd1d0df4c838c3efb06140d480f0633df2\", \"filesystem_service_unittests\": \"6dd1a746ed44867710df343938f4883b99a46e3f\", \"gcm_unit_tests\": \"f9268756df081b0ddc537e13ce7dee8ab1deb54c\", \"gfx_unittests\": \"e8f1ecd5d1fca129712681ef80ae54ac5f54b3f0\", \"gin_unittests\": \"9b618c02146a65f65caa4d9e26dd9a9143f50245\", \"gl_unittests_ozone\": \"b97d8462840f1485aa15e12e1ff0371e8021e70e\", \"google_apis_unittests\": \"8f4aef56fe119ca90c227b639d7a6bf77c39d69f\", \"gpu_unittests\": \"14dcae5fd0bda9298ab8ec3e9d313d090ab685b7\", \"gwp_asan_unittests\": \"c0492c83cf9043470cae8bb690a0ff8d9e1ca0bf\", \"interactive_ui_tests\": \"e5e51cee06896564f1d6725754aeeb02b14e9b94\", \"ipc_tests\": \"e87a4909b52fcda2646a712b87078460520075ff\", \"jingle_unittests\": \"2704f02e126012ec08c964babf28b00b350d7b9a\", \"keyboard_unittests\": \"b4e6d30b1350f6fe840e16349e8a21bdc22f3df9\", \"latency_unittests\": \"1bdecb2a20f3895c24d824b0b23a06f6b9ee86c6\", \"libjingle_xmpp_unittests\": \"cd6b9c67723a008194bf78d00c462e2652590d3a\", \"liburlpattern_unittests\": \"7e49de3cdc4ed022e2195696583ae2719270a531\", \"media_blink_unittests\": \"ecac4d77882045fd5239baabf28c74f2a32758fd\", \"media_unittests\": \"059cbc6814d24d9de09303db35022d27e43e4e1f\", \"message_center_unittests\": \"20addf38cd7c65cbb77f9fa0db8bc5023ad9f8c3\", \"midi_unittests\": \"a04591ce269a63a43ac680c86b2699ce321af046\", \"mojo_core_unittests\": \"b2c508eb7b00c8cece71fc54e7e2d04cdcfdef46\", \"mojo_unittests\": \"b8d2c9403534afbd30a07e9ed6b8f5964e9c37e5\", \"nacl_helper_nonsfi_unittests\": \"e9f29b34bdab5b5d8f3589345f50b8f05f81ef9b\", \"nacl_loader_unittests\": \"77ea7ad92cc622867f634f2d15aadd973260f04e\", \"native_theme_unittests\": \"94f21038d339773e0886cd813fd8451b585653d5\", \"net_unittests\": \"1825f2a7129b786a2a078d243223cfb244b30725\", \"ozone_gl_unittests\": \"384399d9bc0a6239f4f4a7d609b8222c43ed04ec\", \"ozone_unittests\": \"3e7c000fd9f4980fc25b5beaa7546bff9a40ed56\", \"ozone_x11_unittests\": \"4e6227907cf975e475d9c155cf2ef6cf71d3d6a8\", \"pdf_unittests\": \"0a09aeb7b7587475668fcf67d7f48f48652cca3c\", \"perfetto_unittests\": \"cf346d6f230eefce96847927b5f9e300b8eda78b\", \"ppapi_unittests\": \"7c495482fb78f64882db0a192378595b394abe75\", \"printing_unittests\": \"b4d6da9236f01041045a2f6fb1b0ae2836bb73c9\", \"remoting_unittests\": \"cf4d3c82ab505e4502cf228fd2ef414af8bc74cf\", \"sandbox_linux_unittests\": \"877f999c00f4f0280764f1303d05dbd3c95eb8da\", \"service_manager_unittests\": \"93d4c4372a5bd1e59fd59e37bcfa21aa28d55df5\", \"services_unittests\": \"923a5cce73155be935a33bd2556ceb6adff0c4a1\", \"shell_dialogs_unittests\": \"a9bff69a0342d5ebb494e5f5492d57d57baaa8b4\", \"shell_encryption_unittests\": \"52f1ec31c954e45d4b5b02bdabb4fd74fe517084\", \"skia_unittests\": \"689b2f4fe05148a3dfaa23636ba4294bf2ce6e3a\", \"snapshot_unittests\": \"4037b79c4991b6702d50afca82c9ae9ce4687499\", \"sql_unittests\": \"0ef7bf3084f18e7e621e6645322d0394d5d99362\", \"storage_unittests\": \"3e2735ccf014341917afe78ac46e3aba205726f7\", \"sync_integration_tests\": \"ff25a7af52adfab7e42b92ce9783934136a8c0f0\", \"traffic_annotation_auditor_unittests\": \"05ab001fba27c3b0b8d51ae1d01cf30019475726\", \"ui_base_unittests\": \"aa7b07c15f2856113dc150c181bb57569fdde2da\", \"ui_chromeos_unittests\": \"a6d5f185007dbbbcb220dd38f882bc682c9475dd\", \"ui_touch_selection_unittests\": \"d20c0d7518fa8a99863216d197888ee81d79742a\", \"unit_tests\": \"e5b841b42bc5abd2d44d74c61283c311f0125f7c\", \"url_unittests\": \"36679f1a2ca5284ea251a340ee50ec6bde78c81d\", \"usage_time_limit_unittests\": \"9f40f33d0daf25954fdb520b08eeebac7d15e9f2\", \"views_unittests\": \"53b6ac11bf61776ce246515469de3dc9b4a71ff1\", \"viz_unittests\": \"22811ee8dc0ac3b4ebae068dbeb884db4b9f1ac8\", \"wayland_client_perftests\": \"df7253c27b265ef837f079f5ce1f9f87fc86c9eb\", \"wm_unittests\": \"7a8a608a42eaf56321472b811618492f22ade400\", \"wtf_unittests\": \"0781e57f46defaf349dd06b1dca7238f0810305b\", \"zlib_unittests\": \"740e1c1d5a49b6f57be910a3cd8a887b494e7d8e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0fb1f456593ae2600bf9c9616e0e5dcc3c87ffc9d4d6fb93e9350aac8ae4516c_v2\", \"builder_1b9daa149b4790c306d4115e8498bce8e4004f87fdf8195a8bb15f493be69c40_v2\", \"builder_8c23a72064650b4b1d9380637a287eed4ae2e2a2092116afea022d28ee09b5dd_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a038fb555685f584149318062f53e0831a488e02c6d40fe1e156bb7cef46d2c7_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_b21beaca446334e07b00c4982fb2d009cad33fb091bf002422bc83c400c91f3b_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-east1-d-8-7-gais\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610640390625847",
"status": "COMPLETED",
"status_changed_ts": "1610643124627203",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44601",
"builder:linux-chromeos-rel",
"buildset:commit/git/0e5f8e29d72d7eaaa060a867c656c13c8c49a225",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0e5f8e29d72d7eaaa060a867c656c13c8c49a225",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023544923654903904",
"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/8858114861496509424/+/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:511a7777813d5310",
"user_agent:luci-scheduler"
],
"updated_ts": "1610643124644144",
"url": "https://ci.chromium.org/b/8858114861496509424",
"utcnow_ts": "1610643125057880"
}
}
[16:52:05.067] Invocation finished in 45m39.486862084s with status SUCCEEDED