[04:31:21.204] New invocation is queued and will start shortly
[04:31:22.283] Starting the invocation (attempt 1)
[04:31:22.317] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:31:22.317] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:31:22.317] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026397159837914208",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"11e0cfbdb5d2548af8619c32dec227358d0a119d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9026397159837914208",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/11e0cfbdb5d2548af8619c32dec227358d0a119d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11e0cfbdb5d2548af8619c32dec227358d0a119d",
"gitiles_ref:refs/heads/master"
]
}
[04:31:23.220] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607920282568548",
"id": "8860967097743826560",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11e0cfbdb5d2548af8619c32dec227358d0a119d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607920283073193",
"tags": [
"build_address:luci.chromium.ci/win32-official/1108",
"builder:win32-official",
"buildset:commit/git/11e0cfbdb5d2548af8619c32dec227358d0a119d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11e0cfbdb5d2548af8619c32dec227358d0a119d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026397159837914208",
"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/8860967097743826560/+/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": "1607920283073393",
"url": "https://ci.chromium.org/b/8860967097743826560",
"utcnow_ts": "1607920283210434"
}
}
[04:31:23.220] Task URL: https://ci.chromium.org/b/8860967097743826560
[04:31:23.220] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:2:0) after 1m0s
[04:32:23.304] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:2:0)
[04:32:23.304] Timer tick, asking Buildbucket for the build status
[04:32:23.415] Build 8860967097743826560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:23.415] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:3:0) after 1m0s
[04:33:23.432] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:3:0)
[04:33:23.432] Timer tick, asking Buildbucket for the build status
[04:33:23.505] Build 8860967097743826560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:23.505] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:4:0) after 1m0s
[04:34:23.529] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:4:0)
[04:34:23.529] Timer tick, asking Buildbucket for the build status
[04:34:23.650] Build 8860967097743826560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:23.650] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:5:0) after 1m0s
[04:34:58.956] Received PubSub notification, asking Buildbucket for the build status
[04:34:59.028] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:23.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:5:0)
[04:35:23.631] Timer tick, asking Buildbucket for the build status
[04:35:23.700] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:23.700] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:7:0) after 1m0s
[04:36:23.689] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:7:0)
[04:36:23.689] Timer tick, asking Buildbucket for the build status
[04:36:23.779] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:23.779] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:8:0) after 1m0s
[04:37:23.831] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:8:0)
[04:37:23.831] Timer tick, asking Buildbucket for the build status
[04:37:24.228] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:24.228] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:9:0) after 1m0s
[04:38:24.246] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:9:0)
[04:38:24.246] Timer tick, asking Buildbucket for the build status
[04:38:24.646] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:24.646] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:10:0) after 1m0s
[04:39:24.663] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:10:0)
[04:39:24.663] Timer tick, asking Buildbucket for the build status
[04:39:24.747] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:24.747] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:11:0) after 1m0s
[04:40:24.750] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:11:0)
[04:40:24.750] Timer tick, asking Buildbucket for the build status
[04:40:24.825] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:24.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:12:0) after 1m0s
[04:41:24.840] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:12:0)
[04:41:24.840] Timer tick, asking Buildbucket for the build status
[04:41:24.913] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:24.913] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:13:0) after 1m0s
[04:42:24.930] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:13:0)
[04:42:24.930] Timer tick, asking Buildbucket for the build status
[04:42:25.027] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:25.027] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:14:0) after 1m0s
[04:43:25.044] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:14:0)
[04:43:25.044] Timer tick, asking Buildbucket for the build status
[04:43:25.313] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:25.313] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:15:0) after 1m0s
[04:44:25.363] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:15:0)
[04:44:25.363] Timer tick, asking Buildbucket for the build status
[04:44:25.445] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:25.445] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:16:0) after 1m0s
[04:45:25.572] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:16:0)
[04:45:25.572] Timer tick, asking Buildbucket for the build status
[04:45:25.664] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:25.664] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:17:0) after 1m0s
[04:46:25.714] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:17:0)
[04:46:25.714] Timer tick, asking Buildbucket for the build status
[04:46:25.865] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:25.865] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:18:0) after 1m0s
[04:47:25.886] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:18:0)
[04:47:25.886] Timer tick, asking Buildbucket for the build status
[04:47:25.994] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:25.994] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:19:0) after 1m0s
[04:48:26.080] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:19:0)
[04:48:26.080] Timer tick, asking Buildbucket for the build status
[04:48:26.148] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:26.148] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:20:0) after 1m0s
[04:49:26.150] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:20:0)
[04:49:26.150] Timer tick, asking Buildbucket for the build status
[04:49:26.225] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:26.225] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:21:0) after 1m0s
[04:50:26.241] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:21:0)
[04:50:26.241] Timer tick, asking Buildbucket for the build status
[04:50:26.343] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:26.343] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:22:0) after 1m0s
[04:51:26.366] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:22:0)
[04:51:26.366] Timer tick, asking Buildbucket for the build status
[04:51:26.433] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:26.433] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:23:0) after 1m0s
[04:52:26.451] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:23:0)
[04:52:26.451] Timer tick, asking Buildbucket for the build status
[04:52:26.566] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:26.566] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:24:0) after 1m0s
[04:53:26.584] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:24:0)
[04:53:26.584] Timer tick, asking Buildbucket for the build status
[04:53:26.676] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:26.676] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:25:0) after 1m0s
[04:54:26.649] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:25:0)
[04:54:26.649] Timer tick, asking Buildbucket for the build status
[04:54:26.906] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:26.906] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:26:0) after 1m0s
[04:55:27.023] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:26:0)
[04:55:27.023] Timer tick, asking Buildbucket for the build status
[04:55:27.099] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:27.099] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:27:0) after 1m0s
[04:56:27.090] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:27:0)
[04:56:27.090] Timer tick, asking Buildbucket for the build status
[04:56:27.182] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:27.182] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:28:0) after 1m0s
[04:57:27.241] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:28:0)
[04:57:27.241] Timer tick, asking Buildbucket for the build status
[04:57:27.348] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:27.348] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:29:0) after 1m0s
[04:58:27.423] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:29:0)
[04:58:27.423] Timer tick, asking Buildbucket for the build status
[04:58:27.525] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:27.525] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:30:0) after 1m0s
[04:59:27.547] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:30:0)
[04:59:27.547] Timer tick, asking Buildbucket for the build status
[04:59:28.254] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:28.254] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:31:0) after 1m0s
[05:00:28.289] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:31:0)
[05:00:28.289] Timer tick, asking Buildbucket for the build status
[05:00:28.365] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:28.365] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:32:0) after 1m0s
[05:01:28.384] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:32:0)
[05:01:28.384] Timer tick, asking Buildbucket for the build status
[05:01:28.583] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:28.583] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:33:0) after 1m0s
[05:02:28.594] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:33:0)
[05:02:28.594] Timer tick, asking Buildbucket for the build status
[05:02:28.927] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:28.927] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:34:0) after 1m0s
[05:03:28.950] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:34:0)
[05:03:28.950] Timer tick, asking Buildbucket for the build status
[05:03:29.018] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:29.018] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:35:0) after 1m0s
[05:04:29.034] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:35:0)
[05:04:29.034] Timer tick, asking Buildbucket for the build status
[05:04:29.098] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:29.098] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:36:0) after 1m0s
[05:05:29.185] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:36:0)
[05:05:29.185] Timer tick, asking Buildbucket for the build status
[05:05:29.240] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:29.241] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:37:0) after 1m0s
[05:06:29.331] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:37:0)
[05:06:29.331] Timer tick, asking Buildbucket for the build status
[05:06:29.385] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:29.385] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:38:0) after 1m0s
[05:07:29.376] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:38:0)
[05:07:29.376] Timer tick, asking Buildbucket for the build status
[05:07:29.478] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:29.478] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:39:0) after 1m0s
[05:08:29.532] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:39:0)
[05:08:29.532] Timer tick, asking Buildbucket for the build status
[05:08:29.629] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:29.629] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:40:0) after 1m0s
[05:09:29.671] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:40:0)
[05:09:29.671] Timer tick, asking Buildbucket for the build status
[05:09:29.970] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:29.970] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:41:0) after 1m0s
[05:10:29.947] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:41:0)
[05:10:29.947] Timer tick, asking Buildbucket for the build status
[05:10:30.044] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:30.044] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:42:0) after 1m0s
[05:11:30.067] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:42:0)
[05:11:30.067] Timer tick, asking Buildbucket for the build status
[05:11:30.132] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:30.132] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:43:0) after 1m0s
[05:12:30.165] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:43:0)
[05:12:30.165] Timer tick, asking Buildbucket for the build status
[05:12:30.545] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:30.545] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:44:0) after 1m0s
[05:13:30.593] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:44:0)
[05:13:30.593] Timer tick, asking Buildbucket for the build status
[05:13:30.674] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:30.674] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:45:0) after 1m0s
[05:14:30.751] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:45:0)
[05:14:30.751] Timer tick, asking Buildbucket for the build status
[05:14:31.298] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:31.298] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:46:0) after 1m0s
[05:15:31.318] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:46:0)
[05:15:31.318] Timer tick, asking Buildbucket for the build status
[05:15:31.703] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:31.703] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:47:0) after 1m0s
[05:16:31.725] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:47:0)
[05:16:31.725] Timer tick, asking Buildbucket for the build status
[05:16:31.916] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:31.916] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:48:0) after 1m0s
[05:17:31.935] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:48:0)
[05:17:31.935] Timer tick, asking Buildbucket for the build status
[05:17:32.066] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:32.066] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:49:0) after 1m0s
[05:18:32.087] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:49:0)
[05:18:32.087] Timer tick, asking Buildbucket for the build status
[05:18:32.173] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:32.173] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:50:0) after 1m0s
[05:19:32.195] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:50:0)
[05:19:32.195] Timer tick, asking Buildbucket for the build status
[05:19:32.466] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:32.466] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:51:0) after 1m0s
[05:20:32.491] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:51:0)
[05:20:32.491] Timer tick, asking Buildbucket for the build status
[05:20:32.566] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:32.566] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:52:0) after 1m0s
[05:21:32.592] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:52:0)
[05:21:32.592] Timer tick, asking Buildbucket for the build status
[05:21:32.659] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:32.659] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:53:0) after 1m0s
[05:22:32.677] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:53:0)
[05:22:32.677] Timer tick, asking Buildbucket for the build status
[05:22:32.938] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:32.938] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:54:0) after 1m0s
[05:23:32.978] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:54:0)
[05:23:32.978] Timer tick, asking Buildbucket for the build status
[05:23:33.079] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:33.079] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:55:0) after 1m0s
[05:24:33.101] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:55:0)
[05:24:33.101] Timer tick, asking Buildbucket for the build status
[05:24:33.264] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:33.264] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:56:0) after 1m0s
[05:25:33.292] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:56:0)
[05:25:33.292] Timer tick, asking Buildbucket for the build status
[05:25:33.778] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:33.778] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:57:0) after 1m0s
[05:26:33.779] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:57:0)
[05:26:33.779] Timer tick, asking Buildbucket for the build status
[05:26:33.890] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:33.890] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:58:0) after 1m0s
[05:27:33.914] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:58:0)
[05:27:33.914] Timer tick, asking Buildbucket for the build status
[05:27:34.399] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:34.399] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:59:0) after 1m0s
[05:28:34.442] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:59:0)
[05:28:34.442] Timer tick, asking Buildbucket for the build status
[05:28:34.505] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:34.505] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:60:0) after 1m0s
[05:29:34.523] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:60:0)
[05:29:34.523] Timer tick, asking Buildbucket for the build status
[05:29:34.592] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:34.592] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:61:0) after 1m0s
[05:30:34.681] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:61:0)
[05:30:34.681] Timer tick, asking Buildbucket for the build status
[05:30:34.742] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:34.742] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:62:0) after 1m0s
[05:31:34.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:62:0)
[05:31:34.752] Timer tick, asking Buildbucket for the build status
[05:31:34.834] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:34.834] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:63:0) after 1m0s
[05:32:34.850] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:63:0)
[05:32:34.850] Timer tick, asking Buildbucket for the build status
[05:32:34.953] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:34.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:64:0) after 1m0s
[05:33:34.970] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:64:0)
[05:33:34.970] Timer tick, asking Buildbucket for the build status
[05:33:35.301] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:35.301] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:65:0) after 1m0s
[05:34:35.288] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:65:0)
[05:34:35.288] Timer tick, asking Buildbucket for the build status
[05:34:35.518] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:35.518] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:66:0) after 1m0s
[05:35:35.601] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:66:0)
[05:35:35.601] Timer tick, asking Buildbucket for the build status
[05:35:35.660] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:35.660] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:67:0) after 1m0s
[05:36:35.724] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:67:0)
[05:36:35.724] Timer tick, asking Buildbucket for the build status
[05:36:35.784] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:35.784] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:68:0) after 1m0s
[05:37:35.802] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:68:0)
[05:37:35.802] Timer tick, asking Buildbucket for the build status
[05:37:35.890] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:35.890] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:69:0) after 1m0s
[05:38:35.911] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:69:0)
[05:38:35.911] Timer tick, asking Buildbucket for the build status
[05:38:36.042] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:36.042] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:70:0) after 1m0s
[05:39:36.083] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:70:0)
[05:39:36.083] Timer tick, asking Buildbucket for the build status
[05:39:36.340] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:36.340] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:71:0) after 1m0s
[05:40:36.436] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:71:0)
[05:40:36.437] Timer tick, asking Buildbucket for the build status
[05:40:36.499] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:36.499] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:72:0) after 1m0s
[05:41:36.503] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:72:0)
[05:41:36.503] Timer tick, asking Buildbucket for the build status
[05:41:36.552] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:36.552] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:73:0) after 1m0s
[05:42:36.537] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:73:0)
[05:42:36.537] Timer tick, asking Buildbucket for the build status
[05:42:36.641] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:36.641] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:74:0) after 1m0s
[05:43:36.659] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:74:0)
[05:43:36.659] Timer tick, asking Buildbucket for the build status
[05:43:36.724] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:36.724] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:75:0) after 1m0s
[05:44:36.746] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:75:0)
[05:44:36.746] Timer tick, asking Buildbucket for the build status
[05:44:36.814] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:36.814] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:76:0) after 1m0s
[05:45:36.866] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:76:0)
[05:45:36.866] Timer tick, asking Buildbucket for the build status
[05:45:36.930] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:36.930] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:77:0) after 1m0s
[05:46:36.950] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:77:0)
[05:46:36.950] Timer tick, asking Buildbucket for the build status
[05:46:37.011] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:37.011] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:78:0) after 1m0s
[05:47:37.064] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:78:0)
[05:47:37.064] Timer tick, asking Buildbucket for the build status
[05:47:37.167] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:37.167] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:79:0) after 1m0s
[05:48:37.188] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:79:0)
[05:48:37.188] Timer tick, asking Buildbucket for the build status
[05:48:37.255] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:37.255] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:80:0) after 1m0s
[05:49:37.287] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:80:0)
[05:49:37.287] Timer tick, asking Buildbucket for the build status
[05:49:37.351] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:37.351] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:81:0) after 1m0s
[05:50:37.438] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:81:0)
[05:50:37.438] Timer tick, asking Buildbucket for the build status
[05:50:37.491] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:37.491] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:82:0) after 1m0s
[05:51:37.515] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:82:0)
[05:51:37.515] Timer tick, asking Buildbucket for the build status
[05:51:37.573] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:37.573] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:83:0) after 1m0s
[05:52:37.559] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:83:0)
[05:52:37.559] Timer tick, asking Buildbucket for the build status
[05:52:37.664] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:37.664] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:84:0) after 1m0s
[05:53:37.684] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:84:0)
[05:53:37.684] Timer tick, asking Buildbucket for the build status
[05:53:37.753] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:37.753] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:85:0) after 1m0s
[05:54:37.774] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:85:0)
[05:54:37.774] Timer tick, asking Buildbucket for the build status
[05:54:37.840] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:37.840] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:86:0) after 1m0s
[05:55:37.924] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:86:0)
[05:55:37.924] Timer tick, asking Buildbucket for the build status
[05:55:37.988] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:37.988] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:87:0) after 1m0s
[05:56:38.115] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:87:0)
[05:56:38.115] Timer tick, asking Buildbucket for the build status
[05:56:38.226] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:38.226] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:88:0) after 1m0s
[05:57:38.420] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:88:0)
[05:57:38.420] Timer tick, asking Buildbucket for the build status
[05:57:38.522] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:38.522] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:89:0) after 1m0s
[05:58:38.680] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:89:0)
[05:58:38.680] Timer tick, asking Buildbucket for the build status
[05:58:38.736] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:38.736] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:90:0) after 1m0s
[05:59:38.825] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:90:0)
[05:59:38.825] Timer tick, asking Buildbucket for the build status
[05:59:39.209] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:39.209] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:91:0) after 1m0s
[06:00:39.253] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:91:0)
[06:00:39.253] Timer tick, asking Buildbucket for the build status
[06:00:39.317] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:39.317] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:92:0) after 1m0s
[06:01:39.342] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:92:0)
[06:01:39.342] Timer tick, asking Buildbucket for the build status
[06:01:39.403] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:39.403] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:93:0) after 1m0s
[06:02:39.430] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:93:0)
[06:02:39.430] Timer tick, asking Buildbucket for the build status
[06:02:39.529] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:39.529] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:94:0) after 1m0s
[06:03:39.573] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:94:0)
[06:03:39.573] Timer tick, asking Buildbucket for the build status
[06:03:39.627] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:39.627] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:95:0) after 1m0s
[06:04:39.693] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:95:0)
[06:04:39.693] Timer tick, asking Buildbucket for the build status
[06:04:39.768] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:39.768] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:96:0) after 1m0s
[06:05:39.800] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:96:0)
[06:05:39.800] Timer tick, asking Buildbucket for the build status
[06:05:39.866] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:39.866] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:97:0) after 1m0s
[06:06:39.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:97:0)
[06:06:39.901] Timer tick, asking Buildbucket for the build status
[06:06:39.973] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:39.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:98:0) after 1m0s
[06:07:40.179] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:98:0)
[06:07:40.179] Timer tick, asking Buildbucket for the build status
[06:07:40.269] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:40.269] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:99:0) after 1m0s
[06:08:40.309] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:99:0)
[06:08:40.309] Timer tick, asking Buildbucket for the build status
[06:08:40.374] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:40.374] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:100:0) after 1m0s
[06:09:40.460] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:100:0)
[06:09:40.460] Timer tick, asking Buildbucket for the build status
[06:09:40.529] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:40.529] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:101:0) after 1m0s
[06:10:40.580] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:101:0)
[06:10:40.580] Timer tick, asking Buildbucket for the build status
[06:10:40.646] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:40.646] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:102:0) after 1m0s
[06:11:41.373] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:102:0)
[06:11:41.373] Timer tick, asking Buildbucket for the build status
[06:11:41.436] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:41.436] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:103:0) after 1m0s
[06:12:41.545] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:103:0)
[06:12:41.545] Timer tick, asking Buildbucket for the build status
[06:12:41.645] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:41.645] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:104:0) after 1m0s
[06:13:41.667] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:104:0)
[06:13:41.667] Timer tick, asking Buildbucket for the build status
[06:13:41.908] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:41.909] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:105:0) after 1m0s
[06:14:41.995] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:105:0)
[06:14:41.995] Timer tick, asking Buildbucket for the build status
[06:14:42.062] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:42.062] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:106:0) after 1m0s
[06:15:42.085] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:106:0)
[06:15:42.085] Timer tick, asking Buildbucket for the build status
[06:15:42.391] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:42.391] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:107:0) after 1m0s
[06:16:42.419] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:107:0)
[06:16:42.419] Timer tick, asking Buildbucket for the build status
[06:16:42.493] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:42.493] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:108:0) after 1m0s
[06:17:42.526] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:108:0)
[06:17:42.526] Timer tick, asking Buildbucket for the build status
[06:17:42.610] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:42.610] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:109:0) after 1m0s
[06:18:42.629] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:109:0)
[06:18:42.629] Timer tick, asking Buildbucket for the build status
[06:18:42.699] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:42.699] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:110:0) after 1m0s
[06:19:42.720] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:110:0)
[06:19:42.720] Timer tick, asking Buildbucket for the build status
[06:19:42.779] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:42.779] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:111:0) after 1m0s
[06:20:42.891] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:111:0)
[06:20:42.891] Timer tick, asking Buildbucket for the build status
[06:20:43.159] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:43.159] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:112:0) after 1m0s
[06:21:43.262] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:112:0)
[06:21:43.262] Timer tick, asking Buildbucket for the build status
[06:21:43.330] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:43.330] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:113:0) after 1m0s
[06:22:43.367] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:113:0)
[06:22:43.367] Timer tick, asking Buildbucket for the build status
[06:22:43.468] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:43.468] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:114:0) after 1m0s
[06:23:43.492] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:114:0)
[06:23:43.492] Timer tick, asking Buildbucket for the build status
[06:23:43.924] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:43.924] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:115:0) after 1m0s
[06:24:43.979] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:115:0)
[06:24:43.979] Timer tick, asking Buildbucket for the build status
[06:24:44.047] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:44.047] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:116:0) after 1m0s
[06:25:44.158] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:116:0)
[06:25:44.158] Timer tick, asking Buildbucket for the build status
[06:25:44.225] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:44.225] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:117:0) after 1m0s
[06:26:44.235] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:117:0)
[06:26:44.235] Timer tick, asking Buildbucket for the build status
[06:26:44.501] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:44.501] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:118:0) after 1m0s
[06:27:44.669] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:118:0)
[06:27:44.669] Timer tick, asking Buildbucket for the build status
[06:27:44.947] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:44.947] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:119:0) after 1m0s
[06:28:45.000] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:119:0)
[06:28:45.000] Timer tick, asking Buildbucket for the build status
[06:28:45.074] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:45.074] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:120:0) after 1m0s
[06:29:45.129] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:120:0)
[06:29:45.129] Timer tick, asking Buildbucket for the build status
[06:29:45.198] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:45.198] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:121:0) after 1m0s
[06:30:45.226] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:121:0)
[06:30:45.226] Timer tick, asking Buildbucket for the build status
[06:30:45.281] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:45.281] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:122:0) after 1m0s
[06:31:45.358] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:122:0)
[06:31:45.358] Timer tick, asking Buildbucket for the build status
[06:31:45.563] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:45.563] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:123:0) after 1m0s
[06:32:45.606] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:123:0)
[06:32:45.606] Timer tick, asking Buildbucket for the build status
[06:32:45.776] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:45.776] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:124:0) after 1m0s
[06:33:45.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:124:0)
[06:33:45.829] Timer tick, asking Buildbucket for the build status
[06:33:45.930] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:45.930] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:125:0) after 1m0s
[06:34:46.037] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:125:0)
[06:34:46.037] Timer tick, asking Buildbucket for the build status
[06:34:46.146] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:46.146] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:126:0) after 1m0s
[06:35:46.203] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:126:0)
[06:35:46.203] Timer tick, asking Buildbucket for the build status
[06:35:46.286] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:46.286] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:127:0) after 1m0s
[06:36:46.363] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:127:0)
[06:36:46.363] Timer tick, asking Buildbucket for the build status
[06:36:46.425] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:46.425] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:128:0) after 1m0s
[06:37:46.434] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:128:0)
[06:37:46.434] Timer tick, asking Buildbucket for the build status
[06:37:46.559] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:46.559] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:129:0) after 1m0s
[06:38:46.587] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:129:0)
[06:38:46.587] Timer tick, asking Buildbucket for the build status
[06:38:46.660] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:46.660] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:130:0) after 1m0s
[06:39:46.717] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:130:0)
[06:39:46.717] Timer tick, asking Buildbucket for the build status
[06:39:46.839] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:46.839] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:131:0) after 1m0s
[06:40:46.926] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:131:0)
[06:40:46.926] Timer tick, asking Buildbucket for the build status
[06:40:46.992] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:46.992] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:132:0) after 1m0s
[06:41:46.972] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:132:0)
[06:41:46.972] Timer tick, asking Buildbucket for the build status
[06:41:47.045] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:47.045] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:133:0) after 1m0s
[06:42:47.201] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:133:0)
[06:42:47.201] Timer tick, asking Buildbucket for the build status
[06:42:47.314] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:47.314] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:134:0) after 1m0s
[06:43:47.431] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:134:0)
[06:43:47.431] Timer tick, asking Buildbucket for the build status
[06:43:47.503] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:47.503] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:135:0) after 1m0s
[06:44:47.526] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:135:0)
[06:44:47.526] Timer tick, asking Buildbucket for the build status
[06:44:47.635] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:47.635] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:136:0) after 1m0s
[06:45:47.652] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:136:0)
[06:45:47.652] Timer tick, asking Buildbucket for the build status
[06:45:47.712] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:47.712] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:137:0) after 1m0s
[06:46:47.737] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:137:0)
[06:46:47.737] Timer tick, asking Buildbucket for the build status
[06:46:47.807] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:47.807] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:138:0) after 1m0s
[06:47:47.832] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:138:0)
[06:47:47.832] Timer tick, asking Buildbucket for the build status
[06:47:48.021] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:48.021] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:139:0) after 1m0s
[06:48:48.054] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:139:0)
[06:48:48.054] Timer tick, asking Buildbucket for the build status
[06:48:48.118] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:48.118] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:140:0) after 1m0s
[06:49:48.115] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:140:0)
[06:49:48.115] Timer tick, asking Buildbucket for the build status
[06:49:48.170] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:48.170] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:141:0) after 1m0s
[06:50:48.243] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:141:0)
[06:50:48.243] Timer tick, asking Buildbucket for the build status
[06:50:48.318] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:48.318] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:142:0) after 1m0s
[06:51:48.770] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:142:0)
[06:51:48.770] Timer tick, asking Buildbucket for the build status
[06:51:48.838] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:48.838] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:143:0) after 1m0s
[06:52:48.953] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:143:0)
[06:52:48.953] Timer tick, asking Buildbucket for the build status
[06:52:49.087] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:49.087] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:144:0) after 1m0s
[06:53:49.242] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:144:0)
[06:53:49.242] Timer tick, asking Buildbucket for the build status
[06:53:49.297] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:49.297] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:145:0) after 1m0s
[06:54:49.450] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:145:0)
[06:54:49.450] Timer tick, asking Buildbucket for the build status
[06:54:49.511] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:49.511] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:146:0) after 1m0s
[06:55:49.533] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:146:0)
[06:55:49.533] Timer tick, asking Buildbucket for the build status
[06:55:49.585] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:49.585] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:147:0) after 1m0s
[06:56:49.659] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:147:0)
[06:56:49.659] Timer tick, asking Buildbucket for the build status
[06:56:49.718] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:49.718] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:148:0) after 1m0s
[06:57:49.783] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:148:0)
[06:57:49.783] Timer tick, asking Buildbucket for the build status
[06:57:49.877] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:49.877] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:149:0) after 1m0s
[06:58:50.026] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:149:0)
[06:58:50.026] Timer tick, asking Buildbucket for the build status
[06:58:50.082] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:50.082] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:150:0) after 1m0s
[06:59:50.280] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:150:0)
[06:59:50.280] Timer tick, asking Buildbucket for the build status
[06:59:50.339] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:50.339] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:151:0) after 1m0s
[07:00:50.474] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:151:0)
[07:00:50.474] Timer tick, asking Buildbucket for the build status
[07:00:50.544] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:50.544] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:152:0) after 1m0s
[07:01:50.756] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:152:0)
[07:01:50.756] Timer tick, asking Buildbucket for the build status
[07:01:50.922] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:50.922] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:153:0) after 1m0s
[07:02:51.100] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:153:0)
[07:02:51.100] Timer tick, asking Buildbucket for the build status
[07:02:51.607] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:51.607] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:154:0) after 1m0s
[07:03:52.002] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:154:0)
[07:03:52.002] Timer tick, asking Buildbucket for the build status
[07:03:52.130] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:52.130] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:155:0) after 1m0s
[07:04:52.280] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:155:0)
[07:04:52.280] Timer tick, asking Buildbucket for the build status
[07:04:52.352] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:52.352] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:156:0) after 1m0s
[07:05:52.472] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:156:0)
[07:05:52.473] Timer tick, asking Buildbucket for the build status
[07:05:52.536] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:52.536] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:157:0) after 1m0s
[07:06:52.752] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:157:0)
[07:06:52.752] Timer tick, asking Buildbucket for the build status
[07:06:52.825] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:52.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:158:0) after 1m0s
[07:07:52.895] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:158:0)
[07:07:52.895] Timer tick, asking Buildbucket for the build status
[07:07:52.998] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:52.998] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:159:0) after 1m0s
[07:08:53.078] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:159:0)
[07:08:53.078] Timer tick, asking Buildbucket for the build status
[07:08:53.157] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:53.157] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:160:0) after 1m0s
[07:09:53.224] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:160:0)
[07:09:53.224] Timer tick, asking Buildbucket for the build status
[07:09:53.295] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:53.295] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:161:0) after 1m0s
[07:10:53.320] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:161:0)
[07:10:53.320] Timer tick, asking Buildbucket for the build status
[07:10:53.416] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:53.416] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:162:0) after 1m0s
[07:11:53.512] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:162:0)
[07:11:53.512] Timer tick, asking Buildbucket for the build status
[07:11:53.659] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:53.659] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:163:0) after 1m0s
[07:12:54.074] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:163:0)
[07:12:54.074] Timer tick, asking Buildbucket for the build status
[07:12:54.349] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:54.349] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:164:0) after 1m0s
[07:13:54.614] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:164:0)
[07:13:54.614] Timer tick, asking Buildbucket for the build status
[07:13:54.662] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:54.663] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:165:0) after 1m0s
[07:14:54.796] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:165:0)
[07:14:54.796] Timer tick, asking Buildbucket for the build status
[07:14:54.845] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:54.845] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:166:0) after 1m0s
[07:15:54.921] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:166:0)
[07:15:54.921] Timer tick, asking Buildbucket for the build status
[07:15:54.986] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:54.986] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:167:0) after 1m0s
[07:16:55.223] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:167:0)
[07:16:55.224] Timer tick, asking Buildbucket for the build status
[07:16:55.300] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:55.300] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:168:0) after 1m0s
[07:17:55.692] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:168:0)
[07:17:55.692] Timer tick, asking Buildbucket for the build status
[07:17:55.787] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:55.787] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:169:0) after 1m0s
[07:18:55.999] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:169:0)
[07:18:55.999] Timer tick, asking Buildbucket for the build status
[07:18:56.071] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:56.071] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:170:0) after 1m0s
[07:19:56.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:170:0)
[07:19:56.198] Timer tick, asking Buildbucket for the build status
[07:19:56.262] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:56.262] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:171:0) after 1m0s
[07:20:56.394] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:171:0)
[07:20:56.394] Timer tick, asking Buildbucket for the build status
[07:20:56.458] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:56.458] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:172:0) after 1m0s
[07:21:56.539] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:172:0)
[07:21:56.539] Timer tick, asking Buildbucket for the build status
[07:21:56.596] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:56.596] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:173:0) after 1m0s
[07:22:56.664] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:173:0)
[07:22:56.664] Timer tick, asking Buildbucket for the build status
[07:22:56.775] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:56.775] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:174:0) after 1m0s
[07:23:56.896] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:174:0)
[07:23:56.896] Timer tick, asking Buildbucket for the build status
[07:23:56.973] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:56.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:175:0) after 1m0s
[07:24:57.034] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:175:0)
[07:24:57.034] Timer tick, asking Buildbucket for the build status
[07:24:57.101] Build 8860967097743826560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:57.101] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026397159837914208:176:0) after 1m0s
[07:25:42.997] Received PubSub notification, asking Buildbucket for the build status
[07:25:43.228] Build 8860967097743826560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:25:43.228] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607930742598616",
"created_by": "project:chromium",
"created_ts": "1607920282568548",
"id": "8860967097743826560",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11e0cfbdb5d2548af8619c32dec227358d0a119d\"}}",
"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\": \"11e0cfbdb5d2548af8619c32dec227358d0a119d\", \"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-zd44\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1108, \"got_angle_revision\": \"da8c22614051f43cd4d44d6809eafb150310361a\", \"got_dawn_revision\": \"fb6c21547e6c5bc2053c15169769397e6584c9d2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"11e0cfbdb5d2548af8619c32dec227358d0a119d\", \"got_revision_cp\": \"refs/heads/master@{#836523}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"c16dc7107fd329b815c700b002d1ba40372b16dc\", \"got_v8_revision\": \"fdc632431816ab61fd53d15e4beec259eb07e6b6\", \"got_v8_revision_cp\": \"refs/heads/8.9.144@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11e0cfbdb5d2548af8619c32dec227358d0a119d\"}, \"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-zd44\"], \"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\": [\"5657-0417a3f\"], \"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": "1607920498370135",
"status": "COMPLETED",
"status_changed_ts": "1607930742832761",
"tags": [
"build_address:luci.chromium.ci/win32-official/1108",
"builder:win32-official",
"buildset:commit/git/11e0cfbdb5d2548af8619c32dec227358d0a119d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11e0cfbdb5d2548af8619c32dec227358d0a119d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026397159837914208",
"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/8860967097743826560/+/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:5078566b0c424410",
"user_agent:luci-scheduler"
],
"updated_ts": "1607930742836706",
"url": "https://ci.chromium.org/b/8860967097743826560",
"utcnow_ts": "1607930743205829"
}
}
[07:25:43.228] Invocation finished in 2h54m22.040310307s with status SUCCEEDED