[06:54:10.420] New invocation is queued and will start shortly
[06:54:11.535] Starting the invocation (attempt 1)
[06:54:11.572] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:54:11.572] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:54:11.572] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028471904592092800",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"56bd680ca1b1800612e55b91e7389ef9b25483c3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9028471904592092800",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/56bd680ca1b1800612e55b91e7389ef9b25483c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56bd680ca1b1800612e55b91e7389ef9b25483c3",
"gitiles_ref:refs/heads/master"
]
}
[06:54:12.201] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1605941651676030",
"id": "8863041842610819056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56bd680ca1b1800612e55b91e7389ef9b25483c3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605941652057129",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43042",
"builder:linux-chromeos-rel",
"buildset:commit/git/56bd680ca1b1800612e55b91e7389ef9b25483c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56bd680ca1b1800612e55b91e7389ef9b25483c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028471904592092800",
"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/8863041842610819056/+/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": "1605941652057337",
"url": "https://ci.chromium.org/b/8863041842610819056",
"utcnow_ts": "1605941652188614"
}
}
[06:54:12.201] Task URL: https://ci.chromium.org/b/8863041842610819056
[06:54:12.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:2:0) after 1m0s
[06:55:12.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:2:0)
[06:55:12.471] Timer tick, asking Buildbucket for the build status
[06:55:13.102] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:55:13.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:3:0) after 1m0s
[06:56:13.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:3:0)
[06:56:13.188] Timer tick, asking Buildbucket for the build status
[06:56:13.270] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:56:13.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:4:0) after 1m0s
[06:57:13.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:4:0)
[06:57:13.305] Timer tick, asking Buildbucket for the build status
[06:57:13.382] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:57:13.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:5:0) after 1m0s
[06:58:13.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:5:0)
[06:58:13.547] Timer tick, asking Buildbucket for the build status
[06:58:13.758] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:58:13.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:6:0) after 1m0s
[06:59:13.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:6:0)
[06:59:13.846] Timer tick, asking Buildbucket for the build status
[06:59:13.948] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:59:13.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:7:0) after 1m0s
[07:00:13.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:7:0)
[07:00:13.928] Timer tick, asking Buildbucket for the build status
[07:00:14.057] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:00:14.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:8:0) after 1m0s
[07:01:14.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:8:0)
[07:01:14.169] Timer tick, asking Buildbucket for the build status
[07:01:14.255] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:01:14.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:9:0) after 1m0s
[07:02:14.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:9:0)
[07:02:14.332] Timer tick, asking Buildbucket for the build status
[07:02:14.574] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:14.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:10:0) after 1m0s
[07:03:14.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:10:0)
[07:03:14.610] Timer tick, asking Buildbucket for the build status
[07:03:14.731] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:03:14.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:11:0) after 1m0s
[07:04:14.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:11:0)
[07:04:14.732] Timer tick, asking Buildbucket for the build status
[07:04:14.960] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:14.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:12:0) after 1m0s
[07:05:14.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:12:0)
[07:05:14.953] Timer tick, asking Buildbucket for the build status
[07:05:15.019] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:15.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:13:0) after 1m0s
[07:06:15.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:13:0)
[07:06:15.044] Timer tick, asking Buildbucket for the build status
[07:06:15.145] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:06:15.146] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:14:0) after 1m0s
[07:07:15.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:14:0)
[07:07:15.194] Timer tick, asking Buildbucket for the build status
[07:07:15.257] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:07:15.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:15:0) after 1m0s
[07:08:15.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:15:0)
[07:08:15.305] Timer tick, asking Buildbucket for the build status
[07:08:15.778] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:08:15.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:16:0) after 1m0s
[07:09:15.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:16:0)
[07:09:15.827] Timer tick, asking Buildbucket for the build status
[07:09:15.926] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:09:15.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:17:0) after 1m0s
[07:10:15.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:17:0)
[07:10:15.973] Timer tick, asking Buildbucket for the build status
[07:10:16.053] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:10:16.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:18:0) after 1m0s
[07:11:16.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:18:0)
[07:11:16.076] Timer tick, asking Buildbucket for the build status
[07:11:16.156] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:11:16.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:19:0) after 1m0s
[07:12:16.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:19:0)
[07:12:16.205] Timer tick, asking Buildbucket for the build status
[07:12:16.402] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:12:16.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:20:0) after 1m0s
[07:13:16.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:20:0)
[07:13:16.449] Timer tick, asking Buildbucket for the build status
[07:13:16.518] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:13:16.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:21:0) after 1m0s
[07:14:16.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:21:0)
[07:14:16.545] Timer tick, asking Buildbucket for the build status
[07:14:16.725] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:14:16.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:22:0) after 1m0s
[07:15:16.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:22:0)
[07:15:16.744] Timer tick, asking Buildbucket for the build status
[07:15:16.824] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:16.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:23:0) after 1m0s
[07:16:16.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:23:0)
[07:16:16.878] Timer tick, asking Buildbucket for the build status
[07:16:16.956] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:16:16.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:24:0) after 1m0s
[07:17:17.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:24:0)
[07:17:17.056] Timer tick, asking Buildbucket for the build status
[07:17:17.366] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:17.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:25:0) after 1m0s
[07:18:17.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:25:0)
[07:18:17.401] Timer tick, asking Buildbucket for the build status
[07:18:17.546] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:17.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:26:0) after 1m0s
[07:19:17.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:26:0)
[07:19:17.531] Timer tick, asking Buildbucket for the build status
[07:19:17.633] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:19:17.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:27:0) after 1m0s
[07:20:17.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:27:0)
[07:20:17.655] Timer tick, asking Buildbucket for the build status
[07:20:17.928] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:20:17.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:28:0) after 1m0s
[07:21:18.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:28:0)
[07:21:18.026] Timer tick, asking Buildbucket for the build status
[07:21:18.116] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:21:18.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:29:0) after 1m0s
[07:22:18.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:29:0)
[07:22:18.144] Timer tick, asking Buildbucket for the build status
[07:22:18.208] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:22:18.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:30:0) after 1m0s
[07:23:18.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:30:0)
[07:23:18.215] Timer tick, asking Buildbucket for the build status
[07:23:18.293] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:23:18.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:31:0) after 1m0s
[07:24:18.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:31:0)
[07:24:18.637] Timer tick, asking Buildbucket for the build status
[07:24:18.766] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:24:18.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:32:0) after 1m0s
[07:25:19.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:32:0)
[07:25:19.092] Timer tick, asking Buildbucket for the build status
[07:25:19.159] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:25:19.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:33:0) after 1m0s
[07:26:19.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:33:0)
[07:26:19.422] Timer tick, asking Buildbucket for the build status
[07:26:19.488] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:26:19.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:34:0) after 1m0s
[07:27:19.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:34:0)
[07:27:19.788] Timer tick, asking Buildbucket for the build status
[07:27:19.862] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:27:19.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:35:0) after 1m0s
[07:28:20.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:35:0)
[07:28:20.206] Timer tick, asking Buildbucket for the build status
[07:28:20.281] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:28:20.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:36:0) after 1m0s
[07:29:20.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:36:0)
[07:29:20.506] Timer tick, asking Buildbucket for the build status
[07:29:20.611] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:29:20.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:37:0) after 1m0s
[07:30:20.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:37:0)
[07:30:20.745] Timer tick, asking Buildbucket for the build status
[07:30:20.953] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:30:20.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:38:0) after 1m0s
[07:31:21.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:38:0)
[07:31:21.177] Timer tick, asking Buildbucket for the build status
[07:31:21.250] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:31:21.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:39:0) after 1m0s
[07:32:21.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:39:0)
[07:32:21.383] Timer tick, asking Buildbucket for the build status
[07:32:21.469] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:32:21.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:40:0) after 1m0s
[07:33:21.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:40:0)
[07:33:21.549] Timer tick, asking Buildbucket for the build status
[07:33:21.631] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:33:21.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:41:0) after 1m0s
[07:34:21.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:41:0)
[07:34:21.762] Timer tick, asking Buildbucket for the build status
[07:34:21.859] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:34:21.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:42:0) after 1m0s
[07:35:21.908] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:42:0)
[07:35:21.908] Timer tick, asking Buildbucket for the build status
[07:35:22.042] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:35:22.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:43:0) after 1m0s
[07:36:22.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:43:0)
[07:36:22.139] Timer tick, asking Buildbucket for the build status
[07:36:22.301] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:36:22.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:44:0) after 1m0s
[07:37:22.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:44:0)
[07:37:22.441] Timer tick, asking Buildbucket for the build status
[07:37:22.502] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:37:22.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:45:0) after 1m0s
[07:38:22.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:45:0)
[07:38:22.684] Timer tick, asking Buildbucket for the build status
[07:38:22.760] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:38:22.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:46:0) after 1m0s
[07:39:22.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:46:0)
[07:39:22.774] Timer tick, asking Buildbucket for the build status
[07:39:23.061] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:39:23.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:47:0) after 1m0s
[07:40:23.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:47:0)
[07:40:23.101] Timer tick, asking Buildbucket for the build status
[07:40:23.180] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:40:23.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:48:0) after 1m0s
[07:41:23.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:48:0)
[07:41:23.249] Timer tick, asking Buildbucket for the build status
[07:41:23.312] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:41:23.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:49:0) after 1m0s
[07:42:23.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:49:0)
[07:42:23.364] Timer tick, asking Buildbucket for the build status
[07:42:23.565] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:42:23.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:50:0) after 1m0s
[07:43:23.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:50:0)
[07:43:23.567] Timer tick, asking Buildbucket for the build status
[07:43:23.885] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:43:23.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:51:0) after 1m0s
[07:44:23.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:51:0)
[07:44:23.889] Timer tick, asking Buildbucket for the build status
[07:44:24.083] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:44:24.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:52:0) after 1m0s
[07:45:24.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:52:0)
[07:45:24.144] Timer tick, asking Buildbucket for the build status
[07:45:24.276] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:45:24.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:53:0) after 1m0s
[07:46:24.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:53:0)
[07:46:24.405] Timer tick, asking Buildbucket for the build status
[07:46:24.485] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:46:24.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:54:0) after 1m0s
[07:47:24.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:54:0)
[07:47:24.533] Timer tick, asking Buildbucket for the build status
[07:47:24.601] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:47:24.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:55:0) after 1m0s
[07:48:24.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:55:0)
[07:48:24.777] Timer tick, asking Buildbucket for the build status
[07:48:24.929] Build 8863041842610819056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:48:24.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:56:0) after 1m0s
[07:48:49.172] Received PubSub notification, asking Buildbucket for the build status
[07:48:49.301] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:24.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:56:0)
[07:49:24.969] Timer tick, asking Buildbucket for the build status
[07:49:25.103] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:25.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:58:0) after 1m0s
[07:50:25.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:58:0)
[07:50:25.124] Timer tick, asking Buildbucket for the build status
[07:50:25.205] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:25.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:59:0) after 1m0s
[07:51:25.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:59:0)
[07:51:25.250] Timer tick, asking Buildbucket for the build status
[07:51:25.314] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:25.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:60:0) after 1m0s
[07:52:25.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:60:0)
[07:52:25.347] Timer tick, asking Buildbucket for the build status
[07:52:25.448] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:25.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:61:0) after 1m0s
[07:53:25.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:61:0)
[07:53:25.461] Timer tick, asking Buildbucket for the build status
[07:53:25.545] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:25.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:62:0) after 1m0s
[07:54:25.538] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:62:0)
[07:54:25.538] Timer tick, asking Buildbucket for the build status
[07:54:25.638] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:25.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:63:0) after 1m0s
[07:55:25.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:63:0)
[07:55:25.645] Timer tick, asking Buildbucket for the build status
[07:55:25.720] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:25.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:64:0) after 1m0s
[07:56:25.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:64:0)
[07:56:25.741] Timer tick, asking Buildbucket for the build status
[07:56:25.790] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:25.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:65:0) after 1m0s
[07:57:25.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:65:0)
[07:57:25.854] Timer tick, asking Buildbucket for the build status
[07:57:26.042] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:26.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:66:0) after 1m0s
[07:58:26.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:66:0)
[07:58:26.115] Timer tick, asking Buildbucket for the build status
[07:58:26.169] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:26.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:67:0) after 1m0s
[07:59:26.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:67:0)
[07:59:26.189] Timer tick, asking Buildbucket for the build status
[07:59:26.309] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:26.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:68:0) after 1m0s
[08:00:26.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:68:0)
[08:00:26.384] Timer tick, asking Buildbucket for the build status
[08:00:26.998] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:26.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:69:0) after 1m0s
[08:01:27.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:69:0)
[08:01:27.015] Timer tick, asking Buildbucket for the build status
[08:01:27.106] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:27.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:70:0) after 1m0s
[08:02:27.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:70:0)
[08:02:27.188] Timer tick, asking Buildbucket for the build status
[08:02:27.261] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:27.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:71:0) after 1m0s
[08:03:27.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:71:0)
[08:03:27.355] Timer tick, asking Buildbucket for the build status
[08:03:27.448] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:27.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:72:0) after 1m0s
[08:04:27.844] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:72:0)
[08:04:27.844] Timer tick, asking Buildbucket for the build status
[08:04:27.971] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:27.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:73:0) after 1m0s
[08:05:28.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:73:0)
[08:05:28.255] Timer tick, asking Buildbucket for the build status
[08:05:28.391] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:28.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:74:0) after 1m0s
[08:06:28.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:74:0)
[08:06:28.443] Timer tick, asking Buildbucket for the build status
[08:06:28.557] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:28.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:75:0) after 1m0s
[08:07:28.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:75:0)
[08:07:28.741] Timer tick, asking Buildbucket for the build status
[08:07:29.396] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:29.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:76:0) after 1m0s
[08:08:29.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:76:0)
[08:08:29.611] Timer tick, asking Buildbucket for the build status
[08:08:29.757] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:29.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:77:0) after 1m0s
[08:09:29.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:77:0)
[08:09:29.863] Timer tick, asking Buildbucket for the build status
[08:09:29.975] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:29.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:78:0) after 1m0s
[08:10:30.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:78:0)
[08:10:30.102] Timer tick, asking Buildbucket for the build status
[08:10:30.172] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:30.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:79:0) after 1m0s
[08:11:30.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:79:0)
[08:11:30.374] Timer tick, asking Buildbucket for the build status
[08:11:30.433] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:30.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:80:0) after 1m0s
[08:12:30.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:80:0)
[08:12:30.597] Timer tick, asking Buildbucket for the build status
[08:12:30.801] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:30.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:81:0) after 1m0s
[08:13:30.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:81:0)
[08:13:30.815] Timer tick, asking Buildbucket for the build status
[08:13:30.881] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:30.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:82:0) after 1m0s
[08:14:30.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:82:0)
[08:14:30.987] Timer tick, asking Buildbucket for the build status
[08:14:31.252] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:31.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:83:0) after 1m0s
[08:15:31.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:83:0)
[08:15:31.279] Timer tick, asking Buildbucket for the build status
[08:15:31.364] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:31.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:84:0) after 1m0s
[08:16:31.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:84:0)
[08:16:31.516] Timer tick, asking Buildbucket for the build status
[08:16:31.577] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:31.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:85:0) after 1m0s
[08:17:31.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:85:0)
[08:17:31.633] Timer tick, asking Buildbucket for the build status
[08:17:31.703] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:31.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:86:0) after 1m0s
[08:18:31.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:86:0)
[08:18:31.771] Timer tick, asking Buildbucket for the build status
[08:18:31.932] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:31.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:87:0) after 1m0s
[08:19:31.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:87:0)
[08:19:31.972] Timer tick, asking Buildbucket for the build status
[08:19:32.092] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:32.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:88:0) after 1m0s
[08:20:32.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:88:0)
[08:20:32.134] Timer tick, asking Buildbucket for the build status
[08:20:32.205] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:32.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:89:0) after 1m0s
[08:21:32.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:89:0)
[08:21:32.229] Timer tick, asking Buildbucket for the build status
[08:21:32.298] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:32.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:90:0) after 1m0s
[08:22:32.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:90:0)
[08:22:32.362] Timer tick, asking Buildbucket for the build status
[08:22:32.508] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:32.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:91:0) after 1m0s
[08:23:32.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:91:0)
[08:23:32.658] Timer tick, asking Buildbucket for the build status
[08:23:32.781] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:32.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:92:0) after 1m0s
[08:24:32.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:92:0)
[08:24:32.945] Timer tick, asking Buildbucket for the build status
[08:24:33.062] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:33.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:93:0) after 1m0s
[08:25:33.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:93:0)
[08:25:33.155] Timer tick, asking Buildbucket for the build status
[08:25:33.234] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:33.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:94:0) after 1m0s
[08:26:33.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:94:0)
[08:26:33.329] Timer tick, asking Buildbucket for the build status
[08:26:33.383] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:33.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:95:0) after 1m0s
[08:27:33.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:95:0)
[08:27:33.443] Timer tick, asking Buildbucket for the build status
[08:27:33.511] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:33.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:96:0) after 1m0s
[08:28:33.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:96:0)
[08:28:33.550] Timer tick, asking Buildbucket for the build status
[08:28:33.619] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:33.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:97:0) after 1m0s
[08:29:33.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:97:0)
[08:29:33.642] Timer tick, asking Buildbucket for the build status
[08:29:33.745] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:33.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:98:0) after 1m0s
[08:30:33.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:98:0)
[08:30:33.922] Timer tick, asking Buildbucket for the build status
[08:30:34.356] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:34.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:99:0) after 1m0s
[08:31:34.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:99:0)
[08:31:34.593] Timer tick, asking Buildbucket for the build status
[08:31:35.034] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:35.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:100:0) after 1m0s
[08:32:35.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:100:0)
[08:32:35.128] Timer tick, asking Buildbucket for the build status
[08:32:35.366] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:35.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:101:0) after 1m0s
[08:33:35.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:101:0)
[08:33:35.491] Timer tick, asking Buildbucket for the build status
[08:33:35.546] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:35.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:102:0) after 1m0s
[08:34:35.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:102:0)
[08:34:35.613] Timer tick, asking Buildbucket for the build status
[08:34:35.729] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:35.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:103:0) after 1m0s
[08:35:35.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:103:0)
[08:35:35.822] Timer tick, asking Buildbucket for the build status
[08:35:35.885] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:35.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:104:0) after 1m0s
[08:36:35.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:104:0)
[08:36:35.923] Timer tick, asking Buildbucket for the build status
[08:36:36.091] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:36.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:105:0) after 1m0s
[08:37:36.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:105:0)
[08:37:36.149] Timer tick, asking Buildbucket for the build status
[08:37:36.242] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:36.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:106:0) after 1m0s
[08:38:36.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:106:0)
[08:38:36.290] Timer tick, asking Buildbucket for the build status
[08:38:36.351] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:36.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:107:0) after 1m0s
[08:39:36.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:107:0)
[08:39:36.372] Timer tick, asking Buildbucket for the build status
[08:39:36.493] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:36.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:108:0) after 1m0s
[08:40:36.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:108:0)
[08:40:36.568] Timer tick, asking Buildbucket for the build status
[08:40:36.632] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:36.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:109:0) after 1m0s
[08:41:36.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:109:0)
[08:41:36.736] Timer tick, asking Buildbucket for the build status
[08:41:37.051] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:37.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:110:0) after 1m0s
[08:42:37.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:110:0)
[08:42:37.084] Timer tick, asking Buildbucket for the build status
[08:42:37.148] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:37.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:111:0) after 1m0s
[08:43:37.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:111:0)
[08:43:37.207] Timer tick, asking Buildbucket for the build status
[08:43:37.268] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:37.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:112:0) after 1m0s
[08:44:37.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:112:0)
[08:44:37.338] Timer tick, asking Buildbucket for the build status
[08:44:37.508] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:37.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:113:0) after 1m0s
[08:45:37.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:113:0)
[08:45:37.593] Timer tick, asking Buildbucket for the build status
[08:45:37.778] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:37.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:114:0) after 1m0s
[08:46:37.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:114:0)
[08:46:37.878] Timer tick, asking Buildbucket for the build status
[08:46:37.938] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:37.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:115:0) after 1m0s
[08:47:38.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:115:0)
[08:47:38.007] Timer tick, asking Buildbucket for the build status
[08:47:38.298] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:38.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:116:0) after 1m0s
[08:48:38.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:116:0)
[08:48:38.410] Timer tick, asking Buildbucket for the build status
[08:48:38.471] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:38.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:117:0) after 1m0s
[08:49:38.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:117:0)
[08:49:38.533] Timer tick, asking Buildbucket for the build status
[08:49:38.668] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:38.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:118:0) after 1m0s
[08:50:38.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:118:0)
[08:50:38.705] Timer tick, asking Buildbucket for the build status
[08:50:38.968] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:38.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:119:0) after 1m0s
[08:51:39.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:119:0)
[08:51:39.031] Timer tick, asking Buildbucket for the build status
[08:51:39.283] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:39.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:120:0) after 1m0s
[08:52:39.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:120:0)
[08:52:39.313] Timer tick, asking Buildbucket for the build status
[08:52:39.375] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:39.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:121:0) after 1m0s
[08:53:39.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:121:0)
[08:53:39.371] Timer tick, asking Buildbucket for the build status
[08:53:39.480] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:39.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:122:0) after 1m0s
[08:54:39.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:122:0)
[08:54:39.503] Timer tick, asking Buildbucket for the build status
[08:54:39.605] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:39.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:123:0) after 1m0s
[08:55:39.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:123:0)
[08:55:39.615] Timer tick, asking Buildbucket for the build status
[08:55:39.683] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:39.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:124:0) after 1m0s
[08:56:39.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:124:0)
[08:56:39.741] Timer tick, asking Buildbucket for the build status
[08:56:39.798] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:39.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:125:0) after 1m0s
[08:57:39.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:125:0)
[08:57:39.971] Timer tick, asking Buildbucket for the build status
[08:57:40.020] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:40.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:126:0) after 1m0s
[08:58:40.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:126:0)
[08:58:40.041] Timer tick, asking Buildbucket for the build status
[08:58:40.144] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:40.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:127:0) after 1m0s
[08:59:40.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:127:0)
[08:59:40.172] Timer tick, asking Buildbucket for the build status
[08:59:40.293] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:40.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:128:0) after 1m0s
[09:00:40.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:128:0)
[09:00:40.309] Timer tick, asking Buildbucket for the build status
[09:00:40.381] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:40.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:129:0) after 1m0s
[09:01:40.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:129:0)
[09:01:40.411] Timer tick, asking Buildbucket for the build status
[09:01:40.475] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:40.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:130:0) after 1m0s
[09:02:40.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:130:0)
[09:02:40.560] Timer tick, asking Buildbucket for the build status
[09:02:40.628] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:40.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:131:0) after 1m0s
[09:03:40.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:131:0)
[09:03:40.671] Timer tick, asking Buildbucket for the build status
[09:03:40.739] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:40.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:132:0) after 1m0s
[09:04:40.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:132:0)
[09:04:40.803] Timer tick, asking Buildbucket for the build status
[09:04:41.279] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:41.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:133:0) after 1m0s
[09:05:41.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:133:0)
[09:05:41.408] Timer tick, asking Buildbucket for the build status
[09:05:41.474] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:41.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:134:0) after 1m0s
[09:06:41.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:134:0)
[09:06:41.546] Timer tick, asking Buildbucket for the build status
[09:06:41.623] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:41.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:135:0) after 1m0s
[09:07:41.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:135:0)
[09:07:41.706] Timer tick, asking Buildbucket for the build status
[09:07:41.761] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:41.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:136:0) after 1m0s
[09:08:41.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:136:0)
[09:08:41.845] Timer tick, asking Buildbucket for the build status
[09:08:41.927] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:41.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:137:0) after 1m0s
[09:09:41.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:137:0)
[09:09:41.977] Timer tick, asking Buildbucket for the build status
[09:09:42.087] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:42.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:138:0) after 1m0s
[09:10:42.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:138:0)
[09:10:42.129] Timer tick, asking Buildbucket for the build status
[09:10:42.307] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:42.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:139:0) after 1m0s
[09:11:42.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:139:0)
[09:11:42.378] Timer tick, asking Buildbucket for the build status
[09:11:42.437] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:42.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:140:0) after 1m0s
[09:12:42.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:140:0)
[09:12:42.455] Timer tick, asking Buildbucket for the build status
[09:12:42.675] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:42.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:141:0) after 1m0s
[09:13:42.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:141:0)
[09:13:42.700] Timer tick, asking Buildbucket for the build status
[09:13:42.852] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:42.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:142:0) after 1m0s
[09:14:42.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:142:0)
[09:14:42.875] Timer tick, asking Buildbucket for the build status
[09:14:42.996] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:42.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:143:0) after 1m0s
[09:15:43.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:143:0)
[09:15:43.038] Timer tick, asking Buildbucket for the build status
[09:15:43.166] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:43.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:144:0) after 1m0s
[09:16:43.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:144:0)
[09:16:43.338] Timer tick, asking Buildbucket for the build status
[09:16:44.014] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:44.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:145:0) after 1m0s
[09:17:43.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:145:0)
[09:17:43.992] Timer tick, asking Buildbucket for the build status
[09:17:44.121] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:44.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:146:0) after 1m0s
[09:18:44.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:146:0)
[09:18:44.192] Timer tick, asking Buildbucket for the build status
[09:18:44.609] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:44.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:147:0) after 1m0s
[09:19:44.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:147:0)
[09:19:44.595] Timer tick, asking Buildbucket for the build status
[09:19:44.939] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:44.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:148:0) after 1m0s
[09:20:44.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:148:0)
[09:20:44.951] Timer tick, asking Buildbucket for the build status
[09:20:45.158] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:45.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:149:0) after 1m0s
[09:21:45.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:149:0)
[09:21:45.237] Timer tick, asking Buildbucket for the build status
[09:21:45.349] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:45.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:150:0) after 1m0s
[09:22:45.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:150:0)
[09:22:45.441] Timer tick, asking Buildbucket for the build status
[09:22:45.592] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:45.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:151:0) after 1m0s
[09:23:45.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:151:0)
[09:23:45.663] Timer tick, asking Buildbucket for the build status
[09:23:45.784] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:45.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:152:0) after 1m0s
[09:24:45.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:152:0)
[09:24:45.811] Timer tick, asking Buildbucket for the build status
[09:24:46.593] Build 8863041842610819056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:46.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9028471904592092800:153:0) after 1m0s
[09:25:20.711] Received PubSub notification, asking Buildbucket for the build status
[09:25:20.785] Build 8863041842610819056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:25:20.785] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1605950719497411",
"created_by": "project:chromium",
"created_ts": "1605941651676030",
"id": "8863041842610819056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56bd680ca1b1800612e55b91e7389ef9b25483c3\"}}",
"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\": \"56bd680ca1b1800612e55b91e7389ef9b25483c3\", \"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-19-mzq9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43042, \"got_angle_revision\": \"e51c9068a84f14e42157c097eb764ec3009e0e54\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"56bd680ca1b1800612e55b91e7389ef9b25483c3\", \"got_revision_cp\": \"refs/heads/master@{#829964}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"fa2966f12624e498083c1f4cacd3f82d14f4eacb\", \"got_v8_revision_cp\": \"refs/heads/8.9.30@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56bd680ca1b1800612e55b91e7389ef9b25483c3\", \"swarm_hashes_refs/heads/master(at){#829964}_without_patch\": {\"absl_hardening_tests\": \"1275f5b9dc7d3b2cf668af4b1e5dd0b0802fd348\", \"accessibility_unittests\": \"1601856c5ac849729c15a281fd97c21caa757b3c\", \"angle_unittests\": \"c6b51037fb5ee0c98537455f2b5531ae644b33df\", \"app_list_unittests\": \"c9b6550d0ee90ac7904b0954f408a787201de00f\", \"app_shell_unittests\": \"c28053756c7d7f6b082533b36c9d0961051fcb29\", \"ash_unittests\": \"e77470df2a3e6f600061e7c2dfc5459099abe648\", \"aura_unittests\": \"1c0a2d361944145b9e96d6dc20362ab92c2d955a\", \"base_unittests\": \"e74fae86881d5254f451b4515eb715269d2e3886\", \"base_util_unittests\": \"0639181a0c5a7521769fed74dfecbcef59efc9dc\", \"blink_common_unittests\": \"b3cc63a4fe36aa8596dcaf2e8699e88056fc9a4b\", \"blink_fuzzer_unittests\": \"525fb1bb76a693b1c3c3c62dbbf498e9ad52b0af\", \"blink_heap_unittests\": \"8bb5d25f5567b878e3cd9912f893db975bf141a9\", \"blink_platform_unittests\": \"2e287017d9dab62d3bd817b38fe770c9259204dc\", \"blink_unittests\": \"93aab6ab04906ac680240c0b1f70a24f8eb2e4c4\", \"boringssl_crypto_tests\": \"8fd5161edf0c75d2bbef10080e86312301e4a7a3\", \"boringssl_ssl_tests\": \"4f47fed6a41556e792b7cc407473d2c34df24c09\", \"browser_tests\": \"4ce7da375d8925431b68a9cb38ee2b576ac6d8cf\", \"capture_unittests\": \"5816d76a839d0d0287de6ac8d61453fe2e3b8df5\", \"cast_unittests\": \"efad1524c197442de14a0ff846ee9425f5af39d6\", \"cc_unittests\": \"29ce2deeac86c6823c45e585a8fcf16253f4ff7c\", \"chrome_app_unittests\": \"e5792513f273e6c0a87597f6b8ef669a91430870\", \"chromedriver_unittests\": \"533886feb9cfa045ed1fb54ff5457ae6c08e492f\", \"chromeos_components_unittests\": \"2c9f83bc88e0812d4d16d748dddaa9784faa1b20\", \"chromeos_unittests\": \"bef839c232eb7eb6d61cf9258f357108e1a0e50c\", \"components_browsertests\": \"d2ee5bb0d183f2371f7c1617b1e096b26910b4e3\", \"components_unittests\": \"2d0616a56f48702d7979fd1e8fe46dbb443d4762\", \"compositor_unittests\": \"1aa9ce6eab69ea20e2ed40d45c50907814064322\", \"content_browsertests\": \"d2f5456f67197cfa7af4b40d1faeae6bd703c56b\", \"content_unittests\": \"0d8c5c376c00ac723202a8e9a27fbbc1035013cd\", \"crashpad_tests\": \"fc01b6dbf72c3bc891c0765a9629172e2636c93e\", \"crypto_unittests\": \"ffbea861ff40ca63557bf9e0dbdece399f089f71\", \"dbus_unittests\": \"b30fda846fb981fced9fe364e0f5741785b30239\", \"device_unittests\": \"9340cc4cacdda003d44135518cfb41ecc6e63d03\", \"display_unittests\": \"b710c29ce6191a0975feafba94b2ec21cee2c25e\", \"events_unittests\": \"0ffa1c8084bab1b9169b06caf3f76893eab3a72d\", \"exo_unittests\": \"f50a7d65279a12bf5640332f43bab5d79bc5b5e4\", \"extensions_browsertests\": \"9553476c755575d7506772306a2ab7c6f187b1bd\", \"extensions_unittests\": \"bba7d85003c379e9250a3348879a237fddc0aa79\", \"filesystem_service_unittests\": \"efcd9a97647a9416f196c764861d75c4c30bf656\", \"gcm_unit_tests\": \"3e5ce84cbcbac06637e90a4d04ddee2f2f86a75e\", \"gfx_unittests\": \"0d328186d30a21260bbdde6872878f4f081eefd8\", \"gin_unittests\": \"9a9d1e9a3b3da2385879a9b5b70720964739a64c\", \"gl_unittests_ozone\": \"ab8505d609cf1181f7e4f62ff7b7100360958966\", \"google_apis_unittests\": \"0a3ba91063eb37a15cbadb3f4080e8021e0dbef0\", \"gpu_unittests\": \"3805983a36740ed3b9250c1702428bd392781a20\", \"gwp_asan_unittests\": \"d65b1d2535acc5e12b11ac1f06edeaabbd0199d7\", \"interactive_ui_tests\": \"c3e818ef6c5d6289b4227abe6b040f1755a2d707\", \"ipc_tests\": \"8b87262f9970ed84970a72a764462bbc11f023f6\", \"jingle_unittests\": \"968f0457bb35fc6fa0bfbac3b18b6b7ed8b98eca\", \"keyboard_unittests\": \"89f48efaab9aab805668ae284d434f2609feac5a\", \"latency_unittests\": \"26fa0db39c471498c5dd20b6ffd7e35f79592b1e\", \"libjingle_xmpp_unittests\": \"b5db31201688aef291126f97c63d9709e9f70629\", \"liburlpattern_unittests\": \"c4f95f31208321e19a0917611331c145f1753f84\", \"media_blink_unittests\": \"edd4d347f211bb5ec78ddb692fc4d71687d97226\", \"media_unittests\": \"259b0dc56d33bc39f44234f79a96e5dfec2cd7e3\", \"message_center_unittests\": \"d082835cd0dc42652f6607dbe49b12ecd6fa660a\", \"midi_unittests\": \"75adc5694b22900af5ede6584d24a2f60ba48b43\", \"mojo_core_unittests\": \"0213e1ede82a4c76754387df6291734a114302e9\", \"mojo_unittests\": \"2b2612ac362a4a9ceca89a8291b288a677bb5746\", \"nacl_helper_nonsfi_unittests\": \"0c529112e84422506f83264a7850ab1510f252a0\", \"nacl_loader_unittests\": \"bda87bb6f5041ff543eb02946d47551482b9ad0e\", \"native_theme_unittests\": \"3a30db50fbfd73fec03dc0db4c9d1fabce6bdc2c\", \"net_unittests\": \"ada03c657a1ecf4ff0a55d8cf3dc6b24021d1824\", \"ozone_gl_unittests\": \"6b0bb476cb722e64a1e948671bc80743fd8f72a0\", \"ozone_unittests\": \"8d81d24fafd32614635ca32c2250ff6a153a7871\", \"ozone_x11_unittests\": \"e70be94302a13fa162809947cf0ff672834c8fc6\", \"pdf_unittests\": \"4f09e483de9800d4422f60eb7365c8b7e91a8dc7\", \"perfetto_unittests\": \"0e17c8f024261b8610ac61a4acb8aa0d6337da8f\", \"ppapi_unittests\": \"842740a486116eb186c1002a2e3744f31207cc56\", \"printing_unittests\": \"993e9eb1ece6a803954f1006f4daa635eb0d762e\", \"remoting_unittests\": \"735a05eaee81d94a0f28fdfa12652320ef610137\", \"sandbox_linux_unittests\": \"e6f29da3918a2b546731c585ec11a6845e2751de\", \"service_manager_unittests\": \"be563711c659a8faa8fa5b6d0a0c69f01df74541\", \"services_unittests\": \"18ae6a9eaf62fdba9b4a5556df598b8abe34615c\", \"shell_dialogs_unittests\": \"aef5e18e52b9f5b12eed0fd93c76049343026d91\", \"skia_unittests\": \"10e7980b02b46d8eba2ce3be6f002585b459c795\", \"snapshot_unittests\": \"847654430a1881c345ca2020430a9b0c4dc58559\", \"sql_unittests\": \"8dcd0679665edbd2df178372b0cb764bfc7b6ed0\", \"storage_unittests\": \"0d0df7328b8f20c755d19187e3c5d868e77bed03\", \"sync_integration_tests\": \"dc40f50042d7c7dd5edac7061d9f44879d34ea9f\", \"traffic_annotation_auditor_unittests\": \"e5ca577fc76b8a86ebfd7d9a450af012cb4527d2\", \"ui_base_unittests\": \"7455168be957031778c7a1ed6c67eaaf0a962e4f\", \"ui_chromeos_unittests\": \"c50bf9e451119dce8ccdc6bcf7c1b14f964e6f1f\", \"ui_touch_selection_unittests\": \"e58d21d1b003b0cbf8533054b793bb8aa6f1d5d5\", \"unit_tests\": \"75a0ff2edc9d505d6d1995e5fa72709a5b29bad9\", \"url_unittests\": \"7988e351766ee3de3e7ab4fc3196a40c5f3c1026\", \"usage_time_limit_unittests\": \"571aaaafee5ce095a92207d1888b092ada91200c\", \"views_unittests\": \"d85d3ce25d5ecd404a3c15beea4112389a4e0956\", \"viz_unittests\": \"d39c3d37ed071a3449bb6ecc97937a506a92d1b2\", \"wayland_client_perftests\": \"89559c41b5d37cd82a6f81e0c0c8e6341cb7773e\", \"wm_unittests\": \"2a9aa09a4b57eef64e1b9e6467e5d6b813d66ab2\", \"wtf_unittests\": \"6a4055eca1b48a9d602242136f57add30d91e4b5\", \"zlib_unittests\": \"012c3225ce92d10544c0d497e95c4b5ee6655e43\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_554b324272771ff5af13275cc9c865b3499df108d1c4d159c356d5c678bf725c_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_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-19-mzq9\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605944928622655",
"status": "COMPLETED",
"status_changed_ts": "1605950719916553",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43042",
"builder:linux-chromeos-rel",
"buildset:commit/git/56bd680ca1b1800612e55b91e7389ef9b25483c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56bd680ca1b1800612e55b91e7389ef9b25483c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028471904592092800",
"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/8863041842610819056/+/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:500266734dbfcb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605950719927315",
"url": "https://ci.chromium.org/b/8863041842610819056",
"utcnow_ts": "1605950720769437"
}
}
[09:25:20.785] Invocation finished in 2h31m10.381639023s with status SUCCEEDED