[14:14:07.034] New invocation is queued and will start shortly
[14:14:08.439] Starting the invocation (attempt 1)
[14:14:08.494] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:14:08.494] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:14:08.494] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9040403025309925296",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ddbc6e97e6bc5c170a446105ec4914864edd6fb0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9040403025309925296",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/ddbc6e97e6bc5c170a446105ec4914864edd6fb0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddbc6e97e6bc5c170a446105ec4914864edd6fb0",
"gitiles_ref:refs/heads/master"
]
}
[14:14:10.582] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1594563248700640",
"id": "8874972962889145936",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ddbc6e97e6bc5c170a446105ec4914864edd6fb0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594563250081323",
"tags": [
"build_address:luci.chromium.ci/win-official/83",
"builder:win-official",
"buildset:commit/git/ddbc6e97e6bc5c170a446105ec4914864edd6fb0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddbc6e97e6bc5c170a446105ec4914864edd6fb0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040403025309925296",
"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/8874972962889145936/+/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": "1594563250096494",
"url": "https://ci.chromium.org/b/8874972962889145936",
"utcnow_ts": "1594563250476312"
}
}
[14:14:10.582] Task URL: https://ci.chromium.org/b/8874972962889145936
[14:14:10.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:2:0) after 1m0s
[14:14:15.371] Received PubSub notification, asking Buildbucket for the build status
[14:14:15.439] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:10.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:2:0)
[14:15:10.687] Timer tick, asking Buildbucket for the build status
[14:15:10.826] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:10.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:4:0) after 1m0s
[14:16:10.801] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:4:0)
[14:16:10.801] Timer tick, asking Buildbucket for the build status
[14:16:11.025] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:11.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:5:0) after 1m0s
[14:17:11.177] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:5:0)
[14:17:11.177] Timer tick, asking Buildbucket for the build status
[14:17:11.989] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:11.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:6:0) after 1m0s
[14:18:12.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:6:0)
[14:18:12.111] Timer tick, asking Buildbucket for the build status
[14:18:12.323] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:12.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:7:0) after 1m0s
[14:19:12.432] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:7:0)
[14:19:12.432] Timer tick, asking Buildbucket for the build status
[14:19:12.829] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:12.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:8:0) after 1m0s
[14:20:12.879] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:8:0)
[14:20:12.879] Timer tick, asking Buildbucket for the build status
[14:20:13.036] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:13.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:9:0) after 1m0s
[14:21:13.171] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:9:0)
[14:21:13.171] Timer tick, asking Buildbucket for the build status
[14:21:13.380] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:13.380] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:10:0) after 1m0s
[14:22:13.519] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:10:0)
[14:22:13.519] Timer tick, asking Buildbucket for the build status
[14:22:13.811] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:13.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:11:0) after 1m0s
[14:23:13.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:11:0)
[14:23:13.987] Timer tick, asking Buildbucket for the build status
[14:23:14.190] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:14.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:12:0) after 1m0s
[14:24:14.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:12:0)
[14:24:14.193] Timer tick, asking Buildbucket for the build status
[14:24:14.358] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:14.358] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:13:0) after 1m0s
[14:25:14.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:13:0)
[14:25:14.591] Timer tick, asking Buildbucket for the build status
[14:25:14.760] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:14.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:14:0) after 1m0s
[14:26:14.795] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:14:0)
[14:26:14.795] Timer tick, asking Buildbucket for the build status
[14:26:14.956] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:14.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:15:0) after 1m0s
[14:27:15.074] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:15:0)
[14:27:15.074] Timer tick, asking Buildbucket for the build status
[14:27:15.937] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:15.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:16:0) after 1m0s
[14:28:16.010] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:16:0)
[14:28:16.010] Timer tick, asking Buildbucket for the build status
[14:28:16.945] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:16.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:17:0) after 1m0s
[14:29:17.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:17:0)
[14:29:17.111] Timer tick, asking Buildbucket for the build status
[14:29:17.314] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:17.314] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:18:0) after 1m0s
[14:30:17.442] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:18:0)
[14:30:17.442] Timer tick, asking Buildbucket for the build status
[14:30:17.527] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:17.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:19:0) after 1m0s
[14:31:17.656] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:19:0)
[14:31:17.656] Timer tick, asking Buildbucket for the build status
[14:31:17.922] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:17.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:20:0) after 1m0s
[14:32:18.055] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:20:0)
[14:32:18.055] Timer tick, asking Buildbucket for the build status
[14:32:18.168] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:18.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:21:0) after 1m0s
[14:33:18.304] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:21:0)
[14:33:18.304] Timer tick, asking Buildbucket for the build status
[14:33:18.414] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:18.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:22:0) after 1m0s
[14:34:18.576] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:22:0)
[14:34:18.576] Timer tick, asking Buildbucket for the build status
[14:34:18.949] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:18.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:23:0) after 1m0s
[14:35:19.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:23:0)
[14:35:19.011] Timer tick, asking Buildbucket for the build status
[14:35:20.774] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:20.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:24:0) after 1m0s
[14:36:20.950] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:24:0)
[14:36:20.950] Timer tick, asking Buildbucket for the build status
[14:36:21.194] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:21.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:25:0) after 1m0s
[14:37:21.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:25:0)
[14:37:21.628] Timer tick, asking Buildbucket for the build status
[14:37:21.990] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:21.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:26:0) after 1m0s
[14:38:22.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:26:0)
[14:38:22.266] Timer tick, asking Buildbucket for the build status
[14:38:22.585] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:22.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:27:0) after 1m0s
[14:39:23.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:27:0)
[14:39:23.800] Timer tick, asking Buildbucket for the build status
[14:39:23.964] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:23.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:28:0) after 1m0s
[14:40:24.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:28:0)
[14:40:24.106] Timer tick, asking Buildbucket for the build status
[14:40:24.393] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:24.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:29:0) after 1m0s
[14:41:24.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:29:0)
[14:41:24.458] Timer tick, asking Buildbucket for the build status
[14:41:24.853] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:24.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:30:0) after 1m0s
[14:42:24.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:30:0)
[14:42:24.878] Timer tick, asking Buildbucket for the build status
[14:42:25.044] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:25.044] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:31:0) after 1m0s
[14:43:25.082] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:31:0)
[14:43:25.082] Timer tick, asking Buildbucket for the build status
[14:43:25.262] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:25.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:32:0) after 1m0s
[14:44:25.275] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:32:0)
[14:44:25.275] Timer tick, asking Buildbucket for the build status
[14:44:25.939] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:25.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:33:0) after 1m0s
[14:45:25.966] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:33:0)
[14:45:25.966] Timer tick, asking Buildbucket for the build status
[14:45:26.292] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:26.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:34:0) after 1m0s
[14:46:26.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:34:0)
[14:46:26.398] Timer tick, asking Buildbucket for the build status
[14:46:26.556] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:26.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:35:0) after 1m0s
[14:47:26.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:35:0)
[14:47:26.598] Timer tick, asking Buildbucket for the build status
[14:47:26.937] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:26.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:36:0) after 1m0s
[14:48:27.018] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:36:0)
[14:48:27.018] Timer tick, asking Buildbucket for the build status
[14:48:27.329] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:27.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:37:0) after 1m0s
[14:49:27.385] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:37:0)
[14:49:27.385] Timer tick, asking Buildbucket for the build status
[14:49:27.500] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:27.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:38:0) after 1m0s
[14:50:27.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:38:0)
[14:50:27.554] Timer tick, asking Buildbucket for the build status
[14:50:27.756] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:27.756] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:39:0) after 1m0s
[14:51:27.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:39:0)
[14:51:27.747] Timer tick, asking Buildbucket for the build status
[14:51:27.924] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:27.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:40:0) after 1m0s
[14:52:27.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:40:0)
[14:52:27.960] Timer tick, asking Buildbucket for the build status
[14:52:28.571] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:28.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:41:0) after 1m0s
[14:53:28.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:41:0)
[14:53:28.661] Timer tick, asking Buildbucket for the build status
[14:53:28.844] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:28.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:42:0) after 1m0s
[14:54:28.839] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:42:0)
[14:54:28.839] Timer tick, asking Buildbucket for the build status
[14:54:28.967] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:28.967] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:43:0) after 1m0s
[14:55:28.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:43:0)
[14:55:28.996] Timer tick, asking Buildbucket for the build status
[14:55:29.167] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:29.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:44:0) after 1m0s
[14:56:29.245] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:44:0)
[14:56:29.245] Timer tick, asking Buildbucket for the build status
[14:56:29.498] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:29.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:45:0) after 1m0s
[14:57:29.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:45:0)
[14:57:29.629] Timer tick, asking Buildbucket for the build status
[14:57:29.840] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:29.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:46:0) after 1m0s
[14:58:29.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:46:0)
[14:58:29.873] Timer tick, asking Buildbucket for the build status
[14:58:30.045] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:30.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:47:0) after 1m0s
[14:59:30.116] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:47:0)
[14:59:30.116] Timer tick, asking Buildbucket for the build status
[14:59:30.460] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:30.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:48:0) after 1m0s
[15:00:30.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:48:0)
[15:00:30.740] Timer tick, asking Buildbucket for the build status
[15:00:30.897] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:30.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:49:0) after 1m0s
[15:01:30.954] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:49:0)
[15:01:30.954] Timer tick, asking Buildbucket for the build status
[15:01:31.142] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:31.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:50:0) after 1m0s
[15:02:31.168] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:50:0)
[15:02:31.168] Timer tick, asking Buildbucket for the build status
[15:02:31.633] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:31.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:51:0) after 1m0s
[15:03:31.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:51:0)
[15:03:31.661] Timer tick, asking Buildbucket for the build status
[15:03:31.806] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:31.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:52:0) after 1m0s
[15:04:31.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:52:0)
[15:04:31.798] Timer tick, asking Buildbucket for the build status
[15:04:31.958] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:31.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:53:0) after 1m0s
[15:05:31.985] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:53:0)
[15:05:31.985] Timer tick, asking Buildbucket for the build status
[15:05:32.097] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:32.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:54:0) after 1m0s
[15:06:32.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:54:0)
[15:06:32.141] Timer tick, asking Buildbucket for the build status
[15:06:32.322] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:32.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:55:0) after 1m0s
[15:07:32.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:55:0)
[15:07:32.362] Timer tick, asking Buildbucket for the build status
[15:07:32.509] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:32.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:56:0) after 1m0s
[15:08:32.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:56:0)
[15:08:32.542] Timer tick, asking Buildbucket for the build status
[15:08:32.763] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:32.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:57:0) after 1m0s
[15:09:32.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:57:0)
[15:09:32.804] Timer tick, asking Buildbucket for the build status
[15:09:32.956] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:32.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:58:0) after 1m0s
[15:10:33.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:58:0)
[15:10:33.131] Timer tick, asking Buildbucket for the build status
[15:10:33.281] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:33.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:59:0) after 1m0s
[15:11:33.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:59:0)
[15:11:33.643] Timer tick, asking Buildbucket for the build status
[15:11:33.900] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:33.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:60:0) after 1m0s
[15:12:33.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:60:0)
[15:12:33.961] Timer tick, asking Buildbucket for the build status
[15:12:34.370] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:34.370] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:61:0) after 1m0s
[15:13:34.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:61:0)
[15:13:34.500] Timer tick, asking Buildbucket for the build status
[15:13:34.617] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:34.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:62:0) after 1m0s
[15:14:34.607] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:62:0)
[15:14:34.607] Timer tick, asking Buildbucket for the build status
[15:14:34.977] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:34.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:63:0) after 1m0s
[15:15:35.109] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:63:0)
[15:15:35.109] Timer tick, asking Buildbucket for the build status
[15:15:35.313] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:35.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:64:0) after 1m0s
[15:16:35.578] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:64:0)
[15:16:35.578] Timer tick, asking Buildbucket for the build status
[15:16:35.904] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:35.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:65:0) after 1m0s
[15:17:36.021] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:65:0)
[15:17:36.021] Timer tick, asking Buildbucket for the build status
[15:17:36.317] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:36.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:66:0) after 1m0s
[15:18:36.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:66:0)
[15:18:36.389] Timer tick, asking Buildbucket for the build status
[15:18:36.563] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:36.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:67:0) after 1m0s
[15:19:36.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:67:0)
[15:19:36.661] Timer tick, asking Buildbucket for the build status
[15:19:36.919] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:36.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:68:0) after 1m0s
[15:20:37.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:68:0)
[15:20:37.053] Timer tick, asking Buildbucket for the build status
[15:20:37.189] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:37.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:69:0) after 1m0s
[15:21:37.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:69:0)
[15:21:37.444] Timer tick, asking Buildbucket for the build status
[15:21:37.879] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:37.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:70:0) after 1m0s
[15:22:38.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:70:0)
[15:22:38.076] Timer tick, asking Buildbucket for the build status
[15:22:38.548] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:38.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:71:0) after 1m0s
[15:23:38.665] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:71:0)
[15:23:38.665] Timer tick, asking Buildbucket for the build status
[15:23:39.104] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:39.104] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:72:0) after 1m0s
[15:24:39.193] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:72:0)
[15:24:39.193] Timer tick, asking Buildbucket for the build status
[15:24:39.373] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:39.373] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:73:0) after 1m0s
[15:25:39.400] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:73:0)
[15:25:39.400] Timer tick, asking Buildbucket for the build status
[15:25:39.996] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:39.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:74:0) after 1m0s
[15:26:40.090] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:74:0)
[15:26:40.090] Timer tick, asking Buildbucket for the build status
[15:26:40.727] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:40.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:75:0) after 1m0s
[15:27:40.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:75:0)
[15:27:40.804] Timer tick, asking Buildbucket for the build status
[15:27:40.912] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:40.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:76:0) after 1m0s
[15:28:41.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:76:0)
[15:28:41.054] Timer tick, asking Buildbucket for the build status
[15:28:41.276] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:41.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:77:0) after 1m0s
[15:29:41.314] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:77:0)
[15:29:41.314] Timer tick, asking Buildbucket for the build status
[15:29:41.703] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:41.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:78:0) after 1m0s
[15:30:41.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:78:0)
[15:30:41.734] Timer tick, asking Buildbucket for the build status
[15:30:41.935] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:41.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:79:0) after 1m0s
[15:31:41.975] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:79:0)
[15:31:41.975] Timer tick, asking Buildbucket for the build status
[15:31:42.213] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:42.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:80:0) after 1m0s
[15:32:42.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:80:0)
[15:32:42.224] Timer tick, asking Buildbucket for the build status
[15:32:42.492] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:42.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:81:0) after 1m0s
[15:33:42.496] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:81:0)
[15:33:42.496] Timer tick, asking Buildbucket for the build status
[15:33:42.803] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:42.803] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:82:0) after 1m0s
[15:34:42.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:82:0)
[15:34:42.881] Timer tick, asking Buildbucket for the build status
[15:34:42.989] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:42.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:83:0) after 1m0s
[15:35:42.980] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:83:0)
[15:35:42.980] Timer tick, asking Buildbucket for the build status
[15:35:43.105] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:43.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:84:0) after 1m0s
[15:36:43.166] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:84:0)
[15:36:43.166] Timer tick, asking Buildbucket for the build status
[15:36:43.415] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:43.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:85:0) after 1m0s
[15:37:43.443] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:85:0)
[15:37:43.443] Timer tick, asking Buildbucket for the build status
[15:37:43.745] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:43.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:86:0) after 1m0s
[15:38:43.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:86:0)
[15:38:43.784] Timer tick, asking Buildbucket for the build status
[15:38:43.968] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:43.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:87:0) after 1m0s
[15:39:43.991] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:87:0)
[15:39:43.991] Timer tick, asking Buildbucket for the build status
[15:39:44.213] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:44.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:88:0) after 1m0s
[15:40:44.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:88:0)
[15:40:44.272] Timer tick, asking Buildbucket for the build status
[15:40:44.706] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:44.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:89:0) after 1m0s
[15:41:44.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:89:0)
[15:41:44.810] Timer tick, asking Buildbucket for the build status
[15:41:45.177] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:45.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:90:0) after 1m0s
[15:42:45.251] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:90:0)
[15:42:45.251] Timer tick, asking Buildbucket for the build status
[15:42:45.359] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:45.359] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:91:0) after 1m0s
[15:43:45.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:91:0)
[15:43:45.352] Timer tick, asking Buildbucket for the build status
[15:43:45.703] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:45.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:92:0) after 1m0s
[15:44:45.725] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:92:0)
[15:44:45.725] Timer tick, asking Buildbucket for the build status
[15:44:45.877] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:45.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:93:0) after 1m0s
[15:45:45.867] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:93:0)
[15:45:45.867] Timer tick, asking Buildbucket for the build status
[15:45:45.978] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:45.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:94:0) after 1m0s
[15:46:46.056] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:94:0)
[15:46:46.056] Timer tick, asking Buildbucket for the build status
[15:46:46.211] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:46.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:95:0) after 1m0s
[15:47:46.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:95:0)
[15:47:46.239] Timer tick, asking Buildbucket for the build status
[15:47:46.552] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:46.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:96:0) after 1m0s
[15:48:46.590] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:96:0)
[15:48:46.590] Timer tick, asking Buildbucket for the build status
[15:48:47.631] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:47.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:97:0) after 1m0s
[15:49:47.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:97:0)
[15:49:47.647] Timer tick, asking Buildbucket for the build status
[15:49:47.815] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:47.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:98:0) after 1m0s
[15:50:47.902] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:98:0)
[15:50:47.902] Timer tick, asking Buildbucket for the build status
[15:50:48.115] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:48.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:99:0) after 1m0s
[15:51:48.186] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:99:0)
[15:51:48.186] Timer tick, asking Buildbucket for the build status
[15:51:48.762] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:48.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:100:0) after 1m0s
[15:52:48.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:100:0)
[15:52:48.802] Timer tick, asking Buildbucket for the build status
[15:52:48.950] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:48.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:101:0) after 1m0s
[15:53:48.944] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:101:0)
[15:53:48.944] Timer tick, asking Buildbucket for the build status
[15:53:49.149] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:49.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:102:0) after 1m0s
[15:54:49.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:102:0)
[15:54:49.243] Timer tick, asking Buildbucket for the build status
[15:54:49.361] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:49.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:103:0) after 1m0s
[15:55:49.561] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:103:0)
[15:55:49.561] Timer tick, asking Buildbucket for the build status
[15:55:49.961] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:49.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:104:0) after 1m0s
[15:56:49.968] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:104:0)
[15:56:49.968] Timer tick, asking Buildbucket for the build status
[15:56:50.314] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:50.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:105:0) after 1m0s
[15:57:50.322] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:105:0)
[15:57:50.322] Timer tick, asking Buildbucket for the build status
[15:57:50.591] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:50.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:106:0) after 1m0s
[15:58:50.621] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:106:0)
[15:58:50.621] Timer tick, asking Buildbucket for the build status
[15:58:51.180] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:51.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:107:0) after 1m0s
[15:59:51.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:107:0)
[15:59:51.262] Timer tick, asking Buildbucket for the build status
[15:59:51.583] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:51.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:108:0) after 1m0s
[16:00:51.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:108:0)
[16:00:51.721] Timer tick, asking Buildbucket for the build status
[16:00:51.875] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:51.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:109:0) after 1m0s
[16:01:51.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:109:0)
[16:01:51.974] Timer tick, asking Buildbucket for the build status
[16:01:52.094] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:52.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:110:0) after 1m0s
[16:02:52.175] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:110:0)
[16:02:52.175] Timer tick, asking Buildbucket for the build status
[16:02:52.533] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:52.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:111:0) after 1m0s
[16:03:52.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:111:0)
[16:03:52.629] Timer tick, asking Buildbucket for the build status
[16:03:53.067] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:53.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:112:0) after 1m0s
[16:04:53.140] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:112:0)
[16:04:53.140] Timer tick, asking Buildbucket for the build status
[16:04:53.305] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:53.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:113:0) after 1m0s
[16:05:53.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:113:0)
[16:05:53.331] Timer tick, asking Buildbucket for the build status
[16:05:53.544] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:53.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:114:0) after 1m0s
[16:06:53.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:114:0)
[16:06:53.569] Timer tick, asking Buildbucket for the build status
[16:06:53.795] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:53.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:115:0) after 1m0s
[16:07:53.852] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:115:0)
[16:07:53.852] Timer tick, asking Buildbucket for the build status
[16:07:54.193] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:54.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:116:0) after 1m0s
[16:08:54.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:116:0)
[16:08:54.362] Timer tick, asking Buildbucket for the build status
[16:08:54.813] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:54.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:117:0) after 1m0s
[16:09:54.888] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:117:0)
[16:09:54.888] Timer tick, asking Buildbucket for the build status
[16:09:55.051] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:55.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:118:0) after 1m0s
[16:10:55.074] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:118:0)
[16:10:55.074] Timer tick, asking Buildbucket for the build status
[16:10:56.125] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:56.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:119:0) after 1m0s
[16:11:56.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:119:0)
[16:11:56.152] Timer tick, asking Buildbucket for the build status
[16:11:56.688] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:56.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:120:0) after 1m0s
[16:12:56.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:120:0)
[16:12:56.746] Timer tick, asking Buildbucket for the build status
[16:12:56.849] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:56.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:121:0) after 1m0s
[16:13:56.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:121:0)
[16:13:56.921] Timer tick, asking Buildbucket for the build status
[16:13:57.640] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:57.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:122:0) after 1m0s
[16:14:57.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:122:0)
[16:14:57.777] Timer tick, asking Buildbucket for the build status
[16:14:58.186] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:58.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:123:0) after 1m0s
[16:15:58.213] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:123:0)
[16:15:58.213] Timer tick, asking Buildbucket for the build status
[16:15:58.355] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:58.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:124:0) after 1m0s
[16:16:58.379] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:124:0)
[16:16:58.379] Timer tick, asking Buildbucket for the build status
[16:16:58.494] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:58.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:125:0) after 1m0s
[16:17:58.522] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:125:0)
[16:17:58.522] Timer tick, asking Buildbucket for the build status
[16:17:58.645] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:58.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:126:0) after 1m0s
[16:18:58.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:126:0)
[16:18:58.719] Timer tick, asking Buildbucket for the build status
[16:18:58.829] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:58.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:127:0) after 1m0s
[16:19:58.860] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:127:0)
[16:19:58.860] Timer tick, asking Buildbucket for the build status
[16:19:58.991] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:58.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:128:0) after 1m0s
[16:20:58.981] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:128:0)
[16:20:58.981] Timer tick, asking Buildbucket for the build status
[16:20:59.114] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:59.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:129:0) after 1m0s
[16:21:59.141] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:129:0)
[16:21:59.141] Timer tick, asking Buildbucket for the build status
[16:21:59.345] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:59.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:130:0) after 1m0s
[16:22:59.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:130:0)
[16:22:59.371] Timer tick, asking Buildbucket for the build status
[16:22:59.643] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:59.643] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:131:0) after 1m0s
[16:23:59.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:131:0)
[16:23:59.667] Timer tick, asking Buildbucket for the build status
[16:24:00.155] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:00.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:132:0) after 1m0s
[16:25:00.335] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:132:0)
[16:25:00.335] Timer tick, asking Buildbucket for the build status
[16:25:00.445] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:00.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:133:0) after 1m0s
[16:26:01.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:133:0)
[16:26:01.476] Timer tick, asking Buildbucket for the build status
[16:26:01.626] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:01.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:134:0) after 1m0s
[16:27:01.684] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:134:0)
[16:27:01.684] Timer tick, asking Buildbucket for the build status
[16:27:01.850] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:01.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:135:0) after 1m0s
[16:28:01.886] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:135:0)
[16:28:01.886] Timer tick, asking Buildbucket for the build status
[16:28:02.045] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:02.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:136:0) after 1m0s
[16:29:03.351] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:136:0)
[16:29:03.351] Timer tick, asking Buildbucket for the build status
[16:29:04.091] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:04.091] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:137:0) after 1m0s
[16:30:04.181] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:137:0)
[16:30:04.181] Timer tick, asking Buildbucket for the build status
[16:30:04.309] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:04.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:138:0) after 1m0s
[16:31:04.348] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:138:0)
[16:31:04.348] Timer tick, asking Buildbucket for the build status
[16:31:04.445] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:04.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:139:0) after 1m0s
[16:32:04.474] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:139:0)
[16:32:04.474] Timer tick, asking Buildbucket for the build status
[16:32:05.036] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:05.036] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:140:0) after 1m0s
[16:33:05.072] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:140:0)
[16:33:05.072] Timer tick, asking Buildbucket for the build status
[16:33:05.242] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:05.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:141:0) after 1m0s
[16:34:05.232] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:141:0)
[16:34:05.232] Timer tick, asking Buildbucket for the build status
[16:34:05.618] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:05.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:142:0) after 1m0s
[16:35:05.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:142:0)
[16:35:05.661] Timer tick, asking Buildbucket for the build status
[16:35:05.929] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:05.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:143:0) after 1m0s
[16:36:05.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:143:0)
[16:36:05.958] Timer tick, asking Buildbucket for the build status
[16:36:06.149] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:06.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:144:0) after 1m0s
[16:37:06.210] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:144:0)
[16:37:06.210] Timer tick, asking Buildbucket for the build status
[16:37:06.420] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:06.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:145:0) after 1m0s
[16:38:06.446] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:145:0)
[16:38:06.446] Timer tick, asking Buildbucket for the build status
[16:38:06.849] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:06.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:146:0) after 1m0s
[16:39:06.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:146:0)
[16:39:06.909] Timer tick, asking Buildbucket for the build status
[16:39:07.021] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:07.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:147:0) after 1m0s
[16:40:07.153] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:147:0)
[16:40:07.153] Timer tick, asking Buildbucket for the build status
[16:40:07.295] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:07.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:148:0) after 1m0s
[16:41:07.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:148:0)
[16:41:07.371] Timer tick, asking Buildbucket for the build status
[16:41:07.688] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:07.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:149:0) after 1m0s
[16:42:07.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:149:0)
[16:42:07.805] Timer tick, asking Buildbucket for the build status
[16:42:07.921] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:07.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:150:0) after 1m0s
[16:43:08.045] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:150:0)
[16:43:08.045] Timer tick, asking Buildbucket for the build status
[16:43:08.626] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:08.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:151:0) after 1m0s
[16:44:08.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:151:0)
[16:44:08.700] Timer tick, asking Buildbucket for the build status
[16:44:08.838] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:08.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:152:0) after 1m0s
[16:45:08.963] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:152:0)
[16:45:08.963] Timer tick, asking Buildbucket for the build status
[16:45:09.072] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:09.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:153:0) after 1m0s
[16:46:09.255] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:153:0)
[16:46:09.255] Timer tick, asking Buildbucket for the build status
[16:46:09.579] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:09.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:154:0) after 1m0s
[16:47:09.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:154:0)
[16:47:09.701] Timer tick, asking Buildbucket for the build status
[16:47:10.227] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:10.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:155:0) after 1m0s
[16:48:10.314] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:155:0)
[16:48:10.314] Timer tick, asking Buildbucket for the build status
[16:48:10.513] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:10.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:156:0) after 1m0s
[16:49:10.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:156:0)
[16:49:10.599] Timer tick, asking Buildbucket for the build status
[16:49:11.072] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:11.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:157:0) after 1m0s
[16:50:11.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:157:0)
[16:50:11.220] Timer tick, asking Buildbucket for the build status
[16:50:11.673] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:11.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:158:0) after 1m0s
[16:51:11.699] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:158:0)
[16:51:11.700] Timer tick, asking Buildbucket for the build status
[16:51:12.128] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:12.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:159:0) after 1m0s
[16:52:12.195] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:159:0)
[16:52:12.195] Timer tick, asking Buildbucket for the build status
[16:52:12.676] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:12.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:160:0) after 1m0s
[16:53:12.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:160:0)
[16:53:12.907] Timer tick, asking Buildbucket for the build status
[16:53:13.177] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:13.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:161:0) after 1m0s
[16:54:13.424] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:161:0)
[16:54:13.424] Timer tick, asking Buildbucket for the build status
[16:54:13.579] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:13.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:162:0) after 1m0s
[16:55:13.673] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:162:0)
[16:55:13.673] Timer tick, asking Buildbucket for the build status
[16:55:13.807] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:13.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:163:0) after 1m0s
[16:56:13.862] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:163:0)
[16:56:13.862] Timer tick, asking Buildbucket for the build status
[16:56:14.095] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:14.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:164:0) after 1m0s
[16:57:14.271] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:164:0)
[16:57:14.271] Timer tick, asking Buildbucket for the build status
[16:57:14.611] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:14.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:165:0) after 1m0s
[16:58:14.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:165:0)
[16:58:14.762] Timer tick, asking Buildbucket for the build status
[16:58:15.012] Build 8874972962889145936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:15.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9040403025309925296:166:0) after 1m0s
[16:59:07.526] Received PubSub notification, asking Buildbucket for the build status
[16:59:07.740] Build 8874972962889145936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:59:07.740] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1594573146283582",
"created_by": "project:chromium",
"created_ts": "1594563248700640",
"id": "8874972962889145936",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ddbc6e97e6bc5c170a446105ec4914864edd6fb0\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-7-ttns\", \"branch\": \"refs/heads/master\", \"buildername\": \"win-official\", \"buildnumber\": 83, \"got_angle_revision\": \"120e1d66c8ff383029a4fb6d61cc92538d107c03\", \"got_dawn_revision\": \"53405b54d5c68311c5f6bd0d0f68a6fff2808188\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"ddbc6e97e6bc5c170a446105ec4914864edd6fb0\", \"got_revision_cp\": \"refs/heads/master@{#787581}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"ad65826a2ab181592473fb54ab78025771f4caf6\", \"got_v8_revision\": \"7e4760302f6f047a6b5100051ce05282cca1f1dc\", \"got_v8_revision_cp\": \"refs/heads/8.6.115@{#1}\", \"got_webrtc_revision\": \"8df59bc74ebb4d0b8e5d80a8b4f5c674db2a9c4d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31703}\", \"mastername\": \"chromium\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ddbc6e97e6bc5c170a446105ec4914864edd6fb0\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_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-7-ttns\"], \"image\": [\"chrome-win10-1703-20070700-8a9e7990cc1\"], \"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\": [\"5378-e275056\"], \"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": "1594563254216499",
"status": "COMPLETED",
"status_changed_ts": "1594573146927090",
"tags": [
"build_address:luci.chromium.ci/win-official/83",
"builder:win-official",
"buildset:commit/git/ddbc6e97e6bc5c170a446105ec4914864edd6fb0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ddbc6e97e6bc5c170a446105ec4914864edd6fb0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040403025309925296",
"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/8874972962889145936/+/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:4d5c31d74a4bbb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1594573146943726",
"url": "https://ci.chromium.org/b/8874972962889145936",
"utcnow_ts": "1594573147727808"
}
}
[16:59:07.740] Invocation finished in 2h45m0.732115759s with status SUCCEEDED