[11:54:13.057] New invocation is queued and will start shortly
[11:54:14.125] Starting the invocation (attempt 1)
[11:54:14.175] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:54:14.178] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:54:14.178] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031080339484961904",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"289317613ad15098634c2d87e179e631a81e3c54\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9031080339484961904",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/289317613ad15098634c2d87e179e631a81e3c54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/289317613ad15098634c2d87e179e631a81e3c54",
"gitiles_ref:refs/heads/master"
]
}
[11:54:15.049] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603454054309845",
"id": "8865650277506674304",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"289317613ad15098634c2d87e179e631a81e3c54\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603454054729011",
"tags": [
"build_address:luci.chromium.ci/win32-official/801",
"builder:win32-official",
"buildset:commit/git/289317613ad15098634c2d87e179e631a81e3c54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/289317613ad15098634c2d87e179e631a81e3c54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031080339484961904",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865650277506674304/+/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": "1603454054729129",
"url": "https://ci.chromium.org/b/8865650277506674304",
"utcnow_ts": "1603454055040403"
}
}
[11:54:15.049] Task URL: https://ci.chromium.org/b/8865650277506674304
[11:54:15.049] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:2:0) after 1m0s
[11:55:12.630] Received PubSub notification, asking Buildbucket for the build status
[11:55:12.716] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:15.111] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:2:0)
[11:55:15.111] Timer tick, asking Buildbucket for the build status
[11:55:15.208] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:15.208] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:4:0) after 1m0s
[11:56:15.231] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:4:0)
[11:56:15.231] Timer tick, asking Buildbucket for the build status
[11:56:15.325] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:15.325] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:5:0) after 1m0s
[11:57:15.356] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:5:0)
[11:57:15.356] Timer tick, asking Buildbucket for the build status
[11:57:15.438] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:15.438] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:6:0) after 1m0s
[11:58:15.551] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:6:0)
[11:58:15.551] Timer tick, asking Buildbucket for the build status
[11:58:15.623] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:15.623] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:7:0) after 1m0s
[11:59:15.678] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:7:0)
[11:59:15.678] Timer tick, asking Buildbucket for the build status
[11:59:15.765] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:15.765] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:8:0) after 1m0s
[12:00:15.833] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:8:0)
[12:00:15.833] Timer tick, asking Buildbucket for the build status
[12:00:16.570] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:16.570] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:9:0) after 1m0s
[12:01:16.611] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:9:0)
[12:01:16.611] Timer tick, asking Buildbucket for the build status
[12:01:16.897] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:16.897] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:10:0) after 1m0s
[12:02:17.044] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:10:0)
[12:02:17.044] Timer tick, asking Buildbucket for the build status
[12:02:17.157] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:17.157] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:11:0) after 1m0s
[12:03:17.202] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:11:0)
[12:03:17.202] Timer tick, asking Buildbucket for the build status
[12:03:17.331] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:17.331] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:12:0) after 1m0s
[12:04:17.361] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:12:0)
[12:04:17.361] Timer tick, asking Buildbucket for the build status
[12:04:17.743] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:17.743] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:13:0) after 1m0s
[12:05:17.781] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:13:0)
[12:05:17.781] Timer tick, asking Buildbucket for the build status
[12:05:17.888] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:17.888] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:14:0) after 1m0s
[12:06:17.941] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:14:0)
[12:06:17.941] Timer tick, asking Buildbucket for the build status
[12:06:18.035] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:18.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:15:0) after 1m0s
[12:07:18.106] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:15:0)
[12:07:18.106] Timer tick, asking Buildbucket for the build status
[12:07:18.531] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:18.531] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:16:0) after 1m0s
[12:08:18.577] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:16:0)
[12:08:18.577] Timer tick, asking Buildbucket for the build status
[12:08:18.704] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:18.704] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:17:0) after 1m0s
[12:09:18.728] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:17:0)
[12:09:18.728] Timer tick, asking Buildbucket for the build status
[12:09:19.041] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:19.041] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:18:0) after 1m0s
[12:10:19.058] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:18:0)
[12:10:19.058] Timer tick, asking Buildbucket for the build status
[12:10:19.115] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:19.115] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:19:0) after 1m0s
[12:11:19.136] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:19:0)
[12:11:19.136] Timer tick, asking Buildbucket for the build status
[12:11:19.195] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:19.195] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:20:0) after 1m0s
[12:12:19.257] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:20:0)
[12:12:19.257] Timer tick, asking Buildbucket for the build status
[12:12:19.343] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:19.344] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:21:0) after 1m0s
[12:13:19.415] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:21:0)
[12:13:19.415] Timer tick, asking Buildbucket for the build status
[12:13:19.488] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:19.488] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:22:0) after 1m0s
[12:14:19.510] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:22:0)
[12:14:19.510] Timer tick, asking Buildbucket for the build status
[12:14:19.629] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:19.629] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:23:0) after 1m0s
[12:15:19.668] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:23:0)
[12:15:19.668] Timer tick, asking Buildbucket for the build status
[12:15:19.800] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:19.800] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:24:0) after 1m0s
[12:16:19.824] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:24:0)
[12:16:19.824] Timer tick, asking Buildbucket for the build status
[12:16:19.906] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:19.906] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:25:0) after 1m0s
[12:17:19.935] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:25:0)
[12:17:19.935] Timer tick, asking Buildbucket for the build status
[12:17:20.087] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:20.087] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:26:0) after 1m0s
[12:18:20.204] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:26:0)
[12:18:20.204] Timer tick, asking Buildbucket for the build status
[12:18:20.318] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:20.318] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:27:0) after 1m0s
[12:19:21.233] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:27:0)
[12:19:21.233] Timer tick, asking Buildbucket for the build status
[12:19:21.343] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:21.343] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:28:0) after 1m0s
[12:20:21.586] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:28:0)
[12:20:21.586] Timer tick, asking Buildbucket for the build status
[12:20:21.693] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:21.693] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:29:0) after 1m0s
[12:21:21.782] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:29:0)
[12:21:21.782] Timer tick, asking Buildbucket for the build status
[12:21:21.896] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:21.896] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:30:0) after 1m0s
[12:22:22.034] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:30:0)
[12:22:22.034] Timer tick, asking Buildbucket for the build status
[12:22:22.565] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:22.565] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:31:0) after 1m0s
[12:23:22.712] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:31:0)
[12:23:22.712] Timer tick, asking Buildbucket for the build status
[12:23:22.789] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:22.789] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:32:0) after 1m0s
[12:24:22.943] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:32:0)
[12:24:22.943] Timer tick, asking Buildbucket for the build status
[12:24:23.544] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:23.544] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:33:0) after 1m0s
[12:25:23.665] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:33:0)
[12:25:23.665] Timer tick, asking Buildbucket for the build status
[12:25:23.736] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:23.736] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:34:0) after 1m0s
[12:26:23.886] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:34:0)
[12:26:23.886] Timer tick, asking Buildbucket for the build status
[12:26:23.957] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:23.957] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:35:0) after 1m0s
[12:27:24.009] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:35:0)
[12:27:24.010] Timer tick, asking Buildbucket for the build status
[12:27:24.074] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:24.074] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:36:0) after 1m0s
[12:28:24.077] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:36:0)
[12:28:24.077] Timer tick, asking Buildbucket for the build status
[12:28:24.172] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:24.172] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:37:0) after 1m0s
[12:29:24.266] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:37:0)
[12:29:24.266] Timer tick, asking Buildbucket for the build status
[12:29:24.379] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:24.379] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:38:0) after 1m0s
[12:30:24.481] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:38:0)
[12:30:24.481] Timer tick, asking Buildbucket for the build status
[12:30:24.612] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:24.612] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:39:0) after 1m0s
[12:31:24.848] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:39:0)
[12:31:24.848] Timer tick, asking Buildbucket for the build status
[12:31:24.920] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:24.920] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:40:0) after 1m0s
[12:32:24.991] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:40:0)
[12:32:24.991] Timer tick, asking Buildbucket for the build status
[12:32:25.059] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:25.060] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:41:0) after 1m0s
[12:33:25.207] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:41:0)
[12:33:25.207] Timer tick, asking Buildbucket for the build status
[12:33:25.275] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:25.275] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:42:0) after 1m0s
[12:34:25.391] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:42:0)
[12:34:25.391] Timer tick, asking Buildbucket for the build status
[12:34:25.507] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:25.507] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:43:0) after 1m0s
[12:35:25.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:43:0)
[12:35:25.631] Timer tick, asking Buildbucket for the build status
[12:35:25.755] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:25.755] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:44:0) after 1m0s
[12:36:25.847] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:44:0)
[12:36:25.847] Timer tick, asking Buildbucket for the build status
[12:36:25.958] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:25.958] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:45:0) after 1m0s
[12:37:26.055] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:45:0)
[12:37:26.056] Timer tick, asking Buildbucket for the build status
[12:37:26.190] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:26.190] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:46:0) after 1m0s
[12:38:26.287] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:46:0)
[12:38:26.287] Timer tick, asking Buildbucket for the build status
[12:38:26.511] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:26.511] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:47:0) after 1m0s
[12:39:26.533] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:47:0)
[12:39:26.533] Timer tick, asking Buildbucket for the build status
[12:39:26.664] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:26.664] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:48:0) after 1m0s
[12:40:26.771] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:48:0)
[12:40:26.771] Timer tick, asking Buildbucket for the build status
[12:40:26.847] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:26.847] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:49:0) after 1m0s
[12:41:26.905] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:49:0)
[12:41:26.905] Timer tick, asking Buildbucket for the build status
[12:41:27.100] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:27.100] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:50:0) after 1m0s
[12:42:27.128] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:50:0)
[12:42:27.128] Timer tick, asking Buildbucket for the build status
[12:42:27.299] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:27.299] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:51:0) after 1m0s
[12:43:27.414] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:51:0)
[12:43:27.414] Timer tick, asking Buildbucket for the build status
[12:43:27.475] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:27.475] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:52:0) after 1m0s
[12:44:27.643] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:52:0)
[12:44:27.643] Timer tick, asking Buildbucket for the build status
[12:44:27.765] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:27.765] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:53:0) after 1m0s
[12:45:27.801] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:53:0)
[12:45:27.801] Timer tick, asking Buildbucket for the build status
[12:45:27.864] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:27.864] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:54:0) after 1m0s
[12:46:27.991] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:54:0)
[12:46:27.991] Timer tick, asking Buildbucket for the build status
[12:46:28.062] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:28.062] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:55:0) after 1m0s
[12:47:28.156] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:55:0)
[12:47:28.156] Timer tick, asking Buildbucket for the build status
[12:47:28.222] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:28.222] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:56:0) after 1m0s
[12:48:28.341] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:56:0)
[12:48:28.341] Timer tick, asking Buildbucket for the build status
[12:48:28.406] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:28.406] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:57:0) after 1m0s
[12:49:28.593] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:57:0)
[12:49:28.593] Timer tick, asking Buildbucket for the build status
[12:49:28.725] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:28.725] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:58:0) after 1m0s
[12:50:30.235] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:58:0)
[12:50:30.235] Timer tick, asking Buildbucket for the build status
[12:50:30.305] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:30.305] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:59:0) after 1m0s
[12:51:30.386] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:59:0)
[12:51:30.386] Timer tick, asking Buildbucket for the build status
[12:51:30.446] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:30.446] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:60:0) after 1m0s
[12:52:30.536] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:60:0)
[12:52:30.536] Timer tick, asking Buildbucket for the build status
[12:52:30.726] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:30.726] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:61:0) after 1m0s
[12:53:30.803] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:61:0)
[12:53:30.803] Timer tick, asking Buildbucket for the build status
[12:53:30.872] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:30.872] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:62:0) after 1m0s
[12:54:30.890] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:62:0)
[12:54:30.890] Timer tick, asking Buildbucket for the build status
[12:54:30.982] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:30.982] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:63:0) after 1m0s
[12:55:31.137] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:63:0)
[12:55:31.137] Timer tick, asking Buildbucket for the build status
[12:55:31.397] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:31.397] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:64:0) after 1m0s
[12:56:31.448] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:64:0)
[12:56:31.448] Timer tick, asking Buildbucket for the build status
[12:56:31.517] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:31.517] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:65:0) after 1m0s
[12:57:31.597] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:65:0)
[12:57:31.597] Timer tick, asking Buildbucket for the build status
[12:57:31.676] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:31.676] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:66:0) after 1m0s
[12:58:31.741] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:66:0)
[12:58:31.741] Timer tick, asking Buildbucket for the build status
[12:58:31.812] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:31.812] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:67:0) after 1m0s
[12:59:31.879] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:67:0)
[12:59:31.879] Timer tick, asking Buildbucket for the build status
[12:59:32.015] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:32.015] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:68:0) after 1m0s
[13:00:32.008] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:68:0)
[13:00:32.008] Timer tick, asking Buildbucket for the build status
[13:00:32.072] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:32.072] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:69:0) after 1m0s
[13:01:32.109] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:69:0)
[13:01:32.109] Timer tick, asking Buildbucket for the build status
[13:01:32.177] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:32.177] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:70:0) after 1m0s
[13:02:32.261] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:70:0)
[13:02:32.261] Timer tick, asking Buildbucket for the build status
[13:02:32.354] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:32.354] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:71:0) after 1m0s
[13:03:32.394] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:71:0)
[13:03:32.394] Timer tick, asking Buildbucket for the build status
[13:03:32.463] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:32.463] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:72:0) after 1m0s
[13:04:32.525] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:72:0)
[13:04:32.525] Timer tick, asking Buildbucket for the build status
[13:04:32.978] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:32.978] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:73:0) after 1m0s
[13:05:33.090] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:73:0)
[13:05:33.090] Timer tick, asking Buildbucket for the build status
[13:05:33.307] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:33.307] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:74:0) after 1m0s
[13:06:33.340] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:74:0)
[13:06:33.340] Timer tick, asking Buildbucket for the build status
[13:06:33.610] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:33.610] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:75:0) after 1m0s
[13:07:33.596] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:75:0)
[13:07:33.596] Timer tick, asking Buildbucket for the build status
[13:07:33.696] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:33.696] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:76:0) after 1m0s
[13:08:33.731] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:76:0)
[13:08:33.731] Timer tick, asking Buildbucket for the build status
[13:08:33.838] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:33.838] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:77:0) after 1m0s
[13:09:33.865] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:77:0)
[13:09:33.865] Timer tick, asking Buildbucket for the build status
[13:09:33.990] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:33.990] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:78:0) after 1m0s
[13:10:34.043] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:78:0)
[13:10:34.043] Timer tick, asking Buildbucket for the build status
[13:10:34.172] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:34.172] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:79:0) after 1m0s
[13:11:34.216] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:79:0)
[13:11:34.216] Timer tick, asking Buildbucket for the build status
[13:11:34.357] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:34.357] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:80:0) after 1m0s
[13:12:34.377] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:80:0)
[13:12:34.377] Timer tick, asking Buildbucket for the build status
[13:12:34.473] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:34.473] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:81:0) after 1m0s
[13:13:34.523] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:81:0)
[13:13:34.523] Timer tick, asking Buildbucket for the build status
[13:13:34.606] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:34.606] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:82:0) after 1m0s
[13:14:34.674] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:82:0)
[13:14:34.674] Timer tick, asking Buildbucket for the build status
[13:14:34.813] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:34.813] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:83:0) after 1m0s
[13:15:34.904] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:83:0)
[13:15:34.904] Timer tick, asking Buildbucket for the build status
[13:15:35.157] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:35.157] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:84:0) after 1m0s
[13:16:35.186] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:84:0)
[13:16:35.186] Timer tick, asking Buildbucket for the build status
[13:16:35.375] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:35.375] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:85:0) after 1m0s
[13:17:35.385] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:85:0)
[13:17:35.385] Timer tick, asking Buildbucket for the build status
[13:17:35.455] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:35.455] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:86:0) after 1m0s
[13:18:35.516] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:86:0)
[13:18:35.516] Timer tick, asking Buildbucket for the build status
[13:18:35.875] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:35.875] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:87:0) after 1m0s
[13:19:35.974] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:87:0)
[13:19:35.974] Timer tick, asking Buildbucket for the build status
[13:19:36.079] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:36.079] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:88:0) after 1m0s
[13:20:36.189] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:88:0)
[13:20:36.189] Timer tick, asking Buildbucket for the build status
[13:20:36.252] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:36.252] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:89:0) after 1m0s
[13:21:36.243] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:89:0)
[13:21:36.243] Timer tick, asking Buildbucket for the build status
[13:21:36.303] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:36.303] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:90:0) after 1m0s
[13:22:36.331] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:90:0)
[13:22:36.331] Timer tick, asking Buildbucket for the build status
[13:22:36.408] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:36.408] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:91:0) after 1m0s
[13:23:36.445] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:91:0)
[13:23:36.445] Timer tick, asking Buildbucket for the build status
[13:23:36.524] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:36.524] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:92:0) after 1m0s
[13:24:36.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:92:0)
[13:24:36.631] Timer tick, asking Buildbucket for the build status
[13:24:36.768] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:36.768] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:93:0) after 1m0s
[13:25:36.910] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:93:0)
[13:25:36.910] Timer tick, asking Buildbucket for the build status
[13:25:36.999] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:36.999] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:94:0) after 1m0s
[13:26:37.123] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:94:0)
[13:26:37.123] Timer tick, asking Buildbucket for the build status
[13:26:37.299] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:37.299] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:95:0) after 1m0s
[13:27:37.300] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:95:0)
[13:27:37.300] Timer tick, asking Buildbucket for the build status
[13:27:37.373] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:37.373] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:96:0) after 1m0s
[13:28:37.474] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:96:0)
[13:28:37.475] Timer tick, asking Buildbucket for the build status
[13:28:37.543] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:37.543] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:97:0) after 1m0s
[13:29:37.571] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:97:0)
[13:29:37.571] Timer tick, asking Buildbucket for the build status
[13:29:37.828] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:37.828] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:98:0) after 1m0s
[13:30:37.828] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:98:0)
[13:30:37.828] Timer tick, asking Buildbucket for the build status
[13:30:37.928] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:37.928] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:99:0) after 1m0s
[13:31:37.934] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:99:0)
[13:31:37.934] Timer tick, asking Buildbucket for the build status
[13:31:38.222] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:38.222] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:100:0) after 1m0s
[13:32:38.262] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:100:0)
[13:32:38.262] Timer tick, asking Buildbucket for the build status
[13:32:38.420] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:38.420] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:101:0) after 1m0s
[13:33:38.430] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:101:0)
[13:33:38.430] Timer tick, asking Buildbucket for the build status
[13:33:38.626] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:38.626] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:102:0) after 1m0s
[13:34:38.603] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:102:0)
[13:34:38.603] Timer tick, asking Buildbucket for the build status
[13:34:38.995] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:38.995] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:103:0) after 1m0s
[13:35:39.246] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:103:0)
[13:35:39.246] Timer tick, asking Buildbucket for the build status
[13:35:39.411] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:39.411] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:104:0) after 1m0s
[13:36:39.527] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:104:0)
[13:36:39.527] Timer tick, asking Buildbucket for the build status
[13:36:39.777] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:39.777] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:105:0) after 1m0s
[13:37:40.023] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:105:0)
[13:37:40.023] Timer tick, asking Buildbucket for the build status
[13:37:40.108] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:40.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:106:0) after 1m0s
[13:38:40.168] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:106:0)
[13:38:40.168] Timer tick, asking Buildbucket for the build status
[13:38:40.257] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:40.257] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:107:0) after 1m0s
[13:39:40.243] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:107:0)
[13:39:40.243] Timer tick, asking Buildbucket for the build status
[13:39:40.382] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:40.382] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:108:0) after 1m0s
[13:40:40.448] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:108:0)
[13:40:40.448] Timer tick, asking Buildbucket for the build status
[13:40:42.840] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:42.840] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:109:0) after 1m0s
[13:41:42.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:109:0)
[13:41:42.881] Timer tick, asking Buildbucket for the build status
[13:41:43.029] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:43.029] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:110:0) after 1m0s
[13:42:43.109] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:110:0)
[13:42:43.109] Timer tick, asking Buildbucket for the build status
[13:42:43.319] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:43.319] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:111:0) after 1m0s
[13:43:43.331] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:111:0)
[13:43:43.331] Timer tick, asking Buildbucket for the build status
[13:43:43.413] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:43.413] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:112:0) after 1m0s
[13:44:43.478] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:112:0)
[13:44:43.478] Timer tick, asking Buildbucket for the build status
[13:44:43.607] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:43.607] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:113:0) after 1m0s
[13:45:43.625] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:113:0)
[13:45:43.625] Timer tick, asking Buildbucket for the build status
[13:45:43.686] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:43.686] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:114:0) after 1m0s
[13:46:43.778] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:114:0)
[13:46:43.778] Timer tick, asking Buildbucket for the build status
[13:46:44.032] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:44.032] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:115:0) after 1m0s
[13:47:44.166] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:115:0)
[13:47:44.166] Timer tick, asking Buildbucket for the build status
[13:47:44.246] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:44.246] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:116:0) after 1m0s
[13:48:44.371] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:116:0)
[13:48:44.371] Timer tick, asking Buildbucket for the build status
[13:48:44.429] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:44.429] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:117:0) after 1m0s
[13:49:44.546] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:117:0)
[13:49:44.546] Timer tick, asking Buildbucket for the build status
[13:49:44.708] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:44.708] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:118:0) after 1m0s
[13:50:44.787] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:118:0)
[13:50:44.787] Timer tick, asking Buildbucket for the build status
[13:50:44.854] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:44.854] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:119:0) after 1m0s
[13:51:45.034] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:119:0)
[13:51:45.034] Timer tick, asking Buildbucket for the build status
[13:51:45.094] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:45.094] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:120:0) after 1m0s
[13:52:45.158] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:120:0)
[13:52:45.158] Timer tick, asking Buildbucket for the build status
[13:52:45.390] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:45.390] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:121:0) after 1m0s
[13:53:45.426] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:121:0)
[13:53:45.426] Timer tick, asking Buildbucket for the build status
[13:53:45.512] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:45.512] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:122:0) after 1m0s
[13:54:45.571] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:122:0)
[13:54:45.571] Timer tick, asking Buildbucket for the build status
[13:54:46.077] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:46.077] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:123:0) after 1m0s
[13:55:46.227] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:123:0)
[13:55:46.228] Timer tick, asking Buildbucket for the build status
[13:55:46.293] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:46.295] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:124:0) after 1m0s
[13:56:46.420] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:124:0)
[13:56:46.420] Timer tick, asking Buildbucket for the build status
[13:56:46.514] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:46.514] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:125:0) after 1m0s
[13:57:46.560] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:125:0)
[13:57:46.560] Timer tick, asking Buildbucket for the build status
[13:57:46.883] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:46.883] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:126:0) after 1m0s
[13:58:47.390] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:126:0)
[13:58:47.390] Timer tick, asking Buildbucket for the build status
[13:58:47.470] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:47.470] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:127:0) after 1m0s
[13:59:47.610] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:127:0)
[13:59:47.610] Timer tick, asking Buildbucket for the build status
[13:59:47.749] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:47.749] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:128:0) after 1m0s
[14:00:48.000] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:128:0)
[14:00:48.000] Timer tick, asking Buildbucket for the build status
[14:00:48.095] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:48.095] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:129:0) after 1m0s
[14:01:48.229] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:129:0)
[14:01:48.229] Timer tick, asking Buildbucket for the build status
[14:01:48.310] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:48.310] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:130:0) after 1m0s
[14:02:48.511] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:130:0)
[14:02:48.511] Timer tick, asking Buildbucket for the build status
[14:02:48.586] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:48.586] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:131:0) after 1m0s
[14:03:48.693] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:131:0)
[14:03:48.693] Timer tick, asking Buildbucket for the build status
[14:03:48.910] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:48.910] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:132:0) after 1m0s
[14:04:49.166] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:132:0)
[14:04:49.166] Timer tick, asking Buildbucket for the build status
[14:04:49.315] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:49.315] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:133:0) after 1m0s
[14:05:49.437] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:133:0)
[14:05:49.437] Timer tick, asking Buildbucket for the build status
[14:05:49.644] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:49.644] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:134:0) after 1m0s
[14:06:49.758] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:134:0)
[14:06:49.758] Timer tick, asking Buildbucket for the build status
[14:06:49.837] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:49.837] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:135:0) after 1m0s
[14:07:49.894] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:135:0)
[14:07:49.894] Timer tick, asking Buildbucket for the build status
[14:07:49.974] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:49.974] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:136:0) after 1m0s
[14:08:52.042] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:136:0)
[14:08:52.042] Timer tick, asking Buildbucket for the build status
[14:08:52.207] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:52.207] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:137:0) after 1m0s
[14:09:52.399] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:137:0)
[14:09:52.399] Timer tick, asking Buildbucket for the build status
[14:09:52.606] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:52.606] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:138:0) after 1m0s
[14:10:52.683] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:138:0)
[14:10:52.683] Timer tick, asking Buildbucket for the build status
[14:10:52.834] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:52.834] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:139:0) after 1m0s
[14:11:52.966] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:139:0)
[14:11:52.966] Timer tick, asking Buildbucket for the build status
[14:11:53.045] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:53.045] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:140:0) after 1m0s
[14:12:53.148] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:140:0)
[14:12:53.148] Timer tick, asking Buildbucket for the build status
[14:12:53.229] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:53.229] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:141:0) after 1m0s
[14:13:53.269] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:141:0)
[14:13:53.269] Timer tick, asking Buildbucket for the build status
[14:13:53.362] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:53.362] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:142:0) after 1m0s
[14:14:54.314] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:142:0)
[14:14:54.314] Timer tick, asking Buildbucket for the build status
[14:14:54.429] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:54.429] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:143:0) after 1m0s
[14:15:54.607] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:143:0)
[14:15:54.607] Timer tick, asking Buildbucket for the build status
[14:15:54.668] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:54.668] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:144:0) after 1m0s
[14:16:54.704] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:144:0)
[14:16:54.704] Timer tick, asking Buildbucket for the build status
[14:16:54.784] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:54.784] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:145:0) after 1m0s
[14:17:54.998] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:145:0)
[14:17:54.998] Timer tick, asking Buildbucket for the build status
[14:17:55.116] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:55.116] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:146:0) after 1m0s
[14:18:55.312] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:146:0)
[14:18:55.312] Timer tick, asking Buildbucket for the build status
[14:18:55.384] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:55.384] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:147:0) after 1m0s
[14:19:55.480] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:147:0)
[14:19:55.480] Timer tick, asking Buildbucket for the build status
[14:19:55.630] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:55.630] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:148:0) after 1m0s
[14:20:55.730] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:148:0)
[14:20:55.730] Timer tick, asking Buildbucket for the build status
[14:20:55.808] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:55.808] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:149:0) after 1m0s
[14:21:55.859] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:149:0)
[14:21:55.860] Timer tick, asking Buildbucket for the build status
[14:21:56.140] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:56.140] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:150:0) after 1m0s
[14:22:56.170] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:150:0)
[14:22:56.170] Timer tick, asking Buildbucket for the build status
[14:22:56.243] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:56.243] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:151:0) after 1m0s
[14:23:56.295] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:151:0)
[14:23:56.295] Timer tick, asking Buildbucket for the build status
[14:23:56.433] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:56.433] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:152:0) after 1m0s
[14:24:56.463] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:152:0)
[14:24:56.463] Timer tick, asking Buildbucket for the build status
[14:24:56.717] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:56.717] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:153:0) after 1m0s
[14:25:56.784] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:153:0)
[14:25:56.784] Timer tick, asking Buildbucket for the build status
[14:25:56.856] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:56.856] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:154:0) after 1m0s
[14:26:57.004] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:154:0)
[14:26:57.004] Timer tick, asking Buildbucket for the build status
[14:26:57.108] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:57.108] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:155:0) after 1m0s
[14:27:57.102] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:155:0)
[14:27:57.102] Timer tick, asking Buildbucket for the build status
[14:27:57.329] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:57.329] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:156:0) after 1m0s
[14:28:57.359] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:156:0)
[14:28:57.359] Timer tick, asking Buildbucket for the build status
[14:28:57.430] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:57.430] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:157:0) after 1m0s
[14:29:57.459] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:157:0)
[14:29:57.459] Timer tick, asking Buildbucket for the build status
[14:29:57.567] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:57.570] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:158:0) after 1m0s
[14:30:57.679] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:158:0)
[14:30:57.679] Timer tick, asking Buildbucket for the build status
[14:30:58.265] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:58.265] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:159:0) after 1m0s
[14:31:58.406] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:159:0)
[14:31:58.406] Timer tick, asking Buildbucket for the build status
[14:31:58.482] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:58.482] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:160:0) after 1m0s
[14:32:58.596] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:160:0)
[14:32:58.596] Timer tick, asking Buildbucket for the build status
[14:32:58.714] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:58.714] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:161:0) after 1m0s
[14:33:59.991] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:161:0)
[14:33:59.992] Timer tick, asking Buildbucket for the build status
[14:34:00.194] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:00.194] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:162:0) after 1m0s
[14:35:00.214] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:162:0)
[14:35:00.214] Timer tick, asking Buildbucket for the build status
[14:35:00.323] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:00.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:163:0) after 1m0s
[14:36:00.415] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:163:0)
[14:36:00.415] Timer tick, asking Buildbucket for the build status
[14:36:00.486] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:00.486] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:164:0) after 1m0s
[14:37:02.081] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:164:0)
[14:37:02.081] Timer tick, asking Buildbucket for the build status
[14:37:02.169] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:02.169] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:165:0) after 1m0s
[14:38:02.226] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:165:0)
[14:38:02.226] Timer tick, asking Buildbucket for the build status
[14:38:02.371] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:02.371] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:166:0) after 1m0s
[14:39:02.643] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:166:0)
[14:39:02.643] Timer tick, asking Buildbucket for the build status
[14:39:02.745] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:02.745] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:167:0) after 1m0s
[14:40:02.747] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:167:0)
[14:40:02.747] Timer tick, asking Buildbucket for the build status
[14:40:02.931] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:02.931] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:168:0) after 1m0s
[14:41:03.263] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:168:0)
[14:41:03.263] Timer tick, asking Buildbucket for the build status
[14:41:03.529] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:03.529] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:169:0) after 1m0s
[14:42:03.549] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:169:0)
[14:42:03.549] Timer tick, asking Buildbucket for the build status
[14:42:03.646] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:03.646] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:170:0) after 1m0s
[14:43:03.723] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:170:0)
[14:43:03.723] Timer tick, asking Buildbucket for the build status
[14:43:03.801] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:03.801] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:171:0) after 1m0s
[14:44:03.821] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:171:0)
[14:44:03.821] Timer tick, asking Buildbucket for the build status
[14:44:03.935] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:03.935] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:172:0) after 1m0s
[14:45:03.996] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:172:0)
[14:45:03.996] Timer tick, asking Buildbucket for the build status
[14:45:04.128] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:04.129] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:173:0) after 1m0s
[14:46:04.137] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:173:0)
[14:46:04.137] Timer tick, asking Buildbucket for the build status
[14:46:04.217] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:04.218] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:174:0) after 1m0s
[14:47:04.259] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:174:0)
[14:47:04.259] Timer tick, asking Buildbucket for the build status
[14:47:04.336] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:04.336] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:175:0) after 1m0s
[14:48:04.414] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:175:0)
[14:48:04.414] Timer tick, asking Buildbucket for the build status
[14:48:04.488] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:04.488] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:176:0) after 1m0s
[14:49:04.606] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:176:0)
[14:49:04.606] Timer tick, asking Buildbucket for the build status
[14:49:04.737] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:04.737] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:177:0) after 1m0s
[14:50:04.779] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:177:0)
[14:50:04.779] Timer tick, asking Buildbucket for the build status
[14:50:04.908] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:04.908] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:178:0) after 1m0s
[14:51:05.018] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:178:0)
[14:51:05.018] Timer tick, asking Buildbucket for the build status
[14:51:05.410] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:05.410] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:179:0) after 1m0s
[14:52:05.532] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:179:0)
[14:52:05.532] Timer tick, asking Buildbucket for the build status
[14:52:05.609] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:05.609] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:180:0) after 1m0s
[14:53:05.718] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:180:0)
[14:53:05.718] Timer tick, asking Buildbucket for the build status
[14:53:05.867] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:05.867] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:181:0) after 1m0s
[14:54:05.944] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:181:0)
[14:54:05.944] Timer tick, asking Buildbucket for the build status
[14:54:06.028] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:06.028] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:182:0) after 1m0s
[14:55:06.252] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:182:0)
[14:55:06.252] Timer tick, asking Buildbucket for the build status
[14:55:06.476] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:06.476] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:183:0) after 1m0s
[14:56:06.543] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:183:0)
[14:56:06.543] Timer tick, asking Buildbucket for the build status
[14:56:06.732] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:06.732] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:184:0) after 1m0s
[14:57:06.847] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:184:0)
[14:57:06.847] Timer tick, asking Buildbucket for the build status
[14:57:07.032] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:07.032] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:185:0) after 1m0s
[14:58:07.245] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:185:0)
[14:58:07.245] Timer tick, asking Buildbucket for the build status
[14:58:07.316] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:07.316] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:186:0) after 1m0s
[14:59:07.416] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:186:0)
[14:59:07.416] Timer tick, asking Buildbucket for the build status
[14:59:09.482] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:09.482] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:187:0) after 1m0s
[15:00:09.577] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:187:0)
[15:00:09.577] Timer tick, asking Buildbucket for the build status
[15:00:10.731] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:10.731] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:188:0) after 1m0s
[15:01:10.906] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:188:0)
[15:01:10.906] Timer tick, asking Buildbucket for the build status
[15:01:11.044] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:11.044] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:189:0) after 1m0s
[15:02:11.121] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:189:0)
[15:02:11.121] Timer tick, asking Buildbucket for the build status
[15:02:11.228] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:11.228] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:190:0) after 1m0s
[15:03:11.305] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:190:0)
[15:03:11.305] Timer tick, asking Buildbucket for the build status
[15:03:11.677] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:11.677] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:191:0) after 1m0s
[15:04:11.819] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:191:0)
[15:04:11.819] Timer tick, asking Buildbucket for the build status
[15:04:11.907] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:11.907] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:192:0) after 1m0s
[15:05:12.100] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:192:0)
[15:05:12.100] Timer tick, asking Buildbucket for the build status
[15:05:13.106] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:13.106] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:193:0) after 1m0s
[15:06:13.133] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:193:0)
[15:06:13.133] Timer tick, asking Buildbucket for the build status
[15:06:13.254] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:13.254] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:194:0) after 1m0s
[15:07:13.308] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:194:0)
[15:07:13.309] Timer tick, asking Buildbucket for the build status
[15:07:13.368] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:13.368] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:195:0) after 1m0s
[15:08:13.433] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:195:0)
[15:08:13.433] Timer tick, asking Buildbucket for the build status
[15:08:13.833] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:13.833] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:196:0) after 1m0s
[15:09:13.892] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:196:0)
[15:09:13.892] Timer tick, asking Buildbucket for the build status
[15:09:14.009] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:14.009] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:197:0) after 1m0s
[15:10:14.116] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:197:0)
[15:10:14.116] Timer tick, asking Buildbucket for the build status
[15:10:14.548] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:14.548] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:198:0) after 1m0s
[15:11:14.601] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:198:0)
[15:11:14.601] Timer tick, asking Buildbucket for the build status
[15:11:14.880] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:14.880] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:199:0) after 1m0s
[15:12:14.914] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:199:0)
[15:12:14.914] Timer tick, asking Buildbucket for the build status
[15:12:15.100] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:15.100] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:200:0) after 1m0s
[15:13:15.133] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:200:0)
[15:13:15.133] Timer tick, asking Buildbucket for the build status
[15:13:15.205] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:15.205] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:201:0) after 1m0s
[15:14:15.236] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:201:0)
[15:14:15.236] Timer tick, asking Buildbucket for the build status
[15:14:15.323] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:15.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:202:0) after 1m0s
[15:15:15.380] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:202:0)
[15:15:15.380] Timer tick, asking Buildbucket for the build status
[15:15:16.073] Build 8865650277506674304: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:16.073] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9031080339484961904:203:0) after 1m0s
[15:15:32.375] Received PubSub notification, asking Buildbucket for the build status
[15:15:32.526] Build 8865650277506674304: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:15:32.526] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603466131465507",
"created_by": "project:chromium",
"created_ts": "1603454054309845",
"id": "8865650277506674304",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"289317613ad15098634c2d87e179e631a81e3c54\"}}",
"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\": \"289317613ad15098634c2d87e179e631a81e3c54\", \"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-6-1dls\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 801, \"got_angle_revision\": \"5641e3c185a85c04f40441698d693773b1e9e808\", \"got_dawn_revision\": \"ade9a5235c73656699662ec9371a9d42fea34ac6\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"289317613ad15098634c2d87e179e631a81e3c54\", \"got_revision_cp\": \"refs/heads/master@{#820201}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"cdd7e6fa2dcc5c9b616b5974b2d3951d9a3856b9\", \"got_v8_revision_cp\": \"refs/heads/8.8.152@{#2}\", \"got_webrtc_revision\": \"871500da90418cc3e80e8a0eef257ce11abadd27\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32475}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"289317613ad15098634c2d87e179e631a81e3c54\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_f6b49936a2965b3cdad8f63ce13313d0c4b82119a9acfffbfe199e91c26d0c88_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-6-1dls\"], \"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\": [\"5612-26d29a7\"], \"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": "1603454112076697",
"status": "COMPLETED",
"status_changed_ts": "1603466132127655",
"tags": [
"build_address:luci.chromium.ci/win32-official/801",
"builder:win32-official",
"buildset:commit/git/289317613ad15098634c2d87e179e631a81e3c54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/289317613ad15098634c2d87e179e631a81e3c54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031080339484961904",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865650277506674304/+/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:4f6e20babbbf8a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603466132133877",
"url": "https://ci.chromium.org/b/8865650277506674304",
"utcnow_ts": "1603466132500854"
}
}
[15:15:32.526] Invocation finished in 3h21m19.487504503s with status SUCCEEDED