[15:56:14.355] New invocation is queued and will start shortly
[15:56:15.507] Starting the invocation (attempt 1)
[15:56:15.579] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:56:15.579] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:56:15.579] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027622428075974016",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cdf4fd98bc49d4339b7e7586a42c0196e2599483\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9027622428075974016",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/cdf4fd98bc49d4339b7e7586a42c0196e2599483",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cdf4fd98bc49d4339b7e7586a42c0196e2599483",
"gitiles_ref:refs/heads/master"
]
}
[15:56:20.883] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606751775971728",
"id": "8862192365717455008",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cdf4fd98bc49d4339b7e7586a42c0196e2599483\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606751780277692",
"tags": [
"build_address:luci.chromium.ci/win32-official/1031",
"builder:win32-official",
"buildset:commit/git/cdf4fd98bc49d4339b7e7586a42c0196e2599483",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cdf4fd98bc49d4339b7e7586a42c0196e2599483",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027622428075974016",
"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/8862192365717455008/+/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": "1606751780279061",
"url": "https://ci.chromium.org/b/8862192365717455008",
"utcnow_ts": "1606751780869558"
}
}
[15:56:20.883] Task URL: https://ci.chromium.org/b/8862192365717455008
[15:56:20.883] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:2:0) after 1m0s
[15:57:09.545] Received PubSub notification, asking Buildbucket for the build status
[15:57:09.621] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:21.120] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:2:0)
[15:57:21.120] Timer tick, asking Buildbucket for the build status
[15:57:21.445] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:21.445] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:4:0) after 1m0s
[15:58:21.802] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:4:0)
[15:58:21.802] Timer tick, asking Buildbucket for the build status
[15:58:22.009] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:22.009] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:5:0) after 1m0s
[15:59:22.447] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:5:0)
[15:59:22.447] Timer tick, asking Buildbucket for the build status
[15:59:22.600] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:22.600] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:6:0) after 1m0s
[16:00:22.904] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:6:0)
[16:00:22.904] Timer tick, asking Buildbucket for the build status
[16:00:23.656] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:23.656] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:7:0) after 1m0s
[16:01:23.747] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:7:0)
[16:01:23.747] Timer tick, asking Buildbucket for the build status
[16:01:24.823] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:24.823] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:8:0) after 1m0s
[16:02:24.892] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:8:0)
[16:02:24.892] Timer tick, asking Buildbucket for the build status
[16:02:25.097] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:25.097] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:9:0) after 1m0s
[16:03:25.165] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:9:0)
[16:03:25.165] Timer tick, asking Buildbucket for the build status
[16:03:25.264] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:25.264] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:10:0) after 1m0s
[16:04:25.554] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:10:0)
[16:04:25.554] Timer tick, asking Buildbucket for the build status
[16:04:25.645] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:25.645] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:11:0) after 1m0s
[16:05:25.806] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:11:0)
[16:05:25.806] Timer tick, asking Buildbucket for the build status
[16:05:25.927] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:25.927] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:12:0) after 1m0s
[16:06:26.017] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:12:0)
[16:06:26.017] Timer tick, asking Buildbucket for the build status
[16:06:26.147] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:26.147] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:13:0) after 1m0s
[16:07:26.308] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:13:0)
[16:07:26.308] Timer tick, asking Buildbucket for the build status
[16:07:26.717] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:26.717] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:14:0) after 1m0s
[16:08:26.820] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:14:0)
[16:08:26.820] Timer tick, asking Buildbucket for the build status
[16:08:26.940] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:26.940] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:15:0) after 1m0s
[16:09:27.116] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:15:0)
[16:09:27.116] Timer tick, asking Buildbucket for the build status
[16:09:27.232] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:27.232] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:16:0) after 1m0s
[16:10:27.293] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:16:0)
[16:10:27.293] Timer tick, asking Buildbucket for the build status
[16:10:27.395] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:27.395] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:17:0) after 1m0s
[16:11:27.399] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:17:0)
[16:11:27.399] Timer tick, asking Buildbucket for the build status
[16:11:28.031] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:28.031] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:18:0) after 1m0s
[16:12:28.360] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:18:0)
[16:12:28.361] Timer tick, asking Buildbucket for the build status
[16:12:28.419] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:28.419] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:19:0) after 1m0s
[16:13:28.466] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:19:0)
[16:13:28.466] Timer tick, asking Buildbucket for the build status
[16:13:28.611] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:28.611] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:20:0) after 1m0s
[16:14:28.646] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:20:0)
[16:14:28.646] Timer tick, asking Buildbucket for the build status
[16:14:28.776] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:28.776] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:21:0) after 1m0s
[16:15:28.808] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:21:0)
[16:15:28.808] Timer tick, asking Buildbucket for the build status
[16:15:28.961] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:28.961] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:22:0) after 1m0s
[16:16:29.099] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:22:0)
[16:16:29.099] Timer tick, asking Buildbucket for the build status
[16:16:29.203] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:29.203] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:23:0) after 1m0s
[16:17:29.367] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:23:0)
[16:17:29.367] Timer tick, asking Buildbucket for the build status
[16:17:29.495] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:29.495] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:24:0) after 1m0s
[16:18:29.557] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:24:0)
[16:18:29.557] Timer tick, asking Buildbucket for the build status
[16:18:29.645] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:29.645] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:25:0) after 1m0s
[16:19:29.774] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:25:0)
[16:19:29.774] Timer tick, asking Buildbucket for the build status
[16:19:29.830] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:29.830] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:26:0) after 1m0s
[16:20:29.861] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:26:0)
[16:20:29.861] Timer tick, asking Buildbucket for the build status
[16:20:29.924] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:29.924] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:27:0) after 1m0s
[16:21:30.019] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:27:0)
[16:21:30.019] Timer tick, asking Buildbucket for the build status
[16:21:30.558] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:30.558] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:28:0) after 1m0s
[16:22:30.642] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:28:0)
[16:22:30.642] Timer tick, asking Buildbucket for the build status
[16:22:30.884] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:30.884] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:29:0) after 1m0s
[16:23:30.936] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:29:0)
[16:23:30.936] Timer tick, asking Buildbucket for the build status
[16:23:31.065] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:31.065] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:30:0) after 1m0s
[16:24:31.087] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:30:0)
[16:24:31.087] Timer tick, asking Buildbucket for the build status
[16:24:31.163] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:31.163] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:31:0) after 1m0s
[16:25:31.266] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:31:0)
[16:25:31.266] Timer tick, asking Buildbucket for the build status
[16:25:31.363] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:31.363] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:32:0) after 1m0s
[16:26:31.468] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:32:0)
[16:26:31.468] Timer tick, asking Buildbucket for the build status
[16:26:32.144] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:32.144] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:33:0) after 1m0s
[16:27:32.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:33:0)
[16:27:32.198] Timer tick, asking Buildbucket for the build status
[16:27:32.560] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:32.560] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:34:0) after 1m0s
[16:28:32.584] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:34:0)
[16:28:32.584] Timer tick, asking Buildbucket for the build status
[16:28:32.721] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:32.721] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:35:0) after 1m0s
[16:29:32.769] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:35:0)
[16:29:32.769] Timer tick, asking Buildbucket for the build status
[16:29:32.959] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:32.959] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:36:0) after 1m0s
[16:30:32.984] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:36:0)
[16:30:32.984] Timer tick, asking Buildbucket for the build status
[16:30:33.177] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:33.177] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:37:0) after 1m0s
[16:31:33.233] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:37:0)
[16:31:33.233] Timer tick, asking Buildbucket for the build status
[16:31:33.971] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:33.971] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:38:0) after 1m0s
[16:32:34.056] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:38:0)
[16:32:34.056] Timer tick, asking Buildbucket for the build status
[16:32:34.132] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:34.132] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:39:0) after 1m0s
[16:33:34.226] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:39:0)
[16:33:34.226] Timer tick, asking Buildbucket for the build status
[16:33:34.382] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:34.382] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:40:0) after 1m0s
[16:34:34.419] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:40:0)
[16:34:34.419] Timer tick, asking Buildbucket for the build status
[16:34:34.504] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:34.504] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:41:0) after 1m0s
[16:35:34.526] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:41:0)
[16:35:34.526] Timer tick, asking Buildbucket for the build status
[16:35:34.654] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:34.654] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:42:0) after 1m0s
[16:36:34.684] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:42:0)
[16:36:34.684] Timer tick, asking Buildbucket for the build status
[16:36:35.938] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:35.938] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:43:0) after 1m0s
[16:37:36.003] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:43:0)
[16:37:36.003] Timer tick, asking Buildbucket for the build status
[16:37:36.752] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:36.752] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:44:0) after 1m0s
[16:38:36.789] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:44:0)
[16:38:36.789] Timer tick, asking Buildbucket for the build status
[16:38:36.933] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:36.933] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:45:0) after 1m0s
[16:39:36.999] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:45:0)
[16:39:36.999] Timer tick, asking Buildbucket for the build status
[16:39:37.109] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:37.109] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:46:0) after 1m0s
[16:40:37.218] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:46:0)
[16:40:37.218] Timer tick, asking Buildbucket for the build status
[16:40:38.162] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:38.162] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:47:0) after 1m0s
[16:41:38.266] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:47:0)
[16:41:38.266] Timer tick, asking Buildbucket for the build status
[16:41:38.542] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:38.542] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:48:0) after 1m0s
[16:42:38.561] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:48:0)
[16:42:38.561] Timer tick, asking Buildbucket for the build status
[16:42:38.719] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:38.719] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:49:0) after 1m0s
[16:43:38.755] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:49:0)
[16:43:38.755] Timer tick, asking Buildbucket for the build status
[16:43:38.881] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:38.881] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:50:0) after 1m0s
[16:44:38.935] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:50:0)
[16:44:38.935] Timer tick, asking Buildbucket for the build status
[16:44:43.487] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:43.487] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:51:0) after 1m0s
[16:45:43.549] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:51:0)
[16:45:43.549] Timer tick, asking Buildbucket for the build status
[16:45:43.606] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:43.606] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:52:0) after 1m0s
[16:46:43.644] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:52:0)
[16:46:43.644] Timer tick, asking Buildbucket for the build status
[16:46:43.782] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:43.782] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:53:0) after 1m0s
[16:47:43.806] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:53:0)
[16:47:43.806] Timer tick, asking Buildbucket for the build status
[16:47:43.955] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:43.955] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:54:0) after 1m0s
[16:48:43.989] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:54:0)
[16:48:43.989] Timer tick, asking Buildbucket for the build status
[16:48:44.248] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:44.248] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:55:0) after 1m0s
[16:49:44.309] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:55:0)
[16:49:44.309] Timer tick, asking Buildbucket for the build status
[16:49:44.369] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:44.369] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:56:0) after 1m0s
[16:50:44.420] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:56:0)
[16:50:44.420] Timer tick, asking Buildbucket for the build status
[16:50:44.536] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:44.536] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:57:0) after 1m0s
[16:51:44.598] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:57:0)
[16:51:44.598] Timer tick, asking Buildbucket for the build status
[16:51:44.816] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:44.816] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:58:0) after 1m0s
[16:52:44.839] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:58:0)
[16:52:44.839] Timer tick, asking Buildbucket for the build status
[16:52:44.943] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:44.943] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:59:0) after 1m0s
[16:53:44.949] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:59:0)
[16:53:44.949] Timer tick, asking Buildbucket for the build status
[16:53:45.064] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:45.064] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:60:0) after 1m0s
[16:54:45.075] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:60:0)
[16:54:45.075] Timer tick, asking Buildbucket for the build status
[16:54:45.177] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:45.177] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:61:0) after 1m0s
[16:55:45.179] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:61:0)
[16:55:45.179] Timer tick, asking Buildbucket for the build status
[16:55:45.308] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:45.308] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:62:0) after 1m0s
[16:56:45.812] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:62:0)
[16:56:45.812] Timer tick, asking Buildbucket for the build status
[16:56:48.095] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:48.095] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:63:0) after 1m0s
[16:57:48.141] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:63:0)
[16:57:48.141] Timer tick, asking Buildbucket for the build status
[16:57:48.278] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:48.278] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:64:0) after 1m0s
[16:58:48.311] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:64:0)
[16:58:48.311] Timer tick, asking Buildbucket for the build status
[16:58:48.395] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:48.395] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:65:0) after 1m0s
[16:59:48.471] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:65:0)
[16:59:48.471] Timer tick, asking Buildbucket for the build status
[16:59:48.549] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:48.549] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:66:0) after 1m0s
[17:00:49.002] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:66:0)
[17:00:49.002] Timer tick, asking Buildbucket for the build status
[17:00:49.092] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:49.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:67:0) after 1m0s
[17:01:49.312] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:67:0)
[17:01:49.312] Timer tick, asking Buildbucket for the build status
[17:01:49.483] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:49.483] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:68:0) after 1m0s
[17:02:49.629] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:68:0)
[17:02:49.629] Timer tick, asking Buildbucket for the build status
[17:02:49.702] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:49.702] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:69:0) after 1m0s
[17:03:49.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:69:0)
[17:03:49.829] Timer tick, asking Buildbucket for the build status
[17:03:49.898] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:49.898] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:70:0) after 1m0s
[17:04:50.097] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:70:0)
[17:04:50.097] Timer tick, asking Buildbucket for the build status
[17:04:50.246] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:50.246] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:71:0) after 1m0s
[17:05:50.388] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:71:0)
[17:05:50.388] Timer tick, asking Buildbucket for the build status
[17:05:50.485] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:50.485] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:72:0) after 1m0s
[17:06:50.935] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:72:0)
[17:06:50.936] Timer tick, asking Buildbucket for the build status
[17:06:51.272] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:51.272] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:73:0) after 1m0s
[17:07:51.468] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:73:0)
[17:07:51.468] Timer tick, asking Buildbucket for the build status
[17:07:51.527] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:51.527] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:74:0) after 1m0s
[17:08:51.835] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:74:0)
[17:08:51.835] Timer tick, asking Buildbucket for the build status
[17:08:52.198] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:52.198] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:75:0) after 1m0s
[17:09:52.260] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:75:0)
[17:09:52.260] Timer tick, asking Buildbucket for the build status
[17:09:52.359] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:52.359] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:76:0) after 1m0s
[17:10:52.421] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:76:0)
[17:10:52.421] Timer tick, asking Buildbucket for the build status
[17:10:52.514] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:52.514] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:77:0) after 1m0s
[17:11:52.656] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:77:0)
[17:11:52.656] Timer tick, asking Buildbucket for the build status
[17:11:53.369] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:53.369] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:78:0) after 1m0s
[17:12:53.456] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:78:0)
[17:12:53.456] Timer tick, asking Buildbucket for the build status
[17:12:53.529] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:53.529] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:79:0) after 1m0s
[17:13:53.581] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:79:0)
[17:13:53.581] Timer tick, asking Buildbucket for the build status
[17:13:54.256] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:54.256] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:80:0) after 1m0s
[17:14:54.286] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:80:0)
[17:14:54.286] Timer tick, asking Buildbucket for the build status
[17:14:54.355] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:54.355] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:81:0) after 1m0s
[17:15:54.451] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:81:0)
[17:15:54.451] Timer tick, asking Buildbucket for the build status
[17:15:54.728] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:54.728] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:82:0) after 1m0s
[17:16:54.800] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:82:0)
[17:16:54.800] Timer tick, asking Buildbucket for the build status
[17:16:56.156] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:56.156] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:83:0) after 1m0s
[17:17:56.196] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:83:0)
[17:17:56.196] Timer tick, asking Buildbucket for the build status
[17:17:56.413] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:56.413] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:84:0) after 1m0s
[17:18:56.472] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:84:0)
[17:18:56.472] Timer tick, asking Buildbucket for the build status
[17:18:57.167] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:57.167] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:85:0) after 1m0s
[17:19:57.229] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:85:0)
[17:19:57.229] Timer tick, asking Buildbucket for the build status
[17:19:57.400] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:57.400] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:86:0) after 1m0s
[17:20:57.423] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:86:0)
[17:20:57.423] Timer tick, asking Buildbucket for the build status
[17:20:57.504] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:57.504] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:87:0) after 1m0s
[17:21:57.564] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:87:0)
[17:21:57.564] Timer tick, asking Buildbucket for the build status
[17:21:57.718] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:57.718] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:88:0) after 1m0s
[17:22:57.770] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:88:0)
[17:22:57.770] Timer tick, asking Buildbucket for the build status
[17:22:57.973] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:57.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:89:0) after 1m0s
[17:23:58.136] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:89:0)
[17:23:58.136] Timer tick, asking Buildbucket for the build status
[17:23:58.584] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:58.584] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:90:0) after 1m0s
[17:24:58.636] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:90:0)
[17:24:58.636] Timer tick, asking Buildbucket for the build status
[17:24:58.721] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:58.722] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:91:0) after 1m0s
[17:25:58.812] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:91:0)
[17:25:58.812] Timer tick, asking Buildbucket for the build status
[17:25:58.932] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:58.932] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:92:0) after 1m0s
[17:26:59.001] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:92:0)
[17:26:59.001] Timer tick, asking Buildbucket for the build status
[17:26:59.187] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:59.187] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:93:0) after 1m0s
[17:27:59.298] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:93:0)
[17:27:59.298] Timer tick, asking Buildbucket for the build status
[17:27:59.371] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:59.371] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:94:0) after 1m0s
[17:28:59.408] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:94:0)
[17:28:59.408] Timer tick, asking Buildbucket for the build status
[17:28:59.687] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:59.687] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:95:0) after 1m0s
[17:29:59.799] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:95:0)
[17:29:59.799] Timer tick, asking Buildbucket for the build status
[17:29:59.917] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:59.917] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:96:0) after 1m0s
[17:30:59.942] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:96:0)
[17:30:59.942] Timer tick, asking Buildbucket for the build status
[17:31:00.102] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:00.102] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:97:0) after 1m0s
[17:32:00.132] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:97:0)
[17:32:00.132] Timer tick, asking Buildbucket for the build status
[17:32:00.350] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:00.350] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:98:0) after 1m0s
[17:33:01.794] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:98:0)
[17:33:01.794] Timer tick, asking Buildbucket for the build status
[17:33:01.947] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:01.947] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:99:0) after 1m0s
[17:34:02.318] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:99:0)
[17:34:02.318] Timer tick, asking Buildbucket for the build status
[17:34:02.417] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:02.417] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:100:0) after 1m0s
[17:35:03.020] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:100:0)
[17:35:03.020] Timer tick, asking Buildbucket for the build status
[17:35:03.677] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:03.677] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:101:0) after 1m0s
[17:36:03.860] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:101:0)
[17:36:03.860] Timer tick, asking Buildbucket for the build status
[17:36:04.141] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:04.141] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:102:0) after 1m0s
[17:37:04.270] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:102:0)
[17:37:04.270] Timer tick, asking Buildbucket for the build status
[17:37:04.467] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:04.467] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:103:0) after 1m0s
[17:38:04.688] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:103:0)
[17:38:04.688] Timer tick, asking Buildbucket for the build status
[17:38:04.945] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:04.945] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:104:0) after 1m0s
[17:39:04.997] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:104:0)
[17:39:04.997] Timer tick, asking Buildbucket for the build status
[17:39:05.641] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:05.641] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:105:0) after 1m0s
[17:40:05.696] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:105:0)
[17:40:05.696] Timer tick, asking Buildbucket for the build status
[17:40:06.052] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:06.052] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:106:0) after 1m0s
[17:41:06.057] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:106:0)
[17:41:06.057] Timer tick, asking Buildbucket for the build status
[17:41:06.197] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:06.197] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:107:0) after 1m0s
[17:42:06.224] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:107:0)
[17:42:06.224] Timer tick, asking Buildbucket for the build status
[17:42:06.384] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:06.384] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:108:0) after 1m0s
[17:43:06.424] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:108:0)
[17:43:06.424] Timer tick, asking Buildbucket for the build status
[17:43:07.228] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:07.228] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:109:0) after 1m0s
[17:44:07.298] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:109:0)
[17:44:07.298] Timer tick, asking Buildbucket for the build status
[17:44:07.383] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:07.383] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:110:0) after 1m0s
[17:45:07.676] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:110:0)
[17:45:07.677] Timer tick, asking Buildbucket for the build status
[17:45:07.758] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:07.758] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:111:0) after 1m0s
[17:46:07.815] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:111:0)
[17:46:07.815] Timer tick, asking Buildbucket for the build status
[17:46:09.438] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:09.438] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:112:0) after 1m0s
[17:47:09.437] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:112:0)
[17:47:09.437] Timer tick, asking Buildbucket for the build status
[17:47:09.747] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:09.747] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:113:0) after 1m0s
[17:48:09.801] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:113:0)
[17:48:09.801] Timer tick, asking Buildbucket for the build status
[17:48:10.330] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:10.330] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:114:0) after 1m0s
[17:49:10.438] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:114:0)
[17:49:10.438] Timer tick, asking Buildbucket for the build status
[17:49:10.546] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:10.546] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:115:0) after 1m0s
[17:50:10.622] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:115:0)
[17:50:10.622] Timer tick, asking Buildbucket for the build status
[17:50:10.857] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:10.857] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:116:0) after 1m0s
[17:51:11.108] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:116:0)
[17:51:11.108] Timer tick, asking Buildbucket for the build status
[17:51:11.317] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:11.317] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:117:0) after 1m0s
[17:52:11.359] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:117:0)
[17:52:11.359] Timer tick, asking Buildbucket for the build status
[17:52:11.947] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:11.947] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:118:0) after 1m0s
[17:53:12.033] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:118:0)
[17:53:12.033] Timer tick, asking Buildbucket for the build status
[17:53:12.162] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:12.162] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:119:0) after 1m0s
[17:54:12.274] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:119:0)
[17:54:12.274] Timer tick, asking Buildbucket for the build status
[17:54:12.455] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:12.456] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:120:0) after 1m0s
[17:55:12.725] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:120:0)
[17:55:12.725] Timer tick, asking Buildbucket for the build status
[17:55:13.083] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:13.083] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:121:0) after 1m0s
[17:56:13.476] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:121:0)
[17:56:13.476] Timer tick, asking Buildbucket for the build status
[17:56:13.915] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:13.915] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:122:0) after 1m0s
[17:57:14.094] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:122:0)
[17:57:14.094] Timer tick, asking Buildbucket for the build status
[17:57:14.315] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:14.315] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:123:0) after 1m0s
[17:58:14.379] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:123:0)
[17:58:14.379] Timer tick, asking Buildbucket for the build status
[17:58:14.486] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:14.486] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:124:0) after 1m0s
[17:59:14.615] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:124:0)
[17:59:14.615] Timer tick, asking Buildbucket for the build status
[17:59:15.412] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:15.412] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:125:0) after 1m0s
[18:00:16.699] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:125:0)
[18:00:16.701] Timer tick, asking Buildbucket for the build status
[18:00:16.942] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:16.942] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:126:0) after 1m0s
[18:01:17.238] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:126:0)
[18:01:17.238] Timer tick, asking Buildbucket for the build status
[18:01:17.424] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:17.424] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:127:0) after 1m0s
[18:02:18.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:127:0)
[18:02:18.829] Timer tick, asking Buildbucket for the build status
[18:02:19.070] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:19.070] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:128:0) after 1m0s
[18:03:19.915] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:128:0)
[18:03:19.915] Timer tick, asking Buildbucket for the build status
[18:03:19.994] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:19.994] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:129:0) after 1m0s
[18:04:20.025] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:129:0)
[18:04:20.025] Timer tick, asking Buildbucket for the build status
[18:04:20.284] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:20.284] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:130:0) after 1m0s
[18:05:21.885] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:130:0)
[18:05:21.885] Timer tick, asking Buildbucket for the build status
[18:05:22.893] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:22.893] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:131:0) after 1m0s
[18:06:22.966] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:131:0)
[18:06:22.966] Timer tick, asking Buildbucket for the build status
[18:06:23.047] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:23.047] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:132:0) after 1m0s
[18:07:23.230] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:132:0)
[18:07:23.230] Timer tick, asking Buildbucket for the build status
[18:07:23.661] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:23.661] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:133:0) after 1m0s
[18:08:23.781] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:133:0)
[18:08:23.781] Timer tick, asking Buildbucket for the build status
[18:08:23.857] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:23.857] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:134:0) after 1m0s
[18:09:24.006] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:134:0)
[18:09:24.006] Timer tick, asking Buildbucket for the build status
[18:09:24.111] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:24.111] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:135:0) after 1m0s
[18:10:24.718] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:135:0)
[18:10:24.718] Timer tick, asking Buildbucket for the build status
[18:10:24.942] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:24.942] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:136:0) after 1m0s
[18:11:24.979] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:136:0)
[18:11:24.979] Timer tick, asking Buildbucket for the build status
[18:11:25.130] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:25.130] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:137:0) after 1m0s
[18:12:25.479] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:137:0)
[18:12:25.479] Timer tick, asking Buildbucket for the build status
[18:12:25.702] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:25.702] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:138:0) after 1m0s
[18:13:25.742] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:138:0)
[18:13:25.742] Timer tick, asking Buildbucket for the build status
[18:13:25.826] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:25.826] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:139:0) after 1m0s
[18:14:25.939] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:139:0)
[18:14:25.939] Timer tick, asking Buildbucket for the build status
[18:14:27.142] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:27.143] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:140:0) after 1m0s
[18:15:27.877] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:140:0)
[18:15:27.877] Timer tick, asking Buildbucket for the build status
[18:15:28.053] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:28.053] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:141:0) after 1m0s
[18:16:28.588] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:141:0)
[18:16:28.588] Timer tick, asking Buildbucket for the build status
[18:16:28.884] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:28.884] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:142:0) after 1m0s
[18:17:29.076] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:142:0)
[18:17:29.076] Timer tick, asking Buildbucket for the build status
[18:17:29.388] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:29.388] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:143:0) after 1m0s
[18:18:29.418] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:143:0)
[18:18:29.418] Timer tick, asking Buildbucket for the build status
[18:18:29.676] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:29.676] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:144:0) after 1m0s
[18:19:29.833] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:144:0)
[18:19:29.834] Timer tick, asking Buildbucket for the build status
[18:19:29.937] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:29.937] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:145:0) after 1m0s
[18:20:29.994] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:145:0)
[18:20:29.994] Timer tick, asking Buildbucket for the build status
[18:20:30.389] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:30.389] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:146:0) after 1m0s
[18:21:30.471] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:146:0)
[18:21:30.471] Timer tick, asking Buildbucket for the build status
[18:21:30.923] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:30.923] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:147:0) after 1m0s
[18:22:30.973] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:147:0)
[18:22:30.973] Timer tick, asking Buildbucket for the build status
[18:22:31.043] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:31.043] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:148:0) after 1m0s
[18:23:31.098] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:148:0)
[18:23:31.098] Timer tick, asking Buildbucket for the build status
[18:23:31.181] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:31.181] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:149:0) after 1m0s
[18:24:31.212] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:149:0)
[18:24:31.212] Timer tick, asking Buildbucket for the build status
[18:24:31.264] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:31.264] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:150:0) after 1m0s
[18:25:31.641] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:150:0)
[18:25:31.641] Timer tick, asking Buildbucket for the build status
[18:25:31.751] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:31.751] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:151:0) after 1m0s
[18:26:31.814] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:151:0)
[18:26:31.814] Timer tick, asking Buildbucket for the build status
[18:26:31.924] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:31.924] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:152:0) after 1m0s
[18:27:31.975] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:152:0)
[18:27:31.975] Timer tick, asking Buildbucket for the build status
[18:27:32.050] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:32.050] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:153:0) after 1m0s
[18:28:32.053] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:153:0)
[18:28:32.053] Timer tick, asking Buildbucket for the build status
[18:28:32.681] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:32.681] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:154:0) after 1m0s
[18:29:32.767] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:154:0)
[18:29:32.767] Timer tick, asking Buildbucket for the build status
[18:29:33.758] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:33.758] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:155:0) after 1m0s
[18:30:33.786] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:155:0)
[18:30:33.786] Timer tick, asking Buildbucket for the build status
[18:30:33.849] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:33.849] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:156:0) after 1m0s
[18:31:33.911] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:156:0)
[18:31:33.911] Timer tick, asking Buildbucket for the build status
[18:31:34.097] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:34.097] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:157:0) after 1m0s
[18:32:34.230] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:157:0)
[18:32:34.230] Timer tick, asking Buildbucket for the build status
[18:32:34.310] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:34.310] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:158:0) after 1m0s
[18:33:34.586] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:158:0)
[18:33:34.586] Timer tick, asking Buildbucket for the build status
[18:33:34.810] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:34.810] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:159:0) after 1m0s
[18:34:34.926] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:159:0)
[18:34:34.926] Timer tick, asking Buildbucket for the build status
[18:34:35.063] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:35.063] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:160:0) after 1m0s
[18:35:35.300] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:160:0)
[18:35:35.300] Timer tick, asking Buildbucket for the build status
[18:35:35.432] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:35.432] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:161:0) after 1m0s
[18:36:35.658] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:161:0)
[18:36:35.658] Timer tick, asking Buildbucket for the build status
[18:36:35.832] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:35.832] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:162:0) after 1m0s
[18:37:35.859] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:162:0)
[18:37:35.859] Timer tick, asking Buildbucket for the build status
[18:37:36.075] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:36.075] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:163:0) after 1m0s
[18:38:36.137] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:163:0)
[18:38:36.137] Timer tick, asking Buildbucket for the build status
[18:38:36.304] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:36.304] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:164:0) after 1m0s
[18:39:36.316] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:164:0)
[18:39:36.316] Timer tick, asking Buildbucket for the build status
[18:39:36.393] Build 8862192365717455008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:36.393] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9027622428075974016:165:0) after 1m0s
[18:40:31.338] Received PubSub notification, asking Buildbucket for the build status
[18:40:31.453] Build 8862192365717455008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:40:31.453] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606761630184251",
"created_by": "project:chromium",
"created_ts": "1606751775971728",
"id": "8862192365717455008",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cdf4fd98bc49d4339b7e7586a42c0196e2599483\"}}",
"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\": \"cdf4fd98bc49d4339b7e7586a42c0196e2599483\", \"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-2-d7vq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1031, \"got_angle_revision\": \"3d061021c920ada75c5d9ab2424ca5a037607212\", \"got_dawn_revision\": \"d8bb0bb7c735173219d7a8ffec18eee1813ff302\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"cdf4fd98bc49d4339b7e7586a42c0196e2599483\", \"got_revision_cp\": \"refs/heads/master@{#831852}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"9dff6a3bb5950edd890e5141f2d3d2f3b4ef351e\", \"got_v8_revision\": \"ac4c4dc02664bb5a541f817619e037f60a4b2437\", \"got_v8_revision_cp\": \"refs/heads/8.9.69@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cdf4fd98bc49d4339b7e7586a42c0196e2599483\"}, \"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-2-d7vq\"], \"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\": [\"5640-d0eb544\"], \"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": "1606751814378453",
"status": "COMPLETED",
"status_changed_ts": "1606761630786167",
"tags": [
"build_address:luci.chromium.ci/win32-official/1031",
"builder:win32-official",
"buildset:commit/git/cdf4fd98bc49d4339b7e7586a42c0196e2599483",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cdf4fd98bc49d4339b7e7586a42c0196e2599483",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027622428075974016",
"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/8862192365717455008/+/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:5032b009d8b2ec10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606761630850892",
"url": "https://ci.chromium.org/b/8862192365717455008",
"utcnow_ts": "1606761631442172"
}
}
[18:40:31.453] Invocation finished in 2h44m17.115309104s with status SUCCEEDED