[09:53:49.369] New invocation is queued and will start shortly
[09:53:50.462] Starting the invocation (attempt 1)
[09:53:50.496] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:53:50.496] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:53:50.496] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024564932489271264",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d3648b0fd35a2a17cb101d8fb13ed0bda91b029a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9024564932489271264",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d3648b0fd35a2a17cb101d8fb13ed0bda91b029a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3648b0fd35a2a17cb101d8fb13ed0bda91b029a",
"gitiles_ref:refs/heads/master"
]
}
[09:53:51.396] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609667630672109",
"id": "8859134870458314832",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3648b0fd35a2a17cb101d8fb13ed0bda91b029a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609667631163546",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22036",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d3648b0fd35a2a17cb101d8fb13ed0bda91b029a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3648b0fd35a2a17cb101d8fb13ed0bda91b029a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024564932489271264",
"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/8859134870458314832/+/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": "1609667631163649",
"url": "https://ci.chromium.org/b/8859134870458314832",
"utcnow_ts": "1609667631389301"
}
}
[09:53:51.396] Task URL: https://ci.chromium.org/b/8859134870458314832
[09:53:51.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:2:0) after 1m0s
[09:54:51.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:2:0)
[09:54:51.647] Timer tick, asking Buildbucket for the build status
[09:54:51.739] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:51.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:3:0) after 1m0s
[09:55:51.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:3:0)
[09:55:51.945] Timer tick, asking Buildbucket for the build status
[09:55:52.021] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:55:52.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:4:0) after 1m0s
[09:56:52.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:4:0)
[09:56:52.119] Timer tick, asking Buildbucket for the build status
[09:56:52.178] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:52.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:5:0) after 1m0s
[09:57:52.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:5:0)
[09:57:52.455] Timer tick, asking Buildbucket for the build status
[09:57:52.514] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:52.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:6:0) after 1m0s
[09:58:52.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:6:0)
[09:58:52.578] Timer tick, asking Buildbucket for the build status
[09:58:52.708] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:58:52.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:7:0) after 1m0s
[09:59:52.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:7:0)
[09:59:52.707] Timer tick, asking Buildbucket for the build status
[09:59:52.762] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:52.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:8:0) after 1m0s
[10:00:52.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:8:0)
[10:00:52.944] Timer tick, asking Buildbucket for the build status
[10:00:53.029] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:53.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:9:0) after 1m0s
[10:01:53.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:9:0)
[10:01:53.586] Timer tick, asking Buildbucket for the build status
[10:01:53.657] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:53.657] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:10:0) after 1m0s
[10:02:54.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:10:0)
[10:02:54.630] Timer tick, asking Buildbucket for the build status
[10:02:54.707] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:54.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:11:0) after 1m0s
[10:03:54.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:11:0)
[10:03:54.985] Timer tick, asking Buildbucket for the build status
[10:03:55.136] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:55.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:12:0) after 1m0s
[10:04:55.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:12:0)
[10:04:55.175] Timer tick, asking Buildbucket for the build status
[10:04:55.284] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:55.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:13:0) after 1m0s
[10:05:55.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:13:0)
[10:05:55.303] Timer tick, asking Buildbucket for the build status
[10:05:55.364] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:05:55.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:14:0) after 1m0s
[10:06:55.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:14:0)
[10:06:55.531] Timer tick, asking Buildbucket for the build status
[10:06:55.641] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:06:55.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:15:0) after 1m0s
[10:07:55.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:15:0)
[10:07:55.762] Timer tick, asking Buildbucket for the build status
[10:07:55.845] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:07:55.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:16:0) after 1m0s
[10:08:55.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:16:0)
[10:08:55.853] Timer tick, asking Buildbucket for the build status
[10:08:56.228] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:08:56.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:17:0) after 1m0s
[10:09:56.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:17:0)
[10:09:56.237] Timer tick, asking Buildbucket for the build status
[10:09:56.308] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:09:56.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:18:0) after 1m0s
[10:10:56.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:18:0)
[10:10:56.320] Timer tick, asking Buildbucket for the build status
[10:10:56.388] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:10:56.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:19:0) after 1m0s
[10:11:56.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:19:0)
[10:11:56.427] Timer tick, asking Buildbucket for the build status
[10:11:56.481] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:11:56.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:20:0) after 1m0s
[10:12:56.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:20:0)
[10:12:56.574] Timer tick, asking Buildbucket for the build status
[10:12:56.636] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:12:56.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:21:0) after 1m0s
[10:13:56.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:21:0)
[10:13:56.763] Timer tick, asking Buildbucket for the build status
[10:13:56.860] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:13:56.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:22:0) after 1m0s
[10:14:56.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:22:0)
[10:14:56.947] Timer tick, asking Buildbucket for the build status
[10:14:57.211] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:14:57.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:23:0) after 1m0s
[10:15:57.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:23:0)
[10:15:57.410] Timer tick, asking Buildbucket for the build status
[10:15:57.631] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:15:57.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:24:0) after 1m0s
[10:16:57.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:24:0)
[10:16:57.705] Timer tick, asking Buildbucket for the build status
[10:16:57.929] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:16:57.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:25:0) after 1m0s
[10:17:58.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:25:0)
[10:17:58.051] Timer tick, asking Buildbucket for the build status
[10:17:58.409] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:17:58.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:26:0) after 1m0s
[10:18:58.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:26:0)
[10:18:58.431] Timer tick, asking Buildbucket for the build status
[10:18:58.543] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:18:58.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:27:0) after 1m0s
[10:19:58.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:27:0)
[10:19:58.567] Timer tick, asking Buildbucket for the build status
[10:19:58.637] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:19:58.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:28:0) after 1m0s
[10:20:58.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:28:0)
[10:20:58.719] Timer tick, asking Buildbucket for the build status
[10:20:58.787] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:20:58.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:29:0) after 1m0s
[10:21:58.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:29:0)
[10:21:58.839] Timer tick, asking Buildbucket for the build status
[10:21:58.925] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:21:58.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:30:0) after 1m0s
[10:22:58.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:30:0)
[10:22:58.996] Timer tick, asking Buildbucket for the build status
[10:22:59.068] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:22:59.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:31:0) after 1m0s
[10:23:59.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:31:0)
[10:23:59.093] Timer tick, asking Buildbucket for the build status
[10:23:59.181] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:23:59.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:32:0) after 1m0s
[10:24:59.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:32:0)
[10:24:59.193] Timer tick, asking Buildbucket for the build status
[10:24:59.252] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:24:59.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:33:0) after 1m0s
[10:25:59.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:33:0)
[10:25:59.361] Timer tick, asking Buildbucket for the build status
[10:25:59.537] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:59.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:34:0) after 1m0s
[10:26:59.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:34:0)
[10:26:59.559] Timer tick, asking Buildbucket for the build status
[10:26:59.638] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:26:59.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:35:0) after 1m0s
[10:27:59.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:35:0)
[10:27:59.712] Timer tick, asking Buildbucket for the build status
[10:27:59.776] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:27:59.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:36:0) after 1m0s
[10:28:59.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:36:0)
[10:28:59.826] Timer tick, asking Buildbucket for the build status
[10:28:59.914] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:28:59.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:37:0) after 1m0s
[10:29:59.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:37:0)
[10:29:59.931] Timer tick, asking Buildbucket for the build status
[10:30:00.198] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:30:00.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:38:0) after 1m0s
[10:31:00.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:38:0)
[10:31:00.269] Timer tick, asking Buildbucket for the build status
[10:31:00.350] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:31:00.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:39:0) after 1m0s
[10:32:00.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:39:0)
[10:32:00.456] Timer tick, asking Buildbucket for the build status
[10:32:00.715] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:32:00.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:40:0) after 1m0s
[10:33:00.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:40:0)
[10:33:00.713] Timer tick, asking Buildbucket for the build status
[10:33:00.795] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:33:00.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:41:0) after 1m0s
[10:34:00.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:41:0)
[10:34:00.813] Timer tick, asking Buildbucket for the build status
[10:34:01.326] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:34:01.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:42:0) after 1m0s
[10:35:01.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:42:0)
[10:35:01.349] Timer tick, asking Buildbucket for the build status
[10:35:01.420] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:35:01.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:43:0) after 1m0s
[10:36:01.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:43:0)
[10:36:01.493] Timer tick, asking Buildbucket for the build status
[10:36:01.578] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:36:01.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:44:0) after 1m0s
[10:37:01.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:44:0)
[10:37:01.599] Timer tick, asking Buildbucket for the build status
[10:37:01.673] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:37:01.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:45:0) after 1m0s
[10:38:01.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:45:0)
[10:38:01.696] Timer tick, asking Buildbucket for the build status
[10:38:01.801] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:38:01.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:46:0) after 1m0s
[10:39:01.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:46:0)
[10:39:01.824] Timer tick, asking Buildbucket for the build status
[10:39:01.933] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:39:01.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:47:0) after 1m0s
[10:40:01.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:47:0)
[10:40:01.977] Timer tick, asking Buildbucket for the build status
[10:40:02.303] Build 8859134870458314832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:40:02.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:48:0) after 1m0s
[10:40:22.833] Received PubSub notification, asking Buildbucket for the build status
[10:40:22.910] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:02.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:48:0)
[10:41:02.374] Timer tick, asking Buildbucket for the build status
[10:41:02.464] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:02.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:50:0) after 1m0s
[10:42:02.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:50:0)
[10:42:02.539] Timer tick, asking Buildbucket for the build status
[10:42:02.609] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:02.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:51:0) after 1m0s
[10:43:02.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:51:0)
[10:43:02.678] Timer tick, asking Buildbucket for the build status
[10:43:02.742] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:02.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:52:0) after 1m0s
[10:44:02.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:52:0)
[10:44:02.941] Timer tick, asking Buildbucket for the build status
[10:44:03.038] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:03.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:53:0) after 1m0s
[10:45:03.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:53:0)
[10:45:03.216] Timer tick, asking Buildbucket for the build status
[10:45:03.295] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:03.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:54:0) after 1m0s
[10:46:03.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:54:0)
[10:46:03.368] Timer tick, asking Buildbucket for the build status
[10:46:03.665] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:03.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:55:0) after 1m0s
[10:47:03.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:55:0)
[10:47:03.813] Timer tick, asking Buildbucket for the build status
[10:47:03.943] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:03.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:56:0) after 1m0s
[10:48:03.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:56:0)
[10:48:03.977] Timer tick, asking Buildbucket for the build status
[10:48:04.041] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:04.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:57:0) after 1m0s
[10:49:04.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:57:0)
[10:49:04.065] Timer tick, asking Buildbucket for the build status
[10:49:04.156] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:04.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:58:0) after 1m0s
[10:50:04.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:58:0)
[10:50:04.258] Timer tick, asking Buildbucket for the build status
[10:50:04.889] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:04.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:59:0) after 1m0s
[10:51:04.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:59:0)
[10:51:04.995] Timer tick, asking Buildbucket for the build status
[10:51:05.222] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:05.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:60:0) after 1m0s
[10:52:05.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:60:0)
[10:52:05.264] Timer tick, asking Buildbucket for the build status
[10:52:05.369] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:05.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:61:0) after 1m0s
[10:53:05.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:61:0)
[10:53:05.441] Timer tick, asking Buildbucket for the build status
[10:53:05.596] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:05.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:62:0) after 1m0s
[10:54:05.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:62:0)
[10:54:05.670] Timer tick, asking Buildbucket for the build status
[10:54:05.766] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:05.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:63:0) after 1m0s
[10:55:05.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:63:0)
[10:55:05.835] Timer tick, asking Buildbucket for the build status
[10:55:05.895] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:05.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:64:0) after 1m0s
[10:56:05.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:64:0)
[10:56:05.910] Timer tick, asking Buildbucket for the build status
[10:56:06.165] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:06.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:65:0) after 1m0s
[10:57:06.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:65:0)
[10:57:06.185] Timer tick, asking Buildbucket for the build status
[10:57:06.293] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:06.293] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:66:0) after 1m0s
[10:58:06.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:66:0)
[10:58:06.312] Timer tick, asking Buildbucket for the build status
[10:58:06.395] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:06.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:67:0) after 1m0s
[10:59:06.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:67:0)
[10:59:06.461] Timer tick, asking Buildbucket for the build status
[10:59:06.803] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:06.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:68:0) after 1m0s
[11:00:06.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:68:0)
[11:00:06.846] Timer tick, asking Buildbucket for the build status
[11:00:06.925] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:06.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:69:0) after 1m0s
[11:01:08.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:69:0)
[11:01:08.324] Timer tick, asking Buildbucket for the build status
[11:01:08.404] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:08.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:70:0) after 1m0s
[11:02:08.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:70:0)
[11:02:08.513] Timer tick, asking Buildbucket for the build status
[11:02:08.565] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:08.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:71:0) after 1m0s
[11:03:08.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:71:0)
[11:03:08.654] Timer tick, asking Buildbucket for the build status
[11:03:08.718] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:08.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:72:0) after 1m0s
[11:04:08.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:72:0)
[11:04:08.758] Timer tick, asking Buildbucket for the build status
[11:04:09.167] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:09.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:73:0) after 1m0s
[11:05:09.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:73:0)
[11:05:09.167] Timer tick, asking Buildbucket for the build status
[11:05:09.258] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:09.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:74:0) after 1m0s
[11:06:09.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:74:0)
[11:06:09.236] Timer tick, asking Buildbucket for the build status
[11:06:09.428] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:09.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:75:0) after 1m0s
[11:07:09.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:75:0)
[11:07:09.533] Timer tick, asking Buildbucket for the build status
[11:07:09.694] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:09.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:76:0) after 1m0s
[11:08:09.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:76:0)
[11:08:09.769] Timer tick, asking Buildbucket for the build status
[11:08:10.104] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:10.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:77:0) after 1m0s
[11:09:10.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:77:0)
[11:09:10.124] Timer tick, asking Buildbucket for the build status
[11:09:10.242] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:10.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:78:0) after 1m0s
[11:10:10.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:78:0)
[11:10:10.304] Timer tick, asking Buildbucket for the build status
[11:10:10.412] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:10.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:79:0) after 1m0s
[11:11:10.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:79:0)
[11:11:10.439] Timer tick, asking Buildbucket for the build status
[11:11:10.501] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:10.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:80:0) after 1m0s
[11:12:10.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:80:0)
[11:12:10.524] Timer tick, asking Buildbucket for the build status
[11:12:10.658] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:10.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:81:0) after 1m0s
[11:13:10.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:81:0)
[11:13:10.683] Timer tick, asking Buildbucket for the build status
[11:13:10.737] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:10.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:82:0) after 1m0s
[11:14:10.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:82:0)
[11:14:10.787] Timer tick, asking Buildbucket for the build status
[11:14:11.032] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:11.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:83:0) after 1m0s
[11:15:11.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:83:0)
[11:15:11.092] Timer tick, asking Buildbucket for the build status
[11:15:11.153] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:11.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:84:0) after 1m0s
[11:16:11.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:84:0)
[11:16:11.245] Timer tick, asking Buildbucket for the build status
[11:16:11.303] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:11.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:85:0) after 1m0s
[11:17:11.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:85:0)
[11:17:11.324] Timer tick, asking Buildbucket for the build status
[11:17:11.432] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:11.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:86:0) after 1m0s
[11:18:11.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:86:0)
[11:18:11.451] Timer tick, asking Buildbucket for the build status
[11:18:11.515] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:11.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:87:0) after 1m0s
[11:19:11.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:87:0)
[11:19:11.537] Timer tick, asking Buildbucket for the build status
[11:19:11.814] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:11.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:88:0) after 1m0s
[11:20:11.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:88:0)
[11:20:11.841] Timer tick, asking Buildbucket for the build status
[11:20:11.996] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:11.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:89:0) after 1m0s
[11:21:12.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:89:0)
[11:21:12.015] Timer tick, asking Buildbucket for the build status
[11:21:12.068] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:12.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:90:0) after 1m0s
[11:22:12.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:90:0)
[11:22:12.088] Timer tick, asking Buildbucket for the build status
[11:22:12.213] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:12.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:91:0) after 1m0s
[11:23:12.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:91:0)
[11:23:12.405] Timer tick, asking Buildbucket for the build status
[11:23:12.457] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:12.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:92:0) after 1m0s
[11:24:12.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:92:0)
[11:24:12.483] Timer tick, asking Buildbucket for the build status
[11:24:12.571] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:12.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:93:0) after 1m0s
[11:25:12.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:93:0)
[11:25:12.718] Timer tick, asking Buildbucket for the build status
[11:25:12.888] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:12.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:94:0) after 1m0s
[11:26:12.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:94:0)
[11:26:12.918] Timer tick, asking Buildbucket for the build status
[11:26:13.066] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:13.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:95:0) after 1m0s
[11:27:13.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:95:0)
[11:27:13.095] Timer tick, asking Buildbucket for the build status
[11:27:13.207] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:13.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:96:0) after 1m0s
[11:28:13.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:96:0)
[11:28:13.280] Timer tick, asking Buildbucket for the build status
[11:28:13.906] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:13.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:97:0) after 1m0s
[11:29:13.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:97:0)
[11:29:13.997] Timer tick, asking Buildbucket for the build status
[11:29:14.294] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:14.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:98:0) after 1m0s
[11:30:14.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:98:0)
[11:30:14.777] Timer tick, asking Buildbucket for the build status
[11:30:15.046] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:15.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:99:0) after 1m0s
[11:31:15.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:99:0)
[11:31:15.430] Timer tick, asking Buildbucket for the build status
[11:31:15.482] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:15.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:100:0) after 1m0s
[11:32:15.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:100:0)
[11:32:15.728] Timer tick, asking Buildbucket for the build status
[11:32:15.795] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:15.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:101:0) after 1m0s
[11:33:15.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:101:0)
[11:33:15.922] Timer tick, asking Buildbucket for the build status
[11:33:16.267] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:16.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:102:0) after 1m0s
[11:34:16.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:102:0)
[11:34:16.445] Timer tick, asking Buildbucket for the build status
[11:34:16.635] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:16.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:103:0) after 1m0s
[11:35:16.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:103:0)
[11:35:16.748] Timer tick, asking Buildbucket for the build status
[11:35:16.861] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:16.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:104:0) after 1m0s
[11:36:22.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:104:0)
[11:36:22.083] Timer tick, asking Buildbucket for the build status
[11:36:22.189] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:22.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:105:0) after 1m0s
[11:37:22.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:105:0)
[11:37:22.549] Timer tick, asking Buildbucket for the build status
[11:37:22.693] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:22.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:106:0) after 1m0s
[11:38:22.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:106:0)
[11:38:22.884] Timer tick, asking Buildbucket for the build status
[11:38:23.022] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:23.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:107:0) after 1m0s
[11:39:23.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:107:0)
[11:39:23.268] Timer tick, asking Buildbucket for the build status
[11:39:23.425] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:23.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:108:0) after 1m0s
[11:40:23.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:108:0)
[11:40:23.462] Timer tick, asking Buildbucket for the build status
[11:40:23.576] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:23.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:109:0) after 1m0s
[11:41:23.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:109:0)
[11:41:23.745] Timer tick, asking Buildbucket for the build status
[11:41:23.852] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:23.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:110:0) after 1m0s
[11:42:23.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:110:0)
[11:42:23.960] Timer tick, asking Buildbucket for the build status
[11:42:24.127] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:24.127] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:111:0) after 1m0s
[11:43:24.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:111:0)
[11:43:24.199] Timer tick, asking Buildbucket for the build status
[11:43:24.317] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:24.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:112:0) after 1m0s
[11:44:24.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:112:0)
[11:44:24.330] Timer tick, asking Buildbucket for the build status
[11:44:24.799] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:24.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:113:0) after 1m0s
[11:45:24.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:113:0)
[11:45:24.842] Timer tick, asking Buildbucket for the build status
[11:45:24.943] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:24.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:114:0) after 1m0s
[11:46:25.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:114:0)
[11:46:25.021] Timer tick, asking Buildbucket for the build status
[11:46:25.140] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:25.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:115:0) after 1m0s
[11:47:25.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:115:0)
[11:47:25.268] Timer tick, asking Buildbucket for the build status
[11:47:25.733] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:25.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:116:0) after 1m0s
[11:48:25.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:116:0)
[11:48:25.867] Timer tick, asking Buildbucket for the build status
[11:48:25.938] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:25.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:117:0) after 1m0s
[11:49:26.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:117:0)
[11:49:26.134] Timer tick, asking Buildbucket for the build status
[11:49:26.242] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:26.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:118:0) after 1m0s
[11:50:26.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:118:0)
[11:50:26.474] Timer tick, asking Buildbucket for the build status
[11:50:26.916] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:26.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:119:0) after 1m0s
[11:51:27.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:119:0)
[11:51:27.018] Timer tick, asking Buildbucket for the build status
[11:51:27.095] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:27.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:120:0) after 1m0s
[11:52:27.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:120:0)
[11:52:27.146] Timer tick, asking Buildbucket for the build status
[11:52:27.506] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:27.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:121:0) after 1m0s
[11:53:27.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:121:0)
[11:53:27.614] Timer tick, asking Buildbucket for the build status
[11:53:27.674] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:27.674] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:122:0) after 1m0s
[11:54:27.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:122:0)
[11:54:27.773] Timer tick, asking Buildbucket for the build status
[11:54:28.329] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:28.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:123:0) after 1m0s
[11:55:28.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:123:0)
[11:55:28.345] Timer tick, asking Buildbucket for the build status
[11:55:28.454] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:28.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:124:0) after 1m0s
[11:56:28.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:124:0)
[11:56:28.426] Timer tick, asking Buildbucket for the build status
[11:56:29.082] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:29.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:125:0) after 1m0s
[11:57:29.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:125:0)
[11:57:29.107] Timer tick, asking Buildbucket for the build status
[11:57:29.176] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:29.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:126:0) after 1m0s
[11:58:29.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:126:0)
[11:58:29.222] Timer tick, asking Buildbucket for the build status
[11:58:30.401] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:30.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:127:0) after 1m0s
[11:59:31.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:127:0)
[11:59:31.295] Timer tick, asking Buildbucket for the build status
[11:59:31.810] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:31.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:128:0) after 1m0s
[12:00:31.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:128:0)
[12:00:31.871] Timer tick, asking Buildbucket for the build status
[12:00:31.987] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:31.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:129:0) after 1m0s
[12:01:31.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:129:0)
[12:01:31.973] Timer tick, asking Buildbucket for the build status
[12:01:32.072] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:32.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:130:0) after 1m0s
[12:02:32.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:130:0)
[12:02:32.163] Timer tick, asking Buildbucket for the build status
[12:02:32.513] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:32.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:131:0) after 1m0s
[12:03:32.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:131:0)
[12:03:32.537] Timer tick, asking Buildbucket for the build status
[12:03:32.612] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:32.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:132:0) after 1m0s
[12:04:32.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:132:0)
[12:04:32.641] Timer tick, asking Buildbucket for the build status
[12:04:32.740] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:32.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:133:0) after 1m0s
[12:05:32.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:133:0)
[12:05:32.769] Timer tick, asking Buildbucket for the build status
[12:05:33.032] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:33.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:134:0) after 1m0s
[12:06:33.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:134:0)
[12:06:33.086] Timer tick, asking Buildbucket for the build status
[12:06:33.153] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:33.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:135:0) after 1m0s
[12:07:33.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:135:0)
[12:07:33.203] Timer tick, asking Buildbucket for the build status
[12:07:33.359] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:33.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:136:0) after 1m0s
[12:08:33.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:136:0)
[12:08:33.406] Timer tick, asking Buildbucket for the build status
[12:08:33.465] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:33.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:137:0) after 1m0s
[12:09:33.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:137:0)
[12:09:33.478] Timer tick, asking Buildbucket for the build status
[12:09:33.603] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:33.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:138:0) after 1m0s
[12:10:33.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:138:0)
[12:10:33.587] Timer tick, asking Buildbucket for the build status
[12:10:33.659] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:33.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:139:0) after 1m0s
[12:11:33.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:139:0)
[12:11:33.928] Timer tick, asking Buildbucket for the build status
[12:11:34.095] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:34.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:140:0) after 1m0s
[12:12:34.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:140:0)
[12:12:34.154] Timer tick, asking Buildbucket for the build status
[12:12:34.552] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:34.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:141:0) after 1m0s
[12:13:34.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:141:0)
[12:13:34.694] Timer tick, asking Buildbucket for the build status
[12:13:34.802] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:34.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:142:0) after 1m0s
[12:14:34.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:142:0)
[12:14:34.871] Timer tick, asking Buildbucket for the build status
[12:14:34.962] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:34.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:143:0) after 1m0s
[12:15:35.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:143:0)
[12:15:35.112] Timer tick, asking Buildbucket for the build status
[12:15:35.247] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:35.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:144:0) after 1m0s
[12:16:35.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:144:0)
[12:16:35.359] Timer tick, asking Buildbucket for the build status
[12:16:35.434] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:35.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:145:0) after 1m0s
[12:17:35.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:145:0)
[12:17:35.507] Timer tick, asking Buildbucket for the build status
[12:17:35.567] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:35.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:146:0) after 1m0s
[12:18:35.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:146:0)
[12:18:35.659] Timer tick, asking Buildbucket for the build status
[12:18:35.724] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:35.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:147:0) after 1m0s
[12:19:35.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:147:0)
[12:19:35.841] Timer tick, asking Buildbucket for the build status
[12:19:36.177] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:36.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:148:0) after 1m0s
[12:20:36.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:148:0)
[12:20:36.251] Timer tick, asking Buildbucket for the build status
[12:20:36.319] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:36.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:149:0) after 1m0s
[12:21:36.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:149:0)
[12:21:36.407] Timer tick, asking Buildbucket for the build status
[12:21:36.504] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:36.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:150:0) after 1m0s
[12:22:36.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:150:0)
[12:22:36.621] Timer tick, asking Buildbucket for the build status
[12:22:36.692] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:36.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:151:0) after 1m0s
[12:23:36.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:151:0)
[12:23:36.753] Timer tick, asking Buildbucket for the build status
[12:23:36.826] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:36.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:152:0) after 1m0s
[12:24:37.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:152:0)
[12:24:37.033] Timer tick, asking Buildbucket for the build status
[12:24:37.173] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:37.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:153:0) after 1m0s
[12:25:37.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:153:0)
[12:25:37.390] Timer tick, asking Buildbucket for the build status
[12:25:37.505] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:37.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:154:0) after 1m0s
[12:26:37.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:154:0)
[12:26:37.678] Timer tick, asking Buildbucket for the build status
[12:26:38.103] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:155:0) after 1m0s
[12:27:38.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:155:0)
[12:27:38.167] Timer tick, asking Buildbucket for the build status
[12:27:38.256] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:38.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:156:0) after 1m0s
[12:28:38.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:156:0)
[12:28:38.285] Timer tick, asking Buildbucket for the build status
[12:28:38.428] Build 8859134870458314832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:38.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024564932489271264:157:0) after 1m0s
[12:29:29.569] Received PubSub notification, asking Buildbucket for the build status
[12:29:29.682] Build 8859134870458314832: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:29:29.683] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609676968764836",
"created_by": "project:chromium",
"created_ts": "1609667630672109",
"failure_reason": "BUILD_FAILURE",
"id": "8859134870458314832",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3648b0fd35a2a17cb101d8fb13ed0bda91b029a\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**chromeos_unittests** failed because of:\\n\\n- ProcessOutputWatcherTest.OutputWatcher\\n\\n**net_unittests** failed because of:\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailIntermediateCrlDpHttpError/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationHardFailIntermediateCrlDpHttpError/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailLeafRevokedByMd5Crl/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailCrlGoodNoRevokedCertificates/CertVerifyProcBuiltin\\n\\n- ...19 more failure(s) (23 total)...\"}, \"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\": \"d3648b0fd35a2a17cb101d8fb13ed0bda91b029a\", \"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-23-pk7x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22036, \"got_angle_revision\": \"bf02c31bec07a549cc8eea26ad0e63143954643d\", \"got_dawn_revision\": \"86980018b3f2786aeb5ded1220ec94bc927fa6b2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"d3648b0fd35a2a17cb101d8fb13ed0bda91b029a\", \"got_revision_cp\": \"refs/heads/master@{#839972}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"ff29e249d3179766a40c9486183559fe3e5c1456\", \"got_v8_revision\": \"a5786bb381dd6ae4d1b936320a5fc00481566700\", \"got_v8_revision_cp\": \"refs/heads/8.9.202@{#1}\", \"got_webrtc_revision\": \"8673643bc2e357ca7b6dc01c0018ed05d20ffd72\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32900}\", \"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\": \"d3648b0fd35a2a17cb101d8fb13ed0bda91b029a\", \"swarm_hashes_refs/heads/master(at){#839972}_without_patch\": {\"absl_hardening_tests\": \"5233ea38b8dd982e120bdd802c794ee6326be94b\", \"accessibility_unittests\": \"63436893d69d0db60a04616fff5eb0f6f95bb623\", \"angle_unittests\": \"b260fdda44b8dc50077fea667c8808bab7db0e5a\", \"app_list_unittests\": \"80fb9308f20de08999e1d571a5743288fc5ad263\", \"app_shell_unittests\": \"5dd72788ac9e8d04b684f67d738d6038ec490c8b\", \"ash_unittests\": \"b524ebd740889f9e6d61dc61fd771a496fd3677d\", \"aura_unittests\": \"41a0e14f5292cc796bd6412e5ff509140f04a703\", \"base_unittests\": \"d68deee90614e33082ad0de45685e3c2edf20ca9\", \"base_util_unittests\": \"f99c9591b26d7a5d4cfc476242a99109135bd2c9\", \"blink_common_unittests\": \"2355541701203b1e471995acfd2bbf6b19c09b14\", \"blink_fuzzer_unittests\": \"1d91776f7faaa82b4ac87ee160c4add8bb7b7291\", \"blink_heap_unittests\": \"8c7853c192933e41ce457cd75c2f21c652ffc533\", \"blink_platform_unittests\": \"e360f7c7d6e381fdf71c06cb4d42b06eecfba505\", \"blink_unittests\": \"4045f9b79594ebb2884ff1c8ff72ab4f2935c8a0\", \"boringssl_crypto_tests\": \"396bb6f3ab0d3b13dffb61216a8b50f93a1bf6e8\", \"boringssl_ssl_tests\": \"d0e48a2328d4653496aa59637565c50727a6d3e1\", \"browser_tests\": \"ab2a09afc90e48026f6a8094531cacba7fb36a30\", \"capture_unittests\": \"6346b8daad798fd454498c811b026e701e1b80c8\", \"cast_unittests\": \"27e6c2447ba37c2c0b940afeb3fdc0ab3aada47e\", \"cc_unittests\": \"b20814da588804f53f348902596f634d34de6bbe\", \"chrome_app_unittests\": \"381cb9b0acce07e994032d8f28001570557648b1\", \"chromedriver_unittests\": \"2b2ae1fabeabb6c78dcf15a63cb05c544dd5063c\", \"chromeos_components_unittests\": \"50ea6a7ed25751ea61cdb66814b7720ef2933316\", \"chromeos_unittests\": \"6aae557b636ff8f5d7dc902859832499428fbde4\", \"components_browsertests\": \"6dd0cfd25a2b34b8bd69867194714c49e1fbc59c\", \"components_unittests\": \"6617f2396e623a5f4586acf0e3101cf12516003a\", \"compositor_unittests\": \"79647d19b2171384375a96ad1daff0360958a90b\", \"content_browsertests\": \"be652b8c7a77a7ca8beaaed44d9a770122ceac66\", \"content_unittests\": \"a5c8d8d2e1898c466324c714ad43a7baefa10c95\", \"crashpad_tests\": \"1712a4535093fc18d0dd1523b8c6c91a61f5e284\", \"crypto_unittests\": \"782bc99f82cf75b47bdd179b0f84d2fdbec0f384\", \"dbus_unittests\": \"8557e8b124f365f2e5af98c6f6c3b73a8e851f82\", \"device_unittests\": \"f306577c684bdfd2981a542f9bedd987eb9ac367\", \"display_unittests\": \"0195abf0f7f28f39209d0bec67863e0b70900d44\", \"events_unittests\": \"8a5bceb871f66883360fba6e915867fb40f4d9dd\", \"exo_unittests\": \"776284cd10836f5b5eda7d85e13a187a8e451901\", \"extensions_browsertests\": \"c43c06696391ce5011b5b9f7b19a94e07106bfe7\", \"extensions_unittests\": \"e383e24eced82a2c60978ce09d914d71270dab12\", \"filesystem_service_unittests\": \"173eb2da1de91411ca8f0cb34aefb55a9b851f44\", \"gcm_unit_tests\": \"6552d81efb8960f10e690fa667ab64ad9b124f34\", \"gfx_unittests\": \"ceb180819e8be944f795b20b5cb8cc562f879367\", \"gin_unittests\": \"66fa9e64c80eb202565beb15f65e318d7e6f3099\", \"gl_unittests_ozone\": \"95bb7553ad84195f8ebd7020741f9c3a6541bc2f\", \"google_apis_unittests\": \"7020d56a748e89ceb75f44f00d30849b021b6dae\", \"gpu_unittests\": \"c47bf440c7c4b29093ec770cec6d16eddb0116ca\", \"gwp_asan_unittests\": \"b6af5ca489a8d9a2c841cfae2782522827f2c30a\", \"interactive_ui_tests\": \"916aecfa417ffcc822e938954c3f64f4579d75c9\", \"ipc_tests\": \"79bc50ba962b2b29f647120780364a3916d0c3a7\", \"jingle_unittests\": \"9c5a888db14aae1e0759e4b9419544d71f7c96b3\", \"keyboard_unittests\": \"baa5ccdb23e90399d34e9b549eaf6c04e2f562e5\", \"latency_unittests\": \"a987d3d71f18ebe7a1a624d3561f033e7e0839b9\", \"libjingle_xmpp_unittests\": \"17b0ef3748db11d897a84f3eee5645edfce57919\", \"liburlpattern_unittests\": \"19932eb7750ef7f02612cc2d8a86f813f9c05a7f\", \"media_blink_unittests\": \"a3b50742c7ab03367bc9c4c770a2514a4672bf47\", \"media_unittests\": \"7b54f71071c50dad33b80ff9b8a41cac0ad29ae1\", \"message_center_unittests\": \"beab7318a8a4b81fa5b9e90d35997f700a419c25\", \"midi_unittests\": \"99589b4db63b5ad8d5b6c3b1a19fd3ab599f4da9\", \"mojo_core_unittests\": \"e6bb57550e582bc200c742e28d40470ac7efd4c4\", \"mojo_unittests\": \"637639f5130c3249e7e89150008b8d5219968d6e\", \"nacl_helper_nonsfi_unittests\": \"c0e92f99657ff403572a2177c8a310c44ac6bad5\", \"nacl_loader_unittests\": \"891d7348bcfbf29240ac93a85775c6ffd5621b51\", \"native_theme_unittests\": \"71d4ecc30c27208d9ff5d78aace6efd621cba528\", \"net_unittests\": \"5071d4ab9108ed24213fa683b7e172cfb2302b20\", \"ozone_gl_unittests\": \"cb4c1649671606c6cd3648d92b3909386dc909da\", \"ozone_unittests\": \"bea6c0f5f6ff1a5bcc2df2efefe03a3e7ae627a0\", \"ozone_x11_unittests\": \"3f63fe3ebb6374c1d8cf6a9833bd466776814050\", \"pdf_unittests\": \"7c676264d4cfd8c64c170195dbe0c31a1fd836fa\", \"perfetto_unittests\": \"4e68b80fdd933a94d400f47797f4e6bb8d0d154a\", \"ppapi_unittests\": \"48b7424a63aad61c4a75d99cf6e66f08db845374\", \"printing_unittests\": \"60ddf0818fb85b389efa07680c7723789230adc9\", \"remoting_unittests\": \"1a2527fa437f85ccd70dbf95978f860826e6ec94\", \"sandbox_linux_unittests\": \"87b45e57b17d99f0b5c0cfddfba4b2802dbbf4db\", \"service_manager_unittests\": \"1c5dfc808b423f509c5a5e940f7fc92e4418955b\", \"services_unittests\": \"559cedb0fd6eabc20b8f396f24d521e993edfa1f\", \"shell_dialogs_unittests\": \"fdb911d93148fc9d923a7fbc343c61ad2bb011d3\", \"shell_encryption_unittests\": \"35f91acecb44e0d285f80ac413f19763f53c0648\", \"skia_unittests\": \"a06e6987204b4e836a9267a00173d5990a5ceed3\", \"snapshot_unittests\": \"49434c5a0ff26fe818a9793ce1a869f603bcbb80\", \"sql_unittests\": \"93a84f2b841ee0540bc80ce0bf4b17b2d2f99531\", \"storage_unittests\": \"f332e583c49615943ff26f01c012bafe2d007d27\", \"sync_integration_tests\": \"829b0878f7ddbf234a902fb7ca92dff591b92786\", \"traffic_annotation_auditor_unittests\": \"0afdc1c4c8e1a23cae7446abe7872dc12ef63726\", \"ui_base_unittests\": \"d3f6b21e4d8662b37e58dc000e7172c7c769f6a5\", \"ui_chromeos_unittests\": \"0ebc713e86ae8d9d78856227cb2389f69627d2ef\", \"ui_touch_selection_unittests\": \"7c0c90cfdbc692c72119d19dd182989f2d270efb\", \"unit_tests\": \"b500ae6d20df0c7718ba24cbad21d71f8f525575\", \"url_unittests\": \"0fdee3573d5343050cde772784daeceb4e34e61d\", \"usage_time_limit_unittests\": \"94006dd9eb508bb056690a06bad0b936b06687b0\", \"views_unittests\": \"309ad9b241152d28c0402891e8ea24465e7aff44\", \"viz_unittests\": \"646cc37bee0ff9f85fa99596b6ffef16d6b0d2e4\", \"wm_unittests\": \"a0537487e867448af9d7074b7c4efa58da51c8d7\", \"wtf_unittests\": \"1bb42784d082716a6a64ce7f959f9e9ff58090df\", \"zlib_unittests\": \"207aa479ae90cad0fcb806ff56d978e764cba014\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_10ae0cecc46a824e6e4b8bc66fd20b7f887f8d55588c5bf771a07ff303093b1d_v2\", \"builder_1b8c0e295e0040ae60b46798151163eecc632ef935bd1ea9777aec71f94caa4f_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_v2\", \"builder_a038fb555685f584149318062f53e0831a488e02c6d40fe1e156bb7cef46d2c7_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_a27b44a1648dd298adda85735042ac3d0ffdcfd6d22ed3e792b03614ce2ee968_v2\", \"builder_fb646d86e88bda56572dff3378a9fa669f47f3a45e650c7783bf21742e524b22_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-23-pk7x\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**chromeos_unittests** failed because of:\\n\\n- ProcessOutputWatcherTest.OutputWatcher\\n\\n**net_unittests** failed because of:\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailIntermediateCrlDpHttpError/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationHardFailIntermediateCrlDpHttpError/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailLeafRevokedByMd5Crl/CertVerifyProcBuiltin\\n\\n- All/CertVerifyProcInternalWithNetFetchingTest.RevocationSoftFailCrlGoodNoRevokedCertificates/CertVerifyProcBuiltin\\n\\n- ...19 more failure(s) (23 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609670421817476",
"status": "COMPLETED",
"status_changed_ts": "1609670422153204",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22036",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d3648b0fd35a2a17cb101d8fb13ed0bda91b029a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3648b0fd35a2a17cb101d8fb13ed0bda91b029a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024564932489271264",
"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/8859134870458314832/+/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:50e07c6201361d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609676969345565",
"url": "https://ci.chromium.org/b/8859134870458314832",
"utcnow_ts": "1609676969640891"
}
}
[12:29:29.683] Invocation finished in 2h35m40.330553667s with status FAILED