[06:14:41.394] New invocation is queued and will start shortly
[06:14:42.645] Starting the invocation (attempt 1)
[06:14:42.677] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:14:42.680] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:14:42.680] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019777079922533424",
"parameters_json": "{\"builder_name\":\"linux-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9cc6accc0dc6c98cae982b3eee4464daebd5850b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-official",
"scheduler_invocation_id:9019777079922533424",
"scheduler_job_id:chromium/linux-official",
"user_agent:luci-scheduler",
"buildset:commit/git/9cc6accc0dc6c98cae982b3eee4464daebd5850b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9cc6accc0dc6c98cae982b3eee4464daebd5850b",
"gitiles_ref:refs/heads/master"
]
}
[06:14:43.633] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614233682779408",
"id": "8854347017804222800",
"parameters_json": "{\"builder_name\": \"linux-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9cc6accc0dc6c98cae982b3eee4464daebd5850b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614233683333014",
"tags": [
"build_address:luci.chromium.ci/linux-official/1973",
"builder:linux-official",
"buildset:commit/git/9cc6accc0dc6c98cae982b3eee4464daebd5850b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9cc6accc0dc6c98cae982b3eee4464daebd5850b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019777079922533424",
"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/8854347017804222800/+/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": "1614233683333129",
"url": "https://ci.chromium.org/b/8854347017804222800",
"utcnow_ts": "1614233683624310"
}
}
[06:14:43.633] Task URL: https://ci.chromium.org/b/8854347017804222800
[06:14:43.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:2:0) after 1m0s
[06:14:48.876] Received PubSub notification, asking Buildbucket for the build status
[06:14:48.951] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:43.785] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:2:0)
[06:15:43.785] Timer tick, asking Buildbucket for the build status
[06:15:43.862] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:43.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:4:0) after 1m0s
[06:16:43.922] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:4:0)
[06:16:43.922] Timer tick, asking Buildbucket for the build status
[06:16:44.006] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:44.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:5:0) after 1m0s
[06:17:44.087] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:5:0)
[06:17:44.087] Timer tick, asking Buildbucket for the build status
[06:17:44.167] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:44.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:6:0) after 1m0s
[06:18:44.183] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:6:0)
[06:18:44.183] Timer tick, asking Buildbucket for the build status
[06:18:44.474] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:44.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:7:0) after 1m0s
[06:19:44.499] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:7:0)
[06:19:44.499] Timer tick, asking Buildbucket for the build status
[06:19:44.643] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:44.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:8:0) after 1m0s
[06:20:44.690] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:8:0)
[06:20:44.690] Timer tick, asking Buildbucket for the build status
[06:20:45.341] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:45.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:9:0) after 1m0s
[06:21:45.436] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:9:0)
[06:21:45.436] Timer tick, asking Buildbucket for the build status
[06:21:45.831] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:45.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:10:0) after 1m0s
[06:22:45.850] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:10:0)
[06:22:45.850] Timer tick, asking Buildbucket for the build status
[06:22:46.070] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:46.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:11:0) after 1m0s
[06:23:46.167] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:11:0)
[06:23:46.167] Timer tick, asking Buildbucket for the build status
[06:23:46.409] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:46.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:12:0) after 1m0s
[06:24:46.459] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:12:0)
[06:24:46.459] Timer tick, asking Buildbucket for the build status
[06:24:46.548] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:46.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:13:0) after 1m0s
[06:25:46.572] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:13:0)
[06:25:46.572] Timer tick, asking Buildbucket for the build status
[06:25:46.654] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:46.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:14:0) after 1m0s
[06:26:46.730] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:14:0)
[06:26:46.730] Timer tick, asking Buildbucket for the build status
[06:26:46.904] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:46.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:15:0) after 1m0s
[06:27:46.951] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:15:0)
[06:27:46.951] Timer tick, asking Buildbucket for the build status
[06:27:47.211] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:47.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:16:0) after 1m0s
[06:28:47.229] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:16:0)
[06:28:47.229] Timer tick, asking Buildbucket for the build status
[06:28:47.301] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:47.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:17:0) after 1m0s
[06:29:47.370] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:17:0)
[06:29:47.370] Timer tick, asking Buildbucket for the build status
[06:29:47.450] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:47.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:18:0) after 1m0s
[06:30:47.513] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:18:0)
[06:30:47.513] Timer tick, asking Buildbucket for the build status
[06:30:47.578] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:47.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:19:0) after 1m0s
[06:31:47.683] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:19:0)
[06:31:47.683] Timer tick, asking Buildbucket for the build status
[06:31:47.768] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:47.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:20:0) after 1m0s
[06:32:47.889] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:20:0)
[06:32:47.889] Timer tick, asking Buildbucket for the build status
[06:32:47.985] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:47.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:21:0) after 1m0s
[06:33:48.118] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:21:0)
[06:33:48.118] Timer tick, asking Buildbucket for the build status
[06:33:48.276] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:48.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:22:0) after 1m0s
[06:34:48.296] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:22:0)
[06:34:48.296] Timer tick, asking Buildbucket for the build status
[06:34:48.483] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:48.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:23:0) after 1m0s
[06:35:48.499] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:23:0)
[06:35:48.499] Timer tick, asking Buildbucket for the build status
[06:35:48.595] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:48.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:24:0) after 1m0s
[06:36:48.609] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:24:0)
[06:36:48.609] Timer tick, asking Buildbucket for the build status
[06:36:48.973] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:48.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:25:0) after 1m0s
[06:37:48.991] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:25:0)
[06:37:48.991] Timer tick, asking Buildbucket for the build status
[06:37:49.048] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:49.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:26:0) after 1m0s
[06:38:49.091] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:26:0)
[06:38:49.091] Timer tick, asking Buildbucket for the build status
[06:38:49.167] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:49.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:27:0) after 1m0s
[06:39:49.204] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:27:0)
[06:39:49.204] Timer tick, asking Buildbucket for the build status
[06:39:49.531] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:49.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:28:0) after 1m0s
[06:40:49.624] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:28:0)
[06:40:49.624] Timer tick, asking Buildbucket for the build status
[06:40:49.707] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:49.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:29:0) after 1m0s
[06:41:49.753] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:29:0)
[06:41:49.753] Timer tick, asking Buildbucket for the build status
[06:41:49.957] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:49.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:30:0) after 1m0s
[06:42:49.979] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:30:0)
[06:42:49.979] Timer tick, asking Buildbucket for the build status
[06:42:50.247] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:50.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:31:0) after 1m0s
[06:43:50.268] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:31:0)
[06:43:50.268] Timer tick, asking Buildbucket for the build status
[06:43:50.428] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:50.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:32:0) after 1m0s
[06:44:50.455] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:32:0)
[06:44:50.455] Timer tick, asking Buildbucket for the build status
[06:44:50.537] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:50.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:33:0) after 1m0s
[06:45:50.589] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:33:0)
[06:45:50.589] Timer tick, asking Buildbucket for the build status
[06:45:50.738] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:50.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:34:0) after 1m0s
[06:46:50.795] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:34:0)
[06:46:50.795] Timer tick, asking Buildbucket for the build status
[06:46:50.882] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:50.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:35:0) after 1m0s
[06:47:50.929] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:35:0)
[06:47:50.929] Timer tick, asking Buildbucket for the build status
[06:47:51.015] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:51.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:36:0) after 1m0s
[06:48:51.033] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:36:0)
[06:48:51.033] Timer tick, asking Buildbucket for the build status
[06:48:51.118] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:51.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:37:0) after 1m0s
[06:49:51.119] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:37:0)
[06:49:51.119] Timer tick, asking Buildbucket for the build status
[06:49:51.369] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:51.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:38:0) after 1m0s
[06:50:51.369] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:38:0)
[06:50:51.369] Timer tick, asking Buildbucket for the build status
[06:50:51.453] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:51.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:39:0) after 1m0s
[06:51:51.502] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:39:0)
[06:51:51.502] Timer tick, asking Buildbucket for the build status
[06:51:51.568] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:51.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:40:0) after 1m0s
[06:52:51.695] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:40:0)
[06:52:51.695] Timer tick, asking Buildbucket for the build status
[06:52:51.850] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:51.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:41:0) after 1m0s
[06:53:51.974] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:41:0)
[06:53:51.974] Timer tick, asking Buildbucket for the build status
[06:53:52.052] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:52.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:42:0) after 1m0s
[06:54:52.189] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:42:0)
[06:54:52.189] Timer tick, asking Buildbucket for the build status
[06:54:52.270] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:52.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:43:0) after 1m0s
[06:55:52.604] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:43:0)
[06:55:52.604] Timer tick, asking Buildbucket for the build status
[06:55:52.671] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:52.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:44:0) after 1m0s
[06:56:52.969] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:44:0)
[06:56:52.969] Timer tick, asking Buildbucket for the build status
[06:56:53.041] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:53.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:45:0) after 1m0s
[06:57:53.168] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:45:0)
[06:57:53.168] Timer tick, asking Buildbucket for the build status
[06:57:53.947] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:53.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:46:0) after 1m0s
[06:58:54.021] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:46:0)
[06:58:54.021] Timer tick, asking Buildbucket for the build status
[06:58:54.418] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:54.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:47:0) after 1m0s
[06:59:54.578] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:47:0)
[06:59:54.579] Timer tick, asking Buildbucket for the build status
[06:59:54.998] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:54.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:48:0) after 1m0s
[07:00:55.054] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:48:0)
[07:00:55.054] Timer tick, asking Buildbucket for the build status
[07:00:55.196] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:55.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:49:0) after 1m0s
[07:01:55.216] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:49:0)
[07:01:55.216] Timer tick, asking Buildbucket for the build status
[07:01:55.376] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:55.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:50:0) after 1m0s
[07:02:55.413] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:50:0)
[07:02:55.414] Timer tick, asking Buildbucket for the build status
[07:02:55.486] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:55.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:51:0) after 1m0s
[07:03:55.512] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:51:0)
[07:03:55.512] Timer tick, asking Buildbucket for the build status
[07:03:55.603] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:55.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:52:0) after 1m0s
[07:04:55.743] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:52:0)
[07:04:55.743] Timer tick, asking Buildbucket for the build status
[07:04:55.840] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:55.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:53:0) after 1m0s
[07:05:55.933] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:53:0)
[07:05:55.933] Timer tick, asking Buildbucket for the build status
[07:05:56.072] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:56.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:54:0) after 1m0s
[07:06:56.098] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:54:0)
[07:06:56.098] Timer tick, asking Buildbucket for the build status
[07:06:56.168] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:56.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:55:0) after 1m0s
[07:07:56.304] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:55:0)
[07:07:56.304] Timer tick, asking Buildbucket for the build status
[07:07:56.373] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:56.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:56:0) after 1m0s
[07:08:56.556] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:56:0)
[07:08:56.556] Timer tick, asking Buildbucket for the build status
[07:08:56.669] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:56.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:57:0) after 1m0s
[07:09:56.828] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:57:0)
[07:09:56.828] Timer tick, asking Buildbucket for the build status
[07:09:57.051] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:57.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:58:0) after 1m0s
[07:10:57.062] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:58:0)
[07:10:57.062] Timer tick, asking Buildbucket for the build status
[07:10:57.156] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:57.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:59:0) after 1m0s
[07:11:57.352] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:59:0)
[07:11:57.352] Timer tick, asking Buildbucket for the build status
[07:11:57.417] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:57.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:60:0) after 1m0s
[07:12:57.438] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:60:0)
[07:12:57.438] Timer tick, asking Buildbucket for the build status
[07:12:57.527] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:57.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:61:0) after 1m0s
[07:13:57.515] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:61:0)
[07:13:57.515] Timer tick, asking Buildbucket for the build status
[07:13:57.603] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:57.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:62:0) after 1m0s
[07:14:57.625] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:62:0)
[07:14:57.625] Timer tick, asking Buildbucket for the build status
[07:14:57.780] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:57.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:63:0) after 1m0s
[07:15:57.815] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:63:0)
[07:15:57.815] Timer tick, asking Buildbucket for the build status
[07:15:58.066] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:58.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:64:0) after 1m0s
[07:16:58.110] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:64:0)
[07:16:58.110] Timer tick, asking Buildbucket for the build status
[07:16:58.177] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:58.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:65:0) after 1m0s
[07:17:58.310] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:65:0)
[07:17:58.310] Timer tick, asking Buildbucket for the build status
[07:17:58.390] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:58.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:66:0) after 1m0s
[07:18:58.546] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:66:0)
[07:18:58.546] Timer tick, asking Buildbucket for the build status
[07:18:58.727] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:58.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:67:0) after 1m0s
[07:19:58.847] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:67:0)
[07:19:58.847] Timer tick, asking Buildbucket for the build status
[07:19:59.407] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:59.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:68:0) after 1m0s
[07:20:59.497] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:68:0)
[07:20:59.497] Timer tick, asking Buildbucket for the build status
[07:20:59.583] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:59.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:69:0) after 1m0s
[07:21:59.761] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:69:0)
[07:21:59.761] Timer tick, asking Buildbucket for the build status
[07:21:59.861] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:59.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:70:0) after 1m0s
[07:23:00.012] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:70:0)
[07:23:00.012] Timer tick, asking Buildbucket for the build status
[07:23:00.165] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:00.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:71:0) after 1m0s
[07:24:00.247] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:71:0)
[07:24:00.247] Timer tick, asking Buildbucket for the build status
[07:24:00.328] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:00.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:72:0) after 1m0s
[07:25:01.018] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:72:0)
[07:25:01.018] Timer tick, asking Buildbucket for the build status
[07:25:01.195] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:01.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:73:0) after 1m0s
[07:26:01.496] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:73:0)
[07:26:01.496] Timer tick, asking Buildbucket for the build status
[07:26:01.644] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:01.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:74:0) after 1m0s
[07:27:01.720] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:74:0)
[07:27:01.720] Timer tick, asking Buildbucket for the build status
[07:27:01.787] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:01.787] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:75:0) after 1m0s
[07:28:01.861] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:75:0)
[07:28:01.861] Timer tick, asking Buildbucket for the build status
[07:28:01.941] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:01.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:76:0) after 1m0s
[07:29:02.039] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:76:0)
[07:29:02.039] Timer tick, asking Buildbucket for the build status
[07:29:02.119] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:02.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:77:0) after 1m0s
[07:30:02.483] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:77:0)
[07:30:02.483] Timer tick, asking Buildbucket for the build status
[07:30:02.597] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:02.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:78:0) after 1m0s
[07:31:02.675] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:78:0)
[07:31:02.675] Timer tick, asking Buildbucket for the build status
[07:31:02.873] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:02.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:79:0) after 1m0s
[07:32:02.952] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:79:0)
[07:32:02.952] Timer tick, asking Buildbucket for the build status
[07:32:03.042] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:03.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:80:0) after 1m0s
[07:33:03.218] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:80:0)
[07:33:03.218] Timer tick, asking Buildbucket for the build status
[07:33:03.300] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:03.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:81:0) after 1m0s
[07:34:03.377] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:81:0)
[07:34:03.377] Timer tick, asking Buildbucket for the build status
[07:34:03.613] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:03.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:82:0) after 1m0s
[07:35:03.665] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:82:0)
[07:35:03.665] Timer tick, asking Buildbucket for the build status
[07:35:03.754] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:03.754] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:83:0) after 1m0s
[07:36:03.844] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:83:0)
[07:36:03.844] Timer tick, asking Buildbucket for the build status
[07:36:03.924] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:03.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:84:0) after 1m0s
[07:37:04.178] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:84:0)
[07:37:04.178] Timer tick, asking Buildbucket for the build status
[07:37:04.252] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:04.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:85:0) after 1m0s
[07:38:04.466] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:85:0)
[07:38:04.466] Timer tick, asking Buildbucket for the build status
[07:38:04.538] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:04.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:86:0) after 1m0s
[07:39:04.787] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:86:0)
[07:39:04.787] Timer tick, asking Buildbucket for the build status
[07:39:04.912] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:04.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:87:0) after 1m0s
[07:40:04.991] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:87:0)
[07:40:04.991] Timer tick, asking Buildbucket for the build status
[07:40:05.087] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:05.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:88:0) after 1m0s
[07:41:05.269] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:88:0)
[07:41:05.269] Timer tick, asking Buildbucket for the build status
[07:41:05.332] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:05.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:89:0) after 1m0s
[07:42:05.386] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:89:0)
[07:42:05.386] Timer tick, asking Buildbucket for the build status
[07:42:05.468] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:05.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:90:0) after 1m0s
[07:43:05.509] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:90:0)
[07:43:05.509] Timer tick, asking Buildbucket for the build status
[07:43:05.796] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:05.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:91:0) after 1m0s
[07:44:05.799] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:91:0)
[07:44:05.799] Timer tick, asking Buildbucket for the build status
[07:44:05.881] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:05.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:92:0) after 1m0s
[07:45:06.012] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:92:0)
[07:45:06.012] Timer tick, asking Buildbucket for the build status
[07:45:06.398] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:06.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:93:0) after 1m0s
[07:46:06.452] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:93:0)
[07:46:06.452] Timer tick, asking Buildbucket for the build status
[07:46:06.713] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:06.714] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:94:0) after 1m0s
[07:47:06.729] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:94:0)
[07:47:06.729] Timer tick, asking Buildbucket for the build status
[07:47:08.467] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:08.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:95:0) after 1m0s
[07:48:08.567] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:95:0)
[07:48:08.567] Timer tick, asking Buildbucket for the build status
[07:48:08.739] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:08.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:96:0) after 1m0s
[07:49:08.842] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:96:0)
[07:49:08.842] Timer tick, asking Buildbucket for the build status
[07:49:08.920] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:08.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:97:0) after 1m0s
[07:50:08.944] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:97:0)
[07:50:08.944] Timer tick, asking Buildbucket for the build status
[07:50:09.261] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:09.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:98:0) after 1m0s
[07:51:09.311] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:98:0)
[07:51:09.311] Timer tick, asking Buildbucket for the build status
[07:51:09.445] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:09.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:99:0) after 1m0s
[07:52:09.635] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:99:0)
[07:52:09.635] Timer tick, asking Buildbucket for the build status
[07:52:09.723] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:09.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:100:0) after 1m0s
[07:53:09.731] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:100:0)
[07:53:09.731] Timer tick, asking Buildbucket for the build status
[07:53:09.836] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:09.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:101:0) after 1m0s
[07:54:09.864] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:101:0)
[07:54:09.864] Timer tick, asking Buildbucket for the build status
[07:54:10.051] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:10.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:102:0) after 1m0s
[07:55:10.102] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:102:0)
[07:55:10.102] Timer tick, asking Buildbucket for the build status
[07:55:10.196] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:10.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:103:0) after 1m0s
[07:56:10.218] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:103:0)
[07:56:10.218] Timer tick, asking Buildbucket for the build status
[07:56:10.288] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:10.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:104:0) after 1m0s
[07:57:10.400] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:104:0)
[07:57:10.400] Timer tick, asking Buildbucket for the build status
[07:57:10.485] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:10.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:105:0) after 1m0s
[07:58:10.715] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:105:0)
[07:58:10.715] Timer tick, asking Buildbucket for the build status
[07:58:10.847] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:10.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:106:0) after 1m0s
[07:59:10.943] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:106:0)
[07:59:10.943] Timer tick, asking Buildbucket for the build status
[07:59:11.013] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:11.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:107:0) after 1m0s
[08:00:11.069] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:107:0)
[08:00:11.069] Timer tick, asking Buildbucket for the build status
[08:00:11.279] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:11.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:108:0) after 1m0s
[08:01:11.342] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:108:0)
[08:01:11.342] Timer tick, asking Buildbucket for the build status
[08:01:11.443] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:11.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:109:0) after 1m0s
[08:02:11.492] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:109:0)
[08:02:11.492] Timer tick, asking Buildbucket for the build status
[08:02:11.566] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:11.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:110:0) after 1m0s
[08:03:11.672] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:110:0)
[08:03:11.672] Timer tick, asking Buildbucket for the build status
[08:03:11.770] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:11.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:111:0) after 1m0s
[08:04:11.893] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:111:0)
[08:04:11.893] Timer tick, asking Buildbucket for the build status
[08:04:12.002] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:12.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:112:0) after 1m0s
[08:05:12.091] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:112:0)
[08:05:12.091] Timer tick, asking Buildbucket for the build status
[08:05:12.201] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:12.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:113:0) after 1m0s
[08:06:12.316] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:113:0)
[08:06:12.316] Timer tick, asking Buildbucket for the build status
[08:06:12.417] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:12.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:114:0) after 1m0s
[08:07:12.536] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:114:0)
[08:07:12.536] Timer tick, asking Buildbucket for the build status
[08:07:12.725] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:12.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:115:0) after 1m0s
[08:08:12.770] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:115:0)
[08:08:12.770] Timer tick, asking Buildbucket for the build status
[08:08:12.837] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:12.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:116:0) after 1m0s
[08:09:12.872] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:116:0)
[08:09:12.872] Timer tick, asking Buildbucket for the build status
[08:09:12.952] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:12.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:117:0) after 1m0s
[08:10:13.057] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:117:0)
[08:10:13.057] Timer tick, asking Buildbucket for the build status
[08:10:13.145] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:13.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:118:0) after 1m0s
[08:11:13.237] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:118:0)
[08:11:13.237] Timer tick, asking Buildbucket for the build status
[08:11:13.387] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:13.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:119:0) after 1m0s
[08:12:13.410] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:119:0)
[08:12:13.410] Timer tick, asking Buildbucket for the build status
[08:12:13.582] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:13.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:120:0) after 1m0s
[08:13:13.704] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:120:0)
[08:13:13.704] Timer tick, asking Buildbucket for the build status
[08:13:13.853] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:13.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:121:0) after 1m0s
[08:14:14.058] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:121:0)
[08:14:14.058] Timer tick, asking Buildbucket for the build status
[08:14:14.134] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:14.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:122:0) after 1m0s
[08:15:14.225] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:122:0)
[08:15:14.225] Timer tick, asking Buildbucket for the build status
[08:15:14.306] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:14.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:123:0) after 1m0s
[08:16:14.350] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:123:0)
[08:16:14.350] Timer tick, asking Buildbucket for the build status
[08:16:14.442] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:14.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:124:0) after 1m0s
[08:17:14.458] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:124:0)
[08:17:14.458] Timer tick, asking Buildbucket for the build status
[08:17:14.528] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:14.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:125:0) after 1m0s
[08:18:14.573] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:125:0)
[08:18:14.573] Timer tick, asking Buildbucket for the build status
[08:18:14.726] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:14.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:126:0) after 1m0s
[08:19:14.741] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:126:0)
[08:19:14.741] Timer tick, asking Buildbucket for the build status
[08:19:15.848] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:15.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:127:0) after 1m0s
[08:20:15.851] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:127:0)
[08:20:15.851] Timer tick, asking Buildbucket for the build status
[08:20:15.956] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:15.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:128:0) after 1m0s
[08:21:15.966] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:128:0)
[08:21:15.966] Timer tick, asking Buildbucket for the build status
[08:21:16.154] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:16.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:129:0) after 1m0s
[08:22:16.172] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:129:0)
[08:22:16.172] Timer tick, asking Buildbucket for the build status
[08:22:16.256] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:16.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:130:0) after 1m0s
[08:23:16.304] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:130:0)
[08:23:16.304] Timer tick, asking Buildbucket for the build status
[08:23:16.475] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:16.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:131:0) after 1m0s
[08:24:16.469] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:131:0)
[08:24:16.469] Timer tick, asking Buildbucket for the build status
[08:24:16.698] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:16.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:132:0) after 1m0s
[08:25:16.725] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:132:0)
[08:25:16.725] Timer tick, asking Buildbucket for the build status
[08:25:17.126] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:17.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:133:0) after 1m0s
[08:26:17.210] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:133:0)
[08:26:17.210] Timer tick, asking Buildbucket for the build status
[08:26:17.287] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:17.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:134:0) after 1m0s
[08:27:17.338] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:134:0)
[08:27:17.338] Timer tick, asking Buildbucket for the build status
[08:27:17.406] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:17.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:135:0) after 1m0s
[08:28:17.503] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:135:0)
[08:28:17.503] Timer tick, asking Buildbucket for the build status
[08:28:17.576] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:17.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:136:0) after 1m0s
[08:29:17.591] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:136:0)
[08:29:17.591] Timer tick, asking Buildbucket for the build status
[08:29:17.724] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:17.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:137:0) after 1m0s
[08:30:17.775] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:137:0)
[08:30:17.775] Timer tick, asking Buildbucket for the build status
[08:30:17.878] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:17.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:138:0) after 1m0s
[08:31:17.885] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:138:0)
[08:31:17.885] Timer tick, asking Buildbucket for the build status
[08:31:18.003] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:18.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:139:0) after 1m0s
[08:32:18.156] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:139:0)
[08:32:18.156] Timer tick, asking Buildbucket for the build status
[08:32:18.513] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:18.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:140:0) after 1m0s
[08:33:18.750] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:140:0)
[08:33:18.750] Timer tick, asking Buildbucket for the build status
[08:33:18.834] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:18.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:141:0) after 1m0s
[08:34:18.882] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:141:0)
[08:34:18.882] Timer tick, asking Buildbucket for the build status
[08:34:19.016] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:19.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:142:0) after 1m0s
[08:35:19.005] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:142:0)
[08:35:19.005] Timer tick, asking Buildbucket for the build status
[08:35:19.102] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:19.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:143:0) after 1m0s
[08:36:19.735] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:143:0)
[08:36:19.735] Timer tick, asking Buildbucket for the build status
[08:36:19.898] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:19.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:144:0) after 1m0s
[08:37:20.045] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:144:0)
[08:37:20.045] Timer tick, asking Buildbucket for the build status
[08:37:20.153] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:20.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:145:0) after 1m0s
[08:38:20.247] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:145:0)
[08:38:20.247] Timer tick, asking Buildbucket for the build status
[08:38:20.526] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:20.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:146:0) after 1m0s
[08:39:20.598] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:146:0)
[08:39:20.598] Timer tick, asking Buildbucket for the build status
[08:39:20.741] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:20.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:147:0) after 1m0s
[08:40:20.817] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:147:0)
[08:40:20.817] Timer tick, asking Buildbucket for the build status
[08:40:21.132] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:21.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:148:0) after 1m0s
[08:41:21.123] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:148:0)
[08:41:21.123] Timer tick, asking Buildbucket for the build status
[08:41:21.215] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:21.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:149:0) after 1m0s
[08:42:21.273] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:149:0)
[08:42:21.273] Timer tick, asking Buildbucket for the build status
[08:42:21.427] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:21.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:150:0) after 1m0s
[08:43:21.445] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:150:0)
[08:43:21.445] Timer tick, asking Buildbucket for the build status
[08:43:21.515] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:21.515] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:151:0) after 1m0s
[08:44:21.591] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:151:0)
[08:44:21.591] Timer tick, asking Buildbucket for the build status
[08:44:21.726] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:21.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:152:0) after 1m0s
[08:45:21.769] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:152:0)
[08:45:21.769] Timer tick, asking Buildbucket for the build status
[08:45:21.863] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:21.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:153:0) after 1m0s
[08:46:21.928] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:153:0)
[08:46:21.930] Timer tick, asking Buildbucket for the build status
[08:46:21.996] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:21.996] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:154:0) after 1m0s
[08:47:22.047] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:154:0)
[08:47:22.047] Timer tick, asking Buildbucket for the build status
[08:47:22.148] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:22.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:155:0) after 1m0s
[08:48:22.170] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:155:0)
[08:48:22.170] Timer tick, asking Buildbucket for the build status
[08:48:22.331] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:22.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:156:0) after 1m0s
[08:49:22.391] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:156:0)
[08:49:22.391] Timer tick, asking Buildbucket for the build status
[08:49:22.524] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:22.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:157:0) after 1m0s
[08:50:22.596] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:157:0)
[08:50:22.596] Timer tick, asking Buildbucket for the build status
[08:50:22.692] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:22.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:158:0) after 1m0s
[08:51:22.708] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:158:0)
[08:51:22.708] Timer tick, asking Buildbucket for the build status
[08:51:22.878] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:22.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:159:0) after 1m0s
[08:52:22.932] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:159:0)
[08:52:22.932] Timer tick, asking Buildbucket for the build status
[08:52:23.014] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:23.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:160:0) after 1m0s
[08:53:23.121] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:160:0)
[08:53:23.121] Timer tick, asking Buildbucket for the build status
[08:53:23.192] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:23.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:161:0) after 1m0s
[08:54:23.280] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:161:0)
[08:54:23.280] Timer tick, asking Buildbucket for the build status
[08:54:23.464] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:23.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:162:0) after 1m0s
[08:55:23.514] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:162:0)
[08:55:23.514] Timer tick, asking Buildbucket for the build status
[08:55:23.620] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:23.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:163:0) after 1m0s
[08:56:23.647] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:163:0)
[08:56:23.647] Timer tick, asking Buildbucket for the build status
[08:56:23.713] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:23.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:164:0) after 1m0s
[08:57:23.735] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:164:0)
[08:57:23.735] Timer tick, asking Buildbucket for the build status
[08:57:23.794] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:23.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:165:0) after 1m0s
[08:58:23.806] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:165:0)
[08:58:23.806] Timer tick, asking Buildbucket for the build status
[08:58:23.882] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:23.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:166:0) after 1m0s
[08:59:23.957] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:166:0)
[08:59:23.957] Timer tick, asking Buildbucket for the build status
[08:59:24.238] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:24.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:167:0) after 1m0s
[09:00:24.282] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:167:0)
[09:00:24.282] Timer tick, asking Buildbucket for the build status
[09:00:24.917] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:24.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:168:0) after 1m0s
[09:01:24.960] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:168:0)
[09:01:24.960] Timer tick, asking Buildbucket for the build status
[09:01:25.176] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:25.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:169:0) after 1m0s
[09:02:25.197] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:169:0)
[09:02:25.197] Timer tick, asking Buildbucket for the build status
[09:02:25.276] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:25.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:170:0) after 1m0s
[09:03:25.300] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:170:0)
[09:03:25.300] Timer tick, asking Buildbucket for the build status
[09:03:25.376] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:25.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:171:0) after 1m0s
[09:04:25.413] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:171:0)
[09:04:25.413] Timer tick, asking Buildbucket for the build status
[09:04:25.703] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:25.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:172:0) after 1m0s
[09:05:25.726] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:172:0)
[09:05:25.726] Timer tick, asking Buildbucket for the build status
[09:05:25.840] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:25.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:173:0) after 1m0s
[09:06:25.933] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:173:0)
[09:06:25.933] Timer tick, asking Buildbucket for the build status
[09:06:26.000] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:26.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:174:0) after 1m0s
[09:07:26.021] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:174:0)
[09:07:26.021] Timer tick, asking Buildbucket for the build status
[09:07:26.151] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:26.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:175:0) after 1m0s
[09:08:26.150] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:175:0)
[09:08:26.150] Timer tick, asking Buildbucket for the build status
[09:08:26.230] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:26.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:176:0) after 1m0s
[09:09:26.250] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:176:0)
[09:09:26.250] Timer tick, asking Buildbucket for the build status
[09:09:26.320] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:26.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:177:0) after 1m0s
[09:10:26.344] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:177:0)
[09:10:26.344] Timer tick, asking Buildbucket for the build status
[09:10:26.411] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:26.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:178:0) after 1m0s
[09:11:26.506] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:178:0)
[09:11:26.506] Timer tick, asking Buildbucket for the build status
[09:11:26.603] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:26.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:179:0) after 1m0s
[09:12:26.619] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:179:0)
[09:12:26.619] Timer tick, asking Buildbucket for the build status
[09:12:26.691] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:26.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:180:0) after 1m0s
[09:13:26.731] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:180:0)
[09:13:26.731] Timer tick, asking Buildbucket for the build status
[09:13:26.814] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:26.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:181:0) after 1m0s
[09:14:27.003] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:181:0)
[09:14:27.003] Timer tick, asking Buildbucket for the build status
[09:14:27.113] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:27.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:182:0) after 1m0s
[09:15:27.191] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:182:0)
[09:15:27.191] Timer tick, asking Buildbucket for the build status
[09:15:27.297] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:27.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:183:0) after 1m0s
[09:16:27.361] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:183:0)
[09:16:27.361] Timer tick, asking Buildbucket for the build status
[09:16:27.470] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:27.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:184:0) after 1m0s
[09:17:27.535] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:184:0)
[09:17:27.535] Timer tick, asking Buildbucket for the build status
[09:17:27.655] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:27.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:185:0) after 1m0s
[09:18:27.685] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:185:0)
[09:18:27.685] Timer tick, asking Buildbucket for the build status
[09:18:27.961] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:27.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:186:0) after 1m0s
[09:19:28.257] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:186:0)
[09:19:28.257] Timer tick, asking Buildbucket for the build status
[09:19:28.329] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:28.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:187:0) after 1m0s
[09:20:28.423] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:187:0)
[09:20:28.423] Timer tick, asking Buildbucket for the build status
[09:20:28.635] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:28.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:188:0) after 1m0s
[09:21:28.805] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:188:0)
[09:21:28.805] Timer tick, asking Buildbucket for the build status
[09:21:28.880] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:28.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:189:0) after 1m0s
[09:22:29.073] Handling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:189:0)
[09:22:29.073] Timer tick, asking Buildbucket for the build status
[09:22:29.221] Build 8854347017804222800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:29.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-official:9019777079922533424:190:0) after 1m0s
[09:23:06.105] Received PubSub notification, asking Buildbucket for the build status
[09:23:06.174] Build 8854347017804222800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:23:06.174] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614244985571895",
"created_by": "project:chromium",
"created_ts": "1614233682779408",
"id": "8854347017804222800",
"parameters_json": "{\"builder_name\": \"linux-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9cc6accc0dc6c98cae982b3eee4464daebd5850b\"}}",
"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\": \"9cc6accc0dc6c98cae982b3eee4464daebd5850b\", \"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-ev05\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"linux-official\", \"buildnumber\": 1973, \"got_angle_revision\": \"9b1c569b14e90765cdd7c07e449400e88f1d6c45\", \"got_dawn_revision\": \"5eb496b863da5b40dc5c9a713c8ca1e413811f35\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"9cc6accc0dc6c98cae982b3eee4464daebd5850b\", \"got_revision_cp\": \"refs/heads/master@{#857556}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"cd0373f013b5c9672c05e79a48bb1e9fb5f50fa4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33333}\", \"mirrored_builders\": [\"tryserver.chromium:linux-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9cc6accc0dc6c98cae982b3eee4464daebd5850b\"}, \"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-ev05\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614233688174165",
"status": "COMPLETED",
"status_changed_ts": "1614244985843184",
"tags": [
"build_address:luci.chromium.ci/linux-official/1973",
"builder:linux-official",
"buildset:commit/git/9cc6accc0dc6c98cae982b3eee4464daebd5850b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9cc6accc0dc6c98cae982b3eee4464daebd5850b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019777079922533424",
"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/8854347017804222800/+/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:51f0a4cf1877dc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614244985847321",
"url": "https://ci.chromium.org/b/8854347017804222800",
"utcnow_ts": "1614244986168655"
}
}
[09:23:06.174] Invocation finished in 3h8m24.798373454s with status SUCCEEDED