[22:55:29.938] New invocation is queued and will start shortly
[22:55:31.049] Starting the invocation (attempt 1)
[22:55:31.085] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:55:31.085] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:55:31.086] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023609784013770112",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7f5da3bb82704efaeae97b9e5b6bfcde7ebed619\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9023609784013770112",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/7f5da3bb82704efaeae97b9e5b6bfcde7ebed619",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f5da3bb82704efaeae97b9e5b6bfcde7ebed619",
"gitiles_ref:refs/heads/master"
]
}
[22:55:31.818] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610578531249220",
"id": "8858179721975748176",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f5da3bb82704efaeae97b9e5b6bfcde7ebed619\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610578531696430",
"tags": [
"build_address:luci.chromium.ci/win-official/1379",
"builder:win-official",
"buildset:commit/git/7f5da3bb82704efaeae97b9e5b6bfcde7ebed619",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f5da3bb82704efaeae97b9e5b6bfcde7ebed619",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023609784013770112",
"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/8858179721975748176/+/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": "1610578531696539",
"url": "https://ci.chromium.org/b/8858179721975748176",
"utcnow_ts": "1610578531808135"
}
}
[22:55:31.818] Task URL: https://ci.chromium.org/b/8858179721975748176
[22:55:31.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:2:0) after 1m0s
[22:56:10.800] Received PubSub notification, asking Buildbucket for the build status
[22:56:11.228] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:31.813] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:2:0)
[22:56:31.813] Timer tick, asking Buildbucket for the build status
[22:56:31.897] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:31.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:4:0) after 1m0s
[22:57:31.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:4:0)
[22:57:31.974] Timer tick, asking Buildbucket for the build status
[22:57:32.161] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:32.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:5:0) after 1m0s
[22:58:32.250] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:5:0)
[22:58:32.250] Timer tick, asking Buildbucket for the build status
[22:58:32.377] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:32.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:6:0) after 1m0s
[22:59:32.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:6:0)
[22:59:32.441] Timer tick, asking Buildbucket for the build status
[22:59:32.545] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:32.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:7:0) after 1m0s
[23:00:32.552] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:7:0)
[23:00:32.553] Timer tick, asking Buildbucket for the build status
[23:00:32.735] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:32.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:8:0) after 1m0s
[23:01:32.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:8:0)
[23:01:32.805] Timer tick, asking Buildbucket for the build status
[23:01:32.898] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:32.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:9:0) after 1m0s
[23:02:32.945] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:9:0)
[23:02:32.945] Timer tick, asking Buildbucket for the build status
[23:02:33.022] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:33.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:10:0) after 1m0s
[23:03:33.025] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:10:0)
[23:03:33.025] Timer tick, asking Buildbucket for the build status
[23:03:33.158] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:33.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:11:0) after 1m0s
[23:04:33.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:11:0)
[23:04:33.196] Timer tick, asking Buildbucket for the build status
[23:04:33.593] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:33.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:12:0) after 1m0s
[23:05:33.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:12:0)
[23:05:33.701] Timer tick, asking Buildbucket for the build status
[23:05:33.811] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:33.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:13:0) after 1m0s
[23:06:33.804] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:13:0)
[23:06:33.804] Timer tick, asking Buildbucket for the build status
[23:06:34.015] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:34.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:14:0) after 1m0s
[23:07:34.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:14:0)
[23:07:34.079] Timer tick, asking Buildbucket for the build status
[23:07:34.242] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:34.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:15:0) after 1m0s
[23:08:34.282] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:15:0)
[23:08:34.282] Timer tick, asking Buildbucket for the build status
[23:08:34.427] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:34.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:16:0) after 1m0s
[23:09:34.564] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:16:0)
[23:09:34.564] Timer tick, asking Buildbucket for the build status
[23:09:34.905] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:34.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:17:0) after 1m0s
[23:10:35.047] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:17:0)
[23:10:35.047] Timer tick, asking Buildbucket for the build status
[23:10:35.168] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:35.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:18:0) after 1m0s
[23:11:35.232] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:18:0)
[23:11:35.232] Timer tick, asking Buildbucket for the build status
[23:11:35.337] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:35.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:19:0) after 1m0s
[23:12:35.509] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:19:0)
[23:12:35.509] Timer tick, asking Buildbucket for the build status
[23:12:35.569] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:35.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:20:0) after 1m0s
[23:13:35.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:20:0)
[23:13:35.575] Timer tick, asking Buildbucket for the build status
[23:13:35.663] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:35.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:21:0) after 1m0s
[23:14:35.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:21:0)
[23:14:35.734] Timer tick, asking Buildbucket for the build status
[23:14:35.884] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:35.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:22:0) after 1m0s
[23:15:35.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:22:0)
[23:15:35.997] Timer tick, asking Buildbucket for the build status
[23:15:36.128] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:36.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:23:0) after 1m0s
[23:16:36.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:23:0)
[23:16:36.203] Timer tick, asking Buildbucket for the build status
[23:16:36.291] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:36.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:24:0) after 1m0s
[23:17:36.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:24:0)
[23:17:36.343] Timer tick, asking Buildbucket for the build status
[23:17:36.704] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:36.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:25:0) after 1m0s
[23:18:37.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:25:0)
[23:18:37.172] Timer tick, asking Buildbucket for the build status
[23:18:37.290] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:37.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:26:0) after 1m0s
[23:19:37.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:26:0)
[23:19:37.672] Timer tick, asking Buildbucket for the build status
[23:19:37.754] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:37.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:27:0) after 1m0s
[23:20:37.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:27:0)
[23:20:37.791] Timer tick, asking Buildbucket for the build status
[23:20:37.887] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:37.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:28:0) after 1m0s
[23:21:37.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:28:0)
[23:21:37.973] Timer tick, asking Buildbucket for the build status
[23:21:38.038] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:38.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:29:0) after 1m0s
[23:22:38.179] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:29:0)
[23:22:38.179] Timer tick, asking Buildbucket for the build status
[23:22:38.248] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:38.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:30:0) after 1m0s
[23:23:38.427] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:30:0)
[23:23:38.427] Timer tick, asking Buildbucket for the build status
[23:23:38.488] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:38.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:31:0) after 1m0s
[23:24:38.545] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:31:0)
[23:24:38.545] Timer tick, asking Buildbucket for the build status
[23:24:38.599] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:38.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:32:0) after 1m0s
[23:25:38.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:32:0)
[23:25:38.700] Timer tick, asking Buildbucket for the build status
[23:25:38.806] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:38.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:33:0) after 1m0s
[23:26:39.089] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:33:0)
[23:26:39.089] Timer tick, asking Buildbucket for the build status
[23:26:39.149] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:39.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:34:0) after 1m0s
[23:27:39.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:34:0)
[23:27:39.278] Timer tick, asking Buildbucket for the build status
[23:27:39.363] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:39.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:35:0) after 1m0s
[23:28:39.505] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:35:0)
[23:28:39.505] Timer tick, asking Buildbucket for the build status
[23:28:39.693] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:39.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:36:0) after 1m0s
[23:29:39.812] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:36:0)
[23:29:39.812] Timer tick, asking Buildbucket for the build status
[23:29:39.872] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:39.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:37:0) after 1m0s
[23:30:39.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:37:0)
[23:30:39.856] Timer tick, asking Buildbucket for the build status
[23:30:39.966] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:39.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:38:0) after 1m0s
[23:31:40.014] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:38:0)
[23:31:40.014] Timer tick, asking Buildbucket for the build status
[23:31:40.113] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:40.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:39:0) after 1m0s
[23:32:40.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:39:0)
[23:32:40.218] Timer tick, asking Buildbucket for the build status
[23:32:40.458] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:40.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:40:0) after 1m0s
[23:33:40.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:40:0)
[23:33:40.593] Timer tick, asking Buildbucket for the build status
[23:33:40.685] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:40.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:41:0) after 1m0s
[23:34:40.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:41:0)
[23:34:40.821] Timer tick, asking Buildbucket for the build status
[23:34:40.881] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:40.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:42:0) after 1m0s
[23:35:41.031] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:42:0)
[23:35:41.031] Timer tick, asking Buildbucket for the build status
[23:35:41.139] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:41.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:43:0) after 1m0s
[23:36:41.197] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:43:0)
[23:36:41.197] Timer tick, asking Buildbucket for the build status
[23:36:41.258] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:41.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:44:0) after 1m0s
[23:37:41.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:44:0)
[23:37:41.287] Timer tick, asking Buildbucket for the build status
[23:37:41.355] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:41.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:45:0) after 1m0s
[23:38:41.480] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:45:0)
[23:38:41.480] Timer tick, asking Buildbucket for the build status
[23:38:41.551] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:41.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:46:0) after 1m0s
[23:39:41.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:46:0)
[23:39:41.857] Timer tick, asking Buildbucket for the build status
[23:39:41.986] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:41.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:47:0) after 1m0s
[23:40:42.518] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:47:0)
[23:40:42.518] Timer tick, asking Buildbucket for the build status
[23:40:42.617] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:42.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:48:0) after 1m0s
[23:41:42.769] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:48:0)
[23:41:42.769] Timer tick, asking Buildbucket for the build status
[23:41:42.871] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:42.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:49:0) after 1m0s
[23:42:43.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:49:0)
[23:42:43.156] Timer tick, asking Buildbucket for the build status
[23:42:43.256] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:43.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:50:0) after 1m0s
[23:43:43.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:50:0)
[23:43:43.331] Timer tick, asking Buildbucket for the build status
[23:43:43.383] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:43.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:51:0) after 1m0s
[23:44:43.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:51:0)
[23:44:43.550] Timer tick, asking Buildbucket for the build status
[23:44:43.633] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:43.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:52:0) after 1m0s
[23:45:43.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:52:0)
[23:45:43.763] Timer tick, asking Buildbucket for the build status
[23:45:43.898] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:43.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:53:0) after 1m0s
[23:46:43.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:53:0)
[23:46:43.959] Timer tick, asking Buildbucket for the build status
[23:46:44.056] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:44.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:54:0) after 1m0s
[23:47:44.302] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:54:0)
[23:47:44.302] Timer tick, asking Buildbucket for the build status
[23:47:44.362] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:44.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:55:0) after 1m0s
[23:48:44.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:55:0)
[23:48:44.408] Timer tick, asking Buildbucket for the build status
[23:48:44.483] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:44.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:56:0) after 1m0s
[23:49:44.628] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:56:0)
[23:49:44.628] Timer tick, asking Buildbucket for the build status
[23:49:44.673] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:44.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:57:0) after 1m0s
[23:50:44.792] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:57:0)
[23:50:44.792] Timer tick, asking Buildbucket for the build status
[23:50:44.895] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:44.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:58:0) after 1m0s
[23:51:45.750] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:58:0)
[23:51:45.750] Timer tick, asking Buildbucket for the build status
[23:51:45.830] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:45.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:59:0) after 1m0s
[23:52:46.131] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:59:0)
[23:52:46.131] Timer tick, asking Buildbucket for the build status
[23:52:46.199] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:46.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:60:0) after 1m0s
[23:53:46.291] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:60:0)
[23:53:46.291] Timer tick, asking Buildbucket for the build status
[23:53:46.366] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:46.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:61:0) after 1m0s
[23:54:46.368] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:61:0)
[23:54:46.368] Timer tick, asking Buildbucket for the build status
[23:54:46.453] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:46.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:62:0) after 1m0s
[23:55:46.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:62:0)
[23:55:46.633] Timer tick, asking Buildbucket for the build status
[23:55:46.764] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:46.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:63:0) after 1m0s
[23:56:46.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:63:0)
[23:56:46.908] Timer tick, asking Buildbucket for the build status
[23:56:46.972] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:46.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:64:0) after 1m0s
[23:57:47.063] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:64:0)
[23:57:47.063] Timer tick, asking Buildbucket for the build status
[23:57:47.143] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:47.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:65:0) after 1m0s
[23:58:47.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:65:0)
[23:58:47.162] Timer tick, asking Buildbucket for the build status
[23:58:47.740] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:47.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:66:0) after 1m0s
[23:59:47.732] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:66:0)
[23:59:47.732] Timer tick, asking Buildbucket for the build status
[23:59:47.782] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:47.782] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:67:0) after 1m0s
[00:00:47.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:67:0)
[00:00:47.908] Timer tick, asking Buildbucket for the build status
[00:00:48.038] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:48.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:68:0) after 1m0s
[00:01:48.071] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:68:0)
[00:01:48.071] Timer tick, asking Buildbucket for the build status
[00:01:48.152] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:48.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:69:0) after 1m0s
[00:02:48.205] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:69:0)
[00:02:48.206] Timer tick, asking Buildbucket for the build status
[00:02:48.275] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:48.275] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:70:0) after 1m0s
[00:03:48.341] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:70:0)
[00:03:48.342] Timer tick, asking Buildbucket for the build status
[00:03:48.711] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:48.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:71:0) after 1m0s
[00:04:48.726] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:71:0)
[00:04:48.726] Timer tick, asking Buildbucket for the build status
[00:04:48.793] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:48.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:72:0) after 1m0s
[00:05:48.808] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:72:0)
[00:05:48.808] Timer tick, asking Buildbucket for the build status
[00:05:48.931] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:48.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:73:0) after 1m0s
[00:06:48.956] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:73:0)
[00:06:48.956] Timer tick, asking Buildbucket for the build status
[00:06:49.026] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:49.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:74:0) after 1m0s
[00:07:49.076] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:74:0)
[00:07:49.076] Timer tick, asking Buildbucket for the build status
[00:07:49.243] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:49.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:75:0) after 1m0s
[00:08:49.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:75:0)
[00:08:49.266] Timer tick, asking Buildbucket for the build status
[00:08:49.337] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:49.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:76:0) after 1m0s
[00:09:49.456] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:76:0)
[00:09:49.457] Timer tick, asking Buildbucket for the build status
[00:09:49.566] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:49.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:77:0) after 1m0s
[00:10:49.696] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:77:0)
[00:10:49.696] Timer tick, asking Buildbucket for the build status
[00:10:50.145] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:50.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:78:0) after 1m0s
[00:11:50.172] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:78:0)
[00:11:50.172] Timer tick, asking Buildbucket for the build status
[00:11:50.346] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:50.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:79:0) after 1m0s
[00:12:50.422] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:79:0)
[00:12:50.422] Timer tick, asking Buildbucket for the build status
[00:12:50.583] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:50.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:80:0) after 1m0s
[00:13:50.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:80:0)
[00:13:50.593] Timer tick, asking Buildbucket for the build status
[00:13:50.660] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:50.660] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:81:0) after 1m0s
[00:14:50.707] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:81:0)
[00:14:50.707] Timer tick, asking Buildbucket for the build status
[00:14:50.922] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:50.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:82:0) after 1m0s
[00:15:51.025] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:82:0)
[00:15:51.025] Timer tick, asking Buildbucket for the build status
[00:15:51.296] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:51.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:83:0) after 1m0s
[00:16:51.371] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:83:0)
[00:16:51.371] Timer tick, asking Buildbucket for the build status
[00:16:51.430] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:51.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:84:0) after 1m0s
[00:17:51.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:84:0)
[00:17:51.452] Timer tick, asking Buildbucket for the build status
[00:17:51.532] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:51.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:85:0) after 1m0s
[00:18:51.558] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:85:0)
[00:18:51.558] Timer tick, asking Buildbucket for the build status
[00:18:51.622] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:51.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:86:0) after 1m0s
[00:19:51.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:86:0)
[00:19:51.611] Timer tick, asking Buildbucket for the build status
[00:19:51.900] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:51.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:87:0) after 1m0s
[00:20:52.004] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:87:0)
[00:20:52.004] Timer tick, asking Buildbucket for the build status
[00:20:52.228] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:52.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:88:0) after 1m0s
[00:21:52.369] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:88:0)
[00:21:52.369] Timer tick, asking Buildbucket for the build status
[00:21:52.486] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:52.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:89:0) after 1m0s
[00:22:52.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:89:0)
[00:22:52.481] Timer tick, asking Buildbucket for the build status
[00:22:52.567] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:52.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:90:0) after 1m0s
[00:23:52.623] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:90:0)
[00:23:52.623] Timer tick, asking Buildbucket for the build status
[00:23:52.680] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:52.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:91:0) after 1m0s
[00:24:52.756] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:91:0)
[00:24:52.756] Timer tick, asking Buildbucket for the build status
[00:24:52.862] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:52.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:92:0) after 1m0s
[00:25:52.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:92:0)
[00:25:52.907] Timer tick, asking Buildbucket for the build status
[00:25:53.022] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:53.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:93:0) after 1m0s
[00:26:53.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:93:0)
[00:26:53.084] Timer tick, asking Buildbucket for the build status
[00:26:53.160] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:53.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:94:0) after 1m0s
[00:27:53.299] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:94:0)
[00:27:53.299] Timer tick, asking Buildbucket for the build status
[00:27:53.422] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:53.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:95:0) after 1m0s
[00:28:53.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:95:0)
[00:28:53.504] Timer tick, asking Buildbucket for the build status
[00:28:53.701] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:53.701] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:96:0) after 1m0s
[00:29:53.754] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:96:0)
[00:29:53.754] Timer tick, asking Buildbucket for the build status
[00:29:53.820] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:53.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:97:0) after 1m0s
[00:30:53.928] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:97:0)
[00:30:53.928] Timer tick, asking Buildbucket for the build status
[00:30:54.064] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:54.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:98:0) after 1m0s
[00:31:54.154] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:98:0)
[00:31:54.154] Timer tick, asking Buildbucket for the build status
[00:31:54.259] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:54.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:99:0) after 1m0s
[00:32:54.373] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:99:0)
[00:32:54.373] Timer tick, asking Buildbucket for the build status
[00:32:54.450] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:54.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:100:0) after 1m0s
[00:33:54.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:100:0)
[00:33:54.654] Timer tick, asking Buildbucket for the build status
[00:33:54.983] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:54.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:101:0) after 1m0s
[00:34:55.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:101:0)
[00:34:55.095] Timer tick, asking Buildbucket for the build status
[00:34:55.166] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:55.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:102:0) after 1m0s
[00:35:55.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:102:0)
[00:35:55.279] Timer tick, asking Buildbucket for the build status
[00:35:55.491] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:55.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:103:0) after 1m0s
[00:36:55.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:103:0)
[00:36:55.728] Timer tick, asking Buildbucket for the build status
[00:36:55.816] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:55.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:104:0) after 1m0s
[00:37:55.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:104:0)
[00:37:55.912] Timer tick, asking Buildbucket for the build status
[00:37:56.116] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:56.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:105:0) after 1m0s
[00:38:56.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:105:0)
[00:38:56.203] Timer tick, asking Buildbucket for the build status
[00:38:56.442] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:56.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:106:0) after 1m0s
[00:39:56.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:106:0)
[00:39:56.501] Timer tick, asking Buildbucket for the build status
[00:39:56.616] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:56.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:107:0) after 1m0s
[00:40:56.759] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:107:0)
[00:40:56.759] Timer tick, asking Buildbucket for the build status
[00:40:56.964] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:56.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:108:0) after 1m0s
[00:41:57.041] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:108:0)
[00:41:57.041] Timer tick, asking Buildbucket for the build status
[00:41:57.435] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:57.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:109:0) after 1m0s
[00:42:57.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:109:0)
[00:42:57.463] Timer tick, asking Buildbucket for the build status
[00:42:57.537] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:57.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:110:0) after 1m0s
[00:43:57.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:110:0)
[00:43:57.668] Timer tick, asking Buildbucket for the build status
[00:43:57.738] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:57.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:111:0) after 1m0s
[00:44:57.754] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:111:0)
[00:44:57.754] Timer tick, asking Buildbucket for the build status
[00:44:57.822] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:57.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:112:0) after 1m0s
[00:45:57.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:112:0)
[00:45:57.802] Timer tick, asking Buildbucket for the build status
[00:45:57.943] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:57.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:113:0) after 1m0s
[00:46:57.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:113:0)
[00:46:57.973] Timer tick, asking Buildbucket for the build status
[00:46:58.050] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:58.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:114:0) after 1m0s
[00:47:58.147] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:114:0)
[00:47:58.147] Timer tick, asking Buildbucket for the build status
[00:47:58.270] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:58.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:115:0) after 1m0s
[00:48:58.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:115:0)
[00:48:58.272] Timer tick, asking Buildbucket for the build status
[00:48:58.363] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:58.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:116:0) after 1m0s
[00:49:58.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:116:0)
[00:49:58.463] Timer tick, asking Buildbucket for the build status
[00:49:58.533] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:58.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:117:0) after 1m0s
[00:50:58.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:117:0)
[00:50:58.601] Timer tick, asking Buildbucket for the build status
[00:50:58.797] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:58.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:118:0) after 1m0s
[00:51:58.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:118:0)
[00:51:58.866] Timer tick, asking Buildbucket for the build status
[00:51:58.957] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:58.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:119:0) after 1m0s
[00:52:59.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:119:0)
[00:52:59.011] Timer tick, asking Buildbucket for the build status
[00:52:59.071] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:59.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:120:0) after 1m0s
[00:53:59.110] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:120:0)
[00:53:59.110] Timer tick, asking Buildbucket for the build status
[00:53:59.300] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:59.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:121:0) after 1m0s
[00:54:59.329] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:121:0)
[00:54:59.329] Timer tick, asking Buildbucket for the build status
[00:54:59.378] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:59.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:122:0) after 1m0s
[00:55:59.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:122:0)
[00:55:59.354] Timer tick, asking Buildbucket for the build status
[00:55:59.473] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:59.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:123:0) after 1m0s
[00:56:59.511] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:123:0)
[00:56:59.511] Timer tick, asking Buildbucket for the build status
[00:56:59.686] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:59.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:124:0) after 1m0s
[00:57:59.786] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:124:0)
[00:57:59.786] Timer tick, asking Buildbucket for the build status
[00:57:59.934] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:59.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:125:0) after 1m0s
[00:59:00.057] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:125:0)
[00:59:00.057] Timer tick, asking Buildbucket for the build status
[00:59:00.263] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:00.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:126:0) after 1m0s
[01:00:00.290] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:126:0)
[01:00:00.290] Timer tick, asking Buildbucket for the build status
[01:00:00.373] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:00.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:127:0) after 1m0s
[01:01:00.435] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:127:0)
[01:01:00.435] Timer tick, asking Buildbucket for the build status
[01:01:00.580] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:00.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:128:0) after 1m0s
[01:02:00.637] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:128:0)
[01:02:00.637] Timer tick, asking Buildbucket for the build status
[01:02:00.698] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:00.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:129:0) after 1m0s
[01:03:00.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:129:0)
[01:03:00.752] Timer tick, asking Buildbucket for the build status
[01:03:00.837] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:00.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:130:0) after 1m0s
[01:04:01.180] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:130:0)
[01:04:01.180] Timer tick, asking Buildbucket for the build status
[01:04:01.272] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:01.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:131:0) after 1m0s
[01:05:01.531] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:131:0)
[01:05:01.531] Timer tick, asking Buildbucket for the build status
[01:05:01.595] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:01.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:132:0) after 1m0s
[01:06:01.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:132:0)
[01:06:01.621] Timer tick, asking Buildbucket for the build status
[01:06:01.786] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:01.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:133:0) after 1m0s
[01:07:02.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:133:0)
[01:07:02.157] Timer tick, asking Buildbucket for the build status
[01:07:02.422] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:02.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:134:0) after 1m0s
[01:08:02.463] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:134:0)
[01:08:02.463] Timer tick, asking Buildbucket for the build status
[01:08:02.546] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:02.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:135:0) after 1m0s
[01:09:02.720] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:135:0)
[01:09:02.720] Timer tick, asking Buildbucket for the build status
[01:09:02.816] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:02.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:136:0) after 1m0s
[01:10:02.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:136:0)
[01:10:02.908] Timer tick, asking Buildbucket for the build status
[01:10:02.965] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:02.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:137:0) after 1m0s
[01:11:02.980] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:137:0)
[01:11:02.980] Timer tick, asking Buildbucket for the build status
[01:11:03.155] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:03.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:138:0) after 1m0s
[01:12:03.182] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:138:0)
[01:12:03.182] Timer tick, asking Buildbucket for the build status
[01:12:03.366] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:03.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:139:0) after 1m0s
[01:13:03.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:139:0)
[01:13:03.598] Timer tick, asking Buildbucket for the build status
[01:13:03.657] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:03.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:140:0) after 1m0s
[01:14:03.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:140:0)
[01:14:03.810] Timer tick, asking Buildbucket for the build status
[01:14:04.025] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:04.025] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:141:0) after 1m0s
[01:15:04.206] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:141:0)
[01:15:04.206] Timer tick, asking Buildbucket for the build status
[01:15:04.274] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:04.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:142:0) after 1m0s
[01:16:04.405] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:142:0)
[01:16:04.405] Timer tick, asking Buildbucket for the build status
[01:16:04.829] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:04.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:143:0) after 1m0s
[01:17:04.855] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:143:0)
[01:17:04.855] Timer tick, asking Buildbucket for the build status
[01:17:04.929] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:04.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:144:0) after 1m0s
[01:18:05.086] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:144:0)
[01:18:05.086] Timer tick, asking Buildbucket for the build status
[01:18:05.259] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:05.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:145:0) after 1m0s
[01:19:05.362] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:145:0)
[01:19:05.362] Timer tick, asking Buildbucket for the build status
[01:19:05.985] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:05.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:146:0) after 1m0s
[01:20:06.155] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:146:0)
[01:20:06.155] Timer tick, asking Buildbucket for the build status
[01:20:06.244] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:06.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:147:0) after 1m0s
[01:21:06.337] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:147:0)
[01:21:06.337] Timer tick, asking Buildbucket for the build status
[01:21:08.491] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:08.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:148:0) after 1m0s
[01:22:08.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:148:0)
[01:22:08.836] Timer tick, asking Buildbucket for the build status
[01:22:08.895] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:08.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:149:0) after 1m0s
[01:23:09.057] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:149:0)
[01:23:09.057] Timer tick, asking Buildbucket for the build status
[01:23:09.132] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:09.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:150:0) after 1m0s
[01:24:09.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:150:0)
[01:24:09.241] Timer tick, asking Buildbucket for the build status
[01:24:09.325] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:09.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:151:0) after 1m0s
[01:25:09.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:151:0)
[01:25:09.481] Timer tick, asking Buildbucket for the build status
[01:25:09.559] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:09.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:152:0) after 1m0s
[01:26:09.598] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:152:0)
[01:26:09.598] Timer tick, asking Buildbucket for the build status
[01:26:09.698] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:09.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:153:0) after 1m0s
[01:27:09.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:153:0)
[01:27:09.853] Timer tick, asking Buildbucket for the build status
[01:27:10.162] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:10.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:154:0) after 1m0s
[01:28:10.365] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:154:0)
[01:28:10.365] Timer tick, asking Buildbucket for the build status
[01:28:10.504] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:10.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:155:0) after 1m0s
[01:29:10.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:155:0)
[01:29:10.500] Timer tick, asking Buildbucket for the build status
[01:29:10.562] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:10.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:156:0) after 1m0s
[01:30:10.660] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:156:0)
[01:30:10.660] Timer tick, asking Buildbucket for the build status
[01:30:10.781] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:10.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:157:0) after 1m0s
[01:31:11.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:157:0)
[01:31:11.038] Timer tick, asking Buildbucket for the build status
[01:31:11.318] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:11.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:158:0) after 1m0s
[01:32:11.408] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:158:0)
[01:32:11.408] Timer tick, asking Buildbucket for the build status
[01:32:11.550] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:11.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:159:0) after 1m0s
[01:33:11.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:159:0)
[01:33:11.636] Timer tick, asking Buildbucket for the build status
[01:33:11.729] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:11.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:160:0) after 1m0s
[01:34:11.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:160:0)
[01:34:11.781] Timer tick, asking Buildbucket for the build status
[01:34:11.878] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:11.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:161:0) after 1m0s
[01:35:12.179] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:161:0)
[01:35:12.179] Timer tick, asking Buildbucket for the build status
[01:35:12.283] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:12.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:162:0) after 1m0s
[01:36:12.671] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:162:0)
[01:36:12.671] Timer tick, asking Buildbucket for the build status
[01:36:12.777] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:12.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:163:0) after 1m0s
[01:37:13.081] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:163:0)
[01:37:13.081] Timer tick, asking Buildbucket for the build status
[01:37:13.386] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:13.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:164:0) after 1m0s
[01:38:13.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:164:0)
[01:38:13.733] Timer tick, asking Buildbucket for the build status
[01:38:13.844] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:13.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:165:0) after 1m0s
[01:39:14.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:165:0)
[01:39:14.060] Timer tick, asking Buildbucket for the build status
[01:39:14.304] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:14.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:166:0) after 1m0s
[01:40:14.344] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:166:0)
[01:40:14.344] Timer tick, asking Buildbucket for the build status
[01:40:14.645] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:14.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:167:0) after 1m0s
[01:41:14.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:167:0)
[01:41:14.800] Timer tick, asking Buildbucket for the build status
[01:41:14.900] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:14.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:168:0) after 1m0s
[01:42:14.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:168:0)
[01:42:14.998] Timer tick, asking Buildbucket for the build status
[01:42:15.074] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:15.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:169:0) after 1m0s
[01:43:15.087] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:169:0)
[01:43:15.087] Timer tick, asking Buildbucket for the build status
[01:43:15.142] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:15.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:170:0) after 1m0s
[01:44:15.178] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:170:0)
[01:44:15.178] Timer tick, asking Buildbucket for the build status
[01:44:15.255] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:15.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:171:0) after 1m0s
[01:45:15.324] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:171:0)
[01:45:15.324] Timer tick, asking Buildbucket for the build status
[01:45:15.378] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:15.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:172:0) after 1m0s
[01:46:15.428] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:172:0)
[01:46:15.428] Timer tick, asking Buildbucket for the build status
[01:46:15.608] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:15.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:173:0) after 1m0s
[01:47:15.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:173:0)
[01:47:15.686] Timer tick, asking Buildbucket for the build status
[01:47:15.995] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:15.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:174:0) after 1m0s
[01:48:16.121] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:174:0)
[01:48:16.121] Timer tick, asking Buildbucket for the build status
[01:48:16.455] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:16.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:175:0) after 1m0s
[01:49:16.537] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:175:0)
[01:49:16.537] Timer tick, asking Buildbucket for the build status
[01:49:16.727] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:16.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:176:0) after 1m0s
[01:50:16.752] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:176:0)
[01:50:16.752] Timer tick, asking Buildbucket for the build status
[01:50:16.823] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:16.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:177:0) after 1m0s
[01:51:16.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:177:0)
[01:51:16.878] Timer tick, asking Buildbucket for the build status
[01:51:16.995] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:16.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:178:0) after 1m0s
[01:52:17.094] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:178:0)
[01:52:17.094] Timer tick, asking Buildbucket for the build status
[01:52:17.161] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:17.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:179:0) after 1m0s
[01:53:17.224] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:179:0)
[01:53:17.224] Timer tick, asking Buildbucket for the build status
[01:53:17.392] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:17.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:180:0) after 1m0s
[01:54:17.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:180:0)
[01:54:17.475] Timer tick, asking Buildbucket for the build status
[01:54:17.540] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:17.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:181:0) after 1m0s
[01:55:17.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:181:0)
[01:55:17.593] Timer tick, asking Buildbucket for the build status
[01:55:17.690] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:17.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:182:0) after 1m0s
[01:56:17.725] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:182:0)
[01:56:17.725] Timer tick, asking Buildbucket for the build status
[01:56:17.839] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:17.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:183:0) after 1m0s
[01:57:17.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:183:0)
[01:57:17.900] Timer tick, asking Buildbucket for the build status
[01:57:18.129] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:18.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:184:0) after 1m0s
[01:58:18.164] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:184:0)
[01:58:18.164] Timer tick, asking Buildbucket for the build status
[01:58:18.710] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:18.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:185:0) after 1m0s
[01:59:18.764] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:185:0)
[01:59:18.764] Timer tick, asking Buildbucket for the build status
[01:59:18.824] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:18.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:186:0) after 1m0s
[02:00:18.925] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:186:0)
[02:00:18.925] Timer tick, asking Buildbucket for the build status
[02:00:18.993] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:18.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:187:0) after 1m0s
[02:01:19.020] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:187:0)
[02:01:19.020] Timer tick, asking Buildbucket for the build status
[02:01:19.140] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:19.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:188:0) after 1m0s
[02:02:19.221] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:188:0)
[02:02:19.221] Timer tick, asking Buildbucket for the build status
[02:02:19.691] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:19.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:189:0) after 1m0s
[02:03:19.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:189:0)
[02:03:19.723] Timer tick, asking Buildbucket for the build status
[02:03:19.919] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:19.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:190:0) after 1m0s
[02:04:19.930] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:190:0)
[02:04:19.930] Timer tick, asking Buildbucket for the build status
[02:04:20.048] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:20.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:191:0) after 1m0s
[02:05:20.066] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:191:0)
[02:05:20.066] Timer tick, asking Buildbucket for the build status
[02:05:20.132] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:20.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:192:0) after 1m0s
[02:06:20.201] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:192:0)
[02:06:20.201] Timer tick, asking Buildbucket for the build status
[02:06:20.304] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:20.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:193:0) after 1m0s
[02:07:20.401] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:193:0)
[02:07:20.401] Timer tick, asking Buildbucket for the build status
[02:07:20.473] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:20.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:194:0) after 1m0s
[02:08:20.473] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:194:0)
[02:08:20.473] Timer tick, asking Buildbucket for the build status
[02:08:20.622] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:20.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:195:0) after 1m0s
[02:09:20.810] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:195:0)
[02:09:20.810] Timer tick, asking Buildbucket for the build status
[02:09:20.984] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:20.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:196:0) after 1m0s
[02:10:20.993] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:196:0)
[02:10:20.993] Timer tick, asking Buildbucket for the build status
[02:10:21.113] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:21.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:197:0) after 1m0s
[02:11:21.156] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:197:0)
[02:11:21.156] Timer tick, asking Buildbucket for the build status
[02:11:21.722] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:21.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:198:0) after 1m0s
[02:12:21.830] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:198:0)
[02:12:21.830] Timer tick, asking Buildbucket for the build status
[02:12:21.942] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:21.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:199:0) after 1m0s
[02:13:21.963] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:199:0)
[02:13:21.963] Timer tick, asking Buildbucket for the build status
[02:13:22.014] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:22.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:200:0) after 1m0s
[02:14:22.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:200:0)
[02:14:22.048] Timer tick, asking Buildbucket for the build status
[02:14:22.126] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:22.126] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:201:0) after 1m0s
[02:15:22.187] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:201:0)
[02:15:22.187] Timer tick, asking Buildbucket for the build status
[02:15:22.259] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:22.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:202:0) after 1m0s
[02:16:22.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:202:0)
[02:16:22.252] Timer tick, asking Buildbucket for the build status
[02:16:22.394] Build 8858179721975748176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:22.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9023609784013770112:203:0) after 1m0s
[02:17:21.376] Received PubSub notification, asking Buildbucket for the build status
[02:17:21.440] Build 8858179721975748176: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:17:21.440] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610590640521092",
"created_by": "project:chromium",
"created_ts": "1610578531249220",
"id": "8858179721975748176",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f5da3bb82704efaeae97b9e5b6bfcde7ebed619\"}}",
"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\": \"7f5da3bb82704efaeae97b9e5b6bfcde7ebed619\", \"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-yywi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 1379, \"got_angle_revision\": \"47e9aed2af83c0c3f684a804156c3b876a58a1bf\", \"got_dawn_revision\": \"111ba65a5e3dbd23a58dd63991e92e9300f44d13\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"7f5da3bb82704efaeae97b9e5b6bfcde7ebed619\", \"got_revision_cp\": \"refs/heads/master@{#843214}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"a1598e5821fc3ca0d2ca8928d41cdd3a12114c7a\", \"got_v8_revision_cp\": \"refs/heads/8.9.266@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"mirrored_builders\": [\"tryserver.chromium:win-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f5da3bb82704efaeae97b9e5b6bfcde7ebed619\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-yywi\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5661-c6f6250\"], \"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": "1610578569889589",
"status": "COMPLETED",
"status_changed_ts": "1610590640892694",
"tags": [
"build_address:luci.chromium.ci/win-official/1379",
"builder:win-official",
"buildset:commit/git/7f5da3bb82704efaeae97b9e5b6bfcde7ebed619",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f5da3bb82704efaeae97b9e5b6bfcde7ebed619",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023609784013770112",
"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/8858179721975748176/+/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:5116c79eac7bb710",
"user_agent:luci-scheduler"
],
"updated_ts": "1610590640897104",
"url": "https://ci.chromium.org/b/8858179721975748176",
"utcnow_ts": "1610590641433127"
}
}
[02:17:21.440] Invocation finished in 3h21m51.51807446s with status SUCCEEDED