[17:04:16.613] New invocation is queued and will start shortly
[17:04:17.812] Starting the invocation (attempt 1)
[17:04:17.862] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:04:17.865] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:04:17.865] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018377256944081104",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"446ddc8c6fac7625ca5fd87f2ddd92c5b9202202\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9018377256944081104",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/446ddc8c6fac7625ca5fd87f2ddd92c5b9202202",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/446ddc8c6fac7625ca5fd87f2ddd92c5b9202202",
"gitiles_ref:refs/heads/master"
]
}
[17:04:18.918] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615568657961578",
"id": "8852947194867616784",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"446ddc8c6fac7625ca5fd87f2ddd92c5b9202202\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615568658619836",
"tags": [
"build_address:luci.chromium.ci/win-official/1737",
"builder:win-official",
"buildset:commit/git/446ddc8c6fac7625ca5fd87f2ddd92c5b9202202",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/446ddc8c6fac7625ca5fd87f2ddd92c5b9202202",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018377256944081104",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852947194867616784/+/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": "1615568658619943",
"url": "https://ci.chromium.org/b/8852947194867616784",
"utcnow_ts": "1615568658905955"
}
}
[17:04:18.918] Task URL: https://ci.chromium.org/b/8852947194867616784
[17:04:18.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:2:0) after 1m0s
[17:04:25.834] Received PubSub notification, asking Buildbucket for the build status
[17:04:25.911] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:19.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:2:0)
[17:05:19.032] Timer tick, asking Buildbucket for the build status
[17:05:19.184] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:19.184] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:4:0) after 1m0s
[17:06:19.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:4:0)
[17:06:19.244] Timer tick, asking Buildbucket for the build status
[17:06:19.318] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:19.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:5:0) after 1m0s
[17:07:19.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:5:0)
[17:07:19.362] Timer tick, asking Buildbucket for the build status
[17:07:19.506] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:19.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:6:0) after 1m0s
[17:08:19.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:6:0)
[17:08:19.530] Timer tick, asking Buildbucket for the build status
[17:08:19.613] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:19.613] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:7:0) after 1m0s
[17:09:19.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:7:0)
[17:09:19.668] Timer tick, asking Buildbucket for the build status
[17:09:20.039] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:20.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:8:0) after 1m0s
[17:10:20.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:8:0)
[17:10:20.157] Timer tick, asking Buildbucket for the build status
[17:10:20.255] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:20.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:9:0) after 1m0s
[17:11:20.433] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:9:0)
[17:11:20.433] Timer tick, asking Buildbucket for the build status
[17:11:20.498] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:20.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:10:0) after 1m0s
[17:12:20.551] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:10:0)
[17:12:20.551] Timer tick, asking Buildbucket for the build status
[17:12:20.628] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:20.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:11:0) after 1m0s
[17:13:20.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:11:0)
[17:13:20.722] Timer tick, asking Buildbucket for the build status
[17:13:20.788] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:20.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:12:0) after 1m0s
[17:14:20.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:12:0)
[17:14:20.908] Timer tick, asking Buildbucket for the build status
[17:14:20.968] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:20.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:13:0) after 1m0s
[17:15:21.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:13:0)
[17:15:21.053] Timer tick, asking Buildbucket for the build status
[17:15:21.131] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:21.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:14:0) after 1m0s
[17:16:21.205] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:14:0)
[17:16:21.205] Timer tick, asking Buildbucket for the build status
[17:16:21.264] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:21.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:15:0) after 1m0s
[17:17:21.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:15:0)
[17:17:21.380] Timer tick, asking Buildbucket for the build status
[17:17:21.446] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:21.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:16:0) after 1m0s
[17:18:21.588] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:16:0)
[17:18:21.588] Timer tick, asking Buildbucket for the build status
[17:18:21.665] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:21.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:17:0) after 1m0s
[17:19:21.709] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:17:0)
[17:19:21.709] Timer tick, asking Buildbucket for the build status
[17:19:21.889] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:21.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:18:0) after 1m0s
[17:20:21.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:18:0)
[17:20:21.955] Timer tick, asking Buildbucket for the build status
[17:20:22.023] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:22.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:19:0) after 1m0s
[17:21:22.031] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:19:0)
[17:21:22.031] Timer tick, asking Buildbucket for the build status
[17:21:22.146] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:22.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:20:0) after 1m0s
[17:22:22.146] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:20:0)
[17:22:22.146] Timer tick, asking Buildbucket for the build status
[17:22:22.339] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:22.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:21:0) after 1m0s
[17:23:22.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:21:0)
[17:23:22.361] Timer tick, asking Buildbucket for the build status
[17:23:22.434] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:22.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:22:0) after 1m0s
[17:24:22.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:22:0)
[17:24:22.481] Timer tick, asking Buildbucket for the build status
[17:24:22.915] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:22.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:23:0) after 1m0s
[17:25:22.940] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:23:0)
[17:25:22.940] Timer tick, asking Buildbucket for the build status
[17:25:23.007] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:23.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:24:0) after 1m0s
[17:26:23.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:24:0)
[17:26:23.028] Timer tick, asking Buildbucket for the build status
[17:26:23.202] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:23.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:25:0) after 1m0s
[17:27:23.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:25:0)
[17:27:23.201] Timer tick, asking Buildbucket for the build status
[17:27:23.267] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:23.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:26:0) after 1m0s
[17:28:23.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:26:0)
[17:28:23.295] Timer tick, asking Buildbucket for the build status
[17:28:23.377] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:23.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:27:0) after 1m0s
[17:29:23.433] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:27:0)
[17:29:23.433] Timer tick, asking Buildbucket for the build status
[17:29:23.524] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:23.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:28:0) after 1m0s
[17:30:23.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:28:0)
[17:30:23.554] Timer tick, asking Buildbucket for the build status
[17:30:23.646] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:23.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:29:0) after 1m0s
[17:31:23.684] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:29:0)
[17:31:23.684] Timer tick, asking Buildbucket for the build status
[17:31:23.751] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:23.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:30:0) after 1m0s
[17:32:23.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:30:0)
[17:32:23.779] Timer tick, asking Buildbucket for the build status
[17:32:23.894] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:23.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:31:0) after 1m0s
[17:33:23.922] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:31:0)
[17:33:23.922] Timer tick, asking Buildbucket for the build status
[17:33:24.005] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:24.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:32:0) after 1m0s
[17:34:24.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:32:0)
[17:34:24.038] Timer tick, asking Buildbucket for the build status
[17:34:24.246] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:24.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:33:0) after 1m0s
[17:35:24.256] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:33:0)
[17:35:24.256] Timer tick, asking Buildbucket for the build status
[17:35:24.322] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:24.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:34:0) after 1m0s
[17:36:24.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:34:0)
[17:36:24.291] Timer tick, asking Buildbucket for the build status
[17:36:24.380] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:24.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:35:0) after 1m0s
[17:37:24.407] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:35:0)
[17:37:24.407] Timer tick, asking Buildbucket for the build status
[17:37:24.656] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:24.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:36:0) after 1m0s
[17:38:24.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:36:0)
[17:38:24.734] Timer tick, asking Buildbucket for the build status
[17:38:24.794] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:24.794] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:37:0) after 1m0s
[17:39:24.780] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:37:0)
[17:39:24.781] Timer tick, asking Buildbucket for the build status
[17:39:24.855] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:24.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:38:0) after 1m0s
[17:40:24.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:38:0)
[17:40:24.913] Timer tick, asking Buildbucket for the build status
[17:40:25.034] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:25.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:39:0) after 1m0s
[17:41:25.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:39:0)
[17:41:25.076] Timer tick, asking Buildbucket for the build status
[17:41:25.149] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:25.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:40:0) after 1m0s
[17:42:25.294] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:40:0)
[17:42:25.294] Timer tick, asking Buildbucket for the build status
[17:42:25.552] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:25.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:41:0) after 1m0s
[17:43:25.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:41:0)
[17:43:25.643] Timer tick, asking Buildbucket for the build status
[17:43:25.715] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:25.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:42:0) after 1m0s
[17:44:25.813] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:42:0)
[17:44:25.813] Timer tick, asking Buildbucket for the build status
[17:44:25.906] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:25.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:43:0) after 1m0s
[17:45:25.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:43:0)
[17:45:25.974] Timer tick, asking Buildbucket for the build status
[17:45:26.163] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:26.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:44:0) after 1m0s
[17:46:26.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:44:0)
[17:46:26.208] Timer tick, asking Buildbucket for the build status
[17:46:26.329] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:26.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:45:0) after 1m0s
[17:47:26.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:45:0)
[17:47:26.339] Timer tick, asking Buildbucket for the build status
[17:47:26.410] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:26.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:46:0) after 1m0s
[17:48:26.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:46:0)
[17:48:26.442] Timer tick, asking Buildbucket for the build status
[17:48:26.521] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:26.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:47:0) after 1m0s
[17:49:26.563] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:47:0)
[17:49:26.564] Timer tick, asking Buildbucket for the build status
[17:49:26.652] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:26.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:48:0) after 1m0s
[17:50:26.747] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:48:0)
[17:50:26.747] Timer tick, asking Buildbucket for the build status
[17:50:26.829] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:26.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:49:0) after 1m0s
[17:51:26.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:49:0)
[17:51:26.887] Timer tick, asking Buildbucket for the build status
[17:51:26.960] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:26.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:50:0) after 1m0s
[17:52:27.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:50:0)
[17:52:27.002] Timer tick, asking Buildbucket for the build status
[17:52:27.084] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:27.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:51:0) after 1m0s
[17:53:27.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:51:0)
[17:53:27.107] Timer tick, asking Buildbucket for the build status
[17:53:27.306] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:27.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:52:0) after 1m0s
[17:54:27.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:52:0)
[17:54:27.373] Timer tick, asking Buildbucket for the build status
[17:54:27.453] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:27.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:53:0) after 1m0s
[17:55:27.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:53:0)
[17:55:27.458] Timer tick, asking Buildbucket for the build status
[17:55:27.532] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:27.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:54:0) after 1m0s
[17:56:27.573] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:54:0)
[17:56:27.573] Timer tick, asking Buildbucket for the build status
[17:56:27.638] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:27.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:55:0) after 1m0s
[17:57:27.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:55:0)
[17:57:27.674] Timer tick, asking Buildbucket for the build status
[17:57:27.745] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:27.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:56:0) after 1m0s
[17:58:27.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:56:0)
[17:58:27.748] Timer tick, asking Buildbucket for the build status
[17:58:27.927] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:27.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:57:0) after 1m0s
[17:59:27.971] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:57:0)
[17:59:27.971] Timer tick, asking Buildbucket for the build status
[17:59:28.065] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:28.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:58:0) after 1m0s
[18:00:28.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:58:0)
[18:00:28.171] Timer tick, asking Buildbucket for the build status
[18:00:28.283] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:28.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:59:0) after 1m0s
[18:01:28.336] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:59:0)
[18:01:28.336] Timer tick, asking Buildbucket for the build status
[18:01:28.430] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:28.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:60:0) after 1m0s
[18:02:28.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:60:0)
[18:02:28.503] Timer tick, asking Buildbucket for the build status
[18:02:28.579] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:28.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:61:0) after 1m0s
[18:03:28.592] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:61:0)
[18:03:28.592] Timer tick, asking Buildbucket for the build status
[18:03:28.657] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:28.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:62:0) after 1m0s
[18:04:28.744] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:62:0)
[18:04:28.744] Timer tick, asking Buildbucket for the build status
[18:04:28.920] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:28.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:63:0) after 1m0s
[18:05:28.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:63:0)
[18:05:28.941] Timer tick, asking Buildbucket for the build status
[18:05:29.024] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:29.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:64:0) after 1m0s
[18:06:29.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:64:0)
[18:06:29.092] Timer tick, asking Buildbucket for the build status
[18:06:29.166] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:29.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:65:0) after 1m0s
[18:07:29.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:65:0)
[18:07:29.162] Timer tick, asking Buildbucket for the build status
[18:07:29.233] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:29.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:66:0) after 1m0s
[18:08:29.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:66:0)
[18:08:29.308] Timer tick, asking Buildbucket for the build status
[18:08:29.376] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:29.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:67:0) after 1m0s
[18:09:29.396] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:67:0)
[18:09:29.396] Timer tick, asking Buildbucket for the build status
[18:09:29.659] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:29.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:68:0) after 1m0s
[18:10:29.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:68:0)
[18:10:29.722] Timer tick, asking Buildbucket for the build status
[18:10:29.813] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:29.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:69:0) after 1m0s
[18:11:29.845] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:69:0)
[18:11:29.845] Timer tick, asking Buildbucket for the build status
[18:11:30.120] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:30.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:70:0) after 1m0s
[18:12:30.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:70:0)
[18:12:30.211] Timer tick, asking Buildbucket for the build status
[18:12:30.423] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:30.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:71:0) after 1m0s
[18:13:30.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:71:0)
[18:13:30.493] Timer tick, asking Buildbucket for the build status
[18:13:30.567] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:30.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:72:0) after 1m0s
[18:14:30.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:72:0)
[18:14:30.777] Timer tick, asking Buildbucket for the build status
[18:14:30.859] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:30.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:73:0) after 1m0s
[18:15:30.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:73:0)
[18:15:30.893] Timer tick, asking Buildbucket for the build status
[18:15:31.238] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:31.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:74:0) after 1m0s
[18:16:31.267] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:74:0)
[18:16:31.267] Timer tick, asking Buildbucket for the build status
[18:16:31.341] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:31.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:75:0) after 1m0s
[18:17:31.385] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:75:0)
[18:17:31.385] Timer tick, asking Buildbucket for the build status
[18:17:32.885] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:32.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:76:0) after 1m0s
[18:18:32.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:76:0)
[18:18:32.984] Timer tick, asking Buildbucket for the build status
[18:18:33.046] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:33.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:77:0) after 1m0s
[18:19:33.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:77:0)
[18:19:33.081] Timer tick, asking Buildbucket for the build status
[18:19:33.156] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:33.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:78:0) after 1m0s
[18:20:33.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:78:0)
[18:20:33.261] Timer tick, asking Buildbucket for the build status
[18:20:33.352] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:33.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:79:0) after 1m0s
[18:21:33.388] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:79:0)
[18:21:33.388] Timer tick, asking Buildbucket for the build status
[18:21:33.482] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:33.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:80:0) after 1m0s
[18:22:33.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:80:0)
[18:22:33.516] Timer tick, asking Buildbucket for the build status
[18:22:33.623] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:33.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:81:0) after 1m0s
[18:23:33.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:81:0)
[18:23:33.617] Timer tick, asking Buildbucket for the build status
[18:23:33.811] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:33.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:82:0) after 1m0s
[18:24:34.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:82:0)
[18:24:34.037] Timer tick, asking Buildbucket for the build status
[18:24:34.326] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:34.326] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:83:0) after 1m0s
[18:25:34.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:83:0)
[18:25:34.481] Timer tick, asking Buildbucket for the build status
[18:25:34.611] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:34.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:84:0) after 1m0s
[18:26:34.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:84:0)
[18:26:34.667] Timer tick, asking Buildbucket for the build status
[18:26:34.800] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:34.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:85:0) after 1m0s
[18:27:34.903] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:85:0)
[18:27:34.903] Timer tick, asking Buildbucket for the build status
[18:27:35.093] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:35.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:86:0) after 1m0s
[18:28:35.134] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:86:0)
[18:28:35.134] Timer tick, asking Buildbucket for the build status
[18:28:35.205] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:35.205] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:87:0) after 1m0s
[18:29:35.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:87:0)
[18:29:35.230] Timer tick, asking Buildbucket for the build status
[18:29:35.717] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:35.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:88:0) after 1m0s
[18:30:35.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:88:0)
[18:30:35.740] Timer tick, asking Buildbucket for the build status
[18:30:35.937] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:35.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:89:0) after 1m0s
[18:31:36.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:89:0)
[18:31:36.044] Timer tick, asking Buildbucket for the build status
[18:31:36.454] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:36.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:90:0) after 1m0s
[18:32:36.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:90:0)
[18:32:36.504] Timer tick, asking Buildbucket for the build status
[18:32:36.569] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:36.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:91:0) after 1m0s
[18:33:36.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:91:0)
[18:33:36.596] Timer tick, asking Buildbucket for the build status
[18:33:36.675] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:36.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:92:0) after 1m0s
[18:34:36.748] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:92:0)
[18:34:36.748] Timer tick, asking Buildbucket for the build status
[18:34:36.827] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:36.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:93:0) after 1m0s
[18:35:36.913] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:93:0)
[18:35:36.913] Timer tick, asking Buildbucket for the build status
[18:35:36.971] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:36.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:94:0) after 1m0s
[18:36:37.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:94:0)
[18:36:37.023] Timer tick, asking Buildbucket for the build status
[18:36:37.095] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:37.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:95:0) after 1m0s
[18:37:37.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:95:0)
[18:37:37.167] Timer tick, asking Buildbucket for the build status
[18:37:37.262] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:37.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:96:0) after 1m0s
[18:38:37.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:96:0)
[18:38:37.299] Timer tick, asking Buildbucket for the build status
[18:38:37.411] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:37.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:97:0) after 1m0s
[18:39:37.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:97:0)
[18:39:37.480] Timer tick, asking Buildbucket for the build status
[18:39:37.553] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:37.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:98:0) after 1m0s
[18:40:37.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:98:0)
[18:40:37.598] Timer tick, asking Buildbucket for the build status
[18:40:37.957] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:37.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:99:0) after 1m0s
[18:41:38.027] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:99:0)
[18:41:38.027] Timer tick, asking Buildbucket for the build status
[18:41:38.219] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:38.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:100:0) after 1m0s
[18:42:38.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:100:0)
[18:42:38.246] Timer tick, asking Buildbucket for the build status
[18:42:38.320] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:38.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:101:0) after 1m0s
[18:43:38.337] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:101:0)
[18:43:38.337] Timer tick, asking Buildbucket for the build status
[18:43:38.470] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:38.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:102:0) after 1m0s
[18:44:38.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:102:0)
[18:44:38.494] Timer tick, asking Buildbucket for the build status
[18:44:38.589] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:38.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:103:0) after 1m0s
[18:45:38.640] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:103:0)
[18:45:38.640] Timer tick, asking Buildbucket for the build status
[18:45:38.702] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:38.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:104:0) after 1m0s
[18:46:38.775] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:104:0)
[18:46:38.775] Timer tick, asking Buildbucket for the build status
[18:46:38.833] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:38.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:105:0) after 1m0s
[18:47:38.902] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:105:0)
[18:47:38.902] Timer tick, asking Buildbucket for the build status
[18:47:38.977] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:38.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:106:0) after 1m0s
[18:48:39.025] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:106:0)
[18:48:39.025] Timer tick, asking Buildbucket for the build status
[18:48:39.165] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:39.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:107:0) after 1m0s
[18:49:39.191] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:107:0)
[18:49:39.191] Timer tick, asking Buildbucket for the build status
[18:49:39.272] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:39.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:108:0) after 1m0s
[18:50:39.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:108:0)
[18:50:39.299] Timer tick, asking Buildbucket for the build status
[18:50:39.445] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:39.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:109:0) after 1m0s
[18:51:39.466] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:109:0)
[18:51:39.466] Timer tick, asking Buildbucket for the build status
[18:51:39.536] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:39.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:110:0) after 1m0s
[18:52:39.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:110:0)
[18:52:39.583] Timer tick, asking Buildbucket for the build status
[18:52:39.659] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:39.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:111:0) after 1m0s
[18:53:39.682] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:111:0)
[18:53:39.682] Timer tick, asking Buildbucket for the build status
[18:53:39.767] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:39.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:112:0) after 1m0s
[18:54:39.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:112:0)
[18:54:39.771] Timer tick, asking Buildbucket for the build status
[18:54:41.106] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:41.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:113:0) after 1m0s
[18:55:41.149] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:113:0)
[18:55:41.149] Timer tick, asking Buildbucket for the build status
[18:55:41.246] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:41.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:114:0) after 1m0s
[18:56:41.303] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:114:0)
[18:56:41.303] Timer tick, asking Buildbucket for the build status
[18:56:41.461] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:41.461] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:115:0) after 1m0s
[18:57:41.556] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:115:0)
[18:57:41.556] Timer tick, asking Buildbucket for the build status
[18:57:41.628] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:41.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:116:0) after 1m0s
[18:58:41.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:116:0)
[18:58:41.700] Timer tick, asking Buildbucket for the build status
[18:58:41.844] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:41.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:117:0) after 1m0s
[18:59:41.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:117:0)
[18:59:41.871] Timer tick, asking Buildbucket for the build status
[18:59:42.112] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:42.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:118:0) after 1m0s
[19:00:42.127] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:118:0)
[19:00:42.127] Timer tick, asking Buildbucket for the build status
[19:00:42.214] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:42.214] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:119:0) after 1m0s
[19:01:42.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:119:0)
[19:01:42.217] Timer tick, asking Buildbucket for the build status
[19:01:42.445] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:42.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:120:0) after 1m0s
[19:02:42.494] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:120:0)
[19:02:42.494] Timer tick, asking Buildbucket for the build status
[19:02:42.643] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:42.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:121:0) after 1m0s
[19:03:42.706] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:121:0)
[19:03:42.706] Timer tick, asking Buildbucket for the build status
[19:03:43.226] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:43.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:122:0) after 1m0s
[19:04:43.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:122:0)
[19:04:43.251] Timer tick, asking Buildbucket for the build status
[19:04:43.397] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:43.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:123:0) after 1m0s
[19:05:43.421] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:123:0)
[19:05:43.421] Timer tick, asking Buildbucket for the build status
[19:05:43.488] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:43.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:124:0) after 1m0s
[19:06:43.625] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:124:0)
[19:06:43.625] Timer tick, asking Buildbucket for the build status
[19:06:43.811] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:43.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:125:0) after 1m0s
[19:07:43.861] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:125:0)
[19:07:43.861] Timer tick, asking Buildbucket for the build status
[19:07:44.032] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:44.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:126:0) after 1m0s
[19:08:44.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:126:0)
[19:08:44.062] Timer tick, asking Buildbucket for the build status
[19:08:44.373] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:44.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:127:0) after 1m0s
[19:09:44.421] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:127:0)
[19:09:44.422] Timer tick, asking Buildbucket for the build status
[19:09:44.509] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:44.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:128:0) after 1m0s
[19:10:44.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:128:0)
[19:10:44.538] Timer tick, asking Buildbucket for the build status
[19:10:44.742] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:44.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:129:0) after 1m0s
[19:11:44.745] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:129:0)
[19:11:44.745] Timer tick, asking Buildbucket for the build status
[19:11:44.878] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:44.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:130:0) after 1m0s
[19:12:44.930] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:130:0)
[19:12:44.930] Timer tick, asking Buildbucket for the build status
[19:12:44.992] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:44.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:131:0) after 1m0s
[19:13:45.057] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:131:0)
[19:13:45.057] Timer tick, asking Buildbucket for the build status
[19:13:45.134] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:45.134] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:132:0) after 1m0s
[19:14:45.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:132:0)
[19:14:45.233] Timer tick, asking Buildbucket for the build status
[19:14:45.935] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:45.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:133:0) after 1m0s
[19:15:45.971] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:133:0)
[19:15:45.971] Timer tick, asking Buildbucket for the build status
[19:15:46.956] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:46.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:134:0) after 1m0s
[19:16:46.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:134:0)
[19:16:46.965] Timer tick, asking Buildbucket for the build status
[19:16:50.157] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:50.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:135:0) after 1m0s
[19:17:50.183] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:135:0)
[19:17:50.183] Timer tick, asking Buildbucket for the build status
[19:17:50.268] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:50.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:136:0) after 1m0s
[19:18:50.292] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:136:0)
[19:18:50.292] Timer tick, asking Buildbucket for the build status
[19:18:50.376] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:50.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:137:0) after 1m0s
[19:19:50.945] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:137:0)
[19:19:50.945] Timer tick, asking Buildbucket for the build status
[19:19:51.234] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:51.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:138:0) after 1m0s
[19:20:51.326] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:138:0)
[19:20:51.326] Timer tick, asking Buildbucket for the build status
[19:20:51.448] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:51.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:139:0) after 1m0s
[19:21:51.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:139:0)
[19:21:51.474] Timer tick, asking Buildbucket for the build status
[19:21:51.547] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:51.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:140:0) after 1m0s
[19:22:51.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:140:0)
[19:22:51.620] Timer tick, asking Buildbucket for the build status
[19:22:51.696] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:51.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:141:0) after 1m0s
[19:23:51.708] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:141:0)
[19:23:51.708] Timer tick, asking Buildbucket for the build status
[19:23:51.788] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:51.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:142:0) after 1m0s
[19:24:51.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:142:0)
[19:24:51.840] Timer tick, asking Buildbucket for the build status
[19:24:51.964] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:51.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:143:0) after 1m0s
[19:25:52.015] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:143:0)
[19:25:52.015] Timer tick, asking Buildbucket for the build status
[19:25:52.103] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:52.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:144:0) after 1m0s
[19:26:52.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:144:0)
[19:26:52.172] Timer tick, asking Buildbucket for the build status
[19:26:52.346] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:52.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:145:0) after 1m0s
[19:27:52.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:145:0)
[19:27:52.411] Timer tick, asking Buildbucket for the build status
[19:27:52.541] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:52.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:146:0) after 1m0s
[19:28:52.588] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:146:0)
[19:28:52.588] Timer tick, asking Buildbucket for the build status
[19:28:52.654] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:52.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:147:0) after 1m0s
[19:29:52.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:147:0)
[19:29:52.772] Timer tick, asking Buildbucket for the build status
[19:29:52.850] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:52.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:148:0) after 1m0s
[19:30:52.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:148:0)
[19:30:52.954] Timer tick, asking Buildbucket for the build status
[19:30:53.302] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:53.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:149:0) after 1m0s
[19:31:53.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:149:0)
[19:31:53.313] Timer tick, asking Buildbucket for the build status
[19:31:53.415] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:53.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:150:0) after 1m0s
[19:32:53.438] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:150:0)
[19:32:53.438] Timer tick, asking Buildbucket for the build status
[19:32:53.627] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:53.627] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:151:0) after 1m0s
[19:33:53.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:151:0)
[19:33:53.697] Timer tick, asking Buildbucket for the build status
[19:33:53.764] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:53.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:152:0) after 1m0s
[19:34:53.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:152:0)
[19:34:53.867] Timer tick, asking Buildbucket for the build status
[19:34:53.972] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:53.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:153:0) after 1m0s
[19:35:54.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:153:0)
[19:35:54.053] Timer tick, asking Buildbucket for the build status
[19:35:54.307] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:54.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:154:0) after 1m0s
[19:36:54.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:154:0)
[19:36:54.375] Timer tick, asking Buildbucket for the build status
[19:36:54.751] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:54.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:155:0) after 1m0s
[19:37:54.868] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:155:0)
[19:37:54.868] Timer tick, asking Buildbucket for the build status
[19:37:54.950] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:54.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:156:0) after 1m0s
[19:38:55.007] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:156:0)
[19:38:55.007] Timer tick, asking Buildbucket for the build status
[19:38:55.305] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:55.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:157:0) after 1m0s
[19:39:55.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:157:0)
[19:39:55.331] Timer tick, asking Buildbucket for the build status
[19:39:55.438] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:55.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:158:0) after 1m0s
[19:40:55.482] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:158:0)
[19:40:55.482] Timer tick, asking Buildbucket for the build status
[19:40:55.543] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:55.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:159:0) after 1m0s
[19:41:55.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:159:0)
[19:41:55.617] Timer tick, asking Buildbucket for the build status
[19:41:55.674] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:55.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:160:0) after 1m0s
[19:42:55.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:160:0)
[19:42:55.819] Timer tick, asking Buildbucket for the build status
[19:42:55.956] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:55.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:161:0) after 1m0s
[19:43:56.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:161:0)
[19:43:56.065] Timer tick, asking Buildbucket for the build status
[19:43:56.157] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:56.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:162:0) after 1m0s
[19:44:56.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:162:0)
[19:44:56.260] Timer tick, asking Buildbucket for the build status
[19:44:56.339] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:56.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:163:0) after 1m0s
[19:45:56.372] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:163:0)
[19:45:56.372] Timer tick, asking Buildbucket for the build status
[19:45:56.447] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:56.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:164:0) after 1m0s
[19:46:56.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:164:0)
[19:46:56.481] Timer tick, asking Buildbucket for the build status
[19:46:56.579] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:56.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:165:0) after 1m0s
[19:47:56.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:165:0)
[19:47:56.629] Timer tick, asking Buildbucket for the build status
[19:47:56.707] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:56.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:166:0) after 1m0s
[19:48:56.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:166:0)
[19:48:56.733] Timer tick, asking Buildbucket for the build status
[19:48:56.797] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:56.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:167:0) after 1m0s
[19:49:56.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:167:0)
[19:49:56.822] Timer tick, asking Buildbucket for the build status
[19:49:56.900] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:56.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:168:0) after 1m0s
[19:50:57.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:168:0)
[19:50:57.071] Timer tick, asking Buildbucket for the build status
[19:50:57.137] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:57.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:169:0) after 1m0s
[19:51:57.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:169:0)
[19:51:57.172] Timer tick, asking Buildbucket for the build status
[19:51:57.237] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:57.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:170:0) after 1m0s
[19:52:57.395] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:170:0)
[19:52:57.395] Timer tick, asking Buildbucket for the build status
[19:52:57.466] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:57.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:171:0) after 1m0s
[19:53:57.489] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:171:0)
[19:53:57.489] Timer tick, asking Buildbucket for the build status
[19:53:57.570] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:57.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:172:0) after 1m0s
[19:54:57.670] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:172:0)
[19:54:57.670] Timer tick, asking Buildbucket for the build status
[19:54:57.850] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:57.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:173:0) after 1m0s
[19:55:57.876] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:173:0)
[19:55:57.876] Timer tick, asking Buildbucket for the build status
[19:55:57.940] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:57.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:174:0) after 1m0s
[19:56:57.980] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:174:0)
[19:56:57.980] Timer tick, asking Buildbucket for the build status
[19:56:58.232] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:58.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:175:0) after 1m0s
[19:57:58.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:175:0)
[19:57:58.317] Timer tick, asking Buildbucket for the build status
[19:57:58.509] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:58.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:176:0) after 1m0s
[19:58:58.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:176:0)
[19:58:58.498] Timer tick, asking Buildbucket for the build status
[19:58:58.670] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:58.670] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:177:0) after 1m0s
[19:59:58.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:177:0)
[19:59:58.756] Timer tick, asking Buildbucket for the build status
[19:59:59.080] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:59.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:178:0) after 1m0s
[20:00:59.143] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:178:0)
[20:00:59.143] Timer tick, asking Buildbucket for the build status
[20:00:59.206] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:59.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:179:0) after 1m0s
[20:01:59.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:179:0)
[20:01:59.321] Timer tick, asking Buildbucket for the build status
[20:01:59.536] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:59.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:180:0) after 1m0s
[20:02:59.614] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:180:0)
[20:02:59.614] Timer tick, asking Buildbucket for the build status
[20:02:59.804] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:59.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:181:0) after 1m0s
[20:03:59.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:181:0)
[20:03:59.836] Timer tick, asking Buildbucket for the build status
[20:03:59.895] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:59.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:182:0) after 1m0s
[20:04:59.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:182:0)
[20:04:59.925] Timer tick, asking Buildbucket for the build status
[20:05:00.116] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:00.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:183:0) after 1m0s
[20:06:00.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:183:0)
[20:06:00.253] Timer tick, asking Buildbucket for the build status
[20:06:00.352] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:00.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:184:0) after 1m0s
[20:07:00.424] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:184:0)
[20:07:00.424] Timer tick, asking Buildbucket for the build status
[20:07:00.486] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:00.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:185:0) after 1m0s
[20:08:00.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:185:0)
[20:08:00.512] Timer tick, asking Buildbucket for the build status
[20:08:00.585] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:00.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:186:0) after 1m0s
[20:09:00.895] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:186:0)
[20:09:00.895] Timer tick, asking Buildbucket for the build status
[20:09:01.160] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:01.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:187:0) after 1m0s
[20:10:01.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:187:0)
[20:10:01.234] Timer tick, asking Buildbucket for the build status
[20:10:01.331] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:01.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:188:0) after 1m0s
[20:11:01.493] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:188:0)
[20:11:01.493] Timer tick, asking Buildbucket for the build status
[20:11:01.558] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:01.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:189:0) after 1m0s
[20:12:01.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:189:0)
[20:12:01.671] Timer tick, asking Buildbucket for the build status
[20:12:01.752] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:01.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:190:0) after 1m0s
[20:13:01.976] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:190:0)
[20:13:01.976] Timer tick, asking Buildbucket for the build status
[20:13:02.039] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:02.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:191:0) after 1m0s
[20:14:02.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:191:0)
[20:14:02.098] Timer tick, asking Buildbucket for the build status
[20:14:02.174] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:02.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:192:0) after 1m0s
[20:15:02.210] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:192:0)
[20:15:02.210] Timer tick, asking Buildbucket for the build status
[20:15:02.418] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:02.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:193:0) after 1m0s
[20:16:02.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:193:0)
[20:16:02.430] Timer tick, asking Buildbucket for the build status
[20:16:02.506] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:02.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:194:0) after 1m0s
[20:17:02.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:194:0)
[20:17:02.812] Timer tick, asking Buildbucket for the build status
[20:17:02.946] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:02.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:195:0) after 1m0s
[20:18:02.952] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:195:0)
[20:18:02.952] Timer tick, asking Buildbucket for the build status
[20:18:03.018] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:03.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:196:0) after 1m0s
[20:19:03.029] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:196:0)
[20:19:03.029] Timer tick, asking Buildbucket for the build status
[20:19:03.103] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:03.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:197:0) after 1m0s
[20:20:03.176] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:197:0)
[20:20:03.176] Timer tick, asking Buildbucket for the build status
[20:20:04.735] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:04.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:198:0) after 1m0s
[20:21:04.783] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:198:0)
[20:21:04.783] Timer tick, asking Buildbucket for the build status
[20:21:05.309] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:05.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:199:0) after 1m0s
[20:22:05.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:199:0)
[20:22:05.413] Timer tick, asking Buildbucket for the build status
[20:22:05.517] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:05.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:200:0) after 1m0s
[20:23:05.556] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:200:0)
[20:23:05.556] Timer tick, asking Buildbucket for the build status
[20:23:05.762] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:05.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:201:0) after 1m0s
[20:24:05.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:201:0)
[20:24:05.802] Timer tick, asking Buildbucket for the build status
[20:24:06.035] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:06.035] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:202:0) after 1m0s
[20:25:06.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:202:0)
[20:25:06.106] Timer tick, asking Buildbucket for the build status
[20:25:06.182] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:06.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:203:0) after 1m0s
[20:26:06.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:203:0)
[20:26:06.180] Timer tick, asking Buildbucket for the build status
[20:26:06.331] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:06.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:204:0) after 1m0s
[20:27:06.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:204:0)
[20:27:06.390] Timer tick, asking Buildbucket for the build status
[20:27:06.522] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:06.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:205:0) after 1m0s
[20:28:06.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:205:0)
[20:28:06.574] Timer tick, asking Buildbucket for the build status
[20:28:06.638] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:06.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:206:0) after 1m0s
[20:29:06.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:206:0)
[20:29:06.712] Timer tick, asking Buildbucket for the build status
[20:29:06.773] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:06.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:207:0) after 1m0s
[20:30:06.827] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:207:0)
[20:30:06.827] Timer tick, asking Buildbucket for the build status
[20:30:06.965] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:06.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:208:0) after 1m0s
[20:31:07.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:208:0)
[20:31:07.056] Timer tick, asking Buildbucket for the build status
[20:31:07.316] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:07.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:209:0) after 1m0s
[20:32:07.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:209:0)
[20:32:07.339] Timer tick, asking Buildbucket for the build status
[20:32:07.411] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:07.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:210:0) after 1m0s
[20:33:07.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:210:0)
[20:33:07.517] Timer tick, asking Buildbucket for the build status
[20:33:07.585] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:07.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:211:0) after 1m0s
[20:34:07.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:211:0)
[20:34:07.656] Timer tick, asking Buildbucket for the build status
[20:34:07.723] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:07.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:212:0) after 1m0s
[20:35:07.811] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:212:0)
[20:35:07.811] Timer tick, asking Buildbucket for the build status
[20:35:08.044] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:08.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:213:0) after 1m0s
[20:36:08.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:213:0)
[20:36:08.112] Timer tick, asking Buildbucket for the build status
[20:36:08.196] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:08.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:214:0) after 1m0s
[20:37:08.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:214:0)
[20:37:08.257] Timer tick, asking Buildbucket for the build status
[20:37:08.328] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:08.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:215:0) after 1m0s
[20:38:08.381] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:215:0)
[20:38:08.381] Timer tick, asking Buildbucket for the build status
[20:38:08.463] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:08.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:216:0) after 1m0s
[20:39:08.520] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:216:0)
[20:39:08.520] Timer tick, asking Buildbucket for the build status
[20:39:08.719] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:08.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:217:0) after 1m0s
[20:40:08.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:217:0)
[20:40:08.731] Timer tick, asking Buildbucket for the build status
[20:40:09.004] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:09.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:218:0) after 1m0s
[20:41:09.276] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:218:0)
[20:41:09.276] Timer tick, asking Buildbucket for the build status
[20:41:11.756] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:11.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:219:0) after 1m0s
[20:42:11.975] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:219:0)
[20:42:11.975] Timer tick, asking Buildbucket for the build status
[20:42:12.165] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:12.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:220:0) after 1m0s
[20:43:12.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:220:0)
[20:43:12.317] Timer tick, asking Buildbucket for the build status
[20:43:12.390] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:12.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:221:0) after 1m0s
[20:44:12.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:221:0)
[20:44:12.501] Timer tick, asking Buildbucket for the build status
[20:44:12.562] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:12.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:222:0) after 1m0s
[20:45:12.702] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:222:0)
[20:45:12.702] Timer tick, asking Buildbucket for the build status
[20:45:12.805] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:12.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:223:0) after 1m0s
[20:46:13.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:223:0)
[20:46:13.095] Timer tick, asking Buildbucket for the build status
[20:46:13.200] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:13.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:224:0) after 1m0s
[20:47:13.358] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:224:0)
[20:47:13.358] Timer tick, asking Buildbucket for the build status
[20:47:13.448] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:13.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:225:0) after 1m0s
[20:48:13.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:225:0)
[20:48:13.746] Timer tick, asking Buildbucket for the build status
[20:48:13.910] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:13.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:226:0) after 1m0s
[20:49:13.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:226:0)
[20:49:13.973] Timer tick, asking Buildbucket for the build status
[20:49:14.116] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:14.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:227:0) after 1m0s
[20:50:14.235] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:227:0)
[20:50:14.235] Timer tick, asking Buildbucket for the build status
[20:50:14.544] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:14.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:228:0) after 1m0s
[20:51:14.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:228:0)
[20:51:14.623] Timer tick, asking Buildbucket for the build status
[20:51:14.698] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:14.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:229:0) after 1m0s
[20:52:14.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:229:0)
[20:52:14.756] Timer tick, asking Buildbucket for the build status
[20:52:14.833] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:14.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:230:0) after 1m0s
[20:53:14.906] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:230:0)
[20:53:14.906] Timer tick, asking Buildbucket for the build status
[20:53:14.964] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:14.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:231:0) after 1m0s
[20:54:15.054] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:231:0)
[20:54:15.054] Timer tick, asking Buildbucket for the build status
[20:54:15.143] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:15.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:232:0) after 1m0s
[20:55:17.579] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:232:0)
[20:55:17.579] Timer tick, asking Buildbucket for the build status
[20:55:17.652] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:17.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:233:0) after 1m0s
[20:56:17.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:233:0)
[20:56:17.712] Timer tick, asking Buildbucket for the build status
[20:56:17.776] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:17.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:234:0) after 1m0s
[20:57:17.809] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:234:0)
[20:57:17.809] Timer tick, asking Buildbucket for the build status
[20:57:17.909] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:17.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:235:0) after 1m0s
[20:58:17.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:235:0)
[20:58:17.979] Timer tick, asking Buildbucket for the build status
[20:58:25.533] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:25.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:236:0) after 1m0s
[20:59:25.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:236:0)
[20:59:25.597] Timer tick, asking Buildbucket for the build status
[20:59:25.667] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:25.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:237:0) after 1m0s
[21:00:25.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:237:0)
[21:00:25.774] Timer tick, asking Buildbucket for the build status
[21:00:30.221] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:30.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:238:0) after 1m0s
[21:01:30.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:238:0)
[21:01:30.272] Timer tick, asking Buildbucket for the build status
[21:01:30.356] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:30.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:239:0) after 1m0s
[21:02:30.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:239:0)
[21:02:30.345] Timer tick, asking Buildbucket for the build status
[21:02:30.409] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:30.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:240:0) after 1m0s
[21:03:30.496] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:240:0)
[21:03:30.496] Timer tick, asking Buildbucket for the build status
[21:03:30.579] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:30.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:241:0) after 1m0s
[21:04:30.677] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:241:0)
[21:04:30.677] Timer tick, asking Buildbucket for the build status
[21:04:30.801] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:30.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:242:0) after 1m0s
[21:05:31.058] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:242:0)
[21:05:31.058] Timer tick, asking Buildbucket for the build status
[21:05:31.130] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:31.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:243:0) after 1m0s
[21:06:31.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:243:0)
[21:06:31.162] Timer tick, asking Buildbucket for the build status
[21:06:31.222] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:31.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:244:0) after 1m0s
[21:07:31.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:244:0)
[21:07:31.304] Timer tick, asking Buildbucket for the build status
[21:07:31.413] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:31.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:245:0) after 1m0s
[21:08:31.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:245:0)
[21:08:31.577] Timer tick, asking Buildbucket for the build status
[21:08:31.651] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:31.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:246:0) after 1m0s
[21:09:31.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:246:0)
[21:09:31.916] Timer tick, asking Buildbucket for the build status
[21:09:31.989] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:31.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:247:0) after 1m0s
[21:10:32.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:247:0)
[21:10:32.531] Timer tick, asking Buildbucket for the build status
[21:10:32.597] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:32.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:248:0) after 1m0s
[21:11:32.624] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:248:0)
[21:11:32.624] Timer tick, asking Buildbucket for the build status
[21:11:32.688] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:32.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:249:0) after 1m0s
[21:12:32.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:249:0)
[21:12:32.912] Timer tick, asking Buildbucket for the build status
[21:12:32.995] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:32.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:250:0) after 1m0s
[21:13:33.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:250:0)
[21:13:33.072] Timer tick, asking Buildbucket for the build status
[21:13:33.158] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:33.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:251:0) after 1m0s
[21:14:33.215] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:251:0)
[21:14:33.215] Timer tick, asking Buildbucket for the build status
[21:14:33.359] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:33.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:252:0) after 1m0s
[21:15:33.376] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:252:0)
[21:15:33.376] Timer tick, asking Buildbucket for the build status
[21:15:33.446] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:33.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:253:0) after 1m0s
[21:16:33.513] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:253:0)
[21:16:33.513] Timer tick, asking Buildbucket for the build status
[21:16:33.812] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:33.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:254:0) after 1m0s
[21:17:33.894] Handling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:254:0)
[21:17:33.894] Timer tick, asking Buildbucket for the build status
[21:17:33.966] Build 8852947194867616784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:33.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9018377256944081104:255:0) after 1m0s
[21:17:36.817] Received PubSub notification, asking Buildbucket for the build status
[21:17:36.876] Build 8852947194867616784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:17:36.876] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615583856022542",
"created_by": "project:chromium",
"created_ts": "1615568657961578",
"id": "8852947194867616784",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"446ddc8c6fac7625ca5fd87f2ddd92c5b9202202\"}}",
"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\": \"446ddc8c6fac7625ca5fd87f2ddd92c5b9202202\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-4-0esy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1737, \"got_angle_revision\": \"5cc32fc93feae0219014b7ebcc17b1e6e7ff1475\", \"got_dawn_revision\": \"a57308e60b7879ab89bb59abe90b01b5f21e92b5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"446ddc8c6fac7625ca5fd87f2ddd92c5b9202202\", \"got_revision_cp\": \"refs/heads/master@{#862443}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3c4fd15fb075ab3a8eb5809f9a42b5faa9ac63ae\", \"got_v8_revision\": \"9d12b666c3e113f5cd61e2b2eb384aae242ac840\", \"got_v8_revision_cp\": \"refs/heads/9.1.105@{#1}\", \"got_webrtc_revision\": \"86473404362e38131203537b8a8c8ec7c1abc31a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33444}\", \"is_cached\": true, \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"446ddc8c6fac7625ca5fd87f2ddd92c5b9202202\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"builder_cc946d8c9fe3204026095d74248289703a45d938e0b9766be9cb626e466da04f_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-0esy\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615568665128495",
"status": "COMPLETED",
"status_changed_ts": "1615583856371327",
"tags": [
"build_address:luci.chromium.ci/win-official/1737",
"builder:win-official",
"buildset:commit/git/446ddc8c6fac7625ca5fd87f2ddd92c5b9202202",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/446ddc8c6fac7625ca5fd87f2ddd92c5b9202202",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018377256944081104",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852947194867616784/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:524036f14eea0e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615583856388817",
"url": "https://ci.chromium.org/b/8852947194867616784",
"utcnow_ts": "1615583856869436"
}
}
[21:17:36.876] Invocation finished in 4h13m20.277985151s with status SUCCEEDED