[17:52:46.292] New invocation is queued and will start shortly
[17:52:47.365] Starting the invocation (attempt 1)
[17:52:47.406] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:52:47.406] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:52:47.406] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023538233020020112",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2647d58371d8cd15695daf4673a44a465e81f4f7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9023538233020020112",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/2647d58371d8cd15695daf4673a44a465e81f4f7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2647d58371d8cd15695daf4673a44a465e81f4f7",
"gitiles_ref:refs/heads/master"
]
}
[17:52:49.042] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610646767595287",
"id": "8858108170980858960",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2647d58371d8cd15695daf4673a44a465e81f4f7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610646768720752",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44604",
"builder:linux-chromeos-rel",
"buildset:commit/git/2647d58371d8cd15695daf4673a44a465e81f4f7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2647d58371d8cd15695daf4673a44a465e81f4f7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023538233020020112",
"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/8858108170980858960/+/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": "1610646768720897",
"url": "https://ci.chromium.org/b/8858108170980858960",
"utcnow_ts": "1610646769015152"
}
}
[17:52:49.042] Task URL: https://ci.chromium.org/b/8858108170980858960
[17:52:49.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:2:0) after 1m0s
[17:53:49.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:2:0)
[17:53:49.077] Timer tick, asking Buildbucket for the build status
[17:53:49.262] Build 8858108170980858960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:49.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:3:0) after 1m0s
[17:54:49.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:3:0)
[17:54:49.302] Timer tick, asking Buildbucket for the build status
[17:54:49.679] Build 8858108170980858960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:49.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:4:0) after 1m0s
[17:55:49.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:4:0)
[17:55:49.814] Timer tick, asking Buildbucket for the build status
[17:55:49.899] Build 8858108170980858960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:49.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:5:0) after 1m0s
[17:56:49.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:5:0)
[17:56:49.939] Timer tick, asking Buildbucket for the build status
[17:56:50.156] Build 8858108170980858960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:56:50.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:6:0) after 1m0s
[17:57:08.654] Received PubSub notification, asking Buildbucket for the build status
[17:57:08.718] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:50.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:6:0)
[17:57:50.203] Timer tick, asking Buildbucket for the build status
[17:57:50.318] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:50.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:8:0) after 1m0s
[17:58:50.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:8:0)
[17:58:50.396] Timer tick, asking Buildbucket for the build status
[17:58:50.507] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:50.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:9:0) after 1m0s
[17:59:50.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:9:0)
[17:59:50.568] Timer tick, asking Buildbucket for the build status
[17:59:50.628] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:50.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:10:0) after 1m0s
[18:00:50.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:10:0)
[18:00:50.765] Timer tick, asking Buildbucket for the build status
[18:00:50.965] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:50.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:11:0) after 1m0s
[18:01:51.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:11:0)
[18:01:51.009] Timer tick, asking Buildbucket for the build status
[18:01:51.356] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:51.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:12:0) after 1m0s
[18:02:51.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:12:0)
[18:02:51.389] Timer tick, asking Buildbucket for the build status
[18:02:51.481] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:51.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:13:0) after 1m0s
[18:03:51.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:13:0)
[18:03:51.532] Timer tick, asking Buildbucket for the build status
[18:03:51.698] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:51.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:14:0) after 1m0s
[18:04:51.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:14:0)
[18:04:51.738] Timer tick, asking Buildbucket for the build status
[18:04:51.850] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:51.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:15:0) after 1m0s
[18:05:51.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:15:0)
[18:05:51.852] Timer tick, asking Buildbucket for the build status
[18:05:52.095] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:52.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:16:0) after 1m0s
[18:06:52.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:16:0)
[18:06:52.108] Timer tick, asking Buildbucket for the build status
[18:06:52.760] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:52.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:17:0) after 1m0s
[18:07:52.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:17:0)
[18:07:52.795] Timer tick, asking Buildbucket for the build status
[18:07:52.916] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:52.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:18:0) after 1m0s
[18:08:52.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:18:0)
[18:08:52.960] Timer tick, asking Buildbucket for the build status
[18:08:53.219] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:53.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:19:0) after 1m0s
[18:09:53.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:19:0)
[18:09:53.229] Timer tick, asking Buildbucket for the build status
[18:09:53.535] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:53.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:20:0) after 1m0s
[18:10:53.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:20:0)
[18:10:53.575] Timer tick, asking Buildbucket for the build status
[18:10:53.771] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:53.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:21:0) after 1m0s
[18:11:53.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:21:0)
[18:11:53.819] Timer tick, asking Buildbucket for the build status
[18:11:54.146] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:54.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:22:0) after 1m0s
[18:12:54.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:22:0)
[18:12:54.166] Timer tick, asking Buildbucket for the build status
[18:12:54.293] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:54.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:23:0) after 1m0s
[18:13:54.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:23:0)
[18:13:54.319] Timer tick, asking Buildbucket for the build status
[18:13:54.509] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:54.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:24:0) after 1m0s
[18:14:54.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:24:0)
[18:14:54.547] Timer tick, asking Buildbucket for the build status
[18:14:54.621] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:54.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:25:0) after 1m0s
[18:15:54.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:25:0)
[18:15:54.624] Timer tick, asking Buildbucket for the build status
[18:15:54.718] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:54.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:26:0) after 1m0s
[18:16:54.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:26:0)
[18:16:54.761] Timer tick, asking Buildbucket for the build status
[18:16:54.832] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:54.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:27:0) after 1m0s
[18:17:54.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:27:0)
[18:17:54.837] Timer tick, asking Buildbucket for the build status
[18:17:55.017] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:55.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:28:0) after 1m0s
[18:18:55.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:28:0)
[18:18:55.075] Timer tick, asking Buildbucket for the build status
[18:18:55.135] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:55.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:29:0) after 1m0s
[18:19:55.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:29:0)
[18:19:55.191] Timer tick, asking Buildbucket for the build status
[18:19:55.259] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:55.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:30:0) after 1m0s
[18:20:55.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:30:0)
[18:20:55.353] Timer tick, asking Buildbucket for the build status
[18:20:55.414] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:55.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:31:0) after 1m0s
[18:21:55.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:31:0)
[18:21:55.871] Timer tick, asking Buildbucket for the build status
[18:21:55.944] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:55.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:32:0) after 1m0s
[18:22:55.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:32:0)
[18:22:55.945] Timer tick, asking Buildbucket for the build status
[18:22:56.060] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:56.060] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:33:0) after 1m0s
[18:23:56.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:33:0)
[18:23:56.309] Timer tick, asking Buildbucket for the build status
[18:23:56.376] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:56.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:34:0) after 1m0s
[18:24:56.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:34:0)
[18:24:56.580] Timer tick, asking Buildbucket for the build status
[18:24:56.637] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:56.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:35:0) after 1m0s
[18:25:56.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:35:0)
[18:25:56.864] Timer tick, asking Buildbucket for the build status
[18:25:56.932] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:56.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:36:0) after 1m0s
[18:26:56.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:36:0)
[18:26:56.977] Timer tick, asking Buildbucket for the build status
[18:26:57.059] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:57.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:37:0) after 1m0s
[18:27:57.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:37:0)
[18:27:57.053] Timer tick, asking Buildbucket for the build status
[18:27:57.167] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:57.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:38:0) after 1m0s
[18:28:57.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:38:0)
[18:28:57.197] Timer tick, asking Buildbucket for the build status
[18:28:57.275] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:57.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:39:0) after 1m0s
[18:29:57.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:39:0)
[18:29:57.735] Timer tick, asking Buildbucket for the build status
[18:29:57.812] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:57.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:40:0) after 1m0s
[18:30:57.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:40:0)
[18:30:57.943] Timer tick, asking Buildbucket for the build status
[18:30:58.054] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:58.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:41:0) after 1m0s
[18:31:58.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:41:0)
[18:31:58.285] Timer tick, asking Buildbucket for the build status
[18:31:58.444] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:58.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:42:0) after 1m0s
[18:32:58.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:42:0)
[18:32:58.623] Timer tick, asking Buildbucket for the build status
[18:32:58.741] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:58.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:43:0) after 1m0s
[18:33:59.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:43:0)
[18:33:59.013] Timer tick, asking Buildbucket for the build status
[18:33:59.140] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:59.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:44:0) after 1m0s
[18:34:59.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:44:0)
[18:34:59.299] Timer tick, asking Buildbucket for the build status
[18:34:59.368] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:59.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:45:0) after 1m0s
[18:35:59.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:45:0)
[18:35:59.571] Timer tick, asking Buildbucket for the build status
[18:35:59.668] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:59.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:46:0) after 1m0s
[18:36:59.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:46:0)
[18:36:59.894] Timer tick, asking Buildbucket for the build status
[18:36:59.951] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:59.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:47:0) after 1m0s
[18:38:00.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:47:0)
[18:38:00.054] Timer tick, asking Buildbucket for the build status
[18:38:00.281] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:00.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:48:0) after 1m0s
[18:39:00.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:48:0)
[18:39:00.314] Timer tick, asking Buildbucket for the build status
[18:39:00.428] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:00.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:49:0) after 1m0s
[18:40:00.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:49:0)
[18:40:00.464] Timer tick, asking Buildbucket for the build status
[18:40:00.575] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:00.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:50:0) after 1m0s
[18:41:00.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:50:0)
[18:41:00.857] Timer tick, asking Buildbucket for the build status
[18:41:00.938] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:00.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:51:0) after 1m0s
[18:42:01.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:51:0)
[18:42:01.613] Timer tick, asking Buildbucket for the build status
[18:42:01.793] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:01.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:52:0) after 1m0s
[18:43:01.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:52:0)
[18:43:01.864] Timer tick, asking Buildbucket for the build status
[18:43:02.243] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:02.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:53:0) after 1m0s
[18:44:02.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:53:0)
[18:44:02.266] Timer tick, asking Buildbucket for the build status
[18:44:02.531] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:02.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:54:0) after 1m0s
[18:45:02.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:54:0)
[18:45:02.721] Timer tick, asking Buildbucket for the build status
[18:45:02.954] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:02.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:55:0) after 1m0s
[18:46:02.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:55:0)
[18:46:02.954] Timer tick, asking Buildbucket for the build status
[18:46:03.044] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:03.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:56:0) after 1m0s
[18:47:03.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:56:0)
[18:47:03.071] Timer tick, asking Buildbucket for the build status
[18:47:03.145] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:03.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:57:0) after 1m0s
[18:48:03.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:57:0)
[18:48:03.167] Timer tick, asking Buildbucket for the build status
[18:48:03.594] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:03.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:58:0) after 1m0s
[18:49:03.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:58:0)
[18:49:03.622] Timer tick, asking Buildbucket for the build status
[18:49:03.810] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:03.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:59:0) after 1m0s
[18:50:03.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:59:0)
[18:50:03.872] Timer tick, asking Buildbucket for the build status
[18:50:04.133] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:04.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:60:0) after 1m0s
[18:51:04.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:60:0)
[18:51:04.158] Timer tick, asking Buildbucket for the build status
[18:51:04.282] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:04.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:61:0) after 1m0s
[18:52:04.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:61:0)
[18:52:04.301] Timer tick, asking Buildbucket for the build status
[18:52:04.545] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:04.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:62:0) after 1m0s
[18:53:04.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:62:0)
[18:53:04.598] Timer tick, asking Buildbucket for the build status
[18:53:04.721] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:04.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:63:0) after 1m0s
[18:54:04.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:63:0)
[18:54:04.763] Timer tick, asking Buildbucket for the build status
[18:54:05.234] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:05.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:64:0) after 1m0s
[18:55:05.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:64:0)
[18:55:05.363] Timer tick, asking Buildbucket for the build status
[18:55:05.430] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:05.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:65:0) after 1m0s
[18:56:05.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:65:0)
[18:56:05.475] Timer tick, asking Buildbucket for the build status
[18:56:05.535] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:05.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:66:0) after 1m0s
[18:57:05.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:66:0)
[18:57:05.661] Timer tick, asking Buildbucket for the build status
[18:57:07.303] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:07.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:67:0) after 1m0s
[18:58:07.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:67:0)
[18:58:07.448] Timer tick, asking Buildbucket for the build status
[18:58:07.614] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:07.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:68:0) after 1m0s
[18:59:07.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:68:0)
[18:59:07.760] Timer tick, asking Buildbucket for the build status
[18:59:07.911] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:07.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:69:0) after 1m0s
[19:00:08.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:69:0)
[19:00:08.038] Timer tick, asking Buildbucket for the build status
[19:00:08.116] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:08.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:70:0) after 1m0s
[19:01:08.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:70:0)
[19:01:08.339] Timer tick, asking Buildbucket for the build status
[19:01:08.433] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:08.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:71:0) after 1m0s
[19:02:08.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:71:0)
[19:02:08.512] Timer tick, asking Buildbucket for the build status
[19:02:08.598] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:08.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:72:0) after 1m0s
[19:03:08.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:72:0)
[19:03:08.636] Timer tick, asking Buildbucket for the build status
[19:03:09.122] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:09.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:73:0) after 1m0s
[19:04:09.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:73:0)
[19:04:09.138] Timer tick, asking Buildbucket for the build status
[19:04:09.205] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:09.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:74:0) after 1m0s
[19:05:09.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:74:0)
[19:05:09.223] Timer tick, asking Buildbucket for the build status
[19:05:09.388] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:09.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:75:0) after 1m0s
[19:06:09.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:75:0)
[19:06:09.444] Timer tick, asking Buildbucket for the build status
[19:06:10.403] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:10.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:76:0) after 1m0s
[19:07:10.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:76:0)
[19:07:10.501] Timer tick, asking Buildbucket for the build status
[19:07:10.711] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:10.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:77:0) after 1m0s
[19:08:10.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:77:0)
[19:08:10.823] Timer tick, asking Buildbucket for the build status
[19:08:10.968] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:10.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:78:0) after 1m0s
[19:09:11.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:78:0)
[19:09:11.111] Timer tick, asking Buildbucket for the build status
[19:09:11.191] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:11.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:79:0) after 1m0s
[19:10:11.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:79:0)
[19:10:11.276] Timer tick, asking Buildbucket for the build status
[19:10:11.756] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:11.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:80:0) after 1m0s
[19:11:11.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:80:0)
[19:11:11.769] Timer tick, asking Buildbucket for the build status
[19:11:11.825] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:11.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:81:0) after 1m0s
[19:12:11.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:81:0)
[19:12:11.873] Timer tick, asking Buildbucket for the build status
[19:12:11.948] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:11.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:82:0) after 1m0s
[19:13:12.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:82:0)
[19:13:12.069] Timer tick, asking Buildbucket for the build status
[19:13:12.551] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:12.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:83:0) after 1m0s
[19:14:12.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:83:0)
[19:14:12.641] Timer tick, asking Buildbucket for the build status
[19:14:12.737] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:12.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:84:0) after 1m0s
[19:15:12.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:84:0)
[19:15:12.829] Timer tick, asking Buildbucket for the build status
[19:15:12.902] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:12.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:85:0) after 1m0s
[19:16:13.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:85:0)
[19:16:13.023] Timer tick, asking Buildbucket for the build status
[19:16:13.170] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:13.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:86:0) after 1m0s
[19:17:13.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:86:0)
[19:17:13.259] Timer tick, asking Buildbucket for the build status
[19:17:13.409] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:13.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:87:0) after 1m0s
[19:18:13.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:87:0)
[19:18:13.449] Timer tick, asking Buildbucket for the build status
[19:18:13.554] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:13.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:88:0) after 1m0s
[19:19:13.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:88:0)
[19:19:13.691] Timer tick, asking Buildbucket for the build status
[19:19:13.805] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:13.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:89:0) after 1m0s
[19:20:13.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:89:0)
[19:20:13.947] Timer tick, asking Buildbucket for the build status
[19:20:14.130] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:14.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:90:0) after 1m0s
[19:21:14.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:90:0)
[19:21:14.191] Timer tick, asking Buildbucket for the build status
[19:21:14.342] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:14.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:91:0) after 1m0s
[19:22:14.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:91:0)
[19:22:14.393] Timer tick, asking Buildbucket for the build status
[19:22:15.307] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:15.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:92:0) after 1m0s
[19:23:15.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:92:0)
[19:23:15.382] Timer tick, asking Buildbucket for the build status
[19:23:16.050] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:16.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:93:0) after 1m0s
[19:24:16.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:93:0)
[19:24:16.040] Timer tick, asking Buildbucket for the build status
[19:24:16.269] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:16.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:94:0) after 1m0s
[19:25:16.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:94:0)
[19:25:16.342] Timer tick, asking Buildbucket for the build status
[19:25:16.698] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:16.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:95:0) after 1m0s
[19:26:16.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:95:0)
[19:26:16.735] Timer tick, asking Buildbucket for the build status
[19:26:16.893] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:16.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:96:0) after 1m0s
[19:27:16.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:96:0)
[19:27:16.961] Timer tick, asking Buildbucket for the build status
[19:27:17.422] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:17.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:97:0) after 1m0s
[19:28:17.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:97:0)
[19:28:17.446] Timer tick, asking Buildbucket for the build status
[19:28:17.845] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:17.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:98:0) after 1m0s
[19:29:17.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:98:0)
[19:29:17.864] Timer tick, asking Buildbucket for the build status
[19:29:18.333] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:18.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:99:0) after 1m0s
[19:30:18.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:99:0)
[19:30:18.461] Timer tick, asking Buildbucket for the build status
[19:30:18.678] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:18.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:100:0) after 1m0s
[19:31:18.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:100:0)
[19:31:18.716] Timer tick, asking Buildbucket for the build status
[19:31:19.142] Build 8858108170980858960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:19.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9023538233020020112:101:0) after 1m0s
[19:31:44.304] Received PubSub notification, asking Buildbucket for the build status
[19:31:44.364] Build 8858108170980858960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:31:44.364] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610652703603065",
"created_by": "project:chromium",
"created_ts": "1610646767595287",
"id": "8858108170980858960",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2647d58371d8cd15695daf4673a44a465e81f4f7\"}}",
"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\": \"2647d58371d8cd15695daf4673a44a465e81f4f7\", \"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-10-8gq6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44604, \"got_angle_revision\": \"72c58a865b57e4a81334d82b1b7af302b5b579d9\", \"got_dawn_revision\": \"247f511f198f901ce3eb0344f355f53bf9ffe59d\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"2647d58371d8cd15695daf4673a44a465e81f4f7\", \"got_revision_cp\": \"refs/heads/master@{#843608}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"5255c465bbbab020b2fa98f818a705e764865869\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#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\": \"2647d58371d8cd15695daf4673a44a465e81f4f7\", \"swarm_hashes_refs/heads/master(at){#843608}_without_patch\": {\"absl_hardening_tests\": \"9781adecc6ab2942ee7069507629bb7621a257e4\", \"accessibility_unittests\": \"5c391ac02ace23e5d67f3ac87316f67e22570453\", \"angle_unittests\": \"0e9f1b6c655ac116970dd7578a4a0cb648ffb274\", \"app_list_unittests\": \"6e602d617308dffa175e5cdb8fda76b7ea146223\", \"app_shell_unittests\": \"d035394e9889ae57a6225372337d453ac493378b\", \"ash_unittests\": \"25ebf2d54f1b5321c177e255823c69cbd3a1cf8f\", \"aura_unittests\": \"c57577c6c8102882b5c96cb8f3c99497739f0e3e\", \"base_unittests\": \"033ba7eb7b62f5d64956e57667dd783e2fcf17bb\", \"base_util_unittests\": \"625013b7fef875354f4b5b16c3d23bc85719b73f\", \"blink_common_unittests\": \"455b0ea42c672ce8efd52676102dc9ec4428dd53\", \"blink_fuzzer_unittests\": \"fd373e441e502583f434785ab5211dcb7ff97af3\", \"blink_heap_unittests\": \"c9c0599f82b35e4575d255122930fb3d3c339464\", \"blink_platform_unittests\": \"c0bfa6ebf63b04895262a3631b397c05067d35fd\", \"blink_unittests\": \"91b238465395c9f86cd44f41fa0ce16144a16c5a\", \"boringssl_crypto_tests\": \"46de060c5badc27e54041e0c68d7f88c75d5411f\", \"boringssl_ssl_tests\": \"9b69b3aeb9bb9c0f188b84df821669e5c88b5625\", \"browser_tests\": \"d63ba4d60ddf1c250c1c26ea9e5944862bebe5c7\", \"capture_unittests\": \"48bac6f0ea1c2c3e8b039eeae2b6de20869a09af\", \"cast_unittests\": \"2d53faefcc12fcaa373422e7c5d292034c721b91\", \"cc_unittests\": \"29a8ba96b97b978476ad77636a6722b931c7a60f\", \"chrome_app_unittests\": \"1c06cc1a363062824077a0deec708fe6a9a85783\", \"chromedriver_unittests\": \"a56495606fadef6f11afef4ddf8dfdd0060c6f7f\", \"chromeos_components_unittests\": \"df35ef1eabe4e3a07cc34df849e97fd23a859173\", \"chromeos_unittests\": \"4486fcc04179dbf6de81572b226620872c07e02b\", \"components_browsertests\": \"0cbd177191dabfedd24179c4f9e2cbb74d0af9e7\", \"components_unittests\": \"b902ff62f044338e17c5d94e41f2d50be7876d83\", \"compositor_unittests\": \"c4fe34ab2d31d8cf6fdc4b20398c4fee9d35f981\", \"content_browsertests\": \"d36fdffb483c678302849337225c67a84e985daa\", \"content_unittests\": \"5233e3ce0309b97f32cace98a16a4719a62d2e1b\", \"crashpad_tests\": \"e66fad34a18de2cda13240b99f63016e792cb2b8\", \"crypto_unittests\": \"c6cc78506568431d76a2ee575c3784d75471d2e4\", \"dbus_unittests\": \"812c415a34081cebe02cdce3c19eb9a6f9e639d7\", \"device_unittests\": \"f3a7db3ca95a2b987e8ab5ba5227ded2710c752c\", \"display_unittests\": \"ad44a3ea0fd8de638a36b097361e72c4218f41af\", \"events_unittests\": \"2fd574f49255b8dd2e98d1e9356caa22fa2d610a\", \"exo_unittests\": \"5fce19291beaeee29e7d3fedffc624ff0b764abf\", \"extensions_browsertests\": \"ecddfda7293f7e9ca2b177c5b5daf82e5ce80878\", \"extensions_unittests\": \"4433bc09f7685d4ed73384518268f0e0d773cbce\", \"filesystem_service_unittests\": \"6dd1a746ed44867710df343938f4883b99a46e3f\", \"gcm_unit_tests\": \"f9268756df081b0ddc537e13ce7dee8ab1deb54c\", \"gfx_unittests\": \"e8f1ecd5d1fca129712681ef80ae54ac5f54b3f0\", \"gin_unittests\": \"35ea23d2e08483d6d2b38d144f8cfe2063d9f59a\", \"gl_unittests_ozone\": \"b97d8462840f1485aa15e12e1ff0371e8021e70e\", \"google_apis_unittests\": \"8f4aef56fe119ca90c227b639d7a6bf77c39d69f\", \"gpu_unittests\": \"14dcae5fd0bda9298ab8ec3e9d313d090ab685b7\", \"gwp_asan_unittests\": \"c0492c83cf9043470cae8bb690a0ff8d9e1ca0bf\", \"interactive_ui_tests\": \"38f6a57739804d410d56069b56f439f12cbcf465\", \"ipc_tests\": \"e87a4909b52fcda2646a712b87078460520075ff\", \"jingle_unittests\": \"2704f02e126012ec08c964babf28b00b350d7b9a\", \"keyboard_unittests\": \"a8e068a05c91f2fb3bf322130618ebd54eb9135f\", \"latency_unittests\": \"1bdecb2a20f3895c24d824b0b23a06f6b9ee86c6\", \"libjingle_xmpp_unittests\": \"cd6b9c67723a008194bf78d00c462e2652590d3a\", \"liburlpattern_unittests\": \"7e49de3cdc4ed022e2195696583ae2719270a531\", \"media_blink_unittests\": \"eadfe70ce707f9be6f65c8919da4dfe16bdce327\", \"media_unittests\": \"059cbc6814d24d9de09303db35022d27e43e4e1f\", \"message_center_unittests\": \"ce5157b21f42c94d506a335f1cc67a448e9a74da\", \"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\": \"558c32c35b46e5c898c3c94c9dac2877db4554e0\", \"perfetto_unittests\": \"cf346d6f230eefce96847927b5f9e300b8eda78b\", \"ppapi_unittests\": \"037f5145a64ca4f82513a040c11422087a59fe18\", \"printing_unittests\": \"b4d6da9236f01041045a2f6fb1b0ae2836bb73c9\", \"remoting_unittests\": \"cf4d3c82ab505e4502cf228fd2ef414af8bc74cf\", \"sandbox_linux_unittests\": \"877f999c00f4f0280764f1303d05dbd3c95eb8da\", \"service_manager_unittests\": \"93d4c4372a5bd1e59fd59e37bcfa21aa28d55df5\", \"services_unittests\": \"c36908cfeb91b896ab7e589507789a8ddacde216\", \"shell_dialogs_unittests\": \"a9bff69a0342d5ebb494e5f5492d57d57baaa8b4\", \"shell_encryption_unittests\": \"52f1ec31c954e45d4b5b02bdabb4fd74fe517084\", \"skia_unittests\": \"689b2f4fe05148a3dfaa23636ba4294bf2ce6e3a\", \"snapshot_unittests\": \"ffc91b13608ed3b0249ce1f3fad318c06eb5dd0a\", \"sql_unittests\": \"0ef7bf3084f18e7e621e6645322d0394d5d99362\", \"storage_unittests\": \"3e2735ccf014341917afe78ac46e3aba205726f7\", \"sync_integration_tests\": \"72f96cd8770aba980060dc8510adb1eecf5a1b72\", \"traffic_annotation_auditor_unittests\": \"05ab001fba27c3b0b8d51ae1d01cf30019475726\", \"ui_base_unittests\": \"aa7b07c15f2856113dc150c181bb57569fdde2da\", \"ui_chromeos_unittests\": \"a6d5f185007dbbbcb220dd38f882bc682c9475dd\", \"ui_touch_selection_unittests\": \"d20c0d7518fa8a99863216d197888ee81d79742a\", \"unit_tests\": \"fc487efaf394ba1cebc60f85fabe3c15b02b6552\", \"url_unittests\": \"36679f1a2ca5284ea251a340ee50ec6bde78c81d\", \"usage_time_limit_unittests\": \"9f40f33d0daf25954fdb520b08eeebac7d15e9f2\", \"views_unittests\": \"22f8baf27117b9e6a3c8ccf2d07d68858ebb3bcc\", \"viz_unittests\": \"22811ee8dc0ac3b4ebae068dbeb884db4b9f1ac8\", \"wayland_client_perftests\": \"928cabcf63f8afa1ec2ae640834f47c28eecec89\", \"wm_unittests\": \"04ee299473dd208a1af607fbd0170f3092663c7c\", \"wtf_unittests\": \"0781e57f46defaf349dd06b1dca7238f0810305b\", \"zlib_unittests\": \"740e1c1d5a49b6f57be910a3cd8a887b494e7d8e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_fe5305c96c631c9bcc74a68d877d31a94a8d3c28663b28d2fadfc8f798de4ec0_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-10-8gq6\"], \"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\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610647027989406",
"status": "COMPLETED",
"status_changed_ts": "1610652703910321",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44604",
"builder:linux-chromeos-rel",
"buildset:commit/git/2647d58371d8cd15695daf4673a44a465e81f4f7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2647d58371d8cd15695daf4673a44a465e81f4f7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023538233020020112",
"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/8858108170980858960/+/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:511ad8d5d9fb7a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610652703914998",
"url": "https://ci.chromium.org/b/8858108170980858960",
"utcnow_ts": "1610652704353770"
}
}
[19:31:44.364] Invocation finished in 1h38m58.098093881s with status SUCCEEDED