[09:55:56.711] New invocation is queued and will start shortly
[09:55:57.800] Starting the invocation (attempt 1)
[09:55:57.830] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:55:57.830] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:55:57.830] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020125547604626752",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020125547604626752",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"gitiles_ref:refs/heads/master"
]
}
[09:55:59.674] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613901357935904",
"id": "8854695485659894352",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613901359298614",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22717",
"builder:linux-chromeos-dbg",
"buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020125547604626752",
"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/8854695485659894352/+/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": "1613901359299283",
"url": "https://ci.chromium.org/b/8854695485659894352",
"utcnow_ts": "1613901359668020"
}
}
[09:55:59.674] Task URL: https://ci.chromium.org/b/8854695485659894352
[09:55:59.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:2:0) after 1m0s
[09:56:59.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:2:0)
[09:56:59.705] Timer tick, asking Buildbucket for the build status
[09:56:59.791] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:59.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:3:0) after 1m0s
[09:57:59.817] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:3:0)
[09:57:59.817] Timer tick, asking Buildbucket for the build status
[09:57:59.881] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:59.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:4:0) after 1m0s
[09:58:59.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:4:0)
[09:58:59.899] Timer tick, asking Buildbucket for the build status
[09:59:00.046] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:00.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:5:0) after 1m0s
[10:00:00.063] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:5:0)
[10:00:00.063] Timer tick, asking Buildbucket for the build status
[10:00:00.139] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:00.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:6:0) after 1m0s
[10:01:00.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:6:0)
[10:01:00.153] Timer tick, asking Buildbucket for the build status
[10:01:00.309] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:00.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:7:0) after 1m0s
[10:02:00.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:7:0)
[10:02:00.327] Timer tick, asking Buildbucket for the build status
[10:02:00.427] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:00.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:8:0) after 1m0s
[10:03:00.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:8:0)
[10:03:00.499] Timer tick, asking Buildbucket for the build status
[10:03:00.596] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:00.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:9:0) after 1m0s
[10:04:00.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:9:0)
[10:04:00.810] Timer tick, asking Buildbucket for the build status
[10:04:00.874] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:00.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:10:0) after 1m0s
[10:05:00.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:10:0)
[10:05:00.997] Timer tick, asking Buildbucket for the build status
[10:05:01.131] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:05:01.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:11:0) after 1m0s
[10:06:01.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:11:0)
[10:06:01.200] Timer tick, asking Buildbucket for the build status
[10:06:01.290] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:06:01.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:12:0) after 1m0s
[10:07:01.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:12:0)
[10:07:01.467] Timer tick, asking Buildbucket for the build status
[10:07:01.520] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:07:01.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:13:0) after 1m0s
[10:08:01.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:13:0)
[10:08:01.694] Timer tick, asking Buildbucket for the build status
[10:08:01.811] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:08:01.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:14:0) after 1m0s
[10:09:01.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:14:0)
[10:09:01.927] Timer tick, asking Buildbucket for the build status
[10:09:01.986] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:09:01.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:15:0) after 1m0s
[10:10:02.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:15:0)
[10:10:02.103] Timer tick, asking Buildbucket for the build status
[10:10:02.194] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:10:02.194] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:16:0) after 1m0s
[10:11:02.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:16:0)
[10:11:02.369] Timer tick, asking Buildbucket for the build status
[10:11:02.487] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:11:02.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:17:0) after 1m0s
[10:12:02.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:17:0)
[10:12:02.466] Timer tick, asking Buildbucket for the build status
[10:12:02.535] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:12:02.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:18:0) after 1m0s
[10:13:02.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:18:0)
[10:13:02.609] Timer tick, asking Buildbucket for the build status
[10:13:02.706] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:13:02.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:19:0) after 1m0s
[10:14:02.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:19:0)
[10:14:02.773] Timer tick, asking Buildbucket for the build status
[10:14:02.895] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:14:02.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:20:0) after 1m0s
[10:15:02.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:20:0)
[10:15:02.922] Timer tick, asking Buildbucket for the build status
[10:15:03.004] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:15:03.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:21:0) after 1m0s
[10:16:03.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:21:0)
[10:16:03.022] Timer tick, asking Buildbucket for the build status
[10:16:03.108] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:16:03.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:22:0) after 1m0s
[10:17:03.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:22:0)
[10:17:03.120] Timer tick, asking Buildbucket for the build status
[10:17:03.304] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:17:03.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:23:0) after 1m0s
[10:18:03.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:23:0)
[10:18:03.405] Timer tick, asking Buildbucket for the build status
[10:18:03.480] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:18:03.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:24:0) after 1m0s
[10:19:03.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:24:0)
[10:19:03.506] Timer tick, asking Buildbucket for the build status
[10:19:03.718] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:19:03.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:25:0) after 1m0s
[10:20:03.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:25:0)
[10:20:03.867] Timer tick, asking Buildbucket for the build status
[10:20:04.041] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:20:04.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:26:0) after 1m0s
[10:21:04.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:26:0)
[10:21:04.048] Timer tick, asking Buildbucket for the build status
[10:21:04.302] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:21:04.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:27:0) after 1m0s
[10:22:04.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:27:0)
[10:22:04.521] Timer tick, asking Buildbucket for the build status
[10:22:04.597] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:22:04.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:28:0) after 1m0s
[10:23:04.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:28:0)
[10:23:04.707] Timer tick, asking Buildbucket for the build status
[10:23:04.789] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:23:04.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:29:0) after 1m0s
[10:24:04.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:29:0)
[10:24:04.897] Timer tick, asking Buildbucket for the build status
[10:24:04.964] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:24:04.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:30:0) after 1m0s
[10:25:05.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:30:0)
[10:25:05.014] Timer tick, asking Buildbucket for the build status
[10:25:05.077] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:05.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:31:0) after 1m0s
[10:26:05.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:31:0)
[10:26:05.160] Timer tick, asking Buildbucket for the build status
[10:26:05.427] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:26:05.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:32:0) after 1m0s
[10:27:05.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:32:0)
[10:27:05.508] Timer tick, asking Buildbucket for the build status
[10:27:05.572] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:27:05.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:33:0) after 1m0s
[10:28:05.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:33:0)
[10:28:05.645] Timer tick, asking Buildbucket for the build status
[10:28:05.734] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:28:05.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:34:0) after 1m0s
[10:29:05.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:34:0)
[10:29:05.846] Timer tick, asking Buildbucket for the build status
[10:29:06.079] Build 8854695485659894352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:29:06.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:35:0) after 1m0s
[10:29:57.979] Received PubSub notification, asking Buildbucket for the build status
[10:29:58.058] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:06.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:35:0)
[10:30:06.152] Timer tick, asking Buildbucket for the build status
[10:30:06.217] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:06.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:37:0) after 1m0s
[10:31:06.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:37:0)
[10:31:06.480] Timer tick, asking Buildbucket for the build status
[10:31:06.567] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:06.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:38:0) after 1m0s
[10:32:06.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:38:0)
[10:32:06.731] Timer tick, asking Buildbucket for the build status
[10:32:06.802] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:06.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:39:0) after 1m0s
[10:33:06.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:39:0)
[10:33:06.980] Timer tick, asking Buildbucket for the build status
[10:33:07.047] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:07.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:40:0) after 1m0s
[10:34:07.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:40:0)
[10:34:07.026] Timer tick, asking Buildbucket for the build status
[10:34:07.188] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:07.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:41:0) after 1m0s
[10:35:07.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:41:0)
[10:35:07.206] Timer tick, asking Buildbucket for the build status
[10:35:07.317] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:07.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:42:0) after 1m0s
[10:36:07.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:42:0)
[10:36:07.340] Timer tick, asking Buildbucket for the build status
[10:36:07.442] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:07.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:43:0) after 1m0s
[10:37:07.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:43:0)
[10:37:07.491] Timer tick, asking Buildbucket for the build status
[10:37:07.554] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:07.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:44:0) after 1m0s
[10:38:07.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:44:0)
[10:38:07.553] Timer tick, asking Buildbucket for the build status
[10:38:07.726] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:07.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:45:0) after 1m0s
[10:39:07.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:45:0)
[10:39:07.730] Timer tick, asking Buildbucket for the build status
[10:39:07.826] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:07.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:46:0) after 1m0s
[10:40:07.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:46:0)
[10:40:07.815] Timer tick, asking Buildbucket for the build status
[10:40:07.896] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:07.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:47:0) after 1m0s
[10:41:07.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:47:0)
[10:41:07.917] Timer tick, asking Buildbucket for the build status
[10:41:08.024] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:08.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:48:0) after 1m0s
[10:42:08.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:48:0)
[10:42:08.047] Timer tick, asking Buildbucket for the build status
[10:42:08.312] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:08.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:49:0) after 1m0s
[10:43:08.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:49:0)
[10:43:08.372] Timer tick, asking Buildbucket for the build status
[10:43:08.521] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:08.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:50:0) after 1m0s
[10:44:08.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:50:0)
[10:44:08.546] Timer tick, asking Buildbucket for the build status
[10:44:08.611] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:08.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:51:0) after 1m0s
[10:45:08.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:51:0)
[10:45:08.630] Timer tick, asking Buildbucket for the build status
[10:45:08.722] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:08.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:52:0) after 1m0s
[10:46:08.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:52:0)
[10:46:08.746] Timer tick, asking Buildbucket for the build status
[10:46:08.847] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:08.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:53:0) after 1m0s
[10:47:08.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:53:0)
[10:47:08.873] Timer tick, asking Buildbucket for the build status
[10:47:09.037] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:09.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:54:0) after 1m0s
[10:48:09.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:54:0)
[10:48:09.059] Timer tick, asking Buildbucket for the build status
[10:48:09.689] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:09.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:55:0) after 1m0s
[10:49:09.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:55:0)
[10:49:09.783] Timer tick, asking Buildbucket for the build status
[10:49:09.889] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:09.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:56:0) after 1m0s
[10:50:09.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:56:0)
[10:50:09.953] Timer tick, asking Buildbucket for the build status
[10:50:10.317] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:10.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:57:0) after 1m0s
[10:51:10.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:57:0)
[10:51:10.349] Timer tick, asking Buildbucket for the build status
[10:51:10.496] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:10.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:58:0) after 1m0s
[10:52:10.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:58:0)
[10:52:10.561] Timer tick, asking Buildbucket for the build status
[10:52:10.631] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:10.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:59:0) after 1m0s
[10:53:10.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:59:0)
[10:53:10.748] Timer tick, asking Buildbucket for the build status
[10:53:11.185] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:11.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:60:0) after 1m0s
[10:54:11.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:60:0)
[10:54:11.294] Timer tick, asking Buildbucket for the build status
[10:54:11.429] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:11.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:61:0) after 1m0s
[10:55:11.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:61:0)
[10:55:11.482] Timer tick, asking Buildbucket for the build status
[10:55:11.904] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:11.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:62:0) after 1m0s
[10:56:11.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:62:0)
[10:56:11.889] Timer tick, asking Buildbucket for the build status
[10:56:12.059] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:12.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:63:0) after 1m0s
[10:57:12.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:63:0)
[10:57:12.076] Timer tick, asking Buildbucket for the build status
[10:57:12.235] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:12.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:64:0) after 1m0s
[10:58:12.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:64:0)
[10:58:12.257] Timer tick, asking Buildbucket for the build status
[10:58:12.395] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:12.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:65:0) after 1m0s
[10:59:12.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:65:0)
[10:59:12.448] Timer tick, asking Buildbucket for the build status
[10:59:12.727] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:12.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:66:0) after 1m0s
[11:00:12.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:66:0)
[11:00:12.787] Timer tick, asking Buildbucket for the build status
[11:00:13.088] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:13.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:67:0) after 1m0s
[11:01:13.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:67:0)
[11:01:13.158] Timer tick, asking Buildbucket for the build status
[11:01:13.269] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:13.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:68:0) after 1m0s
[11:02:13.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:68:0)
[11:02:13.337] Timer tick, asking Buildbucket for the build status
[11:02:13.413] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:13.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:69:0) after 1m0s
[11:03:13.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:69:0)
[11:03:13.463] Timer tick, asking Buildbucket for the build status
[11:03:13.540] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:13.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:70:0) after 1m0s
[11:04:13.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:70:0)
[11:04:13.562] Timer tick, asking Buildbucket for the build status
[11:04:13.638] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:13.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:71:0) after 1m0s
[11:05:13.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:71:0)
[11:05:13.658] Timer tick, asking Buildbucket for the build status
[11:05:13.737] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:13.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:72:0) after 1m0s
[11:06:13.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:72:0)
[11:06:13.757] Timer tick, asking Buildbucket for the build status
[11:06:13.879] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:13.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:73:0) after 1m0s
[11:07:13.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:73:0)
[11:07:13.927] Timer tick, asking Buildbucket for the build status
[11:07:14.154] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:14.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:74:0) after 1m0s
[11:08:14.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:74:0)
[11:08:14.185] Timer tick, asking Buildbucket for the build status
[11:08:14.253] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:14.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:75:0) after 1m0s
[11:09:14.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:75:0)
[11:09:14.299] Timer tick, asking Buildbucket for the build status
[11:09:14.547] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:14.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:76:0) after 1m0s
[11:10:14.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:76:0)
[11:10:14.702] Timer tick, asking Buildbucket for the build status
[11:10:14.824] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:14.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:77:0) after 1m0s
[11:11:15.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:77:0)
[11:11:15.257] Timer tick, asking Buildbucket for the build status
[11:11:15.375] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:15.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:78:0) after 1m0s
[11:12:15.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:78:0)
[11:12:15.393] Timer tick, asking Buildbucket for the build status
[11:12:15.478] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:15.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:79:0) after 1m0s
[11:13:15.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:79:0)
[11:13:15.506] Timer tick, asking Buildbucket for the build status
[11:13:15.573] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:15.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:80:0) after 1m0s
[11:14:15.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:80:0)
[11:14:15.594] Timer tick, asking Buildbucket for the build status
[11:14:15.920] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:15.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:81:0) after 1m0s
[11:15:15.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:81:0)
[11:15:15.988] Timer tick, asking Buildbucket for the build status
[11:15:16.106] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:16.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:82:0) after 1m0s
[11:16:16.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:82:0)
[11:16:16.231] Timer tick, asking Buildbucket for the build status
[11:16:16.359] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:16.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:83:0) after 1m0s
[11:17:16.742] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:83:0)
[11:17:16.742] Timer tick, asking Buildbucket for the build status
[11:17:16.840] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:16.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:84:0) after 1m0s
[11:18:17.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:84:0)
[11:18:17.049] Timer tick, asking Buildbucket for the build status
[11:18:17.132] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:17.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:85:0) after 1m0s
[11:19:17.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:85:0)
[11:19:17.278] Timer tick, asking Buildbucket for the build status
[11:19:17.379] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:17.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:86:0) after 1m0s
[11:20:17.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:86:0)
[11:20:17.556] Timer tick, asking Buildbucket for the build status
[11:20:17.934] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:17.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:87:0) after 1m0s
[11:21:17.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:87:0)
[11:21:17.961] Timer tick, asking Buildbucket for the build status
[11:21:18.185] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:18.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:88:0) after 1m0s
[11:22:18.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:88:0)
[11:22:18.273] Timer tick, asking Buildbucket for the build status
[11:22:18.423] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:18.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:89:0) after 1m0s
[11:23:18.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:89:0)
[11:23:18.561] Timer tick, asking Buildbucket for the build status
[11:23:18.934] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:18.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:90:0) after 1m0s
[11:24:19.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:90:0)
[11:24:19.120] Timer tick, asking Buildbucket for the build status
[11:24:19.201] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:19.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:91:0) after 1m0s
[11:25:19.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:91:0)
[11:25:19.289] Timer tick, asking Buildbucket for the build status
[11:25:19.372] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:19.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:92:0) after 1m0s
[11:26:19.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:92:0)
[11:26:19.494] Timer tick, asking Buildbucket for the build status
[11:26:19.956] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:19.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:93:0) after 1m0s
[11:27:19.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:93:0)
[11:27:19.977] Timer tick, asking Buildbucket for the build status
[11:27:20.099] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:20.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:94:0) after 1m0s
[11:28:20.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:94:0)
[11:28:20.123] Timer tick, asking Buildbucket for the build status
[11:28:20.187] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:20.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:95:0) after 1m0s
[11:29:20.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:95:0)
[11:29:20.212] Timer tick, asking Buildbucket for the build status
[11:29:20.302] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:20.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:96:0) after 1m0s
[11:30:20.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:96:0)
[11:30:20.404] Timer tick, asking Buildbucket for the build status
[11:30:20.512] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:20.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:97:0) after 1m0s
[11:31:20.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:97:0)
[11:31:20.597] Timer tick, asking Buildbucket for the build status
[11:31:20.844] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:20.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:98:0) after 1m0s
[11:32:20.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:98:0)
[11:32:20.853] Timer tick, asking Buildbucket for the build status
[11:32:20.942] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:20.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:99:0) after 1m0s
[11:33:20.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:99:0)
[11:33:20.961] Timer tick, asking Buildbucket for the build status
[11:33:21.050] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:21.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:100:0) after 1m0s
[11:34:21.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:100:0)
[11:34:21.103] Timer tick, asking Buildbucket for the build status
[11:34:21.193] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:21.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:101:0) after 1m0s
[11:35:21.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:101:0)
[11:35:21.222] Timer tick, asking Buildbucket for the build status
[11:35:21.696] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:21.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:102:0) after 1m0s
[11:36:21.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:102:0)
[11:36:21.719] Timer tick, asking Buildbucket for the build status
[11:36:21.909] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:21.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:103:0) after 1m0s
[11:37:21.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:103:0)
[11:37:21.935] Timer tick, asking Buildbucket for the build status
[11:37:22.006] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:22.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:104:0) after 1m0s
[11:38:22.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:104:0)
[11:38:22.030] Timer tick, asking Buildbucket for the build status
[11:38:22.228] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:22.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:105:0) after 1m0s
[11:39:22.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:105:0)
[11:39:22.249] Timer tick, asking Buildbucket for the build status
[11:39:22.363] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:22.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:106:0) after 1m0s
[11:40:22.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:106:0)
[11:40:22.433] Timer tick, asking Buildbucket for the build status
[11:40:22.518] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:22.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:107:0) after 1m0s
[11:41:22.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:107:0)
[11:41:22.520] Timer tick, asking Buildbucket for the build status
[11:41:22.730] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:22.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:108:0) after 1m0s
[11:42:22.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:108:0)
[11:42:22.726] Timer tick, asking Buildbucket for the build status
[11:42:22.889] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:22.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:109:0) after 1m0s
[11:43:22.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:109:0)
[11:43:22.973] Timer tick, asking Buildbucket for the build status
[11:43:23.093] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:23.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:110:0) after 1m0s
[11:44:23.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:110:0)
[11:44:23.102] Timer tick, asking Buildbucket for the build status
[11:44:23.178] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:23.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:111:0) after 1m0s
[11:45:23.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:111:0)
[11:45:23.259] Timer tick, asking Buildbucket for the build status
[11:45:23.338] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:23.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:112:0) after 1m0s
[11:46:23.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:112:0)
[11:46:23.420] Timer tick, asking Buildbucket for the build status
[11:46:23.850] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:23.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:113:0) after 1m0s
[11:47:23.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:113:0)
[11:47:23.995] Timer tick, asking Buildbucket for the build status
[11:47:24.124] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:24.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:114:0) after 1m0s
[11:48:24.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:114:0)
[11:48:24.279] Timer tick, asking Buildbucket for the build status
[11:48:24.360] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:24.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:115:0) after 1m0s
[11:49:24.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:115:0)
[11:49:24.399] Timer tick, asking Buildbucket for the build status
[11:49:24.814] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:24.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:116:0) after 1m0s
[11:50:24.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:116:0)
[11:50:24.945] Timer tick, asking Buildbucket for the build status
[11:50:25.046] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:25.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:117:0) after 1m0s
[11:51:25.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:117:0)
[11:51:25.100] Timer tick, asking Buildbucket for the build status
[11:51:25.331] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:25.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:118:0) after 1m0s
[11:52:25.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:118:0)
[11:52:25.392] Timer tick, asking Buildbucket for the build status
[11:52:25.471] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:25.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:119:0) after 1m0s
[11:53:25.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:119:0)
[11:53:25.623] Timer tick, asking Buildbucket for the build status
[11:53:25.715] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:25.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:120:0) after 1m0s
[11:54:25.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:120:0)
[11:54:25.787] Timer tick, asking Buildbucket for the build status
[11:54:26.013] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:26.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:121:0) after 1m0s
[11:55:26.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:121:0)
[11:55:26.004] Timer tick, asking Buildbucket for the build status
[11:55:26.079] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:26.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:122:0) after 1m0s
[11:56:26.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:122:0)
[11:56:26.122] Timer tick, asking Buildbucket for the build status
[11:56:26.230] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:26.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:123:0) after 1m0s
[11:57:26.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:123:0)
[11:57:26.252] Timer tick, asking Buildbucket for the build status
[11:57:26.412] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:26.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:124:0) after 1m0s
[11:58:26.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:124:0)
[11:58:26.476] Timer tick, asking Buildbucket for the build status
[11:58:26.817] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:26.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:125:0) after 1m0s
[11:59:26.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:125:0)
[11:59:26.892] Timer tick, asking Buildbucket for the build status
[11:59:27.039] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:27.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:126:0) after 1m0s
[12:00:27.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:126:0)
[12:00:27.127] Timer tick, asking Buildbucket for the build status
[12:00:27.260] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:27.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:127:0) after 1m0s
[12:01:27.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:127:0)
[12:01:27.289] Timer tick, asking Buildbucket for the build status
[12:01:27.436] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:27.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:128:0) after 1m0s
[12:02:27.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:128:0)
[12:02:27.447] Timer tick, asking Buildbucket for the build status
[12:02:27.521] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:27.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:129:0) after 1m0s
[12:03:27.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:129:0)
[12:03:27.548] Timer tick, asking Buildbucket for the build status
[12:03:28.043] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:28.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:130:0) after 1m0s
[12:04:28.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:130:0)
[12:04:28.087] Timer tick, asking Buildbucket for the build status
[12:04:28.500] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:28.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:131:0) after 1m0s
[12:05:28.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:131:0)
[12:05:28.519] Timer tick, asking Buildbucket for the build status
[12:05:28.749] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:28.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:132:0) after 1m0s
[12:06:28.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:132:0)
[12:06:28.795] Timer tick, asking Buildbucket for the build status
[12:06:28.945] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:28.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:133:0) after 1m0s
[12:07:29.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:133:0)
[12:07:29.005] Timer tick, asking Buildbucket for the build status
[12:07:29.314] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:29.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:134:0) after 1m0s
[12:08:29.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:134:0)
[12:08:29.369] Timer tick, asking Buildbucket for the build status
[12:08:29.597] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:29.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:135:0) after 1m0s
[12:09:29.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:135:0)
[12:09:29.630] Timer tick, asking Buildbucket for the build status
[12:09:29.763] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:29.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:136:0) after 1m0s
[12:10:29.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:136:0)
[12:10:29.838] Timer tick, asking Buildbucket for the build status
[12:10:30.310] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:30.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:137:0) after 1m0s
[12:11:30.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:137:0)
[12:11:30.382] Timer tick, asking Buildbucket for the build status
[12:11:30.480] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:30.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:138:0) after 1m0s
[12:12:30.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:138:0)
[12:12:30.502] Timer tick, asking Buildbucket for the build status
[12:12:30.580] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:30.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:139:0) after 1m0s
[12:13:30.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:139:0)
[12:13:30.600] Timer tick, asking Buildbucket for the build status
[12:13:30.694] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:30.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:140:0) after 1m0s
[12:14:30.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:140:0)
[12:14:30.760] Timer tick, asking Buildbucket for the build status
[12:14:30.955] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:30.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:141:0) after 1m0s
[12:15:31.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:141:0)
[12:15:31.005] Timer tick, asking Buildbucket for the build status
[12:15:31.393] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:31.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:142:0) after 1m0s
[12:16:31.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:142:0)
[12:16:31.413] Timer tick, asking Buildbucket for the build status
[12:16:31.514] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:31.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:143:0) after 1m0s
[12:17:31.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:143:0)
[12:17:31.573] Timer tick, asking Buildbucket for the build status
[12:17:31.648] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:31.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:144:0) after 1m0s
[12:18:31.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:144:0)
[12:18:31.685] Timer tick, asking Buildbucket for the build status
[12:18:31.766] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:31.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:145:0) after 1m0s
[12:19:31.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:145:0)
[12:19:31.868] Timer tick, asking Buildbucket for the build status
[12:19:31.960] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:31.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:146:0) after 1m0s
[12:20:32.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:146:0)
[12:20:32.044] Timer tick, asking Buildbucket for the build status
[12:20:32.240] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:32.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:147:0) after 1m0s
[12:21:32.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:147:0)
[12:21:32.238] Timer tick, asking Buildbucket for the build status
[12:21:32.358] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:32.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:148:0) after 1m0s
[12:22:32.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:148:0)
[12:22:32.436] Timer tick, asking Buildbucket for the build status
[12:22:32.534] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:32.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:149:0) after 1m0s
[12:23:32.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:149:0)
[12:23:32.553] Timer tick, asking Buildbucket for the build status
[12:23:32.764] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:32.764] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:150:0) after 1m0s
[12:24:32.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:150:0)
[12:24:32.792] Timer tick, asking Buildbucket for the build status
[12:24:32.880] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:32.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:151:0) after 1m0s
[12:25:32.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:151:0)
[12:25:32.902] Timer tick, asking Buildbucket for the build status
[12:25:32.982] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:32.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:152:0) after 1m0s
[12:26:33.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:152:0)
[12:26:33.148] Timer tick, asking Buildbucket for the build status
[12:26:33.315] Build 8854695485659894352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:33.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020125547604626752:153:0) after 1m0s
[12:27:22.449] Received PubSub notification, asking Buildbucket for the build status
[12:27:22.692] Build 8854695485659894352: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:27:22.692] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613910441516229",
"created_by": "project:chromium",
"created_ts": "1613901357935904",
"failure_reason": "BUILD_FAILURE",
"id": "8854695485659894352",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- WebRtcSignalingMessengerTest.UnsuccessfulSendMessage_EmptyToken\"}, \"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\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"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-18-xpkt\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22717, \"got_angle_revision\": \"6e8cdd39b19912e7fe6408b0318d0907dc7e4d21\", \"got_dawn_revision\": \"1258e245a978083cab0b707c84dea814eadb3fbb\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"got_revision_cp\": \"refs/heads/master@{#856142}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"d85a7a27b27269741a779a72f33436b83d98687c\", \"got_v8_revision\": \"2430d8fffa7d4f8a0992bcb5eb3725e5367cd9ac\", \"got_v8_revision_cp\": \"refs/heads/9.0.229@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"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\": \"22f65038fa8c2d2cd9143435b89ac5f200c33bb2\", \"swarm_hashes_refs/heads/master(at){#856142}_without_patch\": {\"absl_hardening_tests\": \"6d780892097b0a8b3d8e7088fd6a166f25a37196\", \"accessibility_unittests\": \"48d83ad50e5c032174c8d9bf8db7fb9aefb0b898\", \"angle_unittests\": \"545098b2a6efce1242c0f1121e3d6be86400548a\", \"app_list_unittests\": \"1ff26481b7e3c39da2e8c458b2ca2b8106d16b33\", \"app_shell_unittests\": \"1c61c1e9427668490637a7c5d9b470c6f97bb895\", \"ash_unittests\": \"5c21cf2cfa03f9cb550961cf18d39c811bac014d\", \"aura_unittests\": \"a64aa8de44853ee929229b016c840a7a6fd3792b\", \"base_unittests\": \"c1d32eb7d821f5b706cc8dbf6b5c13772c84dae6\", \"base_util_unittests\": \"d1cd169f6aab1216bcb2248a5d45b473ab3aaa70\", \"blink_common_unittests\": \"0f82df698735ec50956cc9ea8030f59dfa043e9b\", \"blink_fuzzer_unittests\": \"4110469ba48c4fa36f0a53fe682cb70d36819a83\", \"blink_heap_unittests\": \"290a13616799a5b37a70daf8ffff6184f374839e\", \"blink_platform_unittests\": \"27ce091b552d7224bda81093938078c07e140341\", \"blink_unittests\": \"8700147f38f10e87c7856eecb6475d7ef77eac4d\", \"boringssl_crypto_tests\": \"864d73ae1929e5d268c9b176aca6fcff14b5be78\", \"boringssl_ssl_tests\": \"65d26cec7dad054d40fae3cb71fd465f0e154fbc\", \"browser_tests\": \"7bebcb3cc77c6ac23d7fee76bbbb8a59f970ee2f\", \"capture_unittests\": \"4aa11768544b482bc0020860bea5c37176ebd1f0\", \"cast_unittests\": \"baa63105ccdac45e03c9364a9b15f621eb1e5451\", \"cc_unittests\": \"734d654f4d4bc02e468d4d5b6db976114af05b0b\", \"chrome_app_unittests\": \"38742b2f28d5093a3b103c3941f1745f108ae1e2\", \"chromedriver_unittests\": \"0f95de64bedf30edb7c355e65631e26ec34d35ef\", \"chromeos_components_unittests\": \"7148621bf296ebe212912b2b5f55321e879a3485\", \"chromeos_unittests\": \"b9d592ce66203fbe0a498243777ec816bb487132\", \"components_browsertests\": \"abc1325cbf5028026b5c56237b96b745abdd39a4\", \"components_unittests\": \"00d72eba743461d07f1bda8c248fe8d17aadc72a\", \"compositor_unittests\": \"e76087792535704476100fc587497c6407e4dc03\", \"content_browsertests\": \"c3534426666518910fb1b82a34d44860cd4c53ba\", \"content_unittests\": \"839d07d4c4c687dc4c3026bd38301628700efd1b\", \"crashpad_tests\": \"a261fd766d05c991fcdd914b70c3525eacafd634\", \"crypto_unittests\": \"8838cceeb1ddffe9216e1c5464de76bf28e0b280\", \"dbus_unittests\": \"23f7c365e64f2d036622a1c45945e2a4f673144b\", \"device_unittests\": \"ec33de65a92c1c1cf2279cf3e2d4e8d9fb6f256c\", \"display_unittests\": \"c3f3c485338782dd8a93c1c22458ee6e21415aa4\", \"events_unittests\": \"e0d1a06c7147bb821b6ba3df36e6ac122893ac6a\", \"exo_unittests\": \"552af3fbf437d6b4db40e1a127df1fcc17cd34a7\", \"extensions_browsertests\": \"74a6fd6a32dda38d88012fd93e02d14ffc2b04cc\", \"extensions_unittests\": \"98cb308fa58afdb15c0020707cbaecaa0c630458\", \"filesystem_service_unittests\": \"1f7f1685f3fc9a381090a1bdc04021689bf7952b\", \"gcm_unit_tests\": \"53e090c6646204204557f74b5429bf0959a954e9\", \"gfx_unittests\": \"eddf0cc625930887dc85881f8dd030e9fc0adc2c\", \"gin_unittests\": \"a8a0443c5a52424445239f93123094c788a7dcca\", \"gl_unittests_ozone\": \"5b36b0a6b52a21415aa5855a30763bbe7aa75ab5\", \"google_apis_unittests\": \"27c4683f6fa7b12791ce18b51945cda6e956ad68\", \"gpu_unittests\": \"b681ad0c44c1f932f458803d35526117eb127e47\", \"gwp_asan_unittests\": \"b034a11b8e935a6acdf55ef8084b8cc7f26fb554\", \"interactive_ui_tests\": \"e7d12a9566de841323ef11fc63fb89f12d5037ac\", \"ipc_tests\": \"812316b267e9574d9d12a3404c95224ad3e43bf3\", \"jingle_unittests\": \"62647341f5f3d54ec986e6ae15abe9b8a1335f45\", \"keyboard_unittests\": \"c119833434dad2e5ca62d82a32bba7d28180548f\", \"latency_unittests\": \"0fb75c669e0c41c1acb4f0c49727e84aa9349c1b\", \"libjingle_xmpp_unittests\": \"a69fff722d1d62770e55748d219ff67b7aaf6f55\", \"liburlpattern_unittests\": \"ffe5981e611ffbcf6bb9d8f3077b8e3a95fd46f5\", \"media_blink_unittests\": \"d1aab83de10e991eba53e314ab1b016c69428d63\", \"media_unittests\": \"e7ad69ad13c221e92478ad8100b31570ec808280\", \"message_center_unittests\": \"c38435be52a6a7e8355e41b49eb5a4f9e7cbd199\", \"midi_unittests\": \"8b522a1c11986ca1a83849cb72fd563c931fa388\", \"mojo_core_unittests\": \"f95e01d89210511d7eeba8f9a63243aa4b488f8c\", \"mojo_unittests\": \"c286c9625c80739bef256ac73e180dd3d8878486\", \"nacl_helper_nonsfi_unittests\": \"2c8c547eae5cddc77d5f0c6cdddc5939c1e3f9e4\", \"nacl_loader_unittests\": \"67e06b32e26dbb3751d058ffc2ec471316136f6e\", \"native_theme_unittests\": \"180869a2d5249b60c2e9022123787f9fc42c3df3\", \"net_unittests\": \"d71a4d507e7521cbdc63eb66d9b7e451010fcf16\", \"ozone_gl_unittests\": \"90a841ea8ab0feecda26148880ead45f7360807d\", \"ozone_unittests\": \"89b4177349b722798c61d64a3c9a818babf6aec5\", \"ozone_x11_unittests\": \"1aa6109fe7cb8d6458e7a6a643f46a399d7c0c48\", \"pdf_unittests\": \"a893cb77c653bfc0500815d96da285521459d3eb\", \"perfetto_unittests\": \"b149e3bfc821dc2eaac480c73bc473a89e2932e4\", \"ppapi_unittests\": \"aec46793d37cfa2fc34a7cd29f3fbdb31774f71b\", \"printing_unittests\": \"e2d9e04cd489dc752214e95bd569a531ab2b73cf\", \"remoting_unittests\": \"30a3775a516ed0f5db2149d4141524e2ad594ae8\", \"sandbox_linux_unittests\": \"a939e50da95a5b661c22809e8da8c2aadd442fa3\", \"service_manager_unittests\": \"7edd8a6eb17dd0dc6e7eec4fb601fda3dfad493e\", \"services_unittests\": \"c15efcfdc64c50eb4f8a81d939637a4b610d3559\", \"shell_dialogs_unittests\": \"18b75916fab6570a8831c7d2284cde491bffb30d\", \"shell_encryption_unittests\": \"dfb79ce48a16f05a759e1619725d287cbe9a83c2\", \"skia_unittests\": \"df4da8f5a5fa9e9fa1b992b5e39b974fd55289f7\", \"snapshot_unittests\": \"e0ecff05d99c4ecfb2cc5c2480cfe4a7a8c65b61\", \"sql_unittests\": \"bfc3fe2e3d00e9fba72faaa49b4de540adc8c0b3\", \"storage_unittests\": \"0b91ac9bcaa065d8df07d58657ea58e641e5b876\", \"sync_integration_tests\": \"f2fa26796482b5a35a5fd8d92699d0e89237d7c1\", \"traffic_annotation_auditor_unittests\": \"21b5611b4f1da617614541ae1fc6a402d150342d\", \"ui_base_unittests\": \"11be2199d7b50ef9991ae09023b69b35cb9b003a\", \"ui_chromeos_unittests\": \"cdf759860add0d7c9b178f0d000c66ac4d6f88ac\", \"ui_touch_selection_unittests\": \"b2a0b668e3d231fdd3a7beabcd955befae1f75dd\", \"unit_tests\": \"de3e617c938e5ee1c222ef8ac88760c055341b0f\", \"url_unittests\": \"63727c764cc4d2149ace2f300118e64af52a4df3\", \"usage_time_limit_unittests\": \"60ce9a130db9f3e82d94b415595171f6623f8a45\", \"views_unittests\": \"594a7e45fc9207ea877487c2302716ef55c746e0\", \"viz_unittests\": \"868903c49d5ee6ee2f88e2fee32e35512becc279\", \"wm_unittests\": \"56f2187609ca8f19ea893af0b03f56f9697c1086\", \"wtf_unittests\": \"afdf7102a833115eea53b11e35c9972728fa175f\", \"zlib_unittests\": \"8e4cfb6c91034add6c3e362d3c21ca6e3c08c57d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_219e0ffc8c25f5e0b87c50b06543131c770ba4c60d610054ab97561314494a41_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_7b27d20986eac2bbcc1513665f8799c69dbe398236c21423fd80a70475184e3c_v2\", \"builder_800f6f487d95d787b5e050c93b44c7c7276a85aefb5f9344834f1f03ffd0e322_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_a7b9f8880f1f76f2cce14c79e9b35da9a713af6654c6d1393cfbcc356d1ede5d_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_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-18-xpkt\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**unit_tests** failed because of:\\n\\n- WebRtcSignalingMessengerTest.UnsuccessfulSendMessage_EmptyToken\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613903397239546",
"status": "COMPLETED",
"status_changed_ts": "1613903397731197",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22717",
"builder:linux-chromeos-dbg",
"buildset:commit/git/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/22f65038fa8c2d2cd9143435b89ac5f200c33bb2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020125547604626752",
"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/8854695485659894352/+/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:51dcd5f35a93ef10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613910442213247",
"url": "https://ci.chromium.org/b/8854695485659894352",
"utcnow_ts": "1613910442683402"
}
}
[12:27:22.692] Invocation finished in 2h31m25.994630511s with status FAILED