[18:07:01.484] New invocation is queued and will start shortly
[18:07:03.109] Starting the invocation (attempt 1)
[18:07:03.147] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:07:03.147] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:07:03.147] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030332108757319552",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"616c937f238cf599b1411042d16c52c4acf2ed5f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9030332108757319552",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/616c937f238cf599b1411042d16c52c4acf2ed5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616c937f238cf599b1411042d16c52c4acf2ed5f",
"gitiles_ref:refs/heads/master"
]
}
[18:07:04.322] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604167623293709",
"id": "8864902046196091312",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616c937f238cf599b1411042d16c52c4acf2ed5f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604167624116097",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21089",
"builder:linux-chromeos-dbg",
"buildset:commit/git/616c937f238cf599b1411042d16c52c4acf2ed5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616c937f238cf599b1411042d16c52c4acf2ed5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030332108757319552",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864902046196091312/+/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": "1604167624116251",
"url": "https://ci.chromium.org/b/8864902046196091312",
"utcnow_ts": "1604167624304127"
}
}
[18:07:04.322] Task URL: https://ci.chromium.org/b/8864902046196091312
[18:07:04.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:2:0) after 1m0s
[18:08:04.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:2:0)
[18:08:04.342] Timer tick, asking Buildbucket for the build status
[18:08:04.454] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:04.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:3:0) after 1m0s
[18:09:04.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:3:0)
[18:09:04.524] Timer tick, asking Buildbucket for the build status
[18:09:04.613] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:04.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:4:0) after 1m0s
[18:10:04.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:4:0)
[18:10:04.654] Timer tick, asking Buildbucket for the build status
[18:10:04.866] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:10:04.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:5:0) after 1m0s
[18:11:04.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:5:0)
[18:11:04.978] Timer tick, asking Buildbucket for the build status
[18:11:05.113] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:11:05.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:6:0) after 1m0s
[18:12:05.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:6:0)
[18:12:05.186] Timer tick, asking Buildbucket for the build status
[18:12:05.305] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:12:05.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:7:0) after 1m0s
[18:13:05.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:7:0)
[18:13:05.333] Timer tick, asking Buildbucket for the build status
[18:13:05.432] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:13:05.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:8:0) after 1m0s
[18:14:05.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:8:0)
[18:14:05.413] Timer tick, asking Buildbucket for the build status
[18:14:05.544] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:14:05.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:9:0) after 1m0s
[18:15:05.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:9:0)
[18:15:05.577] Timer tick, asking Buildbucket for the build status
[18:15:05.658] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:15:05.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:10:0) after 1m0s
[18:16:05.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:10:0)
[18:16:05.708] Timer tick, asking Buildbucket for the build status
[18:16:05.814] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:16:05.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:11:0) after 1m0s
[18:17:05.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:11:0)
[18:17:05.834] Timer tick, asking Buildbucket for the build status
[18:17:06.481] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:17:06.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:12:0) after 1m0s
[18:18:06.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:12:0)
[18:18:06.517] Timer tick, asking Buildbucket for the build status
[18:18:06.591] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:18:06.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:13:0) after 1m0s
[18:19:06.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:13:0)
[18:19:06.612] Timer tick, asking Buildbucket for the build status
[18:19:06.682] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:06.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:14:0) after 1m0s
[18:20:06.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:14:0)
[18:20:06.705] Timer tick, asking Buildbucket for the build status
[18:20:06.783] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:06.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:15:0) after 1m0s
[18:21:06.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:15:0)
[18:21:06.809] Timer tick, asking Buildbucket for the build status
[18:21:06.941] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:06.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:16:0) after 1m0s
[18:22:06.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:16:0)
[18:22:06.966] Timer tick, asking Buildbucket for the build status
[18:22:07.130] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:07.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:17:0) after 1m0s
[18:23:07.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:17:0)
[18:23:07.163] Timer tick, asking Buildbucket for the build status
[18:23:07.318] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:07.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:18:0) after 1m0s
[18:24:07.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:18:0)
[18:24:07.375] Timer tick, asking Buildbucket for the build status
[18:24:07.463] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:24:07.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:19:0) after 1m0s
[18:25:07.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:19:0)
[18:25:07.482] Timer tick, asking Buildbucket for the build status
[18:25:07.579] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:25:07.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:20:0) after 1m0s
[18:26:07.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:20:0)
[18:26:07.605] Timer tick, asking Buildbucket for the build status
[18:26:07.760] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:26:07.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:21:0) after 1m0s
[18:27:07.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:21:0)
[18:27:07.831] Timer tick, asking Buildbucket for the build status
[18:27:07.934] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:07.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:22:0) after 1m0s
[18:28:08.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:22:0)
[18:28:08.082] Timer tick, asking Buildbucket for the build status
[18:28:08.207] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:08.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:23:0) after 1m0s
[18:29:08.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:23:0)
[18:29:08.232] Timer tick, asking Buildbucket for the build status
[18:29:08.362] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:08.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:24:0) after 1m0s
[18:30:08.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:24:0)
[18:30:08.395] Timer tick, asking Buildbucket for the build status
[18:30:08.497] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:08.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:25:0) after 1m0s
[18:31:08.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:25:0)
[18:31:08.530] Timer tick, asking Buildbucket for the build status
[18:31:08.635] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:08.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:26:0) after 1m0s
[18:32:08.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:26:0)
[18:32:08.869] Timer tick, asking Buildbucket for the build status
[18:32:08.985] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:08.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:27:0) after 1m0s
[18:33:09.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:27:0)
[18:33:09.048] Timer tick, asking Buildbucket for the build status
[18:33:09.387] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:09.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:28:0) after 1m0s
[18:34:09.446] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:28:0)
[18:34:09.446] Timer tick, asking Buildbucket for the build status
[18:34:09.539] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:09.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:29:0) after 1m0s
[18:35:09.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:29:0)
[18:35:09.661] Timer tick, asking Buildbucket for the build status
[18:35:09.858] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:09.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:30:0) after 1m0s
[18:36:09.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:30:0)
[18:36:09.878] Timer tick, asking Buildbucket for the build status
[18:36:10.000] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:10.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:31:0) after 1m0s
[18:37:10.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:31:0)
[18:37:10.069] Timer tick, asking Buildbucket for the build status
[18:37:10.176] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:10.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:32:0) after 1m0s
[18:38:10.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:32:0)
[18:38:10.281] Timer tick, asking Buildbucket for the build status
[18:38:10.402] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:10.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:33:0) after 1m0s
[18:39:10.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:33:0)
[18:39:10.464] Timer tick, asking Buildbucket for the build status
[18:39:10.538] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:10.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:34:0) after 1m0s
[18:40:10.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:34:0)
[18:40:10.670] Timer tick, asking Buildbucket for the build status
[18:40:10.790] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:10.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:35:0) after 1m0s
[18:41:10.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:35:0)
[18:41:10.885] Timer tick, asking Buildbucket for the build status
[18:41:11.072] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:11.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:36:0) after 1m0s
[18:42:11.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:36:0)
[18:42:11.113] Timer tick, asking Buildbucket for the build status
[18:42:11.222] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:42:11.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:37:0) after 1m0s
[18:43:11.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:37:0)
[18:43:11.322] Timer tick, asking Buildbucket for the build status
[18:43:11.801] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:43:11.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:38:0) after 1m0s
[18:44:12.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:38:0)
[18:44:12.022] Timer tick, asking Buildbucket for the build status
[18:44:12.097] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:12.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:39:0) after 1m0s
[18:45:12.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:39:0)
[18:45:12.191] Timer tick, asking Buildbucket for the build status
[18:45:12.268] Build 8864902046196091312: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:12.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:40:0) after 1m0s
[18:45:53.680] Received PubSub notification, asking Buildbucket for the build status
[18:45:53.750] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:12.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:40:0)
[18:46:12.355] Timer tick, asking Buildbucket for the build status
[18:46:12.432] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:12.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:42:0) after 1m0s
[18:47:12.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:42:0)
[18:47:12.554] Timer tick, asking Buildbucket for the build status
[18:47:12.937] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:12.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:43:0) after 1m0s
[18:48:12.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:43:0)
[18:48:12.959] Timer tick, asking Buildbucket for the build status
[18:48:13.039] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:13.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:44:0) after 1m0s
[18:49:13.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:44:0)
[18:49:13.110] Timer tick, asking Buildbucket for the build status
[18:49:13.194] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:13.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:45:0) after 1m0s
[18:50:13.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:45:0)
[18:50:13.324] Timer tick, asking Buildbucket for the build status
[18:50:13.424] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:13.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:46:0) after 1m0s
[18:51:13.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:46:0)
[18:51:13.565] Timer tick, asking Buildbucket for the build status
[18:51:13.634] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:13.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:47:0) after 1m0s
[18:52:13.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:47:0)
[18:52:13.695] Timer tick, asking Buildbucket for the build status
[18:52:13.902] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:13.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:48:0) after 1m0s
[18:53:14.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:48:0)
[18:53:14.060] Timer tick, asking Buildbucket for the build status
[18:53:14.575] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:14.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:49:0) after 1m0s
[18:54:14.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:49:0)
[18:54:14.659] Timer tick, asking Buildbucket for the build status
[18:54:14.738] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:14.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:50:0) after 1m0s
[18:55:14.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:50:0)
[18:55:14.761] Timer tick, asking Buildbucket for the build status
[18:55:14.836] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:14.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:51:0) after 1m0s
[18:56:14.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:51:0)
[18:56:14.848] Timer tick, asking Buildbucket for the build status
[18:56:14.919] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:14.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:52:0) after 1m0s
[18:57:14.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:52:0)
[18:57:14.969] Timer tick, asking Buildbucket for the build status
[18:57:15.074] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:15.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:53:0) after 1m0s
[18:58:15.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:53:0)
[18:58:15.116] Timer tick, asking Buildbucket for the build status
[18:58:15.307] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:15.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:54:0) after 1m0s
[18:59:15.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:54:0)
[18:59:15.330] Timer tick, asking Buildbucket for the build status
[18:59:15.406] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:15.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:55:0) after 1m0s
[19:00:15.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:55:0)
[19:00:15.453] Timer tick, asking Buildbucket for the build status
[19:00:15.808] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:15.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:56:0) after 1m0s
[19:01:15.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:56:0)
[19:01:15.885] Timer tick, asking Buildbucket for the build status
[19:01:16.232] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:16.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:57:0) after 1m0s
[19:02:16.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:57:0)
[19:02:16.261] Timer tick, asking Buildbucket for the build status
[19:02:16.368] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:16.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:58:0) after 1m0s
[19:03:16.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:58:0)
[19:03:16.392] Timer tick, asking Buildbucket for the build status
[19:03:16.452] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:16.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:59:0) after 1m0s
[19:04:16.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:59:0)
[19:04:16.483] Timer tick, asking Buildbucket for the build status
[19:04:17.400] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:17.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:60:0) after 1m0s
[19:05:17.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:60:0)
[19:05:17.522] Timer tick, asking Buildbucket for the build status
[19:05:17.764] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:17.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:61:0) after 1m0s
[19:06:17.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:61:0)
[19:06:17.827] Timer tick, asking Buildbucket for the build status
[19:06:18.024] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:18.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:62:0) after 1m0s
[19:07:18.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:62:0)
[19:07:18.022] Timer tick, asking Buildbucket for the build status
[19:07:18.304] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:18.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:63:0) after 1m0s
[19:08:18.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:63:0)
[19:08:18.340] Timer tick, asking Buildbucket for the build status
[19:08:18.419] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:18.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:64:0) after 1m0s
[19:09:18.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:64:0)
[19:09:18.395] Timer tick, asking Buildbucket for the build status
[19:09:18.669] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:18.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:65:0) after 1m0s
[19:10:18.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:65:0)
[19:10:18.697] Timer tick, asking Buildbucket for the build status
[19:10:18.758] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:18.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:66:0) after 1m0s
[19:11:18.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:66:0)
[19:11:18.785] Timer tick, asking Buildbucket for the build status
[19:11:18.848] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:18.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:67:0) after 1m0s
[19:12:18.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:67:0)
[19:12:18.893] Timer tick, asking Buildbucket for the build status
[19:12:19.130] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:19.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:68:0) after 1m0s
[19:13:19.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:68:0)
[19:13:19.246] Timer tick, asking Buildbucket for the build status
[19:13:19.330] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:19.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:69:0) after 1m0s
[19:14:19.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:69:0)
[19:14:19.309] Timer tick, asking Buildbucket for the build status
[19:14:19.372] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:19.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:70:0) after 1m0s
[19:15:19.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:70:0)
[19:15:19.426] Timer tick, asking Buildbucket for the build status
[19:15:19.492] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:19.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:71:0) after 1m0s
[19:16:19.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:71:0)
[19:16:19.535] Timer tick, asking Buildbucket for the build status
[19:16:19.644] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:19.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:72:0) after 1m0s
[19:17:19.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:72:0)
[19:17:19.715] Timer tick, asking Buildbucket for the build status
[19:17:19.833] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:19.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:73:0) after 1m0s
[19:18:19.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:73:0)
[19:18:19.876] Timer tick, asking Buildbucket for the build status
[19:18:19.947] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:19.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:74:0) after 1m0s
[19:19:20.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:74:0)
[19:19:20.014] Timer tick, asking Buildbucket for the build status
[19:19:20.099] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:20.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:75:0) after 1m0s
[19:20:20.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:75:0)
[19:20:20.137] Timer tick, asking Buildbucket for the build status
[19:20:20.237] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:20.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:76:0) after 1m0s
[19:21:20.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:76:0)
[19:21:20.268] Timer tick, asking Buildbucket for the build status
[19:21:20.627] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:20.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:77:0) after 1m0s
[19:22:20.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:77:0)
[19:22:20.722] Timer tick, asking Buildbucket for the build status
[19:22:20.913] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:20.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:78:0) after 1m0s
[19:23:20.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:78:0)
[19:23:20.976] Timer tick, asking Buildbucket for the build status
[19:23:21.068] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:21.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:79:0) after 1m0s
[19:24:21.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:79:0)
[19:24:21.098] Timer tick, asking Buildbucket for the build status
[19:24:21.166] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:21.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:80:0) after 1m0s
[19:25:21.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:80:0)
[19:25:21.198] Timer tick, asking Buildbucket for the build status
[19:25:21.253] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:21.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:81:0) after 1m0s
[19:26:21.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:81:0)
[19:26:21.280] Timer tick, asking Buildbucket for the build status
[19:26:22.011] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:22.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:82:0) after 1m0s
[19:27:22.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:82:0)
[19:27:22.067] Timer tick, asking Buildbucket for the build status
[19:27:22.179] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:22.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:83:0) after 1m0s
[19:28:22.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:83:0)
[19:28:22.203] Timer tick, asking Buildbucket for the build status
[19:28:22.475] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:22.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:84:0) after 1m0s
[19:29:22.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:84:0)
[19:29:22.562] Timer tick, asking Buildbucket for the build status
[19:29:22.644] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:22.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:85:0) after 1m0s
[19:30:22.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:85:0)
[19:30:22.708] Timer tick, asking Buildbucket for the build status
[19:30:22.787] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:22.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:86:0) after 1m0s
[19:31:22.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:86:0)
[19:31:22.883] Timer tick, asking Buildbucket for the build status
[19:31:22.974] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:22.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:87:0) after 1m0s
[19:32:22.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:87:0)
[19:32:22.999] Timer tick, asking Buildbucket for the build status
[19:32:23.204] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:23.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:88:0) after 1m0s
[19:33:23.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:88:0)
[19:33:23.297] Timer tick, asking Buildbucket for the build status
[19:33:23.371] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:23.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:89:0) after 1m0s
[19:34:23.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:89:0)
[19:34:23.455] Timer tick, asking Buildbucket for the build status
[19:34:23.525] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:23.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:90:0) after 1m0s
[19:35:23.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:90:0)
[19:35:23.573] Timer tick, asking Buildbucket for the build status
[19:35:23.642] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:23.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:91:0) after 1m0s
[19:36:23.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:91:0)
[19:36:23.681] Timer tick, asking Buildbucket for the build status
[19:36:23.751] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:23.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:92:0) after 1m0s
[19:37:23.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:92:0)
[19:37:23.871] Timer tick, asking Buildbucket for the build status
[19:37:24.001] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:24.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:93:0) after 1m0s
[19:38:24.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:93:0)
[19:38:24.032] Timer tick, asking Buildbucket for the build status
[19:38:24.188] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:24.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:94:0) after 1m0s
[19:39:24.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:94:0)
[19:39:24.232] Timer tick, asking Buildbucket for the build status
[19:39:24.296] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:24.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:95:0) after 1m0s
[19:40:24.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:95:0)
[19:40:24.282] Timer tick, asking Buildbucket for the build status
[19:40:24.385] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:24.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:96:0) after 1m0s
[19:41:24.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:96:0)
[19:41:24.419] Timer tick, asking Buildbucket for the build status
[19:41:25.190] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:25.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:97:0) after 1m0s
[19:42:25.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:97:0)
[19:42:25.216] Timer tick, asking Buildbucket for the build status
[19:42:25.341] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:25.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:98:0) after 1m0s
[19:43:25.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:98:0)
[19:43:25.369] Timer tick, asking Buildbucket for the build status
[19:43:25.465] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:25.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:99:0) after 1m0s
[19:44:25.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:99:0)
[19:44:25.493] Timer tick, asking Buildbucket for the build status
[19:44:25.609] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:25.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:100:0) after 1m0s
[19:45:25.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:100:0)
[19:45:25.634] Timer tick, asking Buildbucket for the build status
[19:45:25.921] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:25.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:101:0) after 1m0s
[19:46:25.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:101:0)
[19:46:25.946] Timer tick, asking Buildbucket for the build status
[19:46:26.275] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:26.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:102:0) after 1m0s
[19:47:26.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:102:0)
[19:47:26.341] Timer tick, asking Buildbucket for the build status
[19:47:28.004] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:28.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:103:0) after 1m0s
[19:48:28.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:103:0)
[19:48:28.079] Timer tick, asking Buildbucket for the build status
[19:48:28.175] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:28.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:104:0) after 1m0s
[19:49:28.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:104:0)
[19:49:28.171] Timer tick, asking Buildbucket for the build status
[19:49:28.309] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:28.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:105:0) after 1m0s
[19:50:28.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:105:0)
[19:50:28.390] Timer tick, asking Buildbucket for the build status
[19:50:28.988] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:28.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:106:0) after 1m0s
[19:51:29.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:106:0)
[19:51:29.070] Timer tick, asking Buildbucket for the build status
[19:51:29.321] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:29.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:107:0) after 1m0s
[19:52:29.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:107:0)
[19:52:29.348] Timer tick, asking Buildbucket for the build status
[19:52:29.543] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:29.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:108:0) after 1m0s
[19:53:29.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:108:0)
[19:53:29.567] Timer tick, asking Buildbucket for the build status
[19:53:30.357] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:30.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:109:0) after 1m0s
[19:54:30.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:109:0)
[19:54:30.431] Timer tick, asking Buildbucket for the build status
[19:54:30.557] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:30.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:110:0) after 1m0s
[19:55:30.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:110:0)
[19:55:30.607] Timer tick, asking Buildbucket for the build status
[19:55:30.673] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:30.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:111:0) after 1m0s
[19:56:30.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:111:0)
[19:56:30.701] Timer tick, asking Buildbucket for the build status
[19:56:30.772] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:30.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:112:0) after 1m0s
[19:57:30.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:112:0)
[19:57:30.800] Timer tick, asking Buildbucket for the build status
[19:57:30.974] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:30.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:113:0) after 1m0s
[19:58:31.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:113:0)
[19:58:31.065] Timer tick, asking Buildbucket for the build status
[19:58:31.230] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:31.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:114:0) after 1m0s
[19:59:31.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:114:0)
[19:59:31.344] Timer tick, asking Buildbucket for the build status
[19:59:31.423] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:31.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:115:0) after 1m0s
[20:00:31.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:115:0)
[20:00:31.488] Timer tick, asking Buildbucket for the build status
[20:00:31.811] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:31.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:116:0) after 1m0s
[20:01:31.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:116:0)
[20:01:31.955] Timer tick, asking Buildbucket for the build status
[20:01:32.089] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:32.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:117:0) after 1m0s
[20:02:32.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:117:0)
[20:02:32.185] Timer tick, asking Buildbucket for the build status
[20:02:32.451] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:32.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:118:0) after 1m0s
[20:03:32.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:118:0)
[20:03:32.490] Timer tick, asking Buildbucket for the build status
[20:03:32.721] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:32.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:119:0) after 1m0s
[20:04:32.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:119:0)
[20:04:32.746] Timer tick, asking Buildbucket for the build status
[20:04:32.896] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:32.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:120:0) after 1m0s
[20:05:32.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:120:0)
[20:05:32.940] Timer tick, asking Buildbucket for the build status
[20:05:33.048] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:33.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:121:0) after 1m0s
[20:06:33.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:121:0)
[20:06:33.082] Timer tick, asking Buildbucket for the build status
[20:06:33.310] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:33.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:122:0) after 1m0s
[20:07:33.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:122:0)
[20:07:33.377] Timer tick, asking Buildbucket for the build status
[20:07:33.973] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:33.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:123:0) after 1m0s
[20:08:33.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:123:0)
[20:08:33.998] Timer tick, asking Buildbucket for the build status
[20:08:34.161] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:34.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:124:0) after 1m0s
[20:09:34.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:124:0)
[20:09:34.240] Timer tick, asking Buildbucket for the build status
[20:09:34.319] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:34.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:125:0) after 1m0s
[20:10:34.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:125:0)
[20:10:34.377] Timer tick, asking Buildbucket for the build status
[20:10:34.487] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:34.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:126:0) after 1m0s
[20:11:34.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:126:0)
[20:11:34.536] Timer tick, asking Buildbucket for the build status
[20:11:34.624] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:34.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:127:0) after 1m0s
[20:12:34.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:127:0)
[20:12:34.701] Timer tick, asking Buildbucket for the build status
[20:12:34.924] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:34.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:128:0) after 1m0s
[20:13:34.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:128:0)
[20:13:34.951] Timer tick, asking Buildbucket for the build status
[20:13:35.142] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:35.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:129:0) after 1m0s
[20:14:35.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:129:0)
[20:14:35.181] Timer tick, asking Buildbucket for the build status
[20:14:35.305] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:35.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:130:0) after 1m0s
[20:15:35.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:130:0)
[20:15:35.334] Timer tick, asking Buildbucket for the build status
[20:15:35.439] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:35.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:131:0) after 1m0s
[20:16:35.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:131:0)
[20:16:35.464] Timer tick, asking Buildbucket for the build status
[20:16:35.573] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:35.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:132:0) after 1m0s
[20:17:35.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:132:0)
[20:17:35.598] Timer tick, asking Buildbucket for the build status
[20:17:35.722] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:35.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:133:0) after 1m0s
[20:18:35.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:133:0)
[20:18:35.750] Timer tick, asking Buildbucket for the build status
[20:18:35.868] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:35.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:134:0) after 1m0s
[20:19:35.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:134:0)
[20:19:35.905] Timer tick, asking Buildbucket for the build status
[20:19:36.025] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:36.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:135:0) after 1m0s
[20:20:36.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:135:0)
[20:20:36.125] Timer tick, asking Buildbucket for the build status
[20:20:36.528] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:36.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:136:0) after 1m0s
[20:21:36.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:136:0)
[20:21:36.552] Timer tick, asking Buildbucket for the build status
[20:21:36.619] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:36.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:137:0) after 1m0s
[20:22:36.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:137:0)
[20:22:36.648] Timer tick, asking Buildbucket for the build status
[20:22:37.069] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:37.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:138:0) after 1m0s
[20:23:37.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:138:0)
[20:23:37.153] Timer tick, asking Buildbucket for the build status
[20:23:37.282] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:37.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:139:0) after 1m0s
[20:24:37.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:139:0)
[20:24:37.328] Timer tick, asking Buildbucket for the build status
[20:24:37.490] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:37.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:140:0) after 1m0s
[20:25:37.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:140:0)
[20:25:37.563] Timer tick, asking Buildbucket for the build status
[20:25:37.629] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:37.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:141:0) after 1m0s
[20:26:37.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:141:0)
[20:26:37.706] Timer tick, asking Buildbucket for the build status
[20:26:37.797] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:37.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:142:0) after 1m0s
[20:27:37.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:142:0)
[20:27:37.819] Timer tick, asking Buildbucket for the build status
[20:27:37.995] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:37.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:143:0) after 1m0s
[20:28:38.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:143:0)
[20:28:38.030] Timer tick, asking Buildbucket for the build status
[20:28:38.103] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:144:0) after 1m0s
[20:29:38.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:144:0)
[20:29:38.132] Timer tick, asking Buildbucket for the build status
[20:29:38.686] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:38.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:145:0) after 1m0s
[20:30:38.714] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:145:0)
[20:30:38.714] Timer tick, asking Buildbucket for the build status
[20:30:38.775] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:38.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:146:0) after 1m0s
[20:31:38.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:146:0)
[20:31:38.803] Timer tick, asking Buildbucket for the build status
[20:31:38.889] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:38.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:147:0) after 1m0s
[20:32:38.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:147:0)
[20:32:38.915] Timer tick, asking Buildbucket for the build status
[20:32:39.044] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:39.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:148:0) after 1m0s
[20:33:39.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:148:0)
[20:33:39.068] Timer tick, asking Buildbucket for the build status
[20:33:39.143] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:39.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:149:0) after 1m0s
[20:34:39.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:149:0)
[20:34:39.170] Timer tick, asking Buildbucket for the build status
[20:34:39.312] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:39.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:150:0) after 1m0s
[20:35:39.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:150:0)
[20:35:39.335] Timer tick, asking Buildbucket for the build status
[20:35:39.544] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:39.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:151:0) after 1m0s
[20:36:39.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:151:0)
[20:36:39.624] Timer tick, asking Buildbucket for the build status
[20:36:39.847] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:39.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:152:0) after 1m0s
[20:37:39.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:152:0)
[20:37:39.923] Timer tick, asking Buildbucket for the build status
[20:37:40.042] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:40.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:153:0) after 1m0s
[20:38:40.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:153:0)
[20:38:40.147] Timer tick, asking Buildbucket for the build status
[20:38:40.272] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:40.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:154:0) after 1m0s
[20:39:40.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:154:0)
[20:39:40.300] Timer tick, asking Buildbucket for the build status
[20:39:40.473] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:40.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:155:0) after 1m0s
[20:40:40.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:155:0)
[20:40:40.549] Timer tick, asking Buildbucket for the build status
[20:40:40.677] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:40.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:156:0) after 1m0s
[20:41:40.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:156:0)
[20:41:40.704] Timer tick, asking Buildbucket for the build status
[20:41:40.764] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:40.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:157:0) after 1m0s
[20:42:40.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:157:0)
[20:42:40.862] Timer tick, asking Buildbucket for the build status
[20:42:40.973] Build 8864902046196091312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:40.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030332108757319552:158:0) after 1m0s
[20:42:50.786] Received PubSub notification, asking Buildbucket for the build status
[20:42:50.885] Build 8864902046196091312: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:42:50.885] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604176969447340",
"created_by": "project:chromium",
"created_ts": "1604167623293709",
"id": "8864902046196091312",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616c937f238cf599b1411042d16c52c4acf2ed5f\"}}",
"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\": \"616c937f238cf599b1411042d16c52c4acf2ed5f\", \"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-88-qpxe\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21089, \"got_angle_revision\": \"42ad027982404039e6c9a921b2f6354f55b65a2e\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"616c937f238cf599b1411042d16c52c4acf2ed5f\", \"got_revision_cp\": \"refs/heads/master@{#822976}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"69c856dc816ff1dd65fcc536095b44399a7434b9\", \"got_v8_revision_cp\": \"refs/heads/8.8.214@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"616c937f238cf599b1411042d16c52c4acf2ed5f\", \"swarm_hashes_refs/heads/master(at){#822976}_without_patch\": {\"absl_hardening_tests\": \"e482bf9639378857b9008ddc0b8ebf4d761d46a8\", \"accessibility_unittests\": \"3d39da7efca61c048c5b62c3b6ae2bce898e88fc\", \"angle_unittests\": \"3aa70cbc2677760f521b3a79029330d9cd2caefc\", \"app_list_unittests\": \"a8227f8693635fbbe48e1d7d809a3010de81c433\", \"app_shell_unittests\": \"093f0a5dda9d5bfbd610cc10f8be1b920c8bd6cb\", \"ash_unittests\": \"43c2f73417406549235013947641b12341da7da1\", \"aura_unittests\": \"9edb02cae347669544d50b68ebb4ae9b8763a981\", \"base_unittests\": \"247e54e77e63f7637a57965a16392ff5280aaa15\", \"base_util_unittests\": \"788feef7f64a090633abea4ad63759b25008d5c1\", \"blink_common_unittests\": \"58ed25c50d2ba3bd2c817a3ca9427d598151d56b\", \"blink_fuzzer_unittests\": \"a4239f61096c4d30cb316001bea59075d4a56830\", \"blink_heap_unittests\": \"1fb16354ababeeab4d219b97bedbc8f5e0d902ae\", \"blink_platform_unittests\": \"aeaf3cb37a6bf37ca456d168690e29168ea2487f\", \"blink_unittests\": \"ffb7241f1f2801218279ad3ec5a1623fe5d064fc\", \"boringssl_crypto_tests\": \"cf0c9d6d1f25be9f64c0c68793cedac51ed5ef84\", \"boringssl_ssl_tests\": \"808e6abf4ce01353b0138077d1c2fcc34c2638f8\", \"browser_tests\": \"9325f6d7995b499fc6c648d11f2cfb0838a0dfcb\", \"capture_unittests\": \"aded2ae3cc100ce6b7e4053e02a83e279b0a5185\", \"cast_unittests\": \"fde6f301923f0beb761f22b094c92984238af505\", \"cc_unittests\": \"566ab85c59f7d86a6b1f5f10f23ba005ef0edc41\", \"chrome_app_unittests\": \"510c75af58391aea5ee67fc42a1d1b5082cba522\", \"chromedriver_unittests\": \"a14e1a1bc8c82181ab9c77cc71d9e88af343202d\", \"chromeos_components_unittests\": \"3c3e78b362b0d0cf83d401d6c398ff7e236ddeea\", \"chromeos_unittests\": \"5a52cd421d9c3af8dd4d6eeb495903c39e0903ed\", \"components_browsertests\": \"c52ef7ee0cb5c05a1a8ec48bbcdf9d4cfca1ce12\", \"components_unittests\": \"5bdc06da04bf78e412e3ccf3098d97607ac1a0d9\", \"compositor_unittests\": \"9ab45d156e69bed0a6b1a373e321e26c99808afe\", \"content_browsertests\": \"d55023120a6072540320be93bf7fd64713fa0382\", \"content_unittests\": \"0b4bbc0857240c895bf93e04e5cee0c9790e5fb0\", \"crypto_unittests\": \"01908054db0c7d4d0d7f40454b79ea0a2e02012a\", \"dbus_unittests\": \"a7c27f3461e3bfe73ff59276070bc19f362a9b40\", \"device_unittests\": \"d176998d6b5067218144d5e159de6d5f580fc0d3\", \"display_unittests\": \"dcd63991e03f03becd4693cdffb451a3c8832876\", \"events_unittests\": \"00e0144ffa03e0ee68d216b1ff68fb726143dad9\", \"exo_unittests\": \"7280b649a8a1eb2b5d976e773f32f8232175674d\", \"extensions_browsertests\": \"c930c2ba02e2ee57498d692c75ece970f82118eb\", \"extensions_unittests\": \"e8c289fbd4a14614b39477be4346c73a27312326\", \"filesystem_service_unittests\": \"fcc621b0d7c38e4c7db394b826baf46d0cfbab98\", \"gcm_unit_tests\": \"77958fccfce67ee78a1bb1d3d10ba359d59aafc3\", \"gfx_unittests\": \"4d1d6227353182eb71927c95a5ae97e0391517f5\", \"gin_unittests\": \"f1ec3388dc21592478c14cd42cf5ff7abfbc2040\", \"gl_unittests_ozone\": \"a26fa3dfe3ba54720a3569b8619e7683ece67a24\", \"google_apis_unittests\": \"f276bd8250e152a311a5d2a7e37f9850d5427b14\", \"gpu_unittests\": \"2386208ec1de8cceaa7630b01518acfaedd9594c\", \"gwp_asan_unittests\": \"65b56e21cd01d308b9caf7e29e6d52017a722eb4\", \"interactive_ui_tests\": \"9b46da6b7013c21e8a702674ed18c2f3e1191e12\", \"ipc_tests\": \"4472949bcc4a79051e487f3f5028df9d605d82d1\", \"jingle_unittests\": \"b90dbae65784b23096ed53bee5bf2a538a6e55fb\", \"keyboard_unittests\": \"523d4a41b06b16f3d49c9bbec464040e3b000958\", \"latency_unittests\": \"282c76998dcc8ef7ffd038208c47802438894d3c\", \"libjingle_xmpp_unittests\": \"456f6f9ab85b1d798fcb54e228af253b7174aaec\", \"liburlpattern_unittests\": \"0d40deeaeae3d5ec167f0379ef437c6bab59efa7\", \"media_blink_unittests\": \"b401f57ad5faf76ea82abbe9b12af295b3f001d8\", \"media_unittests\": \"6d28d4de79e03785408741e443021c2f13c8328f\", \"message_center_unittests\": \"aeb1e7537f956c876b9be8f0999fdbee546be205\", \"midi_unittests\": \"5c8c16b33fb0adb7deccdffade005c06245c6f58\", \"mojo_core_unittests\": \"0aac15ae911595bcd178f73530edf1071c8b791b\", \"mojo_unittests\": \"95800582858e5d6945e79a1e7749512f70de207d\", \"nacl_helper_nonsfi_unittests\": \"83cae84ae3abd1aff8e6eca00e0f7100982542f3\", \"nacl_loader_unittests\": \"0b182f181e0e52f8710115f6a93cd0f21579ce54\", \"native_theme_unittests\": \"9322145abfdf6387c31e02ba05faee0d09ae708a\", \"net_unittests\": \"fcf2e0c7c3163df33745d0f1463435485eab5a0f\", \"ozone_gl_unittests\": \"3f6d451f7b8ca3469f6aaf83ff0d3518f3a4d5d2\", \"ozone_unittests\": \"6531f5599cd4dadd940080bdcf375255693c1ffd\", \"ozone_x11_unittests\": \"3ce717a9adcef90658ba668d8dd50693de0e5c08\", \"pdf_unittests\": \"bdf861391b79d8589ee6cb1e9ee622d4272c9dcf\", \"perfetto_unittests\": \"fb81ec10fd50e9485a469072469045299433524a\", \"ppapi_unittests\": \"748d9a2be14a18165c9bdb1becacc1721c37875a\", \"printing_unittests\": \"b09e568c7e4431ea113554becaf55be7a47345eb\", \"remoting_unittests\": \"a1c8046799431dabe2db2d13e657867d6d2a91cd\", \"sandbox_linux_unittests\": \"278e6e7454e231346898026f6111c538a7407efa\", \"service_manager_unittests\": \"49322a607843c352d71b9f71a85025c1a8d9c848\", \"services_unittests\": \"8f579bdbac0c3eb162e2ede1c3c0ab20d659856a\", \"shell_dialogs_unittests\": \"371ee0f1b14771f87173f0e2b0a24ff5d10ade15\", \"skia_unittests\": \"0d13e7cad40abc68d04db4eb0bd10737e1c2e870\", \"snapshot_unittests\": \"1ecdcb039b8fe23961bee9023374d65d3311e2c8\", \"sql_unittests\": \"1ac65c7429e64f7c2796e2f465c4c6dde84abcb2\", \"storage_unittests\": \"4ed93451081f9ae37505856e4224e3c5a77fb88e\", \"sync_integration_tests\": \"e5d4073643f450a6e905bd9f490cefb0ebbff182\", \"traffic_annotation_auditor_unittests\": \"bed3fe5d71a148caad7b96e6fc127dc8476a491c\", \"ui_base_unittests\": \"9660ce6ebecdc3cc8972f320032a2351f5fc2208\", \"ui_chromeos_unittests\": \"dffbd95b0f9534e252f07e828b967881fcf7f6fc\", \"ui_touch_selection_unittests\": \"4fd8d1d6cb83738222be0c7189c510965142feb4\", \"unit_tests\": \"6f7f9c98647267851d662320b0ed7ae8005c3e65\", \"url_unittests\": \"b6ca250ac45f54742a00c030eb1603e63b322b96\", \"usage_time_limit_unittests\": \"5675708319d250c8299042168907459632c34b5c\", \"views_unittests\": \"4a40ad498070f38b9a3e2e6bdbce3c93337679ba\", \"viz_unittests\": \"1509f71de113a294e5b2362924695dc1a046e29e\", \"wm_unittests\": \"eeec6c52f45aa0eb09ad8def174f3bda527ad095\", \"wtf_unittests\": \"532c0a4e07704baed62dc0b6d2e21c7bd8d16509\", \"zlib_unittests\": \"efb3972875ffbb5c7ddaa0dd96b4bd3b7bfeee25\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02c50c25350278ea3e2feb85c748c248af9e0ccc93852ce717c8651b544f7a96_v2\", \"builder_3b2af173bd6c7c2422ea21f333ca7959a40b63aa844e8561bdce050550b2b6b9_v2\", \"builder_5bdf72a3926559fa6928bf9d114bb55d47a1d8787cd310af89eaf0a3f1b217d8_v2\", \"builder_73a5b2ce307b316a1240917eaad41a92e4adc44903c6789e05a5f10300306cda_v2\", \"builder_8261abd8e1ac2c81e9d801c1dfded75704f88bd3f012b5aaa312c5f47f314e0f_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_9d393496fc50bd2ba7e16167b6377b317d5cb146b2dfdb60405146db5a374eac_v2\", \"builder_c16bcafb270cf04ef37195bd83bca829ad7ff18c281bac3cbefd0ef7589dbbf9_v2\", \"builder_dd549fc6a716e6a939fbd3a419c5738d31929c905615e3b6decc21ab2a48e41b_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-88-qpxe\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604169952876453",
"status": "COMPLETED",
"status_changed_ts": "1604176969767660",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21089",
"builder:linux-chromeos-dbg",
"buildset:commit/git/616c937f238cf599b1411042d16c52c4acf2ed5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/616c937f238cf599b1411042d16c52c4acf2ed5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030332108757319552",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864902046196091312/+/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:4f98a8eeab20ec10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604176969787214",
"url": "https://ci.chromium.org/b/8864902046196091312",
"utcnow_ts": "1604176970876077"
}
}
[20:42:50.885] Invocation finished in 2h35m49.418861592s with status SUCCEEDED