[19:59:28.397] New invocation is queued and will start shortly
[19:59:29.500] Starting the invocation (attempt 1)
[19:59:29.549] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:59:29.549] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:59:29.549] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034401897595648896",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9034401897595648896",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae",
"gitiles_ref:refs/heads/master"
]
}
[19:59:30.305] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1600286369662186",
"id": "8868971835603066976",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600286370098236",
"tags": [
"build_address:luci.chromium.ci/win-official/600",
"builder:win-official",
"buildset:commit/git/5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034401897595648896",
"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/8868971835603066976/+/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": "1600286370098343",
"url": "https://ci.chromium.org/b/8868971835603066976",
"utcnow_ts": "1600286370285665"
}
}
[19:59:30.305] Task URL: https://ci.chromium.org/b/8868971835603066976
[19:59:30.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:2:0) after 1m0s
[19:59:54.550] Received PubSub notification, asking Buildbucket for the build status
[19:59:54.700] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:30.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:2:0)
[20:00:30.347] Timer tick, asking Buildbucket for the build status
[20:00:30.571] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:30.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:4:0) after 1m0s
[20:01:30.651] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:4:0)
[20:01:30.651] Timer tick, asking Buildbucket for the build status
[20:01:30.830] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:30.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:5:0) after 1m0s
[20:02:30.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:5:0)
[20:02:30.859] Timer tick, asking Buildbucket for the build status
[20:02:30.934] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:30.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:6:0) after 1m0s
[20:03:31.004] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:6:0)
[20:03:31.004] Timer tick, asking Buildbucket for the build status
[20:03:31.230] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:31.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:7:0) after 1m0s
[20:04:31.295] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:7:0)
[20:04:31.295] Timer tick, asking Buildbucket for the build status
[20:04:31.543] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:31.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:8:0) after 1m0s
[20:05:31.576] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:8:0)
[20:05:31.576] Timer tick, asking Buildbucket for the build status
[20:05:31.693] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:31.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:9:0) after 1m0s
[20:06:31.797] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:9:0)
[20:06:31.797] Timer tick, asking Buildbucket for the build status
[20:06:31.955] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:31.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:10:0) after 1m0s
[20:07:32.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:10:0)
[20:07:32.053] Timer tick, asking Buildbucket for the build status
[20:07:32.157] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:32.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:11:0) after 1m0s
[20:08:32.257] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:11:0)
[20:08:32.257] Timer tick, asking Buildbucket for the build status
[20:08:32.333] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:32.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:12:0) after 1m0s
[20:09:32.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:12:0)
[20:09:32.542] Timer tick, asking Buildbucket for the build status
[20:09:32.936] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:32.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:13:0) after 1m0s
[20:10:33.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:13:0)
[20:10:33.017] Timer tick, asking Buildbucket for the build status
[20:10:36.743] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:36.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:14:0) after 1m0s
[20:11:36.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:14:0)
[20:11:36.807] Timer tick, asking Buildbucket for the build status
[20:11:36.903] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:36.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:15:0) after 1m0s
[20:12:37.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:15:0)
[20:12:37.048] Timer tick, asking Buildbucket for the build status
[20:12:37.237] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:37.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:16:0) after 1m0s
[20:13:37.288] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:16:0)
[20:13:37.288] Timer tick, asking Buildbucket for the build status
[20:13:37.500] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:37.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:17:0) after 1m0s
[20:14:37.558] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:17:0)
[20:14:37.558] Timer tick, asking Buildbucket for the build status
[20:14:37.710] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:37.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:18:0) after 1m0s
[20:15:37.799] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:18:0)
[20:15:37.799] Timer tick, asking Buildbucket for the build status
[20:15:37.889] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:37.889] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:19:0) after 1m0s
[20:16:37.965] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:19:0)
[20:16:37.965] Timer tick, asking Buildbucket for the build status
[20:16:38.053] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:38.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:20:0) after 1m0s
[20:17:38.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:20:0)
[20:17:38.085] Timer tick, asking Buildbucket for the build status
[20:17:38.168] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:38.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:21:0) after 1m0s
[20:18:38.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:21:0)
[20:18:38.483] Timer tick, asking Buildbucket for the build status
[20:18:38.563] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:38.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:22:0) after 1m0s
[20:19:38.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:22:0)
[20:19:38.781] Timer tick, asking Buildbucket for the build status
[20:19:38.972] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:38.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:23:0) after 1m0s
[20:20:39.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:23:0)
[20:20:39.092] Timer tick, asking Buildbucket for the build status
[20:20:39.221] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:39.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:24:0) after 1m0s
[20:21:39.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:24:0)
[20:21:39.504] Timer tick, asking Buildbucket for the build status
[20:21:39.734] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:39.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:25:0) after 1m0s
[20:22:40.037] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:25:0)
[20:22:40.037] Timer tick, asking Buildbucket for the build status
[20:22:40.213] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:40.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:26:0) after 1m0s
[20:23:40.445] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:26:0)
[20:23:40.445] Timer tick, asking Buildbucket for the build status
[20:23:40.539] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:40.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:27:0) after 1m0s
[20:24:40.881] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:27:0)
[20:24:40.881] Timer tick, asking Buildbucket for the build status
[20:24:41.109] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:41.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:28:0) after 1m0s
[20:25:41.238] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:28:0)
[20:25:41.238] Timer tick, asking Buildbucket for the build status
[20:25:41.310] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:41.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:29:0) after 1m0s
[20:26:41.422] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:29:0)
[20:26:41.422] Timer tick, asking Buildbucket for the build status
[20:26:41.611] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:41.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:30:0) after 1m0s
[20:27:41.837] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:30:0)
[20:27:41.837] Timer tick, asking Buildbucket for the build status
[20:27:41.909] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:41.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:31:0) after 1m0s
[20:28:42.064] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:31:0)
[20:28:42.064] Timer tick, asking Buildbucket for the build status
[20:28:42.285] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:42.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:32:0) after 1m0s
[20:29:42.380] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:32:0)
[20:29:42.380] Timer tick, asking Buildbucket for the build status
[20:29:42.834] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:42.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:33:0) after 1m0s
[20:30:43.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:33:0)
[20:30:43.002] Timer tick, asking Buildbucket for the build status
[20:30:43.338] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:43.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:34:0) after 1m0s
[20:31:43.899] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:34:0)
[20:31:43.899] Timer tick, asking Buildbucket for the build status
[20:31:43.973] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:43.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:35:0) after 1m0s
[20:32:43.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:35:0)
[20:32:43.995] Timer tick, asking Buildbucket for the build status
[20:32:44.209] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:44.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:36:0) after 1m0s
[20:33:44.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:36:0)
[20:33:44.279] Timer tick, asking Buildbucket for the build status
[20:33:44.344] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:44.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:37:0) after 1m0s
[20:34:44.425] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:37:0)
[20:34:44.425] Timer tick, asking Buildbucket for the build status
[20:34:44.553] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:44.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:38:0) after 1m0s
[20:35:44.604] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:38:0)
[20:35:44.604] Timer tick, asking Buildbucket for the build status
[20:35:44.674] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:44.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:39:0) after 1m0s
[20:36:44.741] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:39:0)
[20:36:44.741] Timer tick, asking Buildbucket for the build status
[20:36:44.839] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:44.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:40:0) after 1m0s
[20:37:44.912] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:40:0)
[20:37:44.912] Timer tick, asking Buildbucket for the build status
[20:37:45.034] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:45.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:41:0) after 1m0s
[20:38:45.052] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:41:0)
[20:38:45.052] Timer tick, asking Buildbucket for the build status
[20:38:45.284] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:45.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:42:0) after 1m0s
[20:39:45.499] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:42:0)
[20:39:45.499] Timer tick, asking Buildbucket for the build status
[20:39:45.617] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:45.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:43:0) after 1m0s
[20:40:45.721] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:43:0)
[20:40:45.721] Timer tick, asking Buildbucket for the build status
[20:40:46.331] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:46.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:44:0) after 1m0s
[20:41:46.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:44:0)
[20:41:46.416] Timer tick, asking Buildbucket for the build status
[20:41:46.531] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:46.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:45:0) after 1m0s
[20:42:46.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:45:0)
[20:42:46.567] Timer tick, asking Buildbucket for the build status
[20:42:46.751] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:46.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:46:0) after 1m0s
[20:43:46.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:46:0)
[20:43:46.772] Timer tick, asking Buildbucket for the build status
[20:43:46.856] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:46.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:47:0) after 1m0s
[20:44:46.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:47:0)
[20:44:46.907] Timer tick, asking Buildbucket for the build status
[20:44:47.094] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:47.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:48:0) after 1m0s
[20:45:47.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:48:0)
[20:45:47.139] Timer tick, asking Buildbucket for the build status
[20:45:47.250] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:47.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:49:0) after 1m0s
[20:46:47.285] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:49:0)
[20:46:47.285] Timer tick, asking Buildbucket for the build status
[20:46:47.543] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:47.543] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:50:0) after 1m0s
[20:47:47.548] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:50:0)
[20:47:47.548] Timer tick, asking Buildbucket for the build status
[20:47:49.341] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:49.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:51:0) after 1m0s
[20:48:49.370] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:51:0)
[20:48:49.370] Timer tick, asking Buildbucket for the build status
[20:48:49.451] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:49.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:52:0) after 1m0s
[20:49:49.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:52:0)
[20:49:49.506] Timer tick, asking Buildbucket for the build status
[20:49:49.677] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:49.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:53:0) after 1m0s
[20:50:49.772] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:53:0)
[20:50:49.772] Timer tick, asking Buildbucket for the build status
[20:50:49.858] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:49.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:54:0) after 1m0s
[20:51:50.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:54:0)
[20:51:50.059] Timer tick, asking Buildbucket for the build status
[20:51:50.155] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:50.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:55:0) after 1m0s
[20:52:50.209] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:55:0)
[20:52:50.209] Timer tick, asking Buildbucket for the build status
[20:52:50.334] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:50.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:56:0) after 1m0s
[20:53:50.411] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:56:0)
[20:53:50.411] Timer tick, asking Buildbucket for the build status
[20:53:50.652] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:50.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:57:0) after 1m0s
[20:54:50.687] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:57:0)
[20:54:50.687] Timer tick, asking Buildbucket for the build status
[20:54:50.850] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:50.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:58:0) after 1m0s
[20:55:50.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:58:0)
[20:55:50.942] Timer tick, asking Buildbucket for the build status
[20:55:51.210] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:51.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:59:0) after 1m0s
[20:56:51.319] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:59:0)
[20:56:51.319] Timer tick, asking Buildbucket for the build status
[20:56:51.410] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:51.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:60:0) after 1m0s
[20:57:51.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:60:0)
[20:57:51.515] Timer tick, asking Buildbucket for the build status
[20:57:51.898] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:51.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:61:0) after 1m0s
[20:58:51.991] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:61:0)
[20:58:51.991] Timer tick, asking Buildbucket for the build status
[20:58:52.294] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:52.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:62:0) after 1m0s
[20:59:52.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:62:0)
[20:59:52.355] Timer tick, asking Buildbucket for the build status
[20:59:52.532] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:52.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:63:0) after 1m0s
[21:00:52.534] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:63:0)
[21:00:52.534] Timer tick, asking Buildbucket for the build status
[21:00:52.597] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:52.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:64:0) after 1m0s
[21:01:52.734] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:64:0)
[21:01:52.734] Timer tick, asking Buildbucket for the build status
[21:01:52.858] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:52.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:65:0) after 1m0s
[21:02:52.992] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:65:0)
[21:02:52.992] Timer tick, asking Buildbucket for the build status
[21:02:53.236] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:53.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:66:0) after 1m0s
[21:03:53.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:66:0)
[21:03:53.265] Timer tick, asking Buildbucket for the build status
[21:03:53.341] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:53.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:67:0) after 1m0s
[21:04:53.394] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:67:0)
[21:04:53.394] Timer tick, asking Buildbucket for the build status
[21:04:53.539] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:53.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:68:0) after 1m0s
[21:05:53.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:68:0)
[21:05:53.584] Timer tick, asking Buildbucket for the build status
[21:05:53.939] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:53.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:69:0) after 1m0s
[21:06:53.995] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:69:0)
[21:06:53.995] Timer tick, asking Buildbucket for the build status
[21:06:54.075] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:54.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:70:0) after 1m0s
[21:07:54.167] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:70:0)
[21:07:54.167] Timer tick, asking Buildbucket for the build status
[21:07:54.255] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:54.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:71:0) after 1m0s
[21:08:54.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:71:0)
[21:08:54.334] Timer tick, asking Buildbucket for the build status
[21:08:54.391] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:54.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:72:0) after 1m0s
[21:09:54.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:72:0)
[21:09:54.452] Timer tick, asking Buildbucket for the build status
[21:09:54.573] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:54.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:73:0) after 1m0s
[21:10:54.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:73:0)
[21:10:54.675] Timer tick, asking Buildbucket for the build status
[21:10:54.875] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:54.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:74:0) after 1m0s
[21:11:54.942] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:74:0)
[21:11:54.942] Timer tick, asking Buildbucket for the build status
[21:11:55.020] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:55.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:75:0) after 1m0s
[21:12:55.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:75:0)
[21:12:55.230] Timer tick, asking Buildbucket for the build status
[21:12:55.526] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:55.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:76:0) after 1m0s
[21:13:55.668] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:76:0)
[21:13:55.668] Timer tick, asking Buildbucket for the build status
[21:13:55.899] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:55.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:77:0) after 1m0s
[21:14:56.084] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:77:0)
[21:14:56.084] Timer tick, asking Buildbucket for the build status
[21:14:56.213] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:56.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:78:0) after 1m0s
[21:15:56.390] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:78:0)
[21:15:56.390] Timer tick, asking Buildbucket for the build status
[21:15:56.545] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:56.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:79:0) after 1m0s
[21:16:56.724] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:79:0)
[21:16:56.724] Timer tick, asking Buildbucket for the build status
[21:16:57.175] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:57.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:80:0) after 1m0s
[21:17:57.323] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:80:0)
[21:17:57.323] Timer tick, asking Buildbucket for the build status
[21:17:57.398] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:57.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:81:0) after 1m0s
[21:18:57.491] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:81:0)
[21:18:57.491] Timer tick, asking Buildbucket for the build status
[21:18:57.571] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:57.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:82:0) after 1m0s
[21:19:57.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:82:0)
[21:19:57.731] Timer tick, asking Buildbucket for the build status
[21:19:57.892] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:57.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:83:0) after 1m0s
[21:20:57.971] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:83:0)
[21:20:57.971] Timer tick, asking Buildbucket for the build status
[21:20:58.031] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:58.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:84:0) after 1m0s
[21:21:58.208] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:84:0)
[21:21:58.208] Timer tick, asking Buildbucket for the build status
[21:21:58.460] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:58.460] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:85:0) after 1m0s
[21:22:58.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:85:0)
[21:22:58.569] Timer tick, asking Buildbucket for the build status
[21:23:00.331] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:00.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:86:0) after 1m0s
[21:24:00.360] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:86:0)
[21:24:00.360] Timer tick, asking Buildbucket for the build status
[21:24:00.436] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:00.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:87:0) after 1m0s
[21:25:00.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:87:0)
[21:25:00.475] Timer tick, asking Buildbucket for the build status
[21:25:00.604] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:00.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:88:0) after 1m0s
[21:26:00.661] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:88:0)
[21:26:00.661] Timer tick, asking Buildbucket for the build status
[21:26:00.880] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:00.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:89:0) after 1m0s
[21:27:00.958] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:89:0)
[21:27:00.958] Timer tick, asking Buildbucket for the build status
[21:27:01.021] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:01.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:90:0) after 1m0s
[21:28:01.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:90:0)
[21:28:01.083] Timer tick, asking Buildbucket for the build status
[21:28:01.422] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:01.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:91:0) after 1m0s
[21:29:01.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:91:0)
[21:29:01.495] Timer tick, asking Buildbucket for the build status
[21:29:01.576] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:01.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:92:0) after 1m0s
[21:30:01.582] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:92:0)
[21:30:01.582] Timer tick, asking Buildbucket for the build status
[21:30:01.890] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:01.890] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:93:0) after 1m0s
[21:31:02.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:93:0)
[21:31:02.652] Timer tick, asking Buildbucket for the build status
[21:31:02.716] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:02.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:94:0) after 1m0s
[21:32:02.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:94:0)
[21:32:02.807] Timer tick, asking Buildbucket for the build status
[21:32:02.894] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:02.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:95:0) after 1m0s
[21:33:02.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:95:0)
[21:33:02.935] Timer tick, asking Buildbucket for the build status
[21:33:03.014] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:03.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:96:0) after 1m0s
[21:34:03.096] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:96:0)
[21:34:03.096] Timer tick, asking Buildbucket for the build status
[21:34:03.396] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:03.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:97:0) after 1m0s
[21:35:03.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:97:0)
[21:35:03.416] Timer tick, asking Buildbucket for the build status
[21:35:03.569] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:03.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:98:0) after 1m0s
[21:36:03.643] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:98:0)
[21:36:03.643] Timer tick, asking Buildbucket for the build status
[21:36:03.716] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:03.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:99:0) after 1m0s
[21:37:03.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:99:0)
[21:37:03.731] Timer tick, asking Buildbucket for the build status
[21:37:03.793] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:03.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:100:0) after 1m0s
[21:38:03.908] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:100:0)
[21:38:03.908] Timer tick, asking Buildbucket for the build status
[21:38:03.996] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:03.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:101:0) after 1m0s
[21:39:04.035] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:101:0)
[21:39:04.035] Timer tick, asking Buildbucket for the build status
[21:39:04.318] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:04.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:102:0) after 1m0s
[21:40:04.409] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:102:0)
[21:40:04.409] Timer tick, asking Buildbucket for the build status
[21:40:04.931] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:04.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:103:0) after 1m0s
[21:41:05.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:103:0)
[21:41:05.059] Timer tick, asking Buildbucket for the build status
[21:41:05.178] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:05.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:104:0) after 1m0s
[21:42:05.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:104:0)
[21:42:05.217] Timer tick, asking Buildbucket for the build status
[21:42:05.362] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:05.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:105:0) after 1m0s
[21:43:05.405] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:105:0)
[21:43:05.405] Timer tick, asking Buildbucket for the build status
[21:43:05.686] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:05.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:106:0) after 1m0s
[21:44:05.714] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:106:0)
[21:44:05.714] Timer tick, asking Buildbucket for the build status
[21:44:05.776] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:05.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:107:0) after 1m0s
[21:45:05.822] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:107:0)
[21:45:05.822] Timer tick, asking Buildbucket for the build status
[21:45:06.005] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:06.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:108:0) after 1m0s
[21:46:06.074] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:108:0)
[21:46:06.074] Timer tick, asking Buildbucket for the build status
[21:46:06.170] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:06.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:109:0) after 1m0s
[21:47:06.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:109:0)
[21:47:06.211] Timer tick, asking Buildbucket for the build status
[21:47:06.498] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:06.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:110:0) after 1m0s
[21:48:06.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:110:0)
[21:48:06.530] Timer tick, asking Buildbucket for the build status
[21:48:06.616] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:06.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:111:0) after 1m0s
[21:49:06.695] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:111:0)
[21:49:06.695] Timer tick, asking Buildbucket for the build status
[21:49:06.791] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:06.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:112:0) after 1m0s
[21:50:06.841] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:112:0)
[21:50:06.841] Timer tick, asking Buildbucket for the build status
[21:50:07.369] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:07.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:113:0) after 1m0s
[21:51:07.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:113:0)
[21:51:07.492] Timer tick, asking Buildbucket for the build status
[21:51:07.574] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:07.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:114:0) after 1m0s
[21:52:07.596] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:114:0)
[21:52:07.596] Timer tick, asking Buildbucket for the build status
[21:52:07.668] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:07.668] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:115:0) after 1m0s
[21:53:07.703] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:115:0)
[21:53:07.703] Timer tick, asking Buildbucket for the build status
[21:53:08.808] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:08.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:116:0) after 1m0s
[21:54:08.826] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:116:0)
[21:54:08.826] Timer tick, asking Buildbucket for the build status
[21:54:08.907] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:08.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:117:0) after 1m0s
[21:55:08.991] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:117:0)
[21:55:08.991] Timer tick, asking Buildbucket for the build status
[21:55:09.175] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:09.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:118:0) after 1m0s
[21:56:09.261] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:118:0)
[21:56:09.261] Timer tick, asking Buildbucket for the build status
[21:56:09.368] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:09.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:119:0) after 1m0s
[21:57:09.422] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:119:0)
[21:57:09.422] Timer tick, asking Buildbucket for the build status
[21:57:09.566] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:09.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:120:0) after 1m0s
[21:58:09.806] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:120:0)
[21:58:09.806] Timer tick, asking Buildbucket for the build status
[21:58:09.910] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:09.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:121:0) after 1m0s
[21:59:09.927] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:121:0)
[21:59:09.927] Timer tick, asking Buildbucket for the build status
[21:59:09.988] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:09.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:122:0) after 1m0s
[22:00:10.033] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:122:0)
[22:00:10.033] Timer tick, asking Buildbucket for the build status
[22:00:10.161] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:10.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:123:0) after 1m0s
[22:01:10.284] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:123:0)
[22:01:10.284] Timer tick, asking Buildbucket for the build status
[22:01:10.436] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:10.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:124:0) after 1m0s
[22:02:10.571] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:124:0)
[22:02:10.571] Timer tick, asking Buildbucket for the build status
[22:02:10.746] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:10.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:125:0) after 1m0s
[22:03:10.914] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:125:0)
[22:03:10.914] Timer tick, asking Buildbucket for the build status
[22:03:11.001] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:11.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:126:0) after 1m0s
[22:04:11.120] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:126:0)
[22:04:11.120] Timer tick, asking Buildbucket for the build status
[22:04:11.281] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:11.282] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:127:0) after 1m0s
[22:05:11.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:127:0)
[22:05:11.414] Timer tick, asking Buildbucket for the build status
[22:05:11.541] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:11.541] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:128:0) after 1m0s
[22:06:11.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:128:0)
[22:06:11.663] Timer tick, asking Buildbucket for the build status
[22:06:11.741] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:11.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:129:0) after 1m0s
[22:07:11.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:129:0)
[22:07:11.858] Timer tick, asking Buildbucket for the build status
[22:07:12.021] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:12.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:130:0) after 1m0s
[22:08:12.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:130:0)
[22:08:12.077] Timer tick, asking Buildbucket for the build status
[22:08:12.136] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:12.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:131:0) after 1m0s
[22:09:12.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:131:0)
[22:09:12.350] Timer tick, asking Buildbucket for the build status
[22:09:12.422] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:12.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:132:0) after 1m0s
[22:10:12.503] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:132:0)
[22:10:12.503] Timer tick, asking Buildbucket for the build status
[22:10:12.631] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:12.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:133:0) after 1m0s
[22:11:12.736] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:133:0)
[22:11:12.736] Timer tick, asking Buildbucket for the build status
[22:11:12.908] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:12.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:134:0) after 1m0s
[22:12:13.077] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:134:0)
[22:12:13.078] Timer tick, asking Buildbucket for the build status
[22:12:13.166] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:13.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:135:0) after 1m0s
[22:13:13.207] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:135:0)
[22:13:13.207] Timer tick, asking Buildbucket for the build status
[22:13:13.344] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:13.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:136:0) after 1m0s
[22:14:13.414] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:136:0)
[22:14:13.414] Timer tick, asking Buildbucket for the build status
[22:14:13.493] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:13.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:137:0) after 1m0s
[22:15:13.525] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:137:0)
[22:15:13.525] Timer tick, asking Buildbucket for the build status
[22:15:13.771] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:13.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:138:0) after 1m0s
[22:16:13.948] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:138:0)
[22:16:13.948] Timer tick, asking Buildbucket for the build status
[22:16:14.057] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:14.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:139:0) after 1m0s
[22:17:14.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:139:0)
[22:17:14.310] Timer tick, asking Buildbucket for the build status
[22:17:14.452] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:14.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:140:0) after 1m0s
[22:18:14.560] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:140:0)
[22:18:14.560] Timer tick, asking Buildbucket for the build status
[22:18:14.644] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:14.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:141:0) after 1m0s
[22:19:14.828] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:141:0)
[22:19:14.828] Timer tick, asking Buildbucket for the build status
[22:19:14.885] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:14.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:142:0) after 1m0s
[22:20:15.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:142:0)
[22:20:15.038] Timer tick, asking Buildbucket for the build status
[22:20:15.171] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:15.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:143:0) after 1m0s
[22:21:15.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:143:0)
[22:21:15.252] Timer tick, asking Buildbucket for the build status
[22:21:15.371] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:15.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:144:0) after 1m0s
[22:22:15.430] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:144:0)
[22:22:15.430] Timer tick, asking Buildbucket for the build status
[22:22:15.519] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:15.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:145:0) after 1m0s
[22:23:15.753] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:145:0)
[22:23:15.753] Timer tick, asking Buildbucket for the build status
[22:23:15.845] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:15.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:146:0) after 1m0s
[22:24:15.933] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:146:0)
[22:24:15.933] Timer tick, asking Buildbucket for the build status
[22:24:16.006] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:16.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:147:0) after 1m0s
[22:25:16.067] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:147:0)
[22:25:16.067] Timer tick, asking Buildbucket for the build status
[22:25:16.185] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:16.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:148:0) after 1m0s
[22:26:16.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:148:0)
[22:26:16.252] Timer tick, asking Buildbucket for the build status
[22:26:16.768] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:16.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:149:0) after 1m0s
[22:27:16.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:149:0)
[22:27:16.791] Timer tick, asking Buildbucket for the build status
[22:27:16.858] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:16.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:150:0) after 1m0s
[22:28:16.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:150:0)
[22:28:16.859] Timer tick, asking Buildbucket for the build status
[22:28:17.013] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:17.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:151:0) after 1m0s
[22:29:17.040] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:151:0)
[22:29:17.040] Timer tick, asking Buildbucket for the build status
[22:29:17.246] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:17.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:152:0) after 1m0s
[22:30:17.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:152:0)
[22:30:17.312] Timer tick, asking Buildbucket for the build status
[22:30:18.742] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:18.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:153:0) after 1m0s
[22:31:18.813] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:153:0)
[22:31:18.813] Timer tick, asking Buildbucket for the build status
[22:31:19.156] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:19.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:154:0) after 1m0s
[22:32:19.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:154:0)
[22:32:19.279] Timer tick, asking Buildbucket for the build status
[22:32:19.354] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:19.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:155:0) after 1m0s
[22:33:19.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:155:0)
[22:33:19.468] Timer tick, asking Buildbucket for the build status
[22:33:19.616] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:19.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:156:0) after 1m0s
[22:34:19.674] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:156:0)
[22:34:19.674] Timer tick, asking Buildbucket for the build status
[22:34:19.781] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:19.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:157:0) after 1m0s
[22:35:19.916] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:157:0)
[22:35:19.916] Timer tick, asking Buildbucket for the build status
[22:35:20.271] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:20.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:158:0) after 1m0s
[22:36:20.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:158:0)
[22:36:20.312] Timer tick, asking Buildbucket for the build status
[22:36:20.372] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:20.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:159:0) after 1m0s
[22:37:20.462] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:159:0)
[22:37:20.462] Timer tick, asking Buildbucket for the build status
[22:37:20.553] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:20.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:160:0) after 1m0s
[22:38:20.645] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:160:0)
[22:38:20.645] Timer tick, asking Buildbucket for the build status
[22:38:20.723] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:20.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:161:0) after 1m0s
[22:39:20.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:161:0)
[22:39:20.798] Timer tick, asking Buildbucket for the build status
[22:39:20.951] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:20.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:162:0) after 1m0s
[22:40:21.059] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:162:0)
[22:40:21.059] Timer tick, asking Buildbucket for the build status
[22:40:21.257] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:21.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:163:0) after 1m0s
[22:41:21.285] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:163:0)
[22:41:21.285] Timer tick, asking Buildbucket for the build status
[22:41:21.377] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:21.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:164:0) after 1m0s
[22:42:21.410] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:164:0)
[22:42:21.410] Timer tick, asking Buildbucket for the build status
[22:42:21.486] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:21.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:165:0) after 1m0s
[22:43:21.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:165:0)
[22:43:21.559] Timer tick, asking Buildbucket for the build status
[22:43:21.698] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:21.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:166:0) after 1m0s
[22:44:21.728] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:166:0)
[22:44:21.728] Timer tick, asking Buildbucket for the build status
[22:44:21.818] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:21.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:167:0) after 1m0s
[22:45:21.846] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:167:0)
[22:45:21.846] Timer tick, asking Buildbucket for the build status
[22:45:22.129] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:22.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:168:0) after 1m0s
[22:46:22.241] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:168:0)
[22:46:22.241] Timer tick, asking Buildbucket for the build status
[22:46:22.357] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:22.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:169:0) after 1m0s
[22:47:22.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:169:0)
[22:47:22.402] Timer tick, asking Buildbucket for the build status
[22:47:22.518] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:22.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:170:0) after 1m0s
[22:48:22.604] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:170:0)
[22:48:22.604] Timer tick, asking Buildbucket for the build status
[22:48:22.690] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:22.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:171:0) after 1m0s
[22:49:22.774] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:171:0)
[22:49:22.774] Timer tick, asking Buildbucket for the build status
[22:49:22.857] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:22.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:172:0) after 1m0s
[22:50:22.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:172:0)
[22:50:22.897] Timer tick, asking Buildbucket for the build status
[22:50:22.989] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:22.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:173:0) after 1m0s
[22:51:23.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:173:0)
[22:51:23.036] Timer tick, asking Buildbucket for the build status
[22:51:23.122] Build 8868971835603066976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:23.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034401897595648896:174:0) after 1m0s
[22:52:17.304] Received PubSub notification, asking Buildbucket for the build status
[22:52:17.514] Build 8868971835603066976: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:52:17.514] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1600296736800410",
"created_by": "project:chromium",
"created_ts": "1600286369662186",
"id": "8868971835603066976",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae\"}}",
"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\": \"5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae\", \"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-0-9d4d\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 600, \"got_angle_revision\": \"3018d5e57091200217e2bd688df28f52f079bab9\", \"got_dawn_revision\": \"c2367695483858cf61d59f34a41c0ead0aac7776\", \"got_nacl_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"got_revision\": \"5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae\", \"got_revision_cp\": \"refs/heads/master@{#807624}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"fe878dedd5addbedab4033c0cb6b19bbbe04f8e4\", \"got_v8_revision\": \"69e493145e02a3a292683e577892fedb6f4964fb\", \"got_v8_revision_cp\": \"refs/heads/8.7.110@{#1}\", \"got_webrtc_revision\": \"804db2dde3f13834891d11b47dc0f0e18b9d6320\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32120}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae\"}, \"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\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-0-9d4d\"], \"image\": [\"chrome-win10-1703-20083100-22dcea0839e\"], \"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\": [\"5522-67570db\"], \"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": "1600286393238675",
"status": "COMPLETED",
"status_changed_ts": "1600296737072925",
"tags": [
"build_address:luci.chromium.ci/win-official/600",
"builder:win-official",
"buildset:commit/git/5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b7d4ebcfd9b949b4efaaa27cd0737e996e2abae",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034401897595648896",
"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/8868971835603066976/+/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:4eb151b56bace610",
"user_agent:luci-scheduler"
],
"updated_ts": "1600296737079136",
"url": "https://ci.chromium.org/b/8868971835603066976",
"utcnow_ts": "1600296737502913"
}
}
[22:52:17.515] Invocation finished in 2h52m49.135919354s with status SUCCEEDED