[03:00:42.147] New invocation is queued and will start shortly
[03:00:43.243] Starting the invocation (attempt 1)
[03:00:43.282] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:43.282] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:43.282] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023050775348023424",
"parameters_json": "{\"builder_name\":\"linux-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"17801e45e6fead9859bb0f1748afd7efd3e76899\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-official",
"scheduler_invocation_id:9023050775348023424",
"scheduler_job_id:chromium/linux-official",
"user_agent:luci-scheduler",
"buildset:commit/git/17801e45e6fead9859bb0f1748afd7efd3e76899",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17801e45e6fead9859bb0f1748afd7efd3e76899",
"gitiles_ref:refs/heads/master"
]
}
[03:00:43.999] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611111643372443",
"id": "8857620713397614096",
"parameters_json": "{\"builder_name\": \"linux-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611111643856809",
"tags": [
"build_address:luci.chromium.ci/linux-official/1708",
"builder:linux-official",
"buildset:commit/git/17801e45e6fead9859bb0f1748afd7efd3e76899",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17801e45e6fead9859bb0f1748afd7efd3e76899",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023050775348023424",
"scheduler_job_id:chromium/linux-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857620713397614096/+/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": "1611111643856917",
"url": "https://ci.chromium.org/b/8857620713397614096",
"utcnow_ts": "1611111643988203"
}
}
[03:00:43.999] Task URL: https://ci.chromium.org/b/8857620713397614096
[03:00:43.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:2:0) after 1m0s
[03:00:49.178] Received PubSub notification, asking Buildbucket for the build status
[03:00:49.251] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:43.982] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:2:0)
[03:01:43.982] Timer tick, asking Buildbucket for the build status
[03:01:44.102] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:44.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:4:0) after 1m0s
[03:02:44.143] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:4:0)
[03:02:44.143] Timer tick, asking Buildbucket for the build status
[03:02:44.213] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:44.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:5:0) after 1m0s
[03:03:44.363] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:5:0)
[03:03:44.363] Timer tick, asking Buildbucket for the build status
[03:03:44.470] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:44.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:6:0) after 1m0s
[03:04:44.503] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:6:0)
[03:04:44.503] Timer tick, asking Buildbucket for the build status
[03:04:44.966] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:44.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:7:0) after 1m0s
[03:05:45.254] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:7:0)
[03:05:45.254] Timer tick, asking Buildbucket for the build status
[03:05:45.362] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:45.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:8:0) after 1m0s
[03:06:45.639] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:8:0)
[03:06:45.639] Timer tick, asking Buildbucket for the build status
[03:06:45.902] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:45.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:9:0) after 1m0s
[03:07:45.892] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:9:0)
[03:07:45.892] Timer tick, asking Buildbucket for the build status
[03:07:46.269] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:46.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:10:0) after 1m0s
[03:08:46.295] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:10:0)
[03:08:46.295] Timer tick, asking Buildbucket for the build status
[03:08:46.812] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:46.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:11:0) after 1m0s
[03:09:46.881] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:11:0)
[03:09:46.881] Timer tick, asking Buildbucket for the build status
[03:09:46.947] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:46.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:12:0) after 1m0s
[03:10:48.996] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:12:0)
[03:10:48.996] Timer tick, asking Buildbucket for the build status
[03:10:49.191] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:49.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:13:0) after 1m0s
[03:11:49.708] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:13:0)
[03:11:49.708] Timer tick, asking Buildbucket for the build status
[03:11:50.099] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:50.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:14:0) after 1m0s
[03:12:50.125] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:14:0)
[03:12:50.125] Timer tick, asking Buildbucket for the build status
[03:12:50.228] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:50.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:15:0) after 1m0s
[03:13:50.451] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:15:0)
[03:13:50.451] Timer tick, asking Buildbucket for the build status
[03:13:50.714] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:50.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:16:0) after 1m0s
[03:14:50.788] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:16:0)
[03:14:50.788] Timer tick, asking Buildbucket for the build status
[03:14:50.847] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:50.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:17:0) after 1m0s
[03:15:50.884] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:17:0)
[03:15:50.884] Timer tick, asking Buildbucket for the build status
[03:15:51.015] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:51.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:18:0) after 1m0s
[03:16:51.076] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:18:0)
[03:16:51.076] Timer tick, asking Buildbucket for the build status
[03:16:51.135] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:51.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:19:0) after 1m0s
[03:17:51.158] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:19:0)
[03:17:51.158] Timer tick, asking Buildbucket for the build status
[03:17:51.211] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:51.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:20:0) after 1m0s
[03:18:51.337] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:20:0)
[03:18:51.337] Timer tick, asking Buildbucket for the build status
[03:18:51.421] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:51.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:21:0) after 1m0s
[03:19:51.472] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:21:0)
[03:19:51.472] Timer tick, asking Buildbucket for the build status
[03:19:51.531] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:51.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:22:0) after 1m0s
[03:20:51.588] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:22:0)
[03:20:51.588] Timer tick, asking Buildbucket for the build status
[03:20:51.705] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:51.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:23:0) after 1m0s
[03:21:51.809] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:23:0)
[03:21:51.809] Timer tick, asking Buildbucket for the build status
[03:21:51.869] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:51.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:24:0) after 1m0s
[03:22:51.992] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:24:0)
[03:22:51.992] Timer tick, asking Buildbucket for the build status
[03:22:52.065] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:52.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:25:0) after 1m0s
[03:23:52.123] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:25:0)
[03:23:52.123] Timer tick, asking Buildbucket for the build status
[03:23:52.215] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:52.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:26:0) after 1m0s
[03:24:52.252] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:26:0)
[03:24:52.252] Timer tick, asking Buildbucket for the build status
[03:24:52.330] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:52.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:27:0) after 1m0s
[03:25:52.371] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:27:0)
[03:25:52.371] Timer tick, asking Buildbucket for the build status
[03:25:52.477] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:52.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:28:0) after 1m0s
[03:26:52.591] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:28:0)
[03:26:52.591] Timer tick, asking Buildbucket for the build status
[03:26:52.646] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:52.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:29:0) after 1m0s
[03:27:52.849] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:29:0)
[03:27:52.849] Timer tick, asking Buildbucket for the build status
[03:27:52.926] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:52.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:30:0) after 1m0s
[03:28:53.010] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:30:0)
[03:28:53.010] Timer tick, asking Buildbucket for the build status
[03:28:53.094] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:53.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:31:0) after 1m0s
[03:29:53.216] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:31:0)
[03:29:53.216] Timer tick, asking Buildbucket for the build status
[03:29:53.299] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:53.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:32:0) after 1m0s
[03:30:53.349] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:32:0)
[03:30:53.349] Timer tick, asking Buildbucket for the build status
[03:30:53.481] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:53.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:33:0) after 1m0s
[03:31:53.550] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:33:0)
[03:31:53.550] Timer tick, asking Buildbucket for the build status
[03:31:53.634] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:53.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:34:0) after 1m0s
[03:32:53.697] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:34:0)
[03:32:53.697] Timer tick, asking Buildbucket for the build status
[03:32:53.767] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:53.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:35:0) after 1m0s
[03:33:53.812] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:35:0)
[03:33:53.812] Timer tick, asking Buildbucket for the build status
[03:33:53.883] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:53.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:36:0) after 1m0s
[03:34:53.983] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:36:0)
[03:34:53.983] Timer tick, asking Buildbucket for the build status
[03:34:54.047] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:54.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:37:0) after 1m0s
[03:35:54.121] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:37:0)
[03:35:54.121] Timer tick, asking Buildbucket for the build status
[03:35:54.246] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:54.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:38:0) after 1m0s
[03:36:54.255] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:38:0)
[03:36:54.255] Timer tick, asking Buildbucket for the build status
[03:36:54.315] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:54.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:39:0) after 1m0s
[03:37:54.348] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:39:0)
[03:37:54.348] Timer tick, asking Buildbucket for the build status
[03:37:54.401] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:54.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:40:0) after 1m0s
[03:38:54.466] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:40:0)
[03:38:54.466] Timer tick, asking Buildbucket for the build status
[03:38:54.713] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:54.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:41:0) after 1m0s
[03:39:54.744] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:41:0)
[03:39:54.744] Timer tick, asking Buildbucket for the build status
[03:39:54.809] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:54.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:42:0) after 1m0s
[03:40:54.828] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:42:0)
[03:40:54.828] Timer tick, asking Buildbucket for the build status
[03:40:54.943] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:54.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:43:0) after 1m0s
[03:41:54.969] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:43:0)
[03:41:54.969] Timer tick, asking Buildbucket for the build status
[03:41:55.026] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:55.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:44:0) after 1m0s
[03:42:55.038] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:44:0)
[03:42:55.038] Timer tick, asking Buildbucket for the build status
[03:42:55.093] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:55.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:45:0) after 1m0s
[03:43:55.117] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:45:0)
[03:43:55.117] Timer tick, asking Buildbucket for the build status
[03:43:55.174] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:55.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:46:0) after 1m0s
[03:44:55.241] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:46:0)
[03:44:55.241] Timer tick, asking Buildbucket for the build status
[03:44:55.553] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:55.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:47:0) after 1m0s
[03:45:55.585] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:47:0)
[03:45:55.585] Timer tick, asking Buildbucket for the build status
[03:45:55.697] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:55.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:48:0) after 1m0s
[03:46:55.757] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:48:0)
[03:46:55.757] Timer tick, asking Buildbucket for the build status
[03:46:55.851] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:55.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:49:0) after 1m0s
[03:47:55.891] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:49:0)
[03:47:55.891] Timer tick, asking Buildbucket for the build status
[03:47:55.958] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:55.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:50:0) after 1m0s
[03:48:55.965] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:50:0)
[03:48:55.966] Timer tick, asking Buildbucket for the build status
[03:48:56.094] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:56.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:51:0) after 1m0s
[03:49:56.116] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:51:0)
[03:49:56.116] Timer tick, asking Buildbucket for the build status
[03:49:56.408] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:56.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:52:0) after 1m0s
[03:50:56.470] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:52:0)
[03:50:56.470] Timer tick, asking Buildbucket for the build status
[03:50:56.576] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:56.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:53:0) after 1m0s
[03:51:56.600] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:53:0)
[03:51:56.600] Timer tick, asking Buildbucket for the build status
[03:51:56.664] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:56.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:54:0) after 1m0s
[03:52:56.682] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:54:0)
[03:52:56.682] Timer tick, asking Buildbucket for the build status
[03:52:56.805] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:56.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:55:0) after 1m0s
[03:53:56.884] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:55:0)
[03:53:56.884] Timer tick, asking Buildbucket for the build status
[03:53:56.974] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:56.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:56:0) after 1m0s
[03:54:57.162] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:56:0)
[03:54:57.162] Timer tick, asking Buildbucket for the build status
[03:54:57.568] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:57.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:57:0) after 1m0s
[03:55:57.618] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:57:0)
[03:55:57.618] Timer tick, asking Buildbucket for the build status
[03:55:58.150] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:58.150] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:58:0) after 1m0s
[03:56:58.177] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:58:0)
[03:56:58.177] Timer tick, asking Buildbucket for the build status
[03:56:58.249] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:58.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:59:0) after 1m0s
[03:57:58.297] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:59:0)
[03:57:58.297] Timer tick, asking Buildbucket for the build status
[03:57:58.361] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:58.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:60:0) after 1m0s
[03:58:58.390] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:60:0)
[03:58:58.390] Timer tick, asking Buildbucket for the build status
[03:58:58.708] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:58.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:61:0) after 1m0s
[03:59:58.767] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:61:0)
[03:59:58.767] Timer tick, asking Buildbucket for the build status
[03:59:58.879] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:58.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:62:0) after 1m0s
[04:00:58.912] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:62:0)
[04:00:58.912] Timer tick, asking Buildbucket for the build status
[04:00:59.045] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:59.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:63:0) after 1m0s
[04:01:59.070] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:63:0)
[04:01:59.070] Timer tick, asking Buildbucket for the build status
[04:01:59.133] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:59.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:64:0) after 1m0s
[04:02:59.158] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:64:0)
[04:02:59.158] Timer tick, asking Buildbucket for the build status
[04:02:59.427] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:59.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:65:0) after 1m0s
[04:03:59.488] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:65:0)
[04:03:59.488] Timer tick, asking Buildbucket for the build status
[04:03:59.535] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:59.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:66:0) after 1m0s
[04:04:59.568] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:66:0)
[04:04:59.568] Timer tick, asking Buildbucket for the build status
[04:04:59.628] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:59.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:67:0) after 1m0s
[04:05:59.699] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:67:0)
[04:05:59.699] Timer tick, asking Buildbucket for the build status
[04:05:59.805] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:59.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:68:0) after 1m0s
[04:06:59.870] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:68:0)
[04:06:59.870] Timer tick, asking Buildbucket for the build status
[04:06:59.931] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:59.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:69:0) after 1m0s
[04:07:59.956] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:69:0)
[04:07:59.956] Timer tick, asking Buildbucket for the build status
[04:08:00.187] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:00.187] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:70:0) after 1m0s
[04:09:00.193] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:70:0)
[04:09:00.193] Timer tick, asking Buildbucket for the build status
[04:09:00.897] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:00.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:71:0) after 1m0s
[04:10:01.296] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:71:0)
[04:10:01.296] Timer tick, asking Buildbucket for the build status
[04:10:01.360] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:01.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:72:0) after 1m0s
[04:11:01.682] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:72:0)
[04:11:01.682] Timer tick, asking Buildbucket for the build status
[04:11:01.809] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:01.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:73:0) after 1m0s
[04:12:01.941] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:73:0)
[04:12:01.941] Timer tick, asking Buildbucket for the build status
[04:12:02.086] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:02.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:74:0) after 1m0s
[04:13:02.175] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:74:0)
[04:13:02.175] Timer tick, asking Buildbucket for the build status
[04:13:02.407] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:02.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:75:0) after 1m0s
[04:14:02.565] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:75:0)
[04:14:02.565] Timer tick, asking Buildbucket for the build status
[04:14:02.635] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:02.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:76:0) after 1m0s
[04:15:02.765] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:76:0)
[04:15:02.765] Timer tick, asking Buildbucket for the build status
[04:15:02.984] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:02.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:77:0) after 1m0s
[04:16:03.034] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:77:0)
[04:16:03.034] Timer tick, asking Buildbucket for the build status
[04:16:03.133] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:03.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:78:0) after 1m0s
[04:17:03.156] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:78:0)
[04:17:03.156] Timer tick, asking Buildbucket for the build status
[04:17:03.228] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:03.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:79:0) after 1m0s
[04:18:03.299] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:79:0)
[04:18:03.299] Timer tick, asking Buildbucket for the build status
[04:18:03.366] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:03.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:80:0) after 1m0s
[04:19:03.440] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:80:0)
[04:19:03.440] Timer tick, asking Buildbucket for the build status
[04:19:03.533] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:03.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:81:0) after 1m0s
[04:20:03.612] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:81:0)
[04:20:03.612] Timer tick, asking Buildbucket for the build status
[04:20:03.739] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:03.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:82:0) after 1m0s
[04:21:03.807] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:82:0)
[04:21:03.807] Timer tick, asking Buildbucket for the build status
[04:21:03.931] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:03.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:83:0) after 1m0s
[04:22:04.004] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:83:0)
[04:22:04.004] Timer tick, asking Buildbucket for the build status
[04:22:04.067] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:04.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:84:0) after 1m0s
[04:23:04.123] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:84:0)
[04:23:04.123] Timer tick, asking Buildbucket for the build status
[04:23:04.182] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:04.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:85:0) after 1m0s
[04:24:04.245] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:85:0)
[04:24:04.245] Timer tick, asking Buildbucket for the build status
[04:24:04.302] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:04.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:86:0) after 1m0s
[04:25:04.402] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:86:0)
[04:25:04.402] Timer tick, asking Buildbucket for the build status
[04:25:04.606] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:04.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:87:0) after 1m0s
[04:26:04.745] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:87:0)
[04:26:04.745] Timer tick, asking Buildbucket for the build status
[04:26:04.908] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:04.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:88:0) after 1m0s
[04:27:05.062] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:88:0)
[04:27:05.062] Timer tick, asking Buildbucket for the build status
[04:27:05.242] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:05.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:89:0) after 1m0s
[04:28:05.387] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:89:0)
[04:28:05.387] Timer tick, asking Buildbucket for the build status
[04:28:05.537] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:05.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:90:0) after 1m0s
[04:29:05.681] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:90:0)
[04:29:05.681] Timer tick, asking Buildbucket for the build status
[04:29:05.894] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:05.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:91:0) after 1m0s
[04:30:05.991] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:91:0)
[04:30:05.991] Timer tick, asking Buildbucket for the build status
[04:30:06.172] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:06.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:92:0) after 1m0s
[04:31:06.959] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:92:0)
[04:31:06.959] Timer tick, asking Buildbucket for the build status
[04:31:07.058] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:07.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:93:0) after 1m0s
[04:32:07.148] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:93:0)
[04:32:07.148] Timer tick, asking Buildbucket for the build status
[04:32:07.212] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:07.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:94:0) after 1m0s
[04:33:08.167] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:94:0)
[04:33:08.168] Timer tick, asking Buildbucket for the build status
[04:33:08.232] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:08.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:95:0) after 1m0s
[04:34:08.494] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:95:0)
[04:34:08.494] Timer tick, asking Buildbucket for the build status
[04:34:08.593] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:08.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:96:0) after 1m0s
[04:35:08.766] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:96:0)
[04:35:08.766] Timer tick, asking Buildbucket for the build status
[04:35:08.838] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:08.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:97:0) after 1m0s
[04:36:09.056] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:97:0)
[04:36:09.056] Timer tick, asking Buildbucket for the build status
[04:36:09.246] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:09.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:98:0) after 1m0s
[04:37:09.334] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:98:0)
[04:37:09.334] Timer tick, asking Buildbucket for the build status
[04:37:09.696] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:09.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:99:0) after 1m0s
[04:38:09.720] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:99:0)
[04:38:09.720] Timer tick, asking Buildbucket for the build status
[04:38:09.798] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:09.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:100:0) after 1m0s
[04:39:09.870] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:100:0)
[04:39:09.870] Timer tick, asking Buildbucket for the build status
[04:39:09.997] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:09.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:101:0) after 1m0s
[04:40:10.162] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:101:0)
[04:40:10.162] Timer tick, asking Buildbucket for the build status
[04:40:10.223] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:10.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:102:0) after 1m0s
[04:41:10.259] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:102:0)
[04:41:10.259] Timer tick, asking Buildbucket for the build status
[04:41:10.612] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:10.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:103:0) after 1m0s
[04:42:10.726] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:103:0)
[04:42:10.726] Timer tick, asking Buildbucket for the build status
[04:42:10.779] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:10.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:104:0) after 1m0s
[04:43:11.096] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:104:0)
[04:43:11.096] Timer tick, asking Buildbucket for the build status
[04:43:11.152] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:11.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:105:0) after 1m0s
[04:44:11.218] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:105:0)
[04:44:11.218] Timer tick, asking Buildbucket for the build status
[04:44:11.460] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:11.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:106:0) after 1m0s
[04:45:11.563] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:106:0)
[04:45:11.563] Timer tick, asking Buildbucket for the build status
[04:45:11.645] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:11.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:107:0) after 1m0s
[04:46:11.757] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:107:0)
[04:46:11.757] Timer tick, asking Buildbucket for the build status
[04:46:11.854] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:11.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:108:0) after 1m0s
[04:47:11.968] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:108:0)
[04:47:11.968] Timer tick, asking Buildbucket for the build status
[04:47:12.690] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:12.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:109:0) after 1m0s
[04:48:12.711] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:109:0)
[04:48:12.711] Timer tick, asking Buildbucket for the build status
[04:48:12.768] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:12.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:110:0) after 1m0s
[04:49:12.893] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:110:0)
[04:49:12.893] Timer tick, asking Buildbucket for the build status
[04:49:12.997] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:12.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:111:0) after 1m0s
[04:50:13.116] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:111:0)
[04:50:13.116] Timer tick, asking Buildbucket for the build status
[04:50:13.218] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:13.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:112:0) after 1m0s
[04:51:13.245] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:112:0)
[04:51:13.245] Timer tick, asking Buildbucket for the build status
[04:51:13.344] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:13.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:113:0) after 1m0s
[04:52:13.359] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:113:0)
[04:52:13.359] Timer tick, asking Buildbucket for the build status
[04:52:13.726] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:13.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:114:0) after 1m0s
[04:53:13.766] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:114:0)
[04:53:13.766] Timer tick, asking Buildbucket for the build status
[04:53:14.026] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:14.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:115:0) after 1m0s
[04:54:14.123] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:115:0)
[04:54:14.123] Timer tick, asking Buildbucket for the build status
[04:54:14.183] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:14.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:116:0) after 1m0s
[04:55:14.229] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:116:0)
[04:55:14.229] Timer tick, asking Buildbucket for the build status
[04:55:14.308] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:14.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:117:0) after 1m0s
[04:56:14.372] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:117:0)
[04:56:14.372] Timer tick, asking Buildbucket for the build status
[04:56:14.717] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:14.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:118:0) after 1m0s
[04:57:14.793] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:118:0)
[04:57:14.793] Timer tick, asking Buildbucket for the build status
[04:57:14.848] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:14.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:119:0) after 1m0s
[04:58:14.920] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:119:0)
[04:58:14.920] Timer tick, asking Buildbucket for the build status
[04:58:15.351] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:15.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:120:0) after 1m0s
[04:59:15.447] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:120:0)
[04:59:15.447] Timer tick, asking Buildbucket for the build status
[04:59:15.730] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:15.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:121:0) after 1m0s
[05:00:16.022] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:121:0)
[05:00:16.022] Timer tick, asking Buildbucket for the build status
[05:00:16.180] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:16.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:122:0) after 1m0s
[05:01:16.348] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:122:0)
[05:01:16.348] Timer tick, asking Buildbucket for the build status
[05:01:16.676] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:16.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:123:0) after 1m0s
[05:02:16.831] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:123:0)
[05:02:16.831] Timer tick, asking Buildbucket for the build status
[05:02:16.924] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:16.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:124:0) after 1m0s
[05:03:17.004] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:124:0)
[05:03:17.004] Timer tick, asking Buildbucket for the build status
[05:03:17.170] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:17.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:125:0) after 1m0s
[05:04:17.181] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:125:0)
[05:04:17.181] Timer tick, asking Buildbucket for the build status
[05:04:17.246] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:17.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:126:0) after 1m0s
[05:05:17.338] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:126:0)
[05:05:17.338] Timer tick, asking Buildbucket for the build status
[05:05:17.415] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:17.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:127:0) after 1m0s
[05:06:17.471] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:127:0)
[05:06:17.471] Timer tick, asking Buildbucket for the build status
[05:06:17.589] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:17.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:128:0) after 1m0s
[05:07:17.870] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:128:0)
[05:07:17.870] Timer tick, asking Buildbucket for the build status
[05:07:18.136] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:18.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:129:0) after 1m0s
[05:08:18.170] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:129:0)
[05:08:18.170] Timer tick, asking Buildbucket for the build status
[05:08:18.492] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:18.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:130:0) after 1m0s
[05:09:18.532] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:130:0)
[05:09:18.532] Timer tick, asking Buildbucket for the build status
[05:09:18.599] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:18.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:131:0) after 1m0s
[05:10:18.723] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:131:0)
[05:10:18.723] Timer tick, asking Buildbucket for the build status
[05:10:18.783] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:18.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:132:0) after 1m0s
[05:11:18.823] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:132:0)
[05:11:18.823] Timer tick, asking Buildbucket for the build status
[05:11:18.924] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:18.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:133:0) after 1m0s
[05:12:19.028] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:133:0)
[05:12:19.028] Timer tick, asking Buildbucket for the build status
[05:12:19.315] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:19.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:134:0) after 1m0s
[05:13:19.345] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:134:0)
[05:13:19.345] Timer tick, asking Buildbucket for the build status
[05:13:19.496] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:19.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:135:0) after 1m0s
[05:14:19.573] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:135:0)
[05:14:19.573] Timer tick, asking Buildbucket for the build status
[05:14:19.634] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:19.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:136:0) after 1m0s
[05:15:19.715] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:136:0)
[05:15:19.715] Timer tick, asking Buildbucket for the build status
[05:15:20.006] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:20.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:137:0) after 1m0s
[05:16:20.064] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:137:0)
[05:16:20.064] Timer tick, asking Buildbucket for the build status
[05:16:20.156] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:20.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:138:0) after 1m0s
[05:17:20.223] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:138:0)
[05:17:20.223] Timer tick, asking Buildbucket for the build status
[05:17:20.435] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:20.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:139:0) after 1m0s
[05:18:20.521] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:139:0)
[05:18:20.521] Timer tick, asking Buildbucket for the build status
[05:18:20.594] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:20.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:140:0) after 1m0s
[05:19:20.626] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:140:0)
[05:19:20.626] Timer tick, asking Buildbucket for the build status
[05:19:20.689] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:20.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:141:0) after 1m0s
[05:20:20.799] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:141:0)
[05:20:20.799] Timer tick, asking Buildbucket for the build status
[05:20:20.862] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:20.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:142:0) after 1m0s
[05:21:20.911] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:142:0)
[05:21:20.911] Timer tick, asking Buildbucket for the build status
[05:21:21.054] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:21.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:143:0) after 1m0s
[05:22:21.167] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:143:0)
[05:22:21.167] Timer tick, asking Buildbucket for the build status
[05:22:21.234] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:21.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:144:0) after 1m0s
[05:23:21.262] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:144:0)
[05:23:21.262] Timer tick, asking Buildbucket for the build status
[05:23:21.646] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:21.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:145:0) after 1m0s
[05:24:21.764] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:145:0)
[05:24:21.764] Timer tick, asking Buildbucket for the build status
[05:24:21.832] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:21.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:146:0) after 1m0s
[05:25:21.921] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:146:0)
[05:25:21.921] Timer tick, asking Buildbucket for the build status
[05:25:21.981] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:21.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:147:0) after 1m0s
[05:26:22.113] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:147:0)
[05:26:22.113] Timer tick, asking Buildbucket for the build status
[05:26:22.286] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:22.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:148:0) after 1m0s
[05:27:22.277] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:148:0)
[05:27:22.277] Timer tick, asking Buildbucket for the build status
[05:27:22.361] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:22.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:149:0) after 1m0s
[05:28:22.406] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:149:0)
[05:28:22.406] Timer tick, asking Buildbucket for the build status
[05:28:22.481] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:22.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:150:0) after 1m0s
[05:29:22.547] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:150:0)
[05:29:22.547] Timer tick, asking Buildbucket for the build status
[05:29:22.702] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:22.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:151:0) after 1m0s
[05:30:22.747] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:151:0)
[05:30:22.747] Timer tick, asking Buildbucket for the build status
[05:30:22.825] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:22.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:152:0) after 1m0s
[05:31:22.853] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:152:0)
[05:31:22.853] Timer tick, asking Buildbucket for the build status
[05:31:22.971] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:22.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:153:0) after 1m0s
[05:32:23.021] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:153:0)
[05:32:23.021] Timer tick, asking Buildbucket for the build status
[05:32:23.097] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:23.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:154:0) after 1m0s
[05:33:23.192] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:154:0)
[05:33:23.192] Timer tick, asking Buildbucket for the build status
[05:33:23.551] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:23.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:155:0) after 1m0s
[05:34:23.578] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:155:0)
[05:34:23.578] Timer tick, asking Buildbucket for the build status
[05:34:23.769] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:23.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:156:0) after 1m0s
[05:35:23.806] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:156:0)
[05:35:23.806] Timer tick, asking Buildbucket for the build status
[05:35:23.873] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:23.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:157:0) after 1m0s
[05:36:23.918] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:157:0)
[05:36:23.918] Timer tick, asking Buildbucket for the build status
[05:36:24.243] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:24.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:158:0) after 1m0s
[05:37:24.225] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:158:0)
[05:37:24.225] Timer tick, asking Buildbucket for the build status
[05:37:24.282] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:24.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:159:0) after 1m0s
[05:38:24.320] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:159:0)
[05:38:24.320] Timer tick, asking Buildbucket for the build status
[05:38:24.413] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:24.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:160:0) after 1m0s
[05:39:24.445] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:160:0)
[05:39:24.445] Timer tick, asking Buildbucket for the build status
[05:39:24.590] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:24.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:161:0) after 1m0s
[05:40:24.656] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:161:0)
[05:40:24.656] Timer tick, asking Buildbucket for the build status
[05:40:24.757] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:24.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:162:0) after 1m0s
[05:41:25.119] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:162:0)
[05:41:25.119] Timer tick, asking Buildbucket for the build status
[05:41:25.637] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:25.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:163:0) after 1m0s
[05:42:25.873] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:163:0)
[05:42:25.873] Timer tick, asking Buildbucket for the build status
[05:42:26.026] Build 8857620713397614096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:26.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9023050775348023424:164:0) after 1m0s
[05:43:23.838] Received PubSub notification, asking Buildbucket for the build status
[05:43:24.098] Build 8857620713397614096: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:43:24.098] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611121400529475",
"created_by": "project:chromium",
"created_ts": "1611111643372443",
"id": "8857620713397614096",
"parameters_json": "{\"builder_name\": \"linux-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\", \"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-500-32-1-l9qy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"linux-official\", \"buildnumber\": 1708, \"got_angle_revision\": \"2e0490eedcc809bcd6359de6afdb9e40bd9f731a\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\", \"got_revision_cp\": \"refs/heads/master@{#844986}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"89fd1480b47e8c8668dfd3c24302c53b76ba4c88\", \"got_v8_revision\": \"6181c222ef4e8307540a8b27201a790957a92fdd\", \"got_v8_revision_cp\": \"refs/heads/9.0.17@{#1}\", \"got_webrtc_revision\": \"5eb527cf7fb28e22d0687c0295cb9f1bb458160c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33034}\", \"mirrored_builders\": [\"tryserver.chromium:linux-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"17801e45e6fead9859bb0f1748afd7efd3e76899\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-official\"], \"caches\": [\"builder_9a08f41e55adb838216e3950bfb49c3434607f8b091e4b7bc76be16714f737b2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"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-500-32-1-l9qy\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611111648183103",
"status": "COMPLETED",
"status_changed_ts": "1611121400909032",
"tags": [
"build_address:luci.chromium.ci/linux-official/1708",
"builder:linux-official",
"buildset:commit/git/17801e45e6fead9859bb0f1748afd7efd3e76899",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/17801e45e6fead9859bb0f1748afd7efd3e76899",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023050775348023424",
"scheduler_job_id:chromium/linux-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857620713397614096/+/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:51368e447cf27810",
"user_agent:luci-scheduler"
],
"updated_ts": "1611121400913512",
"url": "https://ci.chromium.org/b/8857620713397614096",
"utcnow_ts": "1611121404037703"
}
}
[05:43:24.098] Invocation finished in 2h42m41.968885179s with status SUCCEEDED