[19:04:41.526] New invocation is queued and will start shortly
[19:04:42.730] Starting the invocation (attempt 1)
[19:04:42.762] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:04:42.764] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:04:42.764] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022627738493785680",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022627738493785680",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3",
"gitiles_ref:refs/heads/master"
]
}
[19:04:43.387] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1611515082835192",
"id": "8857197676459222192",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611515083229671",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22326",
"builder:linux-chromeos-dbg",
"buildset:commit/git/3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022627738493785680",
"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/8857197676459222192/+/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": "1611515083229825",
"url": "https://ci.chromium.org/b/8857197676459222192",
"utcnow_ts": "1611515083381054"
}
}
[19:04:43.387] Task URL: https://ci.chromium.org/b/8857197676459222192
[19:04:43.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:2:0) after 1m0s
[19:05:43.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:2:0)
[19:05:43.430] Timer tick, asking Buildbucket for the build status
[19:05:43.528] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:43.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:3:0) after 1m0s
[19:06:43.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:3:0)
[19:06:43.546] Timer tick, asking Buildbucket for the build status
[19:06:43.616] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:43.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:4:0) after 1m0s
[19:07:43.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:4:0)
[19:07:43.664] Timer tick, asking Buildbucket for the build status
[19:07:43.744] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:43.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:5:0) after 1m0s
[19:08:43.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:5:0)
[19:08:43.792] Timer tick, asking Buildbucket for the build status
[19:08:43.883] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:08:43.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:6:0) after 1m0s
[19:09:43.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:6:0)
[19:09:43.970] Timer tick, asking Buildbucket for the build status
[19:09:44.416] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:09:44.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:7:0) after 1m0s
[19:10:44.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:7:0)
[19:10:44.443] Timer tick, asking Buildbucket for the build status
[19:10:44.580] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:10:44.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:8:0) after 1m0s
[19:11:44.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:8:0)
[19:11:44.607] Timer tick, asking Buildbucket for the build status
[19:11:44.680] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:11:44.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:9:0) after 1m0s
[19:12:44.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:9:0)
[19:12:44.725] Timer tick, asking Buildbucket for the build status
[19:12:44.813] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:12:44.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:10:0) after 1m0s
[19:13:44.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:10:0)
[19:13:44.839] Timer tick, asking Buildbucket for the build status
[19:13:45.038] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:45.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:11:0) after 1m0s
[19:14:45.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:11:0)
[19:14:45.063] Timer tick, asking Buildbucket for the build status
[19:14:45.469] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:14:45.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:12:0) after 1m0s
[19:15:45.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:12:0)
[19:15:45.482] Timer tick, asking Buildbucket for the build status
[19:15:45.639] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:15:45.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:13:0) after 1m0s
[19:16:45.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:13:0)
[19:16:45.670] Timer tick, asking Buildbucket for the build status
[19:16:45.748] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:16:45.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:14:0) after 1m0s
[19:17:45.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:14:0)
[19:17:45.766] Timer tick, asking Buildbucket for the build status
[19:17:45.938] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:17:45.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:15:0) after 1m0s
[19:18:45.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:15:0)
[19:18:45.967] Timer tick, asking Buildbucket for the build status
[19:18:46.124] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:18:46.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:16:0) after 1m0s
[19:19:46.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:16:0)
[19:19:46.189] Timer tick, asking Buildbucket for the build status
[19:19:46.321] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:19:46.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:17:0) after 1m0s
[19:20:46.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:17:0)
[19:20:46.343] Timer tick, asking Buildbucket for the build status
[19:20:46.728] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:20:46.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:18:0) after 1m0s
[19:21:46.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:18:0)
[19:21:46.724] Timer tick, asking Buildbucket for the build status
[19:21:46.824] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:21:46.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:19:0) after 1m0s
[19:22:46.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:19:0)
[19:22:46.882] Timer tick, asking Buildbucket for the build status
[19:22:46.951] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:22:46.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:20:0) after 1m0s
[19:23:46.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:20:0)
[19:23:46.934] Timer tick, asking Buildbucket for the build status
[19:23:47.002] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:23:47.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:21:0) after 1m0s
[19:24:47.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:21:0)
[19:24:47.043] Timer tick, asking Buildbucket for the build status
[19:24:47.139] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:24:47.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:22:0) after 1m0s
[19:25:47.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:22:0)
[19:25:47.202] Timer tick, asking Buildbucket for the build status
[19:25:47.270] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:25:47.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:23:0) after 1m0s
[19:26:47.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:23:0)
[19:26:47.469] Timer tick, asking Buildbucket for the build status
[19:26:47.735] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:26:47.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:24:0) after 1m0s
[19:27:47.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:24:0)
[19:27:47.776] Timer tick, asking Buildbucket for the build status
[19:27:48.196] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:27:48.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:25:0) after 1m0s
[19:28:48.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:25:0)
[19:28:48.214] Timer tick, asking Buildbucket for the build status
[19:28:48.286] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:28:48.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:26:0) after 1m0s
[19:29:48.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:26:0)
[19:29:48.350] Timer tick, asking Buildbucket for the build status
[19:29:48.504] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:29:48.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:27:0) after 1m0s
[19:30:48.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:27:0)
[19:30:48.521] Timer tick, asking Buildbucket for the build status
[19:30:48.734] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:30:48.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:28:0) after 1m0s
[19:31:48.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:28:0)
[19:31:48.755] Timer tick, asking Buildbucket for the build status
[19:31:48.834] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:31:48.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:29:0) after 1m0s
[19:32:48.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:29:0)
[19:32:48.875] Timer tick, asking Buildbucket for the build status
[19:32:48.973] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:32:48.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:30:0) after 1m0s
[19:33:48.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:30:0)
[19:33:48.994] Timer tick, asking Buildbucket for the build status
[19:33:49.062] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:33:49.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:31:0) after 1m0s
[19:34:49.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:31:0)
[19:34:49.084] Timer tick, asking Buildbucket for the build status
[19:34:49.192] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:34:49.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:32:0) after 1m0s
[19:35:49.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:32:0)
[19:35:49.212] Timer tick, asking Buildbucket for the build status
[19:35:49.304] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:35:49.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:33:0) after 1m0s
[19:36:49.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:33:0)
[19:36:49.374] Timer tick, asking Buildbucket for the build status
[19:36:49.520] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:36:49.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:34:0) after 1m0s
[19:37:49.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:34:0)
[19:37:49.552] Timer tick, asking Buildbucket for the build status
[19:37:49.634] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:37:49.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:35:0) after 1m0s
[19:38:49.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:35:0)
[19:38:49.654] Timer tick, asking Buildbucket for the build status
[19:38:49.723] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:38:49.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:36:0) after 1m0s
[19:39:49.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:36:0)
[19:39:49.755] Timer tick, asking Buildbucket for the build status
[19:39:49.906] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:39:49.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:37:0) after 1m0s
[19:40:49.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:37:0)
[19:40:49.970] Timer tick, asking Buildbucket for the build status
[19:40:50.055] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:40:50.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:38:0) after 1m0s
[19:41:50.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:38:0)
[19:41:50.137] Timer tick, asking Buildbucket for the build status
[19:41:50.204] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:41:50.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:39:0) after 1m0s
[19:42:50.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:39:0)
[19:42:50.303] Timer tick, asking Buildbucket for the build status
[19:42:50.363] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:42:50.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:40:0) after 1m0s
[19:43:50.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:40:0)
[19:43:50.418] Timer tick, asking Buildbucket for the build status
[19:43:50.551] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:43:50.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:41:0) after 1m0s
[19:44:50.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:41:0)
[19:44:50.625] Timer tick, asking Buildbucket for the build status
[19:44:50.987] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:44:50.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:42:0) after 1m0s
[19:45:51.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:42:0)
[19:45:51.057] Timer tick, asking Buildbucket for the build status
[19:45:51.164] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:45:51.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:43:0) after 1m0s
[19:46:51.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:43:0)
[19:46:51.221] Timer tick, asking Buildbucket for the build status
[19:46:51.287] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:46:51.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:44:0) after 1m0s
[19:47:51.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:44:0)
[19:47:51.337] Timer tick, asking Buildbucket for the build status
[19:47:51.625] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:47:51.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:45:0) after 1m0s
[19:48:51.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:45:0)
[19:48:51.736] Timer tick, asking Buildbucket for the build status
[19:48:51.834] Build 8857197676459222192: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:51.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:46:0) after 1m0s
[19:49:16.132] Received PubSub notification, asking Buildbucket for the build status
[19:49:16.196] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:51.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:46:0)
[19:49:51.835] Timer tick, asking Buildbucket for the build status
[19:49:51.992] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:51.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:48:0) after 1m0s
[19:50:52.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:48:0)
[19:50:52.015] Timer tick, asking Buildbucket for the build status
[19:50:52.082] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:52.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:49:0) after 1m0s
[19:51:52.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:49:0)
[19:51:52.111] Timer tick, asking Buildbucket for the build status
[19:51:52.208] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:52.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:50:0) after 1m0s
[19:52:52.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:50:0)
[19:52:52.314] Timer tick, asking Buildbucket for the build status
[19:52:52.439] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:52.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:51:0) after 1m0s
[19:53:52.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:51:0)
[19:53:52.434] Timer tick, asking Buildbucket for the build status
[19:53:52.799] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:52.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:52:0) after 1m0s
[19:54:52.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:52:0)
[19:54:52.796] Timer tick, asking Buildbucket for the build status
[19:54:52.888] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:52.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:53:0) after 1m0s
[19:55:52.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:53:0)
[19:55:52.967] Timer tick, asking Buildbucket for the build status
[19:55:53.153] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:53.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:54:0) after 1m0s
[19:56:53.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:54:0)
[19:56:53.174] Timer tick, asking Buildbucket for the build status
[19:56:53.513] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:53.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:55:0) after 1m0s
[19:57:53.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:55:0)
[19:57:53.534] Timer tick, asking Buildbucket for the build status
[19:57:53.590] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:53.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:56:0) after 1m0s
[19:58:53.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:56:0)
[19:58:53.615] Timer tick, asking Buildbucket for the build status
[19:58:53.674] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:53.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:57:0) after 1m0s
[19:59:53.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:57:0)
[19:59:53.693] Timer tick, asking Buildbucket for the build status
[19:59:53.800] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:53.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:58:0) after 1m0s
[20:00:53.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:58:0)
[20:00:53.890] Timer tick, asking Buildbucket for the build status
[20:00:54.104] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:54.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:59:0) after 1m0s
[20:01:54.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:59:0)
[20:01:54.128] Timer tick, asking Buildbucket for the build status
[20:01:54.613] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:54.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:60:0) after 1m0s
[20:02:55.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:60:0)
[20:02:55.303] Timer tick, asking Buildbucket for the build status
[20:02:55.416] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:55.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:61:0) after 1m0s
[20:03:56.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:61:0)
[20:03:56.489] Timer tick, asking Buildbucket for the build status
[20:03:56.548] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:56.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:62:0) after 1m0s
[20:04:56.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:62:0)
[20:04:56.595] Timer tick, asking Buildbucket for the build status
[20:04:56.693] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:56.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:63:0) after 1m0s
[20:05:56.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:63:0)
[20:05:56.769] Timer tick, asking Buildbucket for the build status
[20:05:56.847] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:56.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:64:0) after 1m0s
[20:06:56.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:64:0)
[20:06:56.934] Timer tick, asking Buildbucket for the build status
[20:06:57.055] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:57.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:65:0) after 1m0s
[20:07:57.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:65:0)
[20:07:57.082] Timer tick, asking Buildbucket for the build status
[20:07:57.272] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:57.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:66:0) after 1m0s
[20:08:57.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:66:0)
[20:08:57.385] Timer tick, asking Buildbucket for the build status
[20:08:57.600] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:57.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:67:0) after 1m0s
[20:09:57.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:67:0)
[20:09:57.645] Timer tick, asking Buildbucket for the build status
[20:09:58.022] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:58.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:68:0) after 1m0s
[20:10:58.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:68:0)
[20:10:58.142] Timer tick, asking Buildbucket for the build status
[20:10:58.204] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:58.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:69:0) after 1m0s
[20:11:58.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:69:0)
[20:11:58.229] Timer tick, asking Buildbucket for the build status
[20:11:58.329] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:58.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:70:0) after 1m0s
[20:12:59.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:70:0)
[20:12:59.259] Timer tick, asking Buildbucket for the build status
[20:12:59.315] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:59.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:71:0) after 1m0s
[20:13:59.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:71:0)
[20:13:59.494] Timer tick, asking Buildbucket for the build status
[20:13:59.654] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:59.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:72:0) after 1m0s
[20:14:59.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:72:0)
[20:14:59.830] Timer tick, asking Buildbucket for the build status
[20:15:00.198] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:00.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:73:0) after 1m0s
[20:16:00.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:73:0)
[20:16:00.250] Timer tick, asking Buildbucket for the build status
[20:16:00.334] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:00.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:74:0) after 1m0s
[20:17:00.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:74:0)
[20:17:00.423] Timer tick, asking Buildbucket for the build status
[20:17:00.482] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:00.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:75:0) after 1m0s
[20:18:00.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:75:0)
[20:18:00.665] Timer tick, asking Buildbucket for the build status
[20:18:00.740] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:00.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:76:0) after 1m0s
[20:19:01.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:76:0)
[20:19:01.495] Timer tick, asking Buildbucket for the build status
[20:19:01.592] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:01.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:77:0) after 1m0s
[20:20:02.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:77:0)
[20:20:02.284] Timer tick, asking Buildbucket for the build status
[20:20:02.417] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:02.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:78:0) after 1m0s
[20:21:02.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:78:0)
[20:21:02.534] Timer tick, asking Buildbucket for the build status
[20:21:02.750] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:02.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:79:0) after 1m0s
[20:22:02.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:79:0)
[20:22:02.874] Timer tick, asking Buildbucket for the build status
[20:22:03.450] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:03.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:80:0) after 1m0s
[20:23:03.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:80:0)
[20:23:03.560] Timer tick, asking Buildbucket for the build status
[20:23:03.656] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:03.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:81:0) after 1m0s
[20:24:03.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:81:0)
[20:24:03.724] Timer tick, asking Buildbucket for the build status
[20:24:03.865] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:03.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:82:0) after 1m0s
[20:25:03.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:82:0)
[20:25:03.850] Timer tick, asking Buildbucket for the build status
[20:25:04.019] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:04.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:83:0) after 1m0s
[20:26:04.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:83:0)
[20:26:04.199] Timer tick, asking Buildbucket for the build status
[20:26:04.294] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:04.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:84:0) after 1m0s
[20:27:04.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:84:0)
[20:27:04.352] Timer tick, asking Buildbucket for the build status
[20:27:04.478] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:04.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:85:0) after 1m0s
[20:28:04.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:85:0)
[20:28:04.584] Timer tick, asking Buildbucket for the build status
[20:28:04.915] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:04.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:86:0) after 1m0s
[20:29:04.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:86:0)
[20:29:04.981] Timer tick, asking Buildbucket for the build status
[20:29:05.043] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:05.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:87:0) after 1m0s
[20:30:05.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:87:0)
[20:30:05.195] Timer tick, asking Buildbucket for the build status
[20:30:05.650] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:05.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:88:0) after 1m0s
[20:31:05.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:88:0)
[20:31:05.742] Timer tick, asking Buildbucket for the build status
[20:31:05.835] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:05.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:89:0) after 1m0s
[20:32:05.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:89:0)
[20:32:05.834] Timer tick, asking Buildbucket for the build status
[20:32:06.161] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:06.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:90:0) after 1m0s
[20:33:06.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:90:0)
[20:33:06.221] Timer tick, asking Buildbucket for the build status
[20:33:06.613] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:06.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:91:0) after 1m0s
[20:34:06.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:91:0)
[20:34:06.759] Timer tick, asking Buildbucket for the build status
[20:34:06.918] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:06.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:92:0) after 1m0s
[20:35:07.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:92:0)
[20:35:07.044] Timer tick, asking Buildbucket for the build status
[20:35:07.145] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:07.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:93:0) after 1m0s
[20:36:07.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:93:0)
[20:36:07.231] Timer tick, asking Buildbucket for the build status
[20:36:07.307] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:07.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:94:0) after 1m0s
[20:37:07.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:94:0)
[20:37:07.431] Timer tick, asking Buildbucket for the build status
[20:37:07.544] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:07.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:95:0) after 1m0s
[20:38:07.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:95:0)
[20:38:07.652] Timer tick, asking Buildbucket for the build status
[20:38:07.706] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:07.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:96:0) after 1m0s
[20:39:07.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:96:0)
[20:39:07.801] Timer tick, asking Buildbucket for the build status
[20:39:07.870] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:07.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:97:0) after 1m0s
[20:40:08.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:97:0)
[20:40:08.007] Timer tick, asking Buildbucket for the build status
[20:40:08.126] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:08.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:98:0) after 1m0s
[20:41:08.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:98:0)
[20:41:08.204] Timer tick, asking Buildbucket for the build status
[20:41:08.374] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:08.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:99:0) after 1m0s
[20:42:08.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:99:0)
[20:42:08.435] Timer tick, asking Buildbucket for the build status
[20:42:08.515] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:08.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:100:0) after 1m0s
[20:43:08.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:100:0)
[20:43:08.572] Timer tick, asking Buildbucket for the build status
[20:43:08.684] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:08.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:101:0) after 1m0s
[20:44:08.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:101:0)
[20:44:08.747] Timer tick, asking Buildbucket for the build status
[20:44:09.305] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:09.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:102:0) after 1m0s
[20:45:09.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:102:0)
[20:45:09.434] Timer tick, asking Buildbucket for the build status
[20:45:10.044] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:10.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:103:0) after 1m0s
[20:46:10.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:103:0)
[20:46:10.111] Timer tick, asking Buildbucket for the build status
[20:46:10.198] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:10.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:104:0) after 1m0s
[20:47:10.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:104:0)
[20:47:10.327] Timer tick, asking Buildbucket for the build status
[20:47:10.436] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:10.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:105:0) after 1m0s
[20:48:10.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:105:0)
[20:48:10.614] Timer tick, asking Buildbucket for the build status
[20:48:10.725] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:10.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:106:0) after 1m0s
[20:49:10.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:106:0)
[20:49:10.774] Timer tick, asking Buildbucket for the build status
[20:49:11.346] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:11.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:107:0) after 1m0s
[20:50:11.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:107:0)
[20:50:11.375] Timer tick, asking Buildbucket for the build status
[20:50:11.495] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:11.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:108:0) after 1m0s
[20:51:11.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:108:0)
[20:51:11.521] Timer tick, asking Buildbucket for the build status
[20:51:11.654] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:11.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:109:0) after 1m0s
[20:52:11.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:109:0)
[20:52:11.686] Timer tick, asking Buildbucket for the build status
[20:52:11.796] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:11.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:110:0) after 1m0s
[20:53:11.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:110:0)
[20:53:11.829] Timer tick, asking Buildbucket for the build status
[20:53:11.956] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:11.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:111:0) after 1m0s
[20:54:11.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:111:0)
[20:54:11.937] Timer tick, asking Buildbucket for the build status
[20:54:12.139] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:12.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:112:0) after 1m0s
[20:55:12.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:112:0)
[20:55:12.169] Timer tick, asking Buildbucket for the build status
[20:55:12.409] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:12.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:113:0) after 1m0s
[20:56:12.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:113:0)
[20:56:12.384] Timer tick, asking Buildbucket for the build status
[20:56:12.487] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:12.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:114:0) after 1m0s
[20:57:12.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:114:0)
[20:57:12.556] Timer tick, asking Buildbucket for the build status
[20:57:12.635] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:12.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:115:0) after 1m0s
[20:58:12.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:115:0)
[20:58:12.723] Timer tick, asking Buildbucket for the build status
[20:58:12.795] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:12.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:116:0) after 1m0s
[20:59:12.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:116:0)
[20:59:12.854] Timer tick, asking Buildbucket for the build status
[20:59:12.922] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:12.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:117:0) after 1m0s
[21:00:12.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:117:0)
[21:00:12.985] Timer tick, asking Buildbucket for the build status
[21:00:13.128] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:13.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:118:0) after 1m0s
[21:01:13.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:118:0)
[21:01:13.103] Timer tick, asking Buildbucket for the build status
[21:01:13.258] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:13.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:119:0) after 1m0s
[21:02:13.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:119:0)
[21:02:13.282] Timer tick, asking Buildbucket for the build status
[21:02:13.475] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:13.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:120:0) after 1m0s
[21:03:13.501] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:120:0)
[21:03:13.501] Timer tick, asking Buildbucket for the build status
[21:03:14.119] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:14.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:121:0) after 1m0s
[21:04:14.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:121:0)
[21:04:14.098] Timer tick, asking Buildbucket for the build status
[21:04:14.204] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:14.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:122:0) after 1m0s
[21:05:14.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:122:0)
[21:05:14.222] Timer tick, asking Buildbucket for the build status
[21:05:14.313] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:14.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:123:0) after 1m0s
[21:06:14.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:123:0)
[21:06:14.337] Timer tick, asking Buildbucket for the build status
[21:06:14.465] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:14.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:124:0) after 1m0s
[21:07:14.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:124:0)
[21:07:14.496] Timer tick, asking Buildbucket for the build status
[21:07:14.655] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:14.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:125:0) after 1m0s
[21:08:14.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:125:0)
[21:08:14.723] Timer tick, asking Buildbucket for the build status
[21:08:14.816] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:14.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:126:0) after 1m0s
[21:09:14.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:126:0)
[21:09:14.904] Timer tick, asking Buildbucket for the build status
[21:09:14.969] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:14.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:127:0) after 1m0s
[21:10:15.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:127:0)
[21:10:15.027] Timer tick, asking Buildbucket for the build status
[21:10:15.533] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:15.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:128:0) after 1m0s
[21:11:15.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:128:0)
[21:11:15.610] Timer tick, asking Buildbucket for the build status
[21:11:16.690] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:16.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:129:0) after 1m0s
[21:12:16.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:129:0)
[21:12:16.712] Timer tick, asking Buildbucket for the build status
[21:12:16.835] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:16.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:130:0) after 1m0s
[21:13:16.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:130:0)
[21:13:16.881] Timer tick, asking Buildbucket for the build status
[21:13:16.952] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:16.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:131:0) after 1m0s
[21:14:17.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:131:0)
[21:14:17.039] Timer tick, asking Buildbucket for the build status
[21:14:17.123] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:17.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:132:0) after 1m0s
[21:15:17.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:132:0)
[21:15:17.237] Timer tick, asking Buildbucket for the build status
[21:15:17.365] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:17.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:133:0) after 1m0s
[21:16:17.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:133:0)
[21:16:17.393] Timer tick, asking Buildbucket for the build status
[21:16:17.557] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:17.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:134:0) after 1m0s
[21:17:17.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:134:0)
[21:17:17.615] Timer tick, asking Buildbucket for the build status
[21:17:17.689] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:17.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:135:0) after 1m0s
[21:18:17.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:135:0)
[21:18:17.720] Timer tick, asking Buildbucket for the build status
[21:18:17.910] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:17.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:136:0) after 1m0s
[21:19:17.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:136:0)
[21:19:17.920] Timer tick, asking Buildbucket for the build status
[21:19:18.233] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:18.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:137:0) after 1m0s
[21:20:18.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:137:0)
[21:20:18.313] Timer tick, asking Buildbucket for the build status
[21:20:18.422] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:18.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:138:0) after 1m0s
[21:21:18.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:138:0)
[21:21:18.445] Timer tick, asking Buildbucket for the build status
[21:21:18.507] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:18.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:139:0) after 1m0s
[21:22:18.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:139:0)
[21:22:18.570] Timer tick, asking Buildbucket for the build status
[21:22:19.012] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:19.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:140:0) after 1m0s
[21:23:19.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:140:0)
[21:23:19.042] Timer tick, asking Buildbucket for the build status
[21:23:19.110] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:19.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:141:0) after 1m0s
[21:24:19.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:141:0)
[21:24:19.146] Timer tick, asking Buildbucket for the build status
[21:24:19.223] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:19.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:142:0) after 1m0s
[21:25:19.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:142:0)
[21:25:19.339] Timer tick, asking Buildbucket for the build status
[21:25:19.442] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:19.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:143:0) after 1m0s
[21:26:19.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:143:0)
[21:26:19.494] Timer tick, asking Buildbucket for the build status
[21:26:19.565] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:19.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:144:0) after 1m0s
[21:27:19.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:144:0)
[21:27:19.628] Timer tick, asking Buildbucket for the build status
[21:27:19.703] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:19.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:145:0) after 1m0s
[21:28:19.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:145:0)
[21:28:19.756] Timer tick, asking Buildbucket for the build status
[21:28:19.915] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:19.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:146:0) after 1m0s
[21:29:19.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:146:0)
[21:29:19.905] Timer tick, asking Buildbucket for the build status
[21:29:19.984] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:19.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:147:0) after 1m0s
[21:30:20.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:147:0)
[21:30:20.007] Timer tick, asking Buildbucket for the build status
[21:30:20.302] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:20.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:148:0) after 1m0s
[21:31:20.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:148:0)
[21:31:20.494] Timer tick, asking Buildbucket for the build status
[21:31:20.608] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:20.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:149:0) after 1m0s
[21:32:20.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:149:0)
[21:32:20.676] Timer tick, asking Buildbucket for the build status
[21:32:20.744] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:20.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:150:0) after 1m0s
[21:33:20.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:150:0)
[21:33:20.779] Timer tick, asking Buildbucket for the build status
[21:33:20.859] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:20.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:151:0) after 1m0s
[21:34:20.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:151:0)
[21:34:20.887] Timer tick, asking Buildbucket for the build status
[21:34:20.951] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:20.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:152:0) after 1m0s
[21:35:21.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:152:0)
[21:35:21.029] Timer tick, asking Buildbucket for the build status
[21:35:21.570] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:21.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:153:0) after 1m0s
[21:36:21.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:153:0)
[21:36:21.653] Timer tick, asking Buildbucket for the build status
[21:36:21.913] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:21.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:154:0) after 1m0s
[21:37:22.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:154:0)
[21:37:22.006] Timer tick, asking Buildbucket for the build status
[21:37:22.126] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:22.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:155:0) after 1m0s
[21:38:22.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:155:0)
[21:38:22.185] Timer tick, asking Buildbucket for the build status
[21:38:22.392] Build 8857197676459222192: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:22.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022627738493785680:156:0) after 1m0s
[21:38:45.006] Received PubSub notification, asking Buildbucket for the build status
[21:38:45.075] Build 8857197676459222192: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:38:45.075] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1611524324532238",
"created_by": "project:chromium",
"created_ts": "1611515082835192",
"failure_reason": "BUILD_FAILURE",
"id": "8857197676459222192",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- GalleryWatchManagerTest.RemoveAllWatches\"}, \"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\": \"3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3\", \"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-62-qn6a\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22326, \"got_angle_revision\": \"3c3b82abcf0a5c18b4d97ae49726045ce6d3b832\", \"got_dawn_revision\": \"f1f8394de04ea9532de763dfb2f968fc9610683b\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3\", \"got_revision_cp\": \"refs/heads/master@{#846590}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"f2b2f28304b332e59226ee6c0688307ed9982884\", \"got_v8_revision_cp\": \"refs/heads/9.0.57@{#1}\", \"got_webrtc_revision\": \"90776cb0ef72d437983c8d29e5a7f2ac264c107d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33064}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3\", \"swarm_hashes_refs/heads/master(at){#846590}_without_patch\": {\"absl_hardening_tests\": \"a3bd4b078a9f594562a4f2c6252dbdce7dbaf521\", \"accessibility_unittests\": \"fd95cb439330e0e1dd6b00b6f831119090fd06a6\", \"angle_unittests\": \"b115aa65c3d018216f882663c23552155eaa230a\", \"app_list_unittests\": \"e538b9f14df61c4214e08fa63ee824fa4db38b9f\", \"app_shell_unittests\": \"68fca04c7ef8d2f87e464c10cc6aeebdec4ac3e9\", \"ash_unittests\": \"0f38710629c62f1d5a16aab660f1bf0299852c50\", \"aura_unittests\": \"e87d84756e102a47d47fda62c865bc9537f4b83a\", \"base_unittests\": \"5d89cf795c3193c3368e1bab3719cfe8f5928140\", \"base_util_unittests\": \"12dae3edfad4eb2a751d11c33684e3f9711ddca6\", \"blink_common_unittests\": \"bbff958b6b996f1ad6121459c4fc00ca9af51704\", \"blink_fuzzer_unittests\": \"5416674f20f7c98a2d393982776b518806cb5c51\", \"blink_heap_unittests\": \"655fc3b67c569b111871553d9e3858377246590c\", \"blink_platform_unittests\": \"b1fcdc7d2d07b9fe0914ce885bf2f688d84b5f63\", \"blink_unittests\": \"ede2647b4a76fddb60a325c7cdf6f432d4591ba3\", \"boringssl_crypto_tests\": \"d18498d5161a89821f60049f177d17a189f1ac1c\", \"boringssl_ssl_tests\": \"203b25c35171c125cfbc18c61936df84ba20b908\", \"browser_tests\": \"975590a7140fada745663c2416b9509808c2e064\", \"capture_unittests\": \"29c80df15aa0dc8e1433e7ad066018406dcc67e9\", \"cast_unittests\": \"5bc959db5069fff28813a320670b8af97e67a2cd\", \"cc_unittests\": \"c2b0bb38492e99ec5ae0e49bcaaf7d4ba1fb3340\", \"chrome_app_unittests\": \"8199447c7d23ccc2d41621ebb6fe14aa379848a5\", \"chromedriver_unittests\": \"d9bb3a0641fa2ba642ae54ba2b7f80ffbd0bc2a4\", \"chromeos_components_unittests\": \"452845de8271cc8604b08f989d880ccaa7102232\", \"chromeos_unittests\": \"40431395533afa973cc9f411cf2b675b61cd6907\", \"components_browsertests\": \"5e389ee994ab790c110d57396580134d2dc0ed5a\", \"components_unittests\": \"d38a53d603969bfe8176ddda219ec09775629191\", \"compositor_unittests\": \"650269cffd2bdf24850ad6c91de7ba8e34b8ad7a\", \"content_browsertests\": \"fa40ba3d9d293c4b8b13a41ccf56dabaac615328\", \"content_unittests\": \"755d4906e5ca9c983f292b4ff981c05e3244c1d3\", \"crashpad_tests\": \"d0420808fbffdfeaec058facb56adb0daebf6a3f\", \"crypto_unittests\": \"23e9e54a086c15aaea103dc19c18ac00db0795cb\", \"dbus_unittests\": \"cf80aaaa41d01df8af2b134e3cebe1d3d0d980e8\", \"device_unittests\": \"f126bbb4f9aedaa992e0d30bd56bd29fe1735017\", \"display_unittests\": \"850facba9c036b8e1bac7a02aeff2ca6c70bbed2\", \"events_unittests\": \"488ba791b977444f13e45fc1897681457258e237\", \"exo_unittests\": \"38b957c787ba6c7fd53a4fda04878770a7703042\", \"extensions_browsertests\": \"912f9656ca3683f7bccaf5059b977f5e0ad21c9a\", \"extensions_unittests\": \"d54b9d7ae693a5b84e24981b1daa5abe1b6f6cd2\", \"filesystem_service_unittests\": \"b80a984bfcfa470cfc45932e3bc7de9b284172d9\", \"gcm_unit_tests\": \"44722f99c62d939d5d5ab063c1d416d09305c570\", \"gfx_unittests\": \"a61cd14972889af03ff10af1de13f563a0f7440e\", \"gin_unittests\": \"c22309d9e0f76160b07aeaa4877cc90b9f9c4869\", \"gl_unittests_ozone\": \"a67008cab59bec74bc6551a6a57c8771f6703158\", \"google_apis_unittests\": \"4ca6c82e1907392b83ca3304083894a0266fc3b2\", \"gpu_unittests\": \"f5cf82be0999456e36633d16a5a3b07e7dd20463\", \"gwp_asan_unittests\": \"33e5463c96ba9d12d5050976a9bde30f38bf0c2f\", \"interactive_ui_tests\": \"fd33514cd0fe07446936a8a4db5414d952b2b24f\", \"ipc_tests\": \"caace76828c07d0cfa8ce7c06a9f6265b9d49331\", \"jingle_unittests\": \"2c07376157233c62d434475901208f2455c839b6\", \"keyboard_unittests\": \"1f510a4facc4e358b37c004094341bce2de9561a\", \"latency_unittests\": \"4bc2f8c7723a0223f4042fa41b76dae6b0d5f4e7\", \"libjingle_xmpp_unittests\": \"2d44f5307d33f186cea3c89c81ee41955c2fc47a\", \"liburlpattern_unittests\": \"4dcc14172e32b2470af3c1ef92fe8b928f005a83\", \"media_blink_unittests\": \"5418705e4d1759d1b5374069ac547aea1a2d0ce1\", \"media_unittests\": \"b447e213a75cd5dc950e5003a0f83090718c65df\", \"message_center_unittests\": \"2f62dfc17e1e306e4216a81df5d6c95fc137807e\", \"midi_unittests\": \"59d9d04e01f4d13e9818b0e35df99fc1206e73ab\", \"mojo_core_unittests\": \"2d6068938942d1043c61d8a2c1068497a12419ff\", \"mojo_unittests\": \"2b3a7ef169badf209d1f1be9bcf76af32e620221\", \"nacl_helper_nonsfi_unittests\": \"f3c7be4dfb040885b8dedaf44399517a302df467\", \"nacl_loader_unittests\": \"6dd731f2ca1c2bbbda67d8b9e27a0be96c2e0754\", \"native_theme_unittests\": \"46399f638e467feed087df98ef4e9b4f660e507a\", \"net_unittests\": \"f47422dde97533466d11614ce253206571a433b5\", \"ozone_gl_unittests\": \"c0ed959073eb0ad69aecc4e33f0e56bf3461acab\", \"ozone_unittests\": \"930122a8dc680a3b7776f794e6fa233f54b9d862\", \"ozone_x11_unittests\": \"429475438edea562f9469e1434225256649db62c\", \"pdf_unittests\": \"ec0f44d8423d0250fa79d08179ad50da44bb117a\", \"perfetto_unittests\": \"51f87dd4922912657977133b98ecff9edb228492\", \"ppapi_unittests\": \"a93899772499e07ae84eb062f5266558daaac7e6\", \"printing_unittests\": \"cc290c6dadf541deedbd3e8cb614fb1df49568b8\", \"remoting_unittests\": \"b62b45893456c0a6d0d4c56738de418d0472dac1\", \"sandbox_linux_unittests\": \"87fddbcf7184b9e45062242efdf5a1d185f7d271\", \"service_manager_unittests\": \"700a1534ed95cbd6f8362c7a3ffba924da5aa37d\", \"services_unittests\": \"1e8bc78cb91c01cda8f690bc00bfa79ef66e9d15\", \"shell_dialogs_unittests\": \"7b7ab936628b412a026118cfe302fb7e359d36d8\", \"shell_encryption_unittests\": \"97f72235aaeab1f242ae8785ba54f60e6f683d86\", \"skia_unittests\": \"18634d689e3d44afaae24ca7636e22483c7aa92a\", \"snapshot_unittests\": \"967f6769b7b3091daaad7fd73f2e317665a37e4a\", \"sql_unittests\": \"e9b8134b70cb790b78419755f5741a9f15c1e5fa\", \"storage_unittests\": \"d3988b3d06299025535b5de5fb9c9f844f5aed57\", \"sync_integration_tests\": \"3c20ae2e97f3cbd7ff11dc5d2e9651d20057ff0a\", \"traffic_annotation_auditor_unittests\": \"b1583a5cd46900bdd6eb56d6dd3a70e1bbff888d\", \"ui_base_unittests\": \"96f9f87663a5cc0870de9cb299be5f43111b9b63\", \"ui_chromeos_unittests\": \"1fb26ba599968698475a5365e515ccecbedf6eb1\", \"ui_touch_selection_unittests\": \"671a28d52b57d4f32fee6638c5580ed2830e8776\", \"unit_tests\": \"6be591de55819e0efe7c188b842494aeaa4dfc6c\", \"url_unittests\": \"57d1481c20b737ba4027526b833052f0c84c3aa9\", \"usage_time_limit_unittests\": \"ac2a9500c9568098f93af80e23a5a29ad935706c\", \"views_unittests\": \"5b4b57182a6d7aa21f2eb6089b8286b0da0edba2\", \"viz_unittests\": \"024dabb4c9f10f9555e173f8822b11c93fd2bc90\", \"wm_unittests\": \"3b21002f22e52428046c70a706beb0c9a4bec9f6\", \"wtf_unittests\": \"9939b4557868d699a6d6cc862a78d47313a59cfe\", \"zlib_unittests\": \"3a4b441cf295279b23fd9b4be9dec5a39012eb65\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1415e99d1ada386cfb0c84043d2495490d2cdcd28ad7785eb6837a9119e6428f_v2\", \"builder_b9373cfdcc5f43b5e07cc4931fc34027757a424c7183ae2b31ae65ec7718ca12_v2\", \"builder_de67dcb387b95c18ea83e54ea320474d260d319089536d63e3279fdbb975ff72_v2\", \"builder_f0afc432815c064941e1e5f998abb72673d4068febb53723f4aedad56e1b9c62_v2\", \"builder_fe5305c96c631c9bcc74a68d877d31a94a8d3c28663b28d2fadfc8f798de4ec0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-62-qn6a\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- GalleryWatchManagerTest.RemoveAllWatches\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611517755388743",
"status": "COMPLETED",
"status_changed_ts": "1611517755834043",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22326",
"builder:linux-chromeos-dbg",
"buildset:commit/git/3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3dfbeec0b4240c9b7f6b1a19fdfeab92d86790d3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022627738493785680",
"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/8857197676459222192/+/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:514e9a43a5f27210",
"user_agent:luci-scheduler"
],
"updated_ts": "1611524324751702",
"url": "https://ci.chromium.org/b/8857197676459222192",
"utcnow_ts": "1611524325066446"
}
}
[21:38:45.075] Invocation finished in 2h34m3.56389835s with status FAILED