[12:32:28.333] New invocation is queued and will start shortly
[12:32:29.526] Starting the invocation (attempt 1)
[12:32:29.577] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:32:29.577] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:32:29.577] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023739578437360384",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2261c4e1a7c4126457be87813944eb77ae93382f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9023739578437360384",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/2261c4e1a7c4126457be87813944eb77ae93382f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2261c4e1a7c4126457be87813944eb77ae93382f",
"gitiles_ref:refs/heads/master"
]
}
[12:32:30.599] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1610454749662906",
"id": "8858309516377012960",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2261c4e1a7c4126457be87813944eb77ae93382f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610454750324327",
"tags": [
"build_address:luci.chromium.ci/win32-official/1327",
"builder:win32-official",
"buildset:commit/git/2261c4e1a7c4126457be87813944eb77ae93382f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2261c4e1a7c4126457be87813944eb77ae93382f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023739578437360384",
"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/8858309516377012960/+/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": "1610454750324441",
"url": "https://ci.chromium.org/b/8858309516377012960",
"utcnow_ts": "1610454750580518"
}
}
[12:32:30.599] Task URL: https://ci.chromium.org/b/8858309516377012960
[12:32:30.599] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:2:0) after 1m0s
[12:32:57.008] Received PubSub notification, asking Buildbucket for the build status
[12:32:57.066] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:30.626] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:2:0)
[12:33:30.626] Timer tick, asking Buildbucket for the build status
[12:33:30.707] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:30.707] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:4:0) after 1m0s
[12:34:30.727] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:4:0)
[12:34:30.727] Timer tick, asking Buildbucket for the build status
[12:34:30.833] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:30.833] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:5:0) after 1m0s
[12:35:30.852] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:5:0)
[12:35:30.852] Timer tick, asking Buildbucket for the build status
[12:35:30.980] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:30.980] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:6:0) after 1m0s
[12:36:31.046] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:6:0)
[12:36:31.046] Timer tick, asking Buildbucket for the build status
[12:36:31.213] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:31.213] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:7:0) after 1m0s
[12:37:31.239] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:7:0)
[12:37:31.239] Timer tick, asking Buildbucket for the build status
[12:37:31.617] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:31.617] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:8:0) after 1m0s
[12:38:31.668] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:8:0)
[12:38:31.668] Timer tick, asking Buildbucket for the build status
[12:38:31.997] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:31.997] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:9:0) after 1m0s
[12:39:32.022] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:9:0)
[12:39:32.022] Timer tick, asking Buildbucket for the build status
[12:39:32.096] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:32.096] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:10:0) after 1m0s
[12:40:32.112] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:10:0)
[12:40:32.112] Timer tick, asking Buildbucket for the build status
[12:40:32.161] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:32.161] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:11:0) after 1m0s
[12:41:32.183] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:11:0)
[12:41:32.183] Timer tick, asking Buildbucket for the build status
[12:41:32.283] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:32.283] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:12:0) after 1m0s
[12:42:32.304] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:12:0)
[12:42:32.304] Timer tick, asking Buildbucket for the build status
[12:42:32.364] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:32.364] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:13:0) after 1m0s
[12:43:32.383] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:13:0)
[12:43:32.383] Timer tick, asking Buildbucket for the build status
[12:43:32.527] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:32.527] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:14:0) after 1m0s
[12:44:32.547] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:14:0)
[12:44:32.547] Timer tick, asking Buildbucket for the build status
[12:44:32.845] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:32.845] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:15:0) after 1m0s
[12:45:32.888] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:15:0)
[12:45:32.888] Timer tick, asking Buildbucket for the build status
[12:45:33.005] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:33.005] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:16:0) after 1m0s
[12:46:33.029] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:16:0)
[12:46:33.029] Timer tick, asking Buildbucket for the build status
[12:46:33.249] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:33.249] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:17:0) after 1m0s
[12:47:33.292] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:17:0)
[12:47:33.292] Timer tick, asking Buildbucket for the build status
[12:47:33.379] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:33.379] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:18:0) after 1m0s
[12:48:33.453] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:18:0)
[12:48:33.453] Timer tick, asking Buildbucket for the build status
[12:48:33.772] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:33.772] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:19:0) after 1m0s
[12:49:33.795] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:19:0)
[12:49:33.795] Timer tick, asking Buildbucket for the build status
[12:49:33.857] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:33.857] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:20:0) after 1m0s
[12:50:33.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:20:0)
[12:50:33.901] Timer tick, asking Buildbucket for the build status
[12:50:33.998] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:33.998] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:21:0) after 1m0s
[12:51:34.158] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:21:0)
[12:51:34.158] Timer tick, asking Buildbucket for the build status
[12:51:34.340] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:34.340] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:22:0) after 1m0s
[12:52:34.416] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:22:0)
[12:52:34.416] Timer tick, asking Buildbucket for the build status
[12:52:35.024] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:35.024] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:23:0) after 1m0s
[12:53:35.107] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:23:0)
[12:53:35.107] Timer tick, asking Buildbucket for the build status
[12:53:35.197] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:35.197] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:24:0) after 1m0s
[12:54:35.288] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:24:0)
[12:54:35.288] Timer tick, asking Buildbucket for the build status
[12:54:35.617] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:35.618] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:25:0) after 1m0s
[12:55:35.637] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:25:0)
[12:55:35.637] Timer tick, asking Buildbucket for the build status
[12:55:35.696] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:35.696] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:26:0) after 1m0s
[12:56:35.749] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:26:0)
[12:56:35.749] Timer tick, asking Buildbucket for the build status
[12:56:35.828] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:35.828] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:27:0) after 1m0s
[12:57:36.047] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:27:0)
[12:57:36.047] Timer tick, asking Buildbucket for the build status
[12:57:36.168] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:36.168] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:28:0) after 1m0s
[12:58:36.201] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:28:0)
[12:58:36.201] Timer tick, asking Buildbucket for the build status
[12:58:36.586] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:36.586] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:29:0) after 1m0s
[12:59:36.616] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:29:0)
[12:59:36.616] Timer tick, asking Buildbucket for the build status
[12:59:36.732] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:36.732] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:30:0) after 1m0s
[13:00:36.809] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:30:0)
[13:00:36.809] Timer tick, asking Buildbucket for the build status
[13:00:36.950] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:36.951] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:31:0) after 1m0s
[13:01:37.013] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:31:0)
[13:01:37.013] Timer tick, asking Buildbucket for the build status
[13:01:37.075] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:37.088] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:32:0) after 1m0s
[13:02:37.119] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:32:0)
[13:02:37.119] Timer tick, asking Buildbucket for the build status
[13:02:37.382] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:37.382] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:33:0) after 1m0s
[13:03:37.480] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:33:0)
[13:03:37.480] Timer tick, asking Buildbucket for the build status
[13:03:37.675] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:37.675] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:34:0) after 1m0s
[13:04:37.745] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:34:0)
[13:04:37.745] Timer tick, asking Buildbucket for the build status
[13:04:37.867] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:37.867] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:35:0) after 1m0s
[13:05:37.922] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:35:0)
[13:05:37.922] Timer tick, asking Buildbucket for the build status
[13:05:38.051] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:38.051] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:36:0) after 1m0s
[13:06:38.155] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:36:0)
[13:06:38.155] Timer tick, asking Buildbucket for the build status
[13:06:38.312] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:38.312] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:37:0) after 1m0s
[13:07:38.329] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:37:0)
[13:07:38.329] Timer tick, asking Buildbucket for the build status
[13:07:38.528] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:38.528] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:38:0) after 1m0s
[13:08:54.018] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:38:0)
[13:08:54.018] Timer tick, asking Buildbucket for the build status
[13:08:54.175] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:54.175] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:39:0) after 1m0s
[13:09:54.195] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:39:0)
[13:09:54.195] Timer tick, asking Buildbucket for the build status
[13:09:54.298] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:54.298] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:40:0) after 1m0s
[13:10:54.324] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:40:0)
[13:10:54.324] Timer tick, asking Buildbucket for the build status
[13:10:54.428] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:54.428] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:41:0) after 1m0s
[13:11:54.613] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:41:0)
[13:11:54.613] Timer tick, asking Buildbucket for the build status
[13:11:54.825] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:54.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:42:0) after 1m0s
[13:12:54.884] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:42:0)
[13:12:54.884] Timer tick, asking Buildbucket for the build status
[13:12:55.115] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:55.115] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:43:0) after 1m0s
[13:13:55.183] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:43:0)
[13:13:55.183] Timer tick, asking Buildbucket for the build status
[13:13:55.297] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:55.297] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:44:0) after 1m0s
[13:14:55.321] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:44:0)
[13:14:55.321] Timer tick, asking Buildbucket for the build status
[13:14:55.665] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:55.665] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:45:0) after 1m0s
[13:15:55.737] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:45:0)
[13:15:55.737] Timer tick, asking Buildbucket for the build status
[13:15:55.907] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:55.907] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:46:0) after 1m0s
[13:16:56.013] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:46:0)
[13:16:56.013] Timer tick, asking Buildbucket for the build status
[13:16:56.118] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:56.118] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:47:0) after 1m0s
[13:17:56.164] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:47:0)
[13:17:56.164] Timer tick, asking Buildbucket for the build status
[13:17:56.315] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:56.315] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:48:0) after 1m0s
[13:18:56.396] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:48:0)
[13:18:56.396] Timer tick, asking Buildbucket for the build status
[13:18:56.553] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:56.553] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:49:0) after 1m0s
[13:19:56.666] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:49:0)
[13:19:56.666] Timer tick, asking Buildbucket for the build status
[13:19:56.777] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:56.777] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:50:0) after 1m0s
[13:20:56.832] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:50:0)
[13:20:56.832] Timer tick, asking Buildbucket for the build status
[13:20:56.962] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:56.962] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:51:0) after 1m0s
[13:21:57.090] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:51:0)
[13:21:57.090] Timer tick, asking Buildbucket for the build status
[13:21:57.288] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:57.288] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:52:0) after 1m0s
[13:22:57.313] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:52:0)
[13:22:57.313] Timer tick, asking Buildbucket for the build status
[13:22:57.494] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:57.494] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:53:0) after 1m0s
[13:23:57.479] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:53:0)
[13:23:57.479] Timer tick, asking Buildbucket for the build status
[13:23:57.576] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:57.576] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:54:0) after 1m0s
[13:24:57.631] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:54:0)
[13:24:57.631] Timer tick, asking Buildbucket for the build status
[13:24:57.910] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:57.910] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:55:0) after 1m0s
[13:25:57.958] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:55:0)
[13:25:57.958] Timer tick, asking Buildbucket for the build status
[13:25:58.056] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:58.056] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:56:0) after 1m0s
[13:26:58.186] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:56:0)
[13:26:58.186] Timer tick, asking Buildbucket for the build status
[13:26:58.456] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:58.456] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:57:0) after 1m0s
[13:27:58.486] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:57:0)
[13:27:58.486] Timer tick, asking Buildbucket for the build status
[13:27:58.622] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:58.622] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:58:0) after 1m0s
[13:28:58.668] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:58:0)
[13:28:58.668] Timer tick, asking Buildbucket for the build status
[13:28:58.777] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:58.777] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:59:0) after 1m0s
[13:29:58.811] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:59:0)
[13:29:58.811] Timer tick, asking Buildbucket for the build status
[13:29:58.926] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:58.926] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:60:0) after 1m0s
[13:30:58.984] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:60:0)
[13:30:58.985] Timer tick, asking Buildbucket for the build status
[13:30:59.118] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:59.118] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:61:0) after 1m0s
[13:31:59.181] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:61:0)
[13:31:59.181] Timer tick, asking Buildbucket for the build status
[13:31:59.373] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:59.373] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:62:0) after 1m0s
[13:32:59.409] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:62:0)
[13:32:59.409] Timer tick, asking Buildbucket for the build status
[13:32:59.812] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:59.812] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:63:0) after 1m0s
[13:33:59.856] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:63:0)
[13:33:59.856] Timer tick, asking Buildbucket for the build status
[13:33:59.977] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:59.977] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:64:0) after 1m0s
[13:35:00.007] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:64:0)
[13:35:00.007] Timer tick, asking Buildbucket for the build status
[13:35:00.131] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:00.131] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:65:0) after 1m0s
[13:36:00.208] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:65:0)
[13:36:00.208] Timer tick, asking Buildbucket for the build status
[13:36:00.325] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:00.326] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:66:0) after 1m0s
[13:37:00.387] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:66:0)
[13:37:00.387] Timer tick, asking Buildbucket for the build status
[13:37:00.498] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:00.498] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:67:0) after 1m0s
[13:38:00.688] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:67:0)
[13:38:00.688] Timer tick, asking Buildbucket for the build status
[13:38:00.827] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:00.827] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:68:0) after 1m0s
[13:39:01.009] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:68:0)
[13:39:01.009] Timer tick, asking Buildbucket for the build status
[13:39:01.331] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:01.331] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:69:0) after 1m0s
[13:40:01.826] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:69:0)
[13:40:01.826] Timer tick, asking Buildbucket for the build status
[13:40:02.135] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:02.135] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:70:0) after 1m0s
[13:41:02.219] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:70:0)
[13:41:02.219] Timer tick, asking Buildbucket for the build status
[13:41:02.489] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:02.489] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:71:0) after 1m0s
[13:42:02.585] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:71:0)
[13:42:02.585] Timer tick, asking Buildbucket for the build status
[13:42:02.712] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:02.712] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:72:0) after 1m0s
[13:43:02.785] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:72:0)
[13:43:02.785] Timer tick, asking Buildbucket for the build status
[13:43:02.903] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:02.903] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:73:0) after 1m0s
[13:44:03.064] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:73:0)
[13:44:03.064] Timer tick, asking Buildbucket for the build status
[13:44:03.152] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:03.152] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:74:0) after 1m0s
[13:45:03.247] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:74:0)
[13:45:03.247] Timer tick, asking Buildbucket for the build status
[13:45:03.352] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:03.352] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:75:0) after 1m0s
[13:46:03.419] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:75:0)
[13:46:03.419] Timer tick, asking Buildbucket for the build status
[13:46:03.513] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:03.513] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:76:0) after 1m0s
[13:47:03.538] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:76:0)
[13:47:03.538] Timer tick, asking Buildbucket for the build status
[13:47:03.623] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:03.623] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:77:0) after 1m0s
[13:48:03.708] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:77:0)
[13:48:03.708] Timer tick, asking Buildbucket for the build status
[13:48:04.083] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:04.083] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:78:0) after 1m0s
[13:49:04.064] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:78:0)
[13:49:04.064] Timer tick, asking Buildbucket for the build status
[13:49:04.174] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:04.174] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:79:0) after 1m0s
[13:50:04.294] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:79:0)
[13:50:04.294] Timer tick, asking Buildbucket for the build status
[13:50:04.501] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:04.501] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:80:0) after 1m0s
[13:51:04.524] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:80:0)
[13:51:04.524] Timer tick, asking Buildbucket for the build status
[13:51:04.763] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:04.763] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:81:0) after 1m0s
[13:52:04.820] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:81:0)
[13:52:04.820] Timer tick, asking Buildbucket for the build status
[13:52:04.952] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:04.952] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:82:0) after 1m0s
[13:53:05.027] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:82:0)
[13:53:05.027] Timer tick, asking Buildbucket for the build status
[13:53:05.404] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:05.404] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:83:0) after 1m0s
[13:54:05.475] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:83:0)
[13:54:05.475] Timer tick, asking Buildbucket for the build status
[13:54:06.746] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:06.746] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:84:0) after 1m0s
[13:55:06.938] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:84:0)
[13:55:06.938] Timer tick, asking Buildbucket for the build status
[13:55:07.082] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:07.082] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:85:0) after 1m0s
[13:56:07.122] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:85:0)
[13:56:07.122] Timer tick, asking Buildbucket for the build status
[13:56:07.227] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:07.227] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:86:0) after 1m0s
[13:57:07.281] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:86:0)
[13:57:07.281] Timer tick, asking Buildbucket for the build status
[13:57:07.368] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:07.368] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:87:0) after 1m0s
[13:58:07.425] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:87:0)
[13:58:07.425] Timer tick, asking Buildbucket for the build status
[13:58:07.575] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:07.575] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:88:0) after 1m0s
[13:59:07.620] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:88:0)
[13:59:07.620] Timer tick, asking Buildbucket for the build status
[13:59:07.767] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:07.767] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:89:0) after 1m0s
[14:00:07.849] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:89:0)
[14:00:07.849] Timer tick, asking Buildbucket for the build status
[14:00:07.934] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:07.934] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:90:0) after 1m0s
[14:01:08.412] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:90:0)
[14:01:08.412] Timer tick, asking Buildbucket for the build status
[14:01:08.487] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:08.487] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:91:0) after 1m0s
[14:02:08.974] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:91:0)
[14:02:08.974] Timer tick, asking Buildbucket for the build status
[14:02:09.035] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:09.035] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:92:0) after 1m0s
[14:03:09.245] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:92:0)
[14:03:09.245] Timer tick, asking Buildbucket for the build status
[14:03:09.413] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:09.413] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:93:0) after 1m0s
[14:04:09.596] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:93:0)
[14:04:09.596] Timer tick, asking Buildbucket for the build status
[14:04:09.745] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:09.745] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:94:0) after 1m0s
[14:05:09.962] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:94:0)
[14:05:09.962] Timer tick, asking Buildbucket for the build status
[14:05:10.078] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:10.078] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:95:0) after 1m0s
[14:06:10.242] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:95:0)
[14:06:10.242] Timer tick, asking Buildbucket for the build status
[14:06:10.507] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:10.507] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:96:0) after 1m0s
[14:07:10.572] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:96:0)
[14:07:10.572] Timer tick, asking Buildbucket for the build status
[14:07:10.699] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:10.699] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:97:0) after 1m0s
[14:08:10.799] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:97:0)
[14:08:10.800] Timer tick, asking Buildbucket for the build status
[14:08:10.945] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:10.945] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:98:0) after 1m0s
[14:09:11.043] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:98:0)
[14:09:11.043] Timer tick, asking Buildbucket for the build status
[14:09:11.186] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:11.186] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:99:0) after 1m0s
[14:10:11.275] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:99:0)
[14:10:11.275] Timer tick, asking Buildbucket for the build status
[14:10:11.382] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:11.382] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:100:0) after 1m0s
[14:11:11.369] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:100:0)
[14:11:11.369] Timer tick, asking Buildbucket for the build status
[14:11:11.701] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:11.701] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:101:0) after 1m0s
[14:12:14.431] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:101:0)
[14:12:14.431] Timer tick, asking Buildbucket for the build status
[14:12:14.896] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:14.896] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:102:0) after 1m0s
[14:13:14.918] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:102:0)
[14:13:14.918] Timer tick, asking Buildbucket for the build status
[14:13:15.048] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:15.048] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:103:0) after 1m0s
[14:14:15.078] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:103:0)
[14:14:15.078] Timer tick, asking Buildbucket for the build status
[14:14:15.163] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:15.163] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:104:0) after 1m0s
[14:15:15.218] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:104:0)
[14:15:15.218] Timer tick, asking Buildbucket for the build status
[14:15:15.288] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:15.288] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:105:0) after 1m0s
[14:16:15.292] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:105:0)
[14:16:15.293] Timer tick, asking Buildbucket for the build status
[14:16:15.465] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:15.465] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:106:0) after 1m0s
[14:17:15.558] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:106:0)
[14:17:15.558] Timer tick, asking Buildbucket for the build status
[14:17:15.621] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:15.621] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:107:0) after 1m0s
[14:18:15.620] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:107:0)
[14:18:15.620] Timer tick, asking Buildbucket for the build status
[14:18:15.744] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:15.744] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:108:0) after 1m0s
[14:19:15.775] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:108:0)
[14:19:15.775] Timer tick, asking Buildbucket for the build status
[14:19:15.862] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:15.862] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:109:0) after 1m0s
[14:20:15.919] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:109:0)
[14:20:15.919] Timer tick, asking Buildbucket for the build status
[14:20:16.155] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:16.155] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:110:0) after 1m0s
[14:21:16.237] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:110:0)
[14:21:16.237] Timer tick, asking Buildbucket for the build status
[14:21:16.399] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:16.400] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:111:0) after 1m0s
[14:22:16.444] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:111:0)
[14:22:16.444] Timer tick, asking Buildbucket for the build status
[14:22:16.497] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:16.497] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:112:0) after 1m0s
[14:23:16.515] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:112:0)
[14:23:16.515] Timer tick, asking Buildbucket for the build status
[14:23:16.638] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:16.638] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:113:0) after 1m0s
[14:24:16.731] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:113:0)
[14:24:16.731] Timer tick, asking Buildbucket for the build status
[14:24:16.794] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:16.794] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:114:0) after 1m0s
[14:25:16.868] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:114:0)
[14:25:16.868] Timer tick, asking Buildbucket for the build status
[14:25:17.284] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:17.284] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:115:0) after 1m0s
[14:26:17.314] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:115:0)
[14:26:17.314] Timer tick, asking Buildbucket for the build status
[14:26:18.572] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:18.572] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:116:0) after 1m0s
[14:27:18.664] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:116:0)
[14:27:18.664] Timer tick, asking Buildbucket for the build status
[14:27:18.723] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:18.723] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:117:0) after 1m0s
[14:28:18.810] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:117:0)
[14:28:18.810] Timer tick, asking Buildbucket for the build status
[14:28:18.943] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:18.943] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:118:0) after 1m0s
[14:29:19.024] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:118:0)
[14:29:19.024] Timer tick, asking Buildbucket for the build status
[14:29:19.102] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:19.102] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:119:0) after 1m0s
[14:30:19.210] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:119:0)
[14:30:19.210] Timer tick, asking Buildbucket for the build status
[14:30:19.278] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:19.278] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:120:0) after 1m0s
[14:31:19.306] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:120:0)
[14:31:19.306] Timer tick, asking Buildbucket for the build status
[14:31:19.476] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:19.476] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:121:0) after 1m0s
[14:32:19.593] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:121:0)
[14:32:19.593] Timer tick, asking Buildbucket for the build status
[14:32:19.676] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:19.676] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:122:0) after 1m0s
[14:33:19.793] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:122:0)
[14:33:19.793] Timer tick, asking Buildbucket for the build status
[14:33:19.937] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:19.937] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:123:0) after 1m0s
[14:34:20.008] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:123:0)
[14:34:20.008] Timer tick, asking Buildbucket for the build status
[14:34:20.259] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:20.259] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:124:0) after 1m0s
[14:35:20.389] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:124:0)
[14:35:20.389] Timer tick, asking Buildbucket for the build status
[14:35:20.458] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:20.458] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:125:0) after 1m0s
[14:36:20.697] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:125:0)
[14:36:20.697] Timer tick, asking Buildbucket for the build status
[14:36:20.767] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:20.767] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:126:0) after 1m0s
[14:37:20.794] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:126:0)
[14:37:20.794] Timer tick, asking Buildbucket for the build status
[14:37:20.857] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:20.857] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:127:0) after 1m0s
[14:38:20.908] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:127:0)
[14:38:20.908] Timer tick, asking Buildbucket for the build status
[14:38:21.020] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:21.020] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:128:0) after 1m0s
[14:39:21.058] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:128:0)
[14:39:21.058] Timer tick, asking Buildbucket for the build status
[14:39:21.335] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:21.335] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:129:0) after 1m0s
[14:40:21.466] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:129:0)
[14:40:21.466] Timer tick, asking Buildbucket for the build status
[14:40:21.578] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:21.578] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:130:0) after 1m0s
[14:41:21.638] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:130:0)
[14:41:21.638] Timer tick, asking Buildbucket for the build status
[14:41:21.718] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:21.718] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:131:0) after 1m0s
[14:42:21.787] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:131:0)
[14:42:21.787] Timer tick, asking Buildbucket for the build status
[14:42:22.028] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:22.028] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:132:0) after 1m0s
[14:43:22.017] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:132:0)
[14:43:22.017] Timer tick, asking Buildbucket for the build status
[14:43:22.335] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:22.335] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:133:0) after 1m0s
[14:44:22.405] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:133:0)
[14:44:22.405] Timer tick, asking Buildbucket for the build status
[14:44:22.519] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:22.519] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:134:0) after 1m0s
[14:45:22.574] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:134:0)
[14:45:22.574] Timer tick, asking Buildbucket for the build status
[14:45:22.720] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:22.720] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:135:0) after 1m0s
[14:46:22.712] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:135:0)
[14:46:22.712] Timer tick, asking Buildbucket for the build status
[14:46:22.825] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:22.825] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:136:0) after 1m0s
[14:47:22.901] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:136:0)
[14:47:22.901] Timer tick, asking Buildbucket for the build status
[14:47:22.965] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:22.965] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:137:0) after 1m0s
[14:48:23.620] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:137:0)
[14:48:23.620] Timer tick, asking Buildbucket for the build status
[14:48:23.805] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:23.805] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:138:0) after 1m0s
[14:49:23.833] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:138:0)
[14:49:23.833] Timer tick, asking Buildbucket for the build status
[14:49:23.898] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:23.898] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:139:0) after 1m0s
[14:50:24.083] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:139:0)
[14:50:24.083] Timer tick, asking Buildbucket for the build status
[14:50:24.196] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:24.196] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:140:0) after 1m0s
[14:51:24.235] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:140:0)
[14:51:24.235] Timer tick, asking Buildbucket for the build status
[14:51:24.323] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:24.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:141:0) after 1m0s
[14:52:24.352] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:141:0)
[14:52:24.352] Timer tick, asking Buildbucket for the build status
[14:52:24.530] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:24.530] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:142:0) after 1m0s
[14:53:24.531] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:142:0)
[14:53:24.531] Timer tick, asking Buildbucket for the build status
[14:53:24.729] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:24.729] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:143:0) after 1m0s
[14:54:24.764] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:143:0)
[14:54:24.764] Timer tick, asking Buildbucket for the build status
[14:54:24.847] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:24.847] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:144:0) after 1m0s
[14:55:24.955] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:144:0)
[14:55:24.955] Timer tick, asking Buildbucket for the build status
[14:55:25.060] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:25.060] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:145:0) after 1m0s
[14:56:25.084] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:145:0)
[14:56:25.084] Timer tick, asking Buildbucket for the build status
[14:56:25.213] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:25.213] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:146:0) after 1m0s
[14:57:25.283] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:146:0)
[14:57:25.283] Timer tick, asking Buildbucket for the build status
[14:57:25.378] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:25.378] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:147:0) after 1m0s
[14:58:25.455] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:147:0)
[14:58:25.455] Timer tick, asking Buildbucket for the build status
[14:58:25.596] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:25.596] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:148:0) after 1m0s
[14:59:25.669] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:148:0)
[14:59:25.669] Timer tick, asking Buildbucket for the build status
[14:59:25.744] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:25.744] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:149:0) after 1m0s
[15:00:25.828] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:149:0)
[15:00:25.828] Timer tick, asking Buildbucket for the build status
[15:00:26.099] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:26.100] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:150:0) after 1m0s
[15:01:26.130] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:150:0)
[15:01:26.130] Timer tick, asking Buildbucket for the build status
[15:01:26.288] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:26.288] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:151:0) after 1m0s
[15:02:26.316] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:151:0)
[15:02:26.316] Timer tick, asking Buildbucket for the build status
[15:02:26.491] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:26.491] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:152:0) after 1m0s
[15:03:26.511] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:152:0)
[15:03:26.511] Timer tick, asking Buildbucket for the build status
[15:03:26.809] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:26.809] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:153:0) after 1m0s
[15:04:26.846] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:153:0)
[15:04:26.846] Timer tick, asking Buildbucket for the build status
[15:04:26.904] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:26.904] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:154:0) after 1m0s
[15:05:27.005] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:154:0)
[15:05:27.005] Timer tick, asking Buildbucket for the build status
[15:05:27.071] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:27.072] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:155:0) after 1m0s
[15:06:27.134] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:155:0)
[15:06:27.134] Timer tick, asking Buildbucket for the build status
[15:06:27.251] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:27.251] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:156:0) after 1m0s
[15:07:27.413] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:156:0)
[15:07:27.413] Timer tick, asking Buildbucket for the build status
[15:07:27.790] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:27.790] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:157:0) after 1m0s
[15:08:27.866] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:157:0)
[15:08:27.866] Timer tick, asking Buildbucket for the build status
[15:08:28.023] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:28.023] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:158:0) after 1m0s
[15:09:28.077] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:158:0)
[15:09:28.077] Timer tick, asking Buildbucket for the build status
[15:09:28.235] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:28.235] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:159:0) after 1m0s
[15:10:28.360] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:159:0)
[15:10:28.360] Timer tick, asking Buildbucket for the build status
[15:10:28.664] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:28.664] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:160:0) after 1m0s
[15:11:28.815] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:160:0)
[15:11:28.815] Timer tick, asking Buildbucket for the build status
[15:11:28.900] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:28.900] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:161:0) after 1m0s
[15:12:28.921] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:161:0)
[15:12:28.921] Timer tick, asking Buildbucket for the build status
[15:12:28.972] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:28.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:162:0) after 1m0s
[15:13:29.027] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:162:0)
[15:13:29.027] Timer tick, asking Buildbucket for the build status
[15:13:29.165] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:29.165] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:163:0) after 1m0s
[15:14:29.196] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:163:0)
[15:14:29.196] Timer tick, asking Buildbucket for the build status
[15:14:29.261] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:29.261] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:164:0) after 1m0s
[15:15:29.320] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:164:0)
[15:15:29.320] Timer tick, asking Buildbucket for the build status
[15:15:30.628] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:30.628] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:165:0) after 1m0s
[15:16:30.652] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:165:0)
[15:16:30.652] Timer tick, asking Buildbucket for the build status
[15:16:30.751] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:30.751] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:166:0) after 1m0s
[15:17:30.777] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:166:0)
[15:17:30.777] Timer tick, asking Buildbucket for the build status
[15:17:30.986] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:30.986] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:167:0) after 1m0s
[15:18:31.013] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:167:0)
[15:18:31.013] Timer tick, asking Buildbucket for the build status
[15:18:31.429] Build 8858309516377012960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:31.429] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023739578437360384:168:0) after 1m0s
[15:18:53.737] Received PubSub notification, asking Buildbucket for the build status
[15:18:53.828] Build 8858309516377012960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:18:53.828] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1610464733143306",
"created_by": "project:chromium",
"created_ts": "1610454749662906",
"id": "8858309516377012960",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2261c4e1a7c4126457be87813944eb77ae93382f\"}}",
"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\": \"2261c4e1a7c4126457be87813944eb77ae93382f\", \"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-8-6vdt\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1327, \"got_angle_revision\": \"7f0e7d0d262aa0ee71c862846c72f737cbbfca04\", \"got_dawn_revision\": \"2bd95f1cf45451119b6644e41919b7bef443d912\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"2261c4e1a7c4126457be87813944eb77ae93382f\", \"got_revision_cp\": \"refs/heads/master@{#842487}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"724907341fdd1a17fced5758d13d736c3c19cc6b\", \"got_v8_revision_cp\": \"refs/heads/8.9.247@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2261c4e1a7c4126457be87813944eb77ae93382f\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-8-6vdt\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610454776221008",
"status": "COMPLETED",
"status_changed_ts": "1610464733532581",
"tags": [
"build_address:luci.chromium.ci/win32-official/1327",
"builder:win32-official",
"buildset:commit/git/2261c4e1a7c4126457be87813944eb77ae93382f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2261c4e1a7c4126457be87813944eb77ae93382f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023739578437360384",
"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/8858309516377012960/+/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:510f66e08387ec10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610464733537478",
"url": "https://ci.chromium.org/b/8858309516377012960",
"utcnow_ts": "1610464733814463"
}
}
[15:18:53.828] Invocation finished in 2h46m25.514282305s with status SUCCEEDED