[06:41:06.425] New invocation is queued and will start shortly
[06:41:07.599] Starting the invocation (attempt 1)
[06:41:07.632] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:41:07.633] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:41:07.633] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028472726667636272",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ed3fa86440ef26f26e38cf20787ddbe702da1a6e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028472726667636272",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/ed3fa86440ef26f26e38cf20787ddbe702da1a6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed3fa86440ef26f26e38cf20787ddbe702da1a6e",
"gitiles_ref:refs/heads/master"
]
}
[06:41:08.252] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605940867726095",
"id": "8863042664642002336",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ed3fa86440ef26f26e38cf20787ddbe702da1a6e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605940868132520",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21408",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ed3fa86440ef26f26e38cf20787ddbe702da1a6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed3fa86440ef26f26e38cf20787ddbe702da1a6e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028472726667636272",
"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/8863042664642002336/+/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": "1605940868132669",
"url": "https://ci.chromium.org/b/8863042664642002336",
"utcnow_ts": "1605940868244552"
}
}
[06:41:08.252] Task URL: https://ci.chromium.org/b/8863042664642002336
[06:41:08.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:2:0) after 1m0s
[06:42:08.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:2:0)
[06:42:08.309] Timer tick, asking Buildbucket for the build status
[06:42:08.410] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:42:08.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:3:0) after 1m0s
[06:43:08.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:3:0)
[06:43:08.524] Timer tick, asking Buildbucket for the build status
[06:43:08.615] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:43:08.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:4:0) after 1m0s
[06:44:08.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:4:0)
[06:44:08.670] Timer tick, asking Buildbucket for the build status
[06:44:08.747] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:44:08.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:5:0) after 1m0s
[06:45:08.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:5:0)
[06:45:08.776] Timer tick, asking Buildbucket for the build status
[06:45:08.855] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:45:08.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:6:0) after 1m0s
[06:46:08.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:6:0)
[06:46:08.905] Timer tick, asking Buildbucket for the build status
[06:46:08.989] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:46:08.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:7:0) after 1m0s
[06:47:09.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:7:0)
[06:47:09.001] Timer tick, asking Buildbucket for the build status
[06:47:09.283] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:47:09.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:8:0) after 1m0s
[06:48:09.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:8:0)
[06:48:09.338] Timer tick, asking Buildbucket for the build status
[06:48:09.408] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:48:09.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:9:0) after 1m0s
[06:49:09.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:9:0)
[06:49:09.489] Timer tick, asking Buildbucket for the build status
[06:49:09.560] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:49:09.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:10:0) after 1m0s
[06:50:09.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:10:0)
[06:50:09.693] Timer tick, asking Buildbucket for the build status
[06:50:09.782] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:50:09.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:11:0) after 1m0s
[06:51:09.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:11:0)
[06:51:09.951] Timer tick, asking Buildbucket for the build status
[06:51:10.056] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:51:10.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:12:0) after 1m0s
[06:52:10.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:12:0)
[06:52:10.194] Timer tick, asking Buildbucket for the build status
[06:52:10.598] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:52:10.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:13:0) after 1m0s
[06:53:11.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:13:0)
[06:53:11.076] Timer tick, asking Buildbucket for the build status
[06:53:11.162] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:53:11.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:14:0) after 1m0s
[06:54:11.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:14:0)
[06:54:11.275] Timer tick, asking Buildbucket for the build status
[06:54:11.350] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:54:11.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:15:0) after 1m0s
[06:55:11.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:15:0)
[06:55:11.639] Timer tick, asking Buildbucket for the build status
[06:55:11.700] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:55:11.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:16:0) after 1m0s
[06:56:11.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:16:0)
[06:56:11.779] Timer tick, asking Buildbucket for the build status
[06:56:11.916] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:56:11.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:17:0) after 1m0s
[06:57:12.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:17:0)
[06:57:12.001] Timer tick, asking Buildbucket for the build status
[06:57:12.252] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:57:12.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:18:0) after 1m0s
[06:58:12.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:18:0)
[06:58:12.314] Timer tick, asking Buildbucket for the build status
[06:58:12.384] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:58:12.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:19:0) after 1m0s
[06:59:12.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:19:0)
[06:59:12.412] Timer tick, asking Buildbucket for the build status
[06:59:12.505] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:59:12.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:20:0) after 1m0s
[07:00:12.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:20:0)
[07:00:12.529] Timer tick, asking Buildbucket for the build status
[07:00:12.683] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:00:12.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:21:0) after 1m0s
[07:01:12.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:21:0)
[07:01:12.748] Timer tick, asking Buildbucket for the build status
[07:01:12.891] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:01:12.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:22:0) after 1m0s
[07:02:12.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:22:0)
[07:02:12.917] Timer tick, asking Buildbucket for the build status
[07:02:13.089] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:13.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:23:0) after 1m0s
[07:03:13.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:23:0)
[07:03:13.177] Timer tick, asking Buildbucket for the build status
[07:03:13.436] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:03:13.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:24:0) after 1m0s
[07:04:13.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:24:0)
[07:04:13.500] Timer tick, asking Buildbucket for the build status
[07:04:13.595] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:13.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:25:0) after 1m0s
[07:05:13.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:25:0)
[07:05:13.663] Timer tick, asking Buildbucket for the build status
[07:05:13.734] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:13.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:26:0) after 1m0s
[07:06:13.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:26:0)
[07:06:13.779] Timer tick, asking Buildbucket for the build status
[07:06:13.861] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:06:13.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:27:0) after 1m0s
[07:07:13.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:27:0)
[07:07:13.974] Timer tick, asking Buildbucket for the build status
[07:07:14.085] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:07:14.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:28:0) after 1m0s
[07:08:14.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:28:0)
[07:08:14.106] Timer tick, asking Buildbucket for the build status
[07:08:14.396] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:08:14.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:29:0) after 1m0s
[07:09:14.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:29:0)
[07:09:14.457] Timer tick, asking Buildbucket for the build status
[07:09:14.907] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:09:14.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:30:0) after 1m0s
[07:10:14.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:30:0)
[07:10:14.964] Timer tick, asking Buildbucket for the build status
[07:10:15.569] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:10:15.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:31:0) after 1m0s
[07:11:15.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:31:0)
[07:11:15.625] Timer tick, asking Buildbucket for the build status
[07:11:15.715] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:11:15.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:32:0) after 1m0s
[07:12:15.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:32:0)
[07:12:15.722] Timer tick, asking Buildbucket for the build status
[07:12:15.905] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:12:15.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:33:0) after 1m0s
[07:13:15.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:33:0)
[07:13:15.905] Timer tick, asking Buildbucket for the build status
[07:13:16.029] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:13:16.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:34:0) after 1m0s
[07:14:16.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:34:0)
[07:14:16.091] Timer tick, asking Buildbucket for the build status
[07:14:16.276] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:14:16.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:35:0) after 1m0s
[07:15:16.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:35:0)
[07:15:16.283] Timer tick, asking Buildbucket for the build status
[07:15:16.378] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:16.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:36:0) after 1m0s
[07:16:16.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:36:0)
[07:16:16.404] Timer tick, asking Buildbucket for the build status
[07:16:16.543] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:16:16.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:37:0) after 1m0s
[07:17:16.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:37:0)
[07:17:16.592] Timer tick, asking Buildbucket for the build status
[07:17:16.673] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:16.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:38:0) after 1m0s
[07:18:16.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:38:0)
[07:18:16.707] Timer tick, asking Buildbucket for the build status
[07:18:16.781] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:16.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:39:0) after 1m0s
[07:19:16.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:39:0)
[07:19:16.813] Timer tick, asking Buildbucket for the build status
[07:19:16.886] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:19:16.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:40:0) after 1m0s
[07:20:16.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:40:0)
[07:20:16.937] Timer tick, asking Buildbucket for the build status
[07:20:17.211] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:20:17.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:41:0) after 1m0s
[07:21:17.246] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:41:0)
[07:21:17.247] Timer tick, asking Buildbucket for the build status
[07:21:17.348] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:21:17.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:42:0) after 1m0s
[07:22:17.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:42:0)
[07:22:17.331] Timer tick, asking Buildbucket for the build status
[07:22:17.862] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:22:17.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:43:0) after 1m0s
[07:23:17.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:43:0)
[07:23:17.913] Timer tick, asking Buildbucket for the build status
[07:23:17.978] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:23:17.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:44:0) after 1m0s
[07:24:18.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:44:0)
[07:24:18.437] Timer tick, asking Buildbucket for the build status
[07:24:18.606] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:24:18.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:45:0) after 1m0s
[07:25:19.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:45:0)
[07:25:19.057] Timer tick, asking Buildbucket for the build status
[07:25:19.134] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:25:19.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:46:0) after 1m0s
[07:26:19.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:46:0)
[07:26:19.522] Timer tick, asking Buildbucket for the build status
[07:26:19.617] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:26:19.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:47:0) after 1m0s
[07:27:19.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:47:0)
[07:27:19.900] Timer tick, asking Buildbucket for the build status
[07:27:19.964] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:27:19.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:48:0) after 1m0s
[07:28:20.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:48:0)
[07:28:20.245] Timer tick, asking Buildbucket for the build status
[07:28:20.340] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:28:20.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:49:0) after 1m0s
[07:29:20.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:49:0)
[07:29:20.640] Timer tick, asking Buildbucket for the build status
[07:29:20.724] Build 8863042664642002336: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:29:20.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:50:0) after 1m0s
[07:29:59.631] Received PubSub notification, asking Buildbucket for the build status
[07:29:59.720] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:20.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:50:0)
[07:30:20.888] Timer tick, asking Buildbucket for the build status
[07:30:21.046] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:21.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:52:0) after 1m0s
[07:31:21.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:52:0)
[07:31:21.310] Timer tick, asking Buildbucket for the build status
[07:31:21.445] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:21.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:53:0) after 1m0s
[07:32:21.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:53:0)
[07:32:21.498] Timer tick, asking Buildbucket for the build status
[07:32:21.703] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:21.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:54:0) after 1m0s
[07:33:21.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:54:0)
[07:33:21.777] Timer tick, asking Buildbucket for the build status
[07:33:21.859] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:21.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:55:0) after 1m0s
[07:34:22.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:55:0)
[07:34:22.003] Timer tick, asking Buildbucket for the build status
[07:34:22.132] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:22.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:56:0) after 1m0s
[07:35:22.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:56:0)
[07:35:22.300] Timer tick, asking Buildbucket for the build status
[07:35:22.417] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:22.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:57:0) after 1m0s
[07:36:22.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:57:0)
[07:36:22.544] Timer tick, asking Buildbucket for the build status
[07:36:22.648] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:22.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:58:0) after 1m0s
[07:37:22.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:58:0)
[07:37:22.695] Timer tick, asking Buildbucket for the build status
[07:37:22.759] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:22.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:59:0) after 1m0s
[07:38:22.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:59:0)
[07:38:22.850] Timer tick, asking Buildbucket for the build status
[07:38:22.943] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:22.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:60:0) after 1m0s
[07:39:22.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:60:0)
[07:39:22.980] Timer tick, asking Buildbucket for the build status
[07:39:23.042] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:23.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:61:0) after 1m0s
[07:40:23.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:61:0)
[07:40:23.083] Timer tick, asking Buildbucket for the build status
[07:40:23.220] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:23.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:62:0) after 1m0s
[07:41:23.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:62:0)
[07:41:23.223] Timer tick, asking Buildbucket for the build status
[07:41:23.362] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:23.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:63:0) after 1m0s
[07:42:23.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:63:0)
[07:42:23.382] Timer tick, asking Buildbucket for the build status
[07:42:23.450] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:23.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:64:0) after 1m0s
[07:43:23.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:64:0)
[07:43:23.439] Timer tick, asking Buildbucket for the build status
[07:43:23.511] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:23.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:65:0) after 1m0s
[07:44:23.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:65:0)
[07:44:23.564] Timer tick, asking Buildbucket for the build status
[07:44:23.759] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:23.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:66:0) after 1m0s
[07:45:23.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:66:0)
[07:45:23.813] Timer tick, asking Buildbucket for the build status
[07:45:24.187] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:24.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:67:0) after 1m0s
[07:46:24.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:67:0)
[07:46:24.241] Timer tick, asking Buildbucket for the build status
[07:46:24.338] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:24.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:68:0) after 1m0s
[07:47:24.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:68:0)
[07:47:24.361] Timer tick, asking Buildbucket for the build status
[07:47:24.482] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:24.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:69:0) after 1m0s
[07:48:24.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:69:0)
[07:48:24.511] Timer tick, asking Buildbucket for the build status
[07:48:24.644] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:24.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:70:0) after 1m0s
[07:49:24.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:70:0)
[07:49:24.691] Timer tick, asking Buildbucket for the build status
[07:49:24.755] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:24.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:71:0) after 1m0s
[07:50:24.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:71:0)
[07:50:24.859] Timer tick, asking Buildbucket for the build status
[07:50:24.923] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:24.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:72:0) after 1m0s
[07:51:24.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:72:0)
[07:51:24.985] Timer tick, asking Buildbucket for the build status
[07:51:25.088] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:25.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:73:0) after 1m0s
[07:52:25.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:73:0)
[07:52:25.112] Timer tick, asking Buildbucket for the build status
[07:52:25.244] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:25.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:74:0) after 1m0s
[07:53:25.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:74:0)
[07:53:25.282] Timer tick, asking Buildbucket for the build status
[07:53:25.343] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:25.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:75:0) after 1m0s
[07:54:25.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:75:0)
[07:54:25.428] Timer tick, asking Buildbucket for the build status
[07:54:25.492] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:25.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:76:0) after 1m0s
[07:55:25.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:76:0)
[07:55:25.536] Timer tick, asking Buildbucket for the build status
[07:55:25.635] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:25.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:77:0) after 1m0s
[07:56:25.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:77:0)
[07:56:25.712] Timer tick, asking Buildbucket for the build status
[07:56:25.817] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:25.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:78:0) after 1m0s
[07:57:25.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:78:0)
[07:57:25.850] Timer tick, asking Buildbucket for the build status
[07:57:25.942] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:25.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:79:0) after 1m0s
[07:58:26.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:79:0)
[07:58:26.033] Timer tick, asking Buildbucket for the build status
[07:58:26.102] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:26.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:80:0) after 1m0s
[07:59:26.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:80:0)
[07:59:26.124] Timer tick, asking Buildbucket for the build status
[07:59:26.196] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:26.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:81:0) after 1m0s
[08:00:26.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:81:0)
[08:00:26.222] Timer tick, asking Buildbucket for the build status
[08:00:26.323] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:26.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:82:0) after 1m0s
[08:01:26.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:82:0)
[08:01:26.364] Timer tick, asking Buildbucket for the build status
[08:01:26.467] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:26.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:83:0) after 1m0s
[08:02:26.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:83:0)
[08:02:26.520] Timer tick, asking Buildbucket for the build status
[08:02:26.596] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:26.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:84:0) after 1m0s
[08:03:26.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:84:0)
[08:03:26.699] Timer tick, asking Buildbucket for the build status
[08:03:26.761] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:26.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:85:0) after 1m0s
[08:04:26.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:85:0)
[08:04:26.959] Timer tick, asking Buildbucket for the build status
[08:04:27.030] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:27.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:86:0) after 1m0s
[08:05:27.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:86:0)
[08:05:27.285] Timer tick, asking Buildbucket for the build status
[08:05:27.408] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:27.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:87:0) after 1m0s
[08:06:27.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:87:0)
[08:06:27.494] Timer tick, asking Buildbucket for the build status
[08:06:27.614] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:27.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:88:0) after 1m0s
[08:07:27.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:88:0)
[08:07:27.743] Timer tick, asking Buildbucket for the build status
[08:07:27.864] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:27.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:89:0) after 1m0s
[08:08:27.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:89:0)
[08:08:27.909] Timer tick, asking Buildbucket for the build status
[08:08:28.004] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:28.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:90:0) after 1m0s
[08:09:28.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:90:0)
[08:09:28.012] Timer tick, asking Buildbucket for the build status
[08:09:28.068] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:28.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:91:0) after 1m0s
[08:10:28.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:91:0)
[08:10:28.098] Timer tick, asking Buildbucket for the build status
[08:10:28.166] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:28.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:92:0) after 1m0s
[08:11:28.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:92:0)
[08:11:28.188] Timer tick, asking Buildbucket for the build status
[08:11:28.310] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:28.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:93:0) after 1m0s
[08:12:28.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:93:0)
[08:12:28.375] Timer tick, asking Buildbucket for the build status
[08:12:28.444] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:28.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:94:0) after 1m0s
[08:13:28.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:94:0)
[08:13:28.546] Timer tick, asking Buildbucket for the build status
[08:13:28.656] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:28.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:95:0) after 1m0s
[08:14:28.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:95:0)
[08:14:28.838] Timer tick, asking Buildbucket for the build status
[08:14:28.928] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:28.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:96:0) after 1m0s
[08:15:29.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:96:0)
[08:15:29.005] Timer tick, asking Buildbucket for the build status
[08:15:29.063] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:29.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:97:0) after 1m0s
[08:16:29.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:97:0)
[08:16:29.132] Timer tick, asking Buildbucket for the build status
[08:16:29.311] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:29.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:98:0) after 1m0s
[08:17:29.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:98:0)
[08:17:29.414] Timer tick, asking Buildbucket for the build status
[08:17:29.556] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:29.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:99:0) after 1m0s
[08:18:29.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:99:0)
[08:18:29.533] Timer tick, asking Buildbucket for the build status
[08:18:29.793] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:29.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:100:0) after 1m0s
[08:19:29.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:100:0)
[08:19:29.919] Timer tick, asking Buildbucket for the build status
[08:19:29.979] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:29.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:101:0) after 1m0s
[08:20:30.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:101:0)
[08:20:30.080] Timer tick, asking Buildbucket for the build status
[08:20:30.284] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:30.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:102:0) after 1m0s
[08:21:30.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:102:0)
[08:21:30.348] Timer tick, asking Buildbucket for the build status
[08:21:30.455] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:30.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:103:0) after 1m0s
[08:22:30.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:103:0)
[08:22:30.503] Timer tick, asking Buildbucket for the build status
[08:22:30.614] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:30.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:104:0) after 1m0s
[08:23:30.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:104:0)
[08:23:30.660] Timer tick, asking Buildbucket for the build status
[08:23:30.821] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:30.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:105:0) after 1m0s
[08:24:30.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:105:0)
[08:24:30.912] Timer tick, asking Buildbucket for the build status
[08:24:31.232] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:31.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:106:0) after 1m0s
[08:25:31.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:106:0)
[08:25:31.357] Timer tick, asking Buildbucket for the build status
[08:25:31.505] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:31.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:107:0) after 1m0s
[08:26:31.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:107:0)
[08:26:31.555] Timer tick, asking Buildbucket for the build status
[08:26:31.681] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:31.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:108:0) after 1m0s
[08:27:31.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:108:0)
[08:27:31.775] Timer tick, asking Buildbucket for the build status
[08:27:31.833] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:31.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:109:0) after 1m0s
[08:28:31.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:109:0)
[08:28:31.862] Timer tick, asking Buildbucket for the build status
[08:28:32.054] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:32.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:110:0) after 1m0s
[08:29:32.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:110:0)
[08:29:32.306] Timer tick, asking Buildbucket for the build status
[08:29:32.416] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:32.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:111:0) after 1m0s
[08:30:32.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:111:0)
[08:30:32.559] Timer tick, asking Buildbucket for the build status
[08:30:32.691] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:32.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:112:0) after 1m0s
[08:31:32.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:112:0)
[08:31:32.814] Timer tick, asking Buildbucket for the build status
[08:31:32.940] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:32.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:113:0) after 1m0s
[08:32:32.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:113:0)
[08:32:32.957] Timer tick, asking Buildbucket for the build status
[08:32:33.283] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:33.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:114:0) after 1m0s
[08:33:33.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:114:0)
[08:33:33.321] Timer tick, asking Buildbucket for the build status
[08:33:33.445] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:33.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:115:0) after 1m0s
[08:34:33.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:115:0)
[08:34:33.521] Timer tick, asking Buildbucket for the build status
[08:34:33.745] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:33.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:116:0) after 1m0s
[08:35:33.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:116:0)
[08:35:33.833] Timer tick, asking Buildbucket for the build status
[08:35:33.945] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:33.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:117:0) after 1m0s
[08:36:33.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:117:0)
[08:36:33.971] Timer tick, asking Buildbucket for the build status
[08:36:34.433] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:34.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:118:0) after 1m0s
[08:37:34.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:118:0)
[08:37:34.461] Timer tick, asking Buildbucket for the build status
[08:37:34.545] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:34.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:119:0) after 1m0s
[08:38:34.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:119:0)
[08:38:34.637] Timer tick, asking Buildbucket for the build status
[08:38:34.702] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:34.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:120:0) after 1m0s
[08:39:34.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:120:0)
[08:39:34.756] Timer tick, asking Buildbucket for the build status
[08:39:34.832] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:34.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:121:0) after 1m0s
[08:40:34.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:121:0)
[08:40:34.861] Timer tick, asking Buildbucket for the build status
[08:40:34.981] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:34.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:122:0) after 1m0s
[08:41:35.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:122:0)
[08:41:35.008] Timer tick, asking Buildbucket for the build status
[08:41:35.408] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:35.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:123:0) after 1m0s
[08:42:35.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:123:0)
[08:42:35.430] Timer tick, asking Buildbucket for the build status
[08:42:35.520] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:35.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:124:0) after 1m0s
[08:43:35.551] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:124:0)
[08:43:35.551] Timer tick, asking Buildbucket for the build status
[08:43:35.620] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:35.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:125:0) after 1m0s
[08:44:35.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:125:0)
[08:44:35.621] Timer tick, asking Buildbucket for the build status
[08:44:35.700] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:35.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:126:0) after 1m0s
[08:45:35.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:126:0)
[08:45:35.760] Timer tick, asking Buildbucket for the build status
[08:45:35.913] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:35.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:127:0) after 1m0s
[08:46:35.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:127:0)
[08:46:35.936] Timer tick, asking Buildbucket for the build status
[08:46:36.573] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:36.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:128:0) after 1m0s
[08:47:36.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:128:0)
[08:47:36.595] Timer tick, asking Buildbucket for the build status
[08:47:36.704] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:36.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:129:0) after 1m0s
[08:48:36.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:129:0)
[08:48:36.729] Timer tick, asking Buildbucket for the build status
[08:48:36.801] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:36.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:130:0) after 1m0s
[08:49:36.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:130:0)
[08:49:36.857] Timer tick, asking Buildbucket for the build status
[08:49:37.279] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:37.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:131:0) after 1m0s
[08:50:37.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:131:0)
[08:50:37.345] Timer tick, asking Buildbucket for the build status
[08:50:38.034] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:38.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:132:0) after 1m0s
[08:51:38.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:132:0)
[08:51:38.034] Timer tick, asking Buildbucket for the build status
[08:51:38.181] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:38.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:133:0) after 1m0s
[08:52:38.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:133:0)
[08:52:38.238] Timer tick, asking Buildbucket for the build status
[08:52:38.305] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:38.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:134:0) after 1m0s
[08:53:38.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:134:0)
[08:53:38.346] Timer tick, asking Buildbucket for the build status
[08:53:38.622] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:38.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:135:0) after 1m0s
[08:54:38.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:135:0)
[08:54:38.745] Timer tick, asking Buildbucket for the build status
[08:54:39.116] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:39.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:136:0) after 1m0s
[08:55:39.174] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:136:0)
[08:55:39.174] Timer tick, asking Buildbucket for the build status
[08:55:39.263] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:39.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:137:0) after 1m0s
[08:56:39.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:137:0)
[08:56:39.375] Timer tick, asking Buildbucket for the build status
[08:56:39.482] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:39.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:138:0) after 1m0s
[08:57:39.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:138:0)
[08:57:39.534] Timer tick, asking Buildbucket for the build status
[08:57:39.615] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:39.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:139:0) after 1m0s
[08:58:39.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:139:0)
[08:58:39.662] Timer tick, asking Buildbucket for the build status
[08:58:39.733] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:39.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:140:0) after 1m0s
[08:59:39.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:140:0)
[08:59:39.720] Timer tick, asking Buildbucket for the build status
[08:59:40.143] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:40.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:141:0) after 1m0s
[09:00:40.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:141:0)
[09:00:40.216] Timer tick, asking Buildbucket for the build status
[09:00:40.523] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:40.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:142:0) after 1m0s
[09:01:40.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:142:0)
[09:01:40.558] Timer tick, asking Buildbucket for the build status
[09:01:40.808] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:40.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:143:0) after 1m0s
[09:02:40.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:143:0)
[09:02:40.856] Timer tick, asking Buildbucket for the build status
[09:02:40.975] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:40.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:144:0) after 1m0s
[09:03:41.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:144:0)
[09:03:41.011] Timer tick, asking Buildbucket for the build status
[09:03:41.093] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:41.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:145:0) after 1m0s
[09:04:41.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:145:0)
[09:04:41.199] Timer tick, asking Buildbucket for the build status
[09:04:41.338] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:41.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:146:0) after 1m0s
[09:05:41.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:146:0)
[09:05:41.506] Timer tick, asking Buildbucket for the build status
[09:05:41.630] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:41.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:147:0) after 1m0s
[09:06:41.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:147:0)
[09:06:41.631] Timer tick, asking Buildbucket for the build status
[09:06:41.742] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:41.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:148:0) after 1m0s
[09:07:41.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:148:0)
[09:07:41.738] Timer tick, asking Buildbucket for the build status
[09:07:41.808] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:41.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:149:0) after 1m0s
[09:08:41.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:149:0)
[09:08:41.890] Timer tick, asking Buildbucket for the build status
[09:08:41.968] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:41.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:150:0) after 1m0s
[09:09:42.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:150:0)
[09:09:42.039] Timer tick, asking Buildbucket for the build status
[09:09:42.225] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:42.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:151:0) after 1m0s
[09:10:42.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:151:0)
[09:10:42.316] Timer tick, asking Buildbucket for the build status
[09:10:42.398] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:42.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:152:0) after 1m0s
[09:11:42.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:152:0)
[09:11:42.451] Timer tick, asking Buildbucket for the build status
[09:11:42.558] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:42.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:153:0) after 1m0s
[09:12:42.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:153:0)
[09:12:42.585] Timer tick, asking Buildbucket for the build status
[09:12:42.705] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:42.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:154:0) after 1m0s
[09:13:42.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:154:0)
[09:13:42.767] Timer tick, asking Buildbucket for the build status
[09:13:42.939] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:42.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:155:0) after 1m0s
[09:14:42.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:155:0)
[09:14:42.975] Timer tick, asking Buildbucket for the build status
[09:14:43.057] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:43.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:156:0) after 1m0s
[09:15:43.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:156:0)
[09:15:43.124] Timer tick, asking Buildbucket for the build status
[09:15:43.467] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:43.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:157:0) after 1m0s
[09:16:43.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:157:0)
[09:16:43.489] Timer tick, asking Buildbucket for the build status
[09:16:43.609] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:43.609] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:158:0) after 1m0s
[09:17:43.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:158:0)
[09:17:43.664] Timer tick, asking Buildbucket for the build status
[09:17:43.775] Build 8863042664642002336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:43.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028472726667636272:159:0) after 1m0s
[09:17:49.296] Received PubSub notification, asking Buildbucket for the build status
[09:17:49.379] Build 8863042664642002336: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[09:17:49.379] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605950268520838",
"created_by": "project:chromium",
"created_ts": "1605940867726095",
"failure_reason": "BUILD_FAILURE",
"id": "8863042664642002336",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ed3fa86440ef26f26e38cf20787ddbe702da1a6e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- RecordingServiceBrowserTest.RecordingInterruptedOnCaptureLocked\"}, \"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\": \"ed3fa86440ef26f26e38cf20787ddbe702da1a6e\", \"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-38-ovbl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21408, \"got_angle_revision\": \"040de9214830ab194b073f35596f70c0e965df91\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"ed3fa86440ef26f26e38cf20787ddbe702da1a6e\", \"got_revision_cp\": \"refs/heads/master@{#829961}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"fa2966f12624e498083c1f4cacd3f82d14f4eacb\", \"got_v8_revision_cp\": \"refs/heads/8.9.30@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ed3fa86440ef26f26e38cf20787ddbe702da1a6e\", \"swarm_hashes_refs/heads/master(at){#829961}_without_patch\": {\"absl_hardening_tests\": \"bab17941a8426673cecd2ba1c171827729a43936\", \"accessibility_unittests\": \"c8e38cd791aa89d0d5662e8987d0a5bb42fc06c8\", \"angle_unittests\": \"dfae650d847fbefe7fdf688b5bb72e9d51b49a96\", \"app_list_unittests\": \"c1df9be0388626d4bf76d5c0998b8ff16c6b6c14\", \"app_shell_unittests\": \"219235da027404467d54c1c1382576a55d9ebb21\", \"ash_unittests\": \"d32ecd5f8f4017af9052436010214d5ea93d85d1\", \"aura_unittests\": \"97fbb6ae3b8bdeece1c07338611e0f16916ce6e6\", \"base_unittests\": \"fcf86e9135094bd05b1e438103a71ce4f83ca066\", \"base_util_unittests\": \"51483e7d88ab82be3d11a12f5290996116daeb5d\", \"blink_common_unittests\": \"832aeea5968b24211c74c21c29e5d19e00e6e4c2\", \"blink_fuzzer_unittests\": \"465e8b4feb8af70b68526b6a26c41052cdd05729\", \"blink_heap_unittests\": \"d62318ef1e3636a7e0e2adcf4d762df8a39cc4ba\", \"blink_platform_unittests\": \"64c9d3b6b7b8612481895254f2ec8105b41490b3\", \"blink_unittests\": \"c4140e6f4770cc8785351eb880386a64a6439725\", \"boringssl_crypto_tests\": \"759047396816eafb873208c92f90b32edbffdbe1\", \"boringssl_ssl_tests\": \"26ab3eac59b4eddd709d482174f4aff932125bf1\", \"browser_tests\": \"d0dbc34724fb7a890eb6ddb3312bf038897d9e6b\", \"capture_unittests\": \"ef044c1c88150407309cd28bdd6d90198414bf20\", \"cast_unittests\": \"e0a63001d6841ae6fd9750d254b62d9f243f6e9e\", \"cc_unittests\": \"f4c98378db9f2e1eacbe5cddb198d96f7281df49\", \"chrome_app_unittests\": \"80914804f4ed9b225b70ab86de1fcce9a11040eb\", \"chromedriver_unittests\": \"16a876c22994e7fdbb74d2e5aa7a7d23d2bc4270\", \"chromeos_components_unittests\": \"7872d5be7447797e14aab8faa853536c8a19bdb9\", \"chromeos_unittests\": \"c2f34afff72dd6bca99ebea71e7d0d8fc54c893b\", \"components_browsertests\": \"10d1d86f2266d7e947c2d7b6ffdc0b2cf98730cc\", \"components_unittests\": \"aca4781459f643f1be5f8725d601e5bfbb0f00fb\", \"compositor_unittests\": \"0a26835a118c4bfe3010405bd56a0c54f9cbff29\", \"content_browsertests\": \"4275f5aae259b4a792e17c0bc0a7095665364741\", \"content_unittests\": \"7bb721cdcfa9164f84c9ede0d33fb88de568762e\", \"crashpad_tests\": \"e55d70adefd0c1128209f73eedbb11da3f8c6de9\", \"crypto_unittests\": \"6920b4ed35541f63906c63d6da86548d87d24ab2\", \"dbus_unittests\": \"ba8880ac83ba852465f73a4ecdbe2bbfcd032fdf\", \"device_unittests\": \"281e32668a38f9a2551fc0406c08b6724ef75966\", \"display_unittests\": \"6fdc04d93900582f7ba328796b7112d0c49ac330\", \"events_unittests\": \"daeaa5fb5c148a79cdb1601e3658146628515c31\", \"exo_unittests\": \"610fde9cda73f06721286f465586768aaf3b3f3c\", \"extensions_browsertests\": \"92f2e4180d523b495eb0ffcce3707e0091910a86\", \"extensions_unittests\": \"e5ef0e35089ec803266d19c31621d59159c732df\", \"filesystem_service_unittests\": \"148439324e8b0eab977da4729065f9ba1d49a7e0\", \"gcm_unit_tests\": \"4657d4fea8849386b07a863d83efba3d4965bbda\", \"gfx_unittests\": \"05fd416504b5a1d86a5c1a734641764daabb53e8\", \"gin_unittests\": \"73d59d2cbcca0fbc9af0359911a073d6971be718\", \"gl_unittests_ozone\": \"20b6ab29ba30585e7c9715387ebd3225c96ffdd3\", \"google_apis_unittests\": \"4f186ca5521458f5514c1278832b42180331e64b\", \"gpu_unittests\": \"4381a3e206eb03d96a2207fac1c7b4bac28063d1\", \"gwp_asan_unittests\": \"c99833dcbb0e2f833fb989ccb2b56c9f3ca5703e\", \"interactive_ui_tests\": \"1f0aa5ae60d9186c357e78c8eafecfe68e291a66\", \"ipc_tests\": \"01762122dbd00356ea7b2d93a21d938aa3388798\", \"jingle_unittests\": \"6c7344fb2afb98d691a66259fa3635187f4aefa9\", \"keyboard_unittests\": \"82ac14ffdb3dc33f6d0f46aae79d9209c361166f\", \"latency_unittests\": \"700a6d736c5fe7dd3b3a1fbe60ecdba68cfa7f35\", \"libjingle_xmpp_unittests\": \"d7a25e9ced377a864233f1c17b1dfc10c55de8f4\", \"liburlpattern_unittests\": \"3afdcaf466a2ad8b2006b1866a578a54c5e6f305\", \"media_blink_unittests\": \"19ee21a00528f66a60eb64084ca67fa7aa34079d\", \"media_unittests\": \"350e7094a1d0c5626cc350809eed60e7ef10489f\", \"message_center_unittests\": \"123d4784ff85a5b3ee3f4f4f5633effc06ac6abe\", \"midi_unittests\": \"3e8aa7fbe147c1541428ccf9ae24f913f09fa065\", \"mojo_core_unittests\": \"56f9d4f5a00eda3a367f62e49adbbc9f0d8ee779\", \"mojo_unittests\": \"b1867f3dabc767e1cf4ee4668dfa7c95a5ae53c6\", \"nacl_helper_nonsfi_unittests\": \"070470da83fe73fa5608b900f6d2de65b0752e1b\", \"nacl_loader_unittests\": \"31897edc80c3cc2d2fd7a39f226469194fe89dc3\", \"native_theme_unittests\": \"6d2f707b18402e245c45eb7b3f20d53eec2c4694\", \"net_unittests\": \"e6e938aaa70c3e2c0f6391768475cbfd85285a02\", \"ozone_gl_unittests\": \"7f967a5aa63587c505c67ce5be4aa99e7b5335ff\", \"ozone_unittests\": \"ae4443d01ef1308bde830185ab6daa7959e293f2\", \"ozone_x11_unittests\": \"fd85536001c92b4791562fe3ae62b62fdfb49640\", \"pdf_unittests\": \"33ebbcf3fa4339ea45df5d9bf28839fa745ce232\", \"perfetto_unittests\": \"1051db82915c1155c85db38f7fd2fc453e88bcef\", \"ppapi_unittests\": \"d68c4bc8701f4a4c31565d068652bcdef6363f98\", \"printing_unittests\": \"8fdfe3ccb71313f403d289bd139e66f6f25ea137\", \"remoting_unittests\": \"a491c31817dba2d8dd80802323fd4367b5d6b33c\", \"sandbox_linux_unittests\": \"ef548146519ac7bbc3431a46200d54c7bcab4587\", \"service_manager_unittests\": \"8fbe12330687861b27596bcda50ccee51ad11de7\", \"services_unittests\": \"56bfe3bc8df67d4abbc0924e219e0316c6742f33\", \"shell_dialogs_unittests\": \"9b485d779454700d1d1578a5683f043827f5b01a\", \"skia_unittests\": \"4d3b7af73d0fd052e5d7da9b8e9a872a31522962\", \"snapshot_unittests\": \"6de11bcfbe92ceb3685814f7b07c2c28b04d0eca\", \"sql_unittests\": \"982aaffe149e2ca4e37673e669ee723af186e179\", \"storage_unittests\": \"399059ac404559f8e1878a9d0c08165ec4a5a3bc\", \"sync_integration_tests\": \"7d1e57ab3648093eaf0c974df00eb26457feffcf\", \"traffic_annotation_auditor_unittests\": \"ff3a2f5bf1c19ab7f1d65b1eeaa5800e3b21bacf\", \"ui_base_unittests\": \"218775cd664b92063718659b95bac24982066185\", \"ui_chromeos_unittests\": \"dc03d864cba019d8818498e013a1a403c539db81\", \"ui_touch_selection_unittests\": \"b6cf49205523b18551ebfec5306f1cb19453e822\", \"unit_tests\": \"456871bc173793f2b2dc4239c98e2482e3e26538\", \"url_unittests\": \"03adf97baff6d0528d415aee39418543aff7b1d4\", \"usage_time_limit_unittests\": \"e4957f97361f13e59385afed25b2c2d14c96b356\", \"views_unittests\": \"b98edcde52faf4a786154ed35c26c6618dc3da70\", \"viz_unittests\": \"36365a0660f2e61cda977f6c4e75dc9a8ed533ac\", \"wm_unittests\": \"471f26711eb40288da9c4c8b5c4513a6673d033b\", \"wtf_unittests\": \"a72ddb001808369e585814d6aa39a6004eff6989\", \"zlib_unittests\": \"aecb9de89d942f1f1bf64b2cf68d2f965f8bac10\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0e4559ffd6169ab721e778dfe83867ca08424e9b4d480f5c0e6f91286240fc3f_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_78080097a3960c8831291638a631c67e272aa3d821d469cd7fbf44d1ce982b94_v2\", \"builder_7ac44f9f43d6a2d32c05bd5b65ce082467e4e76030f98d79d844856060c02531_v2\", \"builder_8ed59a4fa98a52009c5b7be7e9c90826b738aab438c85f8db549ef122247493f_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_b73f380ff82aebbfe08c374279666467ed7ae9f4699bdf686b893daa00950c8e_v2\", \"builder_e3c511bab72b23733448544bf03eead15dcea51fe3ad494bd400cacf7c8c4bfb_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_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-38-ovbl\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- RecordingServiceBrowserTest.RecordingInterruptedOnCaptureLocked\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605943798916042",
"status": "COMPLETED",
"status_changed_ts": "1605943799284724",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21408",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ed3fa86440ef26f26e38cf20787ddbe702da1a6e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed3fa86440ef26f26e38cf20787ddbe702da1a6e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028472726667636272",
"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/8863042664642002336/+/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:50025a7d07dc2a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605950268846395",
"url": "https://ci.chromium.org/b/8863042664642002336",
"utcnow_ts": "1605950269367643"
}
}
[09:17:49.379] Invocation finished in 2h36m42.968794021s with status FAILED