[12:11:43.210] New invocation is queued and will start shortly
[12:11:44.285] Starting the invocation (attempt 1)
[12:11:44.318] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:11:44.320] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:11:44.320] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023106705275095024",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4ce9888371cba53fc21702714881d10df2be23ec\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9023106705275095024",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/4ce9888371cba53fc21702714881d10df2be23ec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4ce9888371cba53fc21702714881d10df2be23ec",
"gitiles_ref:refs/heads/master"
]
}
[12:11:44.916] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611058304400496",
"id": "8857676643364031072",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4ce9888371cba53fc21702714881d10df2be23ec\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611058304767863",
"tags": [
"build_address:luci.chromium.ci/win32-official/1369",
"builder:win32-official",
"buildset:commit/git/4ce9888371cba53fc21702714881d10df2be23ec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4ce9888371cba53fc21702714881d10df2be23ec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023106705275095024",
"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/8857676643364031072/+/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": "1611058304767973",
"url": "https://ci.chromium.org/b/8857676643364031072",
"utcnow_ts": "1611058304898442"
}
}
[12:11:44.916] Task URL: https://ci.chromium.org/b/8857676643364031072
[12:11:44.916] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:2:0) after 1m0s
[12:12:18.228] Received PubSub notification, asking Buildbucket for the build status
[12:12:18.299] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:44.949] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:2:0)
[12:12:44.949] Timer tick, asking Buildbucket for the build status
[12:12:45.022] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:45.022] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:4:0) after 1m0s
[12:13:45.046] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:4:0)
[12:13:45.046] Timer tick, asking Buildbucket for the build status
[12:13:45.177] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:45.177] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:5:0) after 1m0s
[12:14:45.216] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:5:0)
[12:14:45.217] Timer tick, asking Buildbucket for the build status
[12:14:45.330] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:45.330] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:6:0) after 1m0s
[12:15:45.372] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:6:0)
[12:15:45.372] Timer tick, asking Buildbucket for the build status
[12:15:45.427] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:45.427] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:7:0) after 1m0s
[12:16:45.484] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:7:0)
[12:16:45.484] Timer tick, asking Buildbucket for the build status
[12:16:45.543] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:45.543] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:8:0) after 1m0s
[12:17:45.517] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:8:0)
[12:17:45.517] Timer tick, asking Buildbucket for the build status
[12:17:45.644] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:45.644] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:9:0) after 1m0s
[12:18:45.669] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:9:0)
[12:18:45.669] Timer tick, asking Buildbucket for the build status
[12:18:45.740] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:45.740] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:10:0) after 1m0s
[12:19:45.784] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:10:0)
[12:19:45.784] Timer tick, asking Buildbucket for the build status
[12:19:45.844] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:45.844] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:11:0) after 1m0s
[12:20:45.855] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:11:0)
[12:20:45.855] Timer tick, asking Buildbucket for the build status
[12:20:46.121] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:46.121] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:12:0) after 1m0s
[12:21:46.181] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:12:0)
[12:21:46.181] Timer tick, asking Buildbucket for the build status
[12:21:46.318] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:46.318] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:13:0) after 1m0s
[12:22:46.314] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:13:0)
[12:22:46.314] Timer tick, asking Buildbucket for the build status
[12:22:46.527] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:46.527] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:14:0) after 1m0s
[12:23:46.619] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:14:0)
[12:23:46.619] Timer tick, asking Buildbucket for the build status
[12:23:46.701] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:46.701] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:15:0) after 1m0s
[12:24:46.760] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:15:0)
[12:24:46.760] Timer tick, asking Buildbucket for the build status
[12:24:46.845] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:46.845] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:16:0) after 1m0s
[12:25:46.873] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:16:0)
[12:25:46.873] Timer tick, asking Buildbucket for the build status
[12:25:46.938] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:46.938] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:17:0) after 1m0s
[12:26:46.955] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:17:0)
[12:26:46.955] Timer tick, asking Buildbucket for the build status
[12:26:47.290] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:47.290] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:18:0) after 1m0s
[12:27:47.334] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:18:0)
[12:27:47.334] Timer tick, asking Buildbucket for the build status
[12:27:47.633] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:47.633] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:19:0) after 1m0s
[12:28:47.611] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:19:0)
[12:28:47.611] Timer tick, asking Buildbucket for the build status
[12:28:47.850] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:47.850] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:20:0) after 1m0s
[12:29:47.917] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:20:0)
[12:29:47.917] Timer tick, asking Buildbucket for the build status
[12:29:48.263] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:48.263] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:21:0) after 1m0s
[12:30:48.285] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:21:0)
[12:30:48.285] Timer tick, asking Buildbucket for the build status
[12:30:48.491] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:48.491] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:22:0) after 1m0s
[12:31:48.577] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:22:0)
[12:31:48.577] Timer tick, asking Buildbucket for the build status
[12:31:48.652] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:48.652] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:23:0) after 1m0s
[12:32:48.675] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:23:0)
[12:32:48.675] Timer tick, asking Buildbucket for the build status
[12:32:48.802] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:48.803] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:24:0) after 1m0s
[12:33:48.794] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:24:0)
[12:33:48.794] Timer tick, asking Buildbucket for the build status
[12:33:48.848] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:48.848] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:25:0) after 1m0s
[12:34:48.874] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:25:0)
[12:34:48.874] Timer tick, asking Buildbucket for the build status
[12:34:49.165] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:49.165] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:26:0) after 1m0s
[12:35:49.168] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:26:0)
[12:35:49.168] Timer tick, asking Buildbucket for the build status
[12:35:49.549] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:49.549] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:27:0) after 1m0s
[12:36:49.571] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:27:0)
[12:36:49.571] Timer tick, asking Buildbucket for the build status
[12:36:49.727] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:49.727] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:28:0) after 1m0s
[12:37:50.138] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:28:0)
[12:37:50.138] Timer tick, asking Buildbucket for the build status
[12:37:50.253] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:50.253] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:29:0) after 1m0s
[12:38:50.509] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:29:0)
[12:38:50.509] Timer tick, asking Buildbucket for the build status
[12:38:50.615] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:50.615] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:30:0) after 1m0s
[12:39:50.693] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:30:0)
[12:39:50.693] Timer tick, asking Buildbucket for the build status
[12:39:50.783] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:50.783] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:31:0) after 1m0s
[12:40:50.842] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:31:0)
[12:40:50.842] Timer tick, asking Buildbucket for the build status
[12:40:50.915] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:50.915] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:32:0) after 1m0s
[12:41:50.900] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:32:0)
[12:41:50.900] Timer tick, asking Buildbucket for the build status
[12:41:50.973] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:50.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:33:0) after 1m0s
[12:42:51.022] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:33:0)
[12:42:51.022] Timer tick, asking Buildbucket for the build status
[12:42:51.185] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:51.185] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:34:0) after 1m0s
[12:43:51.265] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:34:0)
[12:43:51.265] Timer tick, asking Buildbucket for the build status
[12:43:51.331] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:51.331] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:35:0) after 1m0s
[12:44:51.357] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:35:0)
[12:44:51.357] Timer tick, asking Buildbucket for the build status
[12:44:51.448] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:51.448] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:36:0) after 1m0s
[12:45:51.482] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:36:0)
[12:45:51.482] Timer tick, asking Buildbucket for the build status
[12:45:51.543] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:51.543] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:37:0) after 1m0s
[12:46:51.596] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:37:0)
[12:46:51.596] Timer tick, asking Buildbucket for the build status
[12:46:51.657] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:51.657] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:38:0) after 1m0s
[12:47:51.713] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:38:0)
[12:47:51.713] Timer tick, asking Buildbucket for the build status
[12:47:51.829] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:51.829] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:39:0) after 1m0s
[12:48:51.826] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:39:0)
[12:48:51.826] Timer tick, asking Buildbucket for the build status
[12:48:51.926] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:51.926] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:40:0) after 1m0s
[12:49:51.972] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:40:0)
[12:49:51.972] Timer tick, asking Buildbucket for the build status
[12:49:52.033] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:52.033] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:41:0) after 1m0s
[12:50:52.057] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:41:0)
[12:50:52.057] Timer tick, asking Buildbucket for the build status
[12:50:52.321] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:52.321] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:42:0) after 1m0s
[12:51:52.377] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:42:0)
[12:51:52.377] Timer tick, asking Buildbucket for the build status
[12:51:52.437] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:52.437] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:43:0) after 1m0s
[12:52:52.485] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:43:0)
[12:52:52.485] Timer tick, asking Buildbucket for the build status
[12:52:52.614] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:52.614] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:44:0) after 1m0s
[12:53:52.618] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:44:0)
[12:53:52.618] Timer tick, asking Buildbucket for the build status
[12:53:52.683] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:52.683] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:45:0) after 1m0s
[12:54:52.705] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:45:0)
[12:54:52.705] Timer tick, asking Buildbucket for the build status
[12:54:52.769] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:52.769] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:46:0) after 1m0s
[12:55:52.804] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:46:0)
[12:55:52.804] Timer tick, asking Buildbucket for the build status
[12:55:52.891] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:52.891] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:47:0) after 1m0s
[12:56:52.911] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:47:0)
[12:56:52.911] Timer tick, asking Buildbucket for the build status
[12:56:53.103] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:53.103] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:48:0) after 1m0s
[12:57:53.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:48:0)
[12:57:53.198] Timer tick, asking Buildbucket for the build status
[12:57:53.347] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:53.347] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:49:0) after 1m0s
[12:58:53.386] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:49:0)
[12:58:53.386] Timer tick, asking Buildbucket for the build status
[12:58:53.453] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:53.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:50:0) after 1m0s
[12:59:53.508] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:50:0)
[12:59:53.508] Timer tick, asking Buildbucket for the build status
[12:59:53.590] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:53.590] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:51:0) after 1m0s
[13:00:53.650] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:51:0)
[13:00:53.650] Timer tick, asking Buildbucket for the build status
[13:00:53.799] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:53.799] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:52:0) after 1m0s
[13:01:53.896] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:52:0)
[13:01:53.896] Timer tick, asking Buildbucket for the build status
[13:01:53.953] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:53.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:53:0) after 1m0s
[13:02:53.989] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:53:0)
[13:02:53.989] Timer tick, asking Buildbucket for the build status
[13:02:54.598] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:54.598] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:54:0) after 1m0s
[13:03:54.637] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:54:0)
[13:03:54.637] Timer tick, asking Buildbucket for the build status
[13:03:54.761] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:54.761] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:55:0) after 1m0s
[13:04:54.756] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:55:0)
[13:04:54.756] Timer tick, asking Buildbucket for the build status
[13:04:54.838] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:54.838] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:56:0) after 1m0s
[13:05:54.868] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:56:0)
[13:05:54.868] Timer tick, asking Buildbucket for the build status
[13:05:55.326] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:55.326] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:57:0) after 1m0s
[13:06:55.387] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:57:0)
[13:06:55.387] Timer tick, asking Buildbucket for the build status
[13:06:55.501] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:55.501] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:58:0) after 1m0s
[13:07:55.546] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:58:0)
[13:07:55.546] Timer tick, asking Buildbucket for the build status
[13:07:55.949] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:55.949] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:59:0) after 1m0s
[13:08:55.988] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:59:0)
[13:08:55.988] Timer tick, asking Buildbucket for the build status
[13:08:56.116] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:56.116] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:60:0) after 1m0s
[13:09:56.139] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:60:0)
[13:09:56.139] Timer tick, asking Buildbucket for the build status
[13:09:56.318] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:56.318] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:61:0) after 1m0s
[13:10:56.381] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:61:0)
[13:10:56.381] Timer tick, asking Buildbucket for the build status
[13:10:56.476] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:56.476] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:62:0) after 1m0s
[13:11:56.498] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:62:0)
[13:11:56.498] Timer tick, asking Buildbucket for the build status
[13:11:56.977] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:56.977] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:63:0) after 1m0s
[13:12:57.025] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:63:0)
[13:12:57.025] Timer tick, asking Buildbucket for the build status
[13:12:57.395] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:57.395] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:64:0) after 1m0s
[13:13:57.479] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:64:0)
[13:13:57.479] Timer tick, asking Buildbucket for the build status
[13:13:57.636] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:57.637] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:65:0) after 1m0s
[13:14:57.658] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:65:0)
[13:14:57.658] Timer tick, asking Buildbucket for the build status
[13:14:57.816] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:57.816] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:66:0) after 1m0s
[13:15:57.851] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:66:0)
[13:15:57.851] Timer tick, asking Buildbucket for the build status
[13:15:58.026] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:58.026] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:67:0) after 1m0s
[13:16:58.080] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:67:0)
[13:16:58.080] Timer tick, asking Buildbucket for the build status
[13:16:58.133] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:58.133] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:68:0) after 1m0s
[13:17:58.197] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:68:0)
[13:17:58.197] Timer tick, asking Buildbucket for the build status
[13:17:58.354] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:58.354] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:69:0) after 1m0s
[13:18:58.412] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:69:0)
[13:18:58.412] Timer tick, asking Buildbucket for the build status
[13:18:58.524] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:58.524] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:70:0) after 1m0s
[13:19:58.576] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:70:0)
[13:19:58.576] Timer tick, asking Buildbucket for the build status
[13:19:58.645] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:58.645] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:71:0) after 1m0s
[13:20:58.741] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:71:0)
[13:20:58.741] Timer tick, asking Buildbucket for the build status
[13:20:59.005] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:59.005] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:72:0) after 1m0s
[13:21:59.059] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:72:0)
[13:21:59.059] Timer tick, asking Buildbucket for the build status
[13:21:59.220] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:59.220] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:73:0) after 1m0s
[13:22:59.254] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:73:0)
[13:22:59.254] Timer tick, asking Buildbucket for the build status
[13:22:59.345] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:59.345] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:74:0) after 1m0s
[13:23:59.410] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:74:0)
[13:23:59.410] Timer tick, asking Buildbucket for the build status
[13:23:59.477] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:59.477] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:75:0) after 1m0s
[13:24:59.516] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:75:0)
[13:24:59.516] Timer tick, asking Buildbucket for the build status
[13:24:59.584] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:59.584] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:76:0) after 1m0s
[13:25:59.792] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:76:0)
[13:25:59.792] Timer tick, asking Buildbucket for the build status
[13:25:59.971] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:59.971] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:77:0) after 1m0s
[13:27:00.001] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:77:0)
[13:27:00.001] Timer tick, asking Buildbucket for the build status
[13:27:00.271] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:00.271] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:78:0) after 1m0s
[13:28:00.321] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:78:0)
[13:28:00.321] Timer tick, asking Buildbucket for the build status
[13:28:00.798] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:00.798] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:79:0) after 1m0s
[13:29:01.512] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:79:0)
[13:29:01.512] Timer tick, asking Buildbucket for the build status
[13:29:01.570] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:01.570] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:80:0) after 1m0s
[13:30:01.674] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:80:0)
[13:30:01.674] Timer tick, asking Buildbucket for the build status
[13:30:01.796] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:01.796] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:81:0) after 1m0s
[13:31:01.978] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:81:0)
[13:31:01.978] Timer tick, asking Buildbucket for the build status
[13:31:02.105] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:02.105] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:82:0) after 1m0s
[13:32:02.108] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:82:0)
[13:32:02.108] Timer tick, asking Buildbucket for the build status
[13:32:02.171] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:02.171] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:83:0) after 1m0s
[13:33:02.192] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:83:0)
[13:33:02.193] Timer tick, asking Buildbucket for the build status
[13:33:02.600] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:02.600] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:84:0) after 1m0s
[13:34:02.626] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:84:0)
[13:34:02.626] Timer tick, asking Buildbucket for the build status
[13:34:02.700] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:02.700] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:85:0) after 1m0s
[13:35:02.722] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:85:0)
[13:35:02.722] Timer tick, asking Buildbucket for the build status
[13:35:02.782] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:02.782] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:86:0) after 1m0s
[13:36:02.814] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:86:0)
[13:36:02.814] Timer tick, asking Buildbucket for the build status
[13:36:02.913] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:02.913] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:87:0) after 1m0s
[13:37:02.944] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:87:0)
[13:37:02.944] Timer tick, asking Buildbucket for the build status
[13:37:03.027] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:03.027] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:88:0) after 1m0s
[13:38:03.104] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:88:0)
[13:38:03.104] Timer tick, asking Buildbucket for the build status
[13:38:04.554] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:04.555] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:89:0) after 1m0s
[13:39:04.613] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:89:0)
[13:39:04.613] Timer tick, asking Buildbucket for the build status
[13:39:04.698] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:04.698] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:90:0) after 1m0s
[13:40:04.857] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:90:0)
[13:40:04.857] Timer tick, asking Buildbucket for the build status
[13:40:06.815] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:06.815] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:91:0) after 1m0s
[13:41:06.866] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:91:0)
[13:41:06.866] Timer tick, asking Buildbucket for the build status
[13:41:06.962] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:06.962] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:92:0) after 1m0s
[13:42:07.187] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:92:0)
[13:42:07.187] Timer tick, asking Buildbucket for the build status
[13:42:07.520] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:07.520] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:93:0) after 1m0s
[13:43:07.618] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:93:0)
[13:43:07.618] Timer tick, asking Buildbucket for the build status
[13:43:07.758] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:07.758] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:94:0) after 1m0s
[13:44:07.935] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:94:0)
[13:44:07.935] Timer tick, asking Buildbucket for the build status
[13:44:08.009] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:08.009] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:95:0) after 1m0s
[13:45:08.197] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:95:0)
[13:45:08.197] Timer tick, asking Buildbucket for the build status
[13:45:16.655] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:16.655] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:96:0) after 1m0s
[13:46:16.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:96:0)
[13:46:16.829] Timer tick, asking Buildbucket for the build status
[13:46:17.041] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:17.041] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:97:0) after 1m0s
[13:47:17.039] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:97:0)
[13:47:17.039] Timer tick, asking Buildbucket for the build status
[13:47:17.501] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:17.501] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:98:0) after 1m0s
[13:48:17.538] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:98:0)
[13:48:17.538] Timer tick, asking Buildbucket for the build status
[13:48:17.597] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:17.597] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:99:0) after 1m0s
[13:49:17.718] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:99:0)
[13:49:17.718] Timer tick, asking Buildbucket for the build status
[13:49:17.773] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:17.773] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:100:0) after 1m0s
[13:50:17.876] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:100:0)
[13:50:17.876] Timer tick, asking Buildbucket for the build status
[13:50:17.929] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:17.929] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:101:0) after 1m0s
[13:51:18.046] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:101:0)
[13:51:18.046] Timer tick, asking Buildbucket for the build status
[13:51:18.111] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:18.111] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:102:0) after 1m0s
[13:52:18.183] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:102:0)
[13:52:18.183] Timer tick, asking Buildbucket for the build status
[13:52:18.314] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:18.314] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:103:0) after 1m0s
[13:53:18.335] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:103:0)
[13:53:18.335] Timer tick, asking Buildbucket for the build status
[13:53:18.635] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:18.635] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:104:0) after 1m0s
[13:54:18.683] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:104:0)
[13:54:18.683] Timer tick, asking Buildbucket for the build status
[13:54:18.954] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:18.954] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:105:0) after 1m0s
[13:55:19.041] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:105:0)
[13:55:19.041] Timer tick, asking Buildbucket for the build status
[13:55:19.111] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:19.111] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:106:0) after 1m0s
[13:56:19.192] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:106:0)
[13:56:19.192] Timer tick, asking Buildbucket for the build status
[13:56:19.314] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:19.314] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:107:0) after 1m0s
[13:57:19.436] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:107:0)
[13:57:19.436] Timer tick, asking Buildbucket for the build status
[13:57:19.765] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:19.765] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:108:0) after 1m0s
[13:58:19.822] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:108:0)
[13:58:19.822] Timer tick, asking Buildbucket for the build status
[13:58:20.067] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:20.067] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:109:0) after 1m0s
[13:59:20.111] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:109:0)
[13:59:20.111] Timer tick, asking Buildbucket for the build status
[13:59:20.319] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:20.319] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:110:0) after 1m0s
[14:00:20.403] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:110:0)
[14:00:20.403] Timer tick, asking Buildbucket for the build status
[14:00:20.694] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:20.694] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:111:0) after 1m0s
[14:01:20.739] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:111:0)
[14:01:20.739] Timer tick, asking Buildbucket for the build status
[14:01:20.938] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:20.938] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:112:0) after 1m0s
[14:02:20.967] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:112:0)
[14:02:20.967] Timer tick, asking Buildbucket for the build status
[14:02:21.285] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:21.285] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:113:0) after 1m0s
[14:03:21.385] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:113:0)
[14:03:21.385] Timer tick, asking Buildbucket for the build status
[14:03:21.466] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:21.466] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:114:0) after 1m0s
[14:04:21.611] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:114:0)
[14:04:21.611] Timer tick, asking Buildbucket for the build status
[14:04:21.750] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:21.750] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:115:0) after 1m0s
[14:05:21.796] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:115:0)
[14:05:21.796] Timer tick, asking Buildbucket for the build status
[14:05:21.872] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:21.872] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:116:0) after 1m0s
[14:06:21.916] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:116:0)
[14:06:21.916] Timer tick, asking Buildbucket for the build status
[14:06:22.004] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:22.004] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:117:0) after 1m0s
[14:07:22.066] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:117:0)
[14:07:22.066] Timer tick, asking Buildbucket for the build status
[14:07:22.318] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:22.318] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:118:0) after 1m0s
[14:08:22.332] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:118:0)
[14:08:22.332] Timer tick, asking Buildbucket for the build status
[14:08:22.403] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:22.403] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:119:0) after 1m0s
[14:09:22.445] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:119:0)
[14:09:22.445] Timer tick, asking Buildbucket for the build status
[14:09:22.735] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:22.735] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:120:0) after 1m0s
[14:10:22.824] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:120:0)
[14:10:22.824] Timer tick, asking Buildbucket for the build status
[14:10:22.966] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:22.966] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:121:0) after 1m0s
[14:11:23.037] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:121:0)
[14:11:23.037] Timer tick, asking Buildbucket for the build status
[14:11:23.146] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:23.146] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:122:0) after 1m0s
[14:12:23.179] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:122:0)
[14:12:23.179] Timer tick, asking Buildbucket for the build status
[14:12:23.349] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:23.349] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:123:0) after 1m0s
[14:13:23.507] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:123:0)
[14:13:23.507] Timer tick, asking Buildbucket for the build status
[14:13:23.572] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:23.572] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:124:0) after 1m0s
[14:14:23.610] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:124:0)
[14:14:23.610] Timer tick, asking Buildbucket for the build status
[14:14:23.669] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:23.669] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:125:0) after 1m0s
[14:15:23.757] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:125:0)
[14:15:23.757] Timer tick, asking Buildbucket for the build status
[14:15:23.822] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:23.822] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:126:0) after 1m0s
[14:16:23.879] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:126:0)
[14:16:23.879] Timer tick, asking Buildbucket for the build status
[14:16:24.107] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:24.107] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:127:0) after 1m0s
[14:17:24.383] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:127:0)
[14:17:24.383] Timer tick, asking Buildbucket for the build status
[14:17:24.496] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:24.496] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:128:0) after 1m0s
[14:18:24.693] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:128:0)
[14:18:24.693] Timer tick, asking Buildbucket for the build status
[14:18:24.953] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:24.953] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:129:0) after 1m0s
[14:19:25.091] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:129:0)
[14:19:25.091] Timer tick, asking Buildbucket for the build status
[14:19:25.168] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:25.168] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:130:0) after 1m0s
[14:20:25.201] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:130:0)
[14:20:25.201] Timer tick, asking Buildbucket for the build status
[14:20:25.443] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:25.443] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:131:0) after 1m0s
[14:21:25.432] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:131:0)
[14:21:25.432] Timer tick, asking Buildbucket for the build status
[14:21:25.498] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:25.498] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:132:0) after 1m0s
[14:22:25.557] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:132:0)
[14:22:25.557] Timer tick, asking Buildbucket for the build status
[14:22:25.663] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:25.664] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:133:0) after 1m0s
[14:23:25.699] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:133:0)
[14:23:25.699] Timer tick, asking Buildbucket for the build status
[14:23:26.271] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:26.271] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:134:0) after 1m0s
[14:24:26.346] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:134:0)
[14:24:26.346] Timer tick, asking Buildbucket for the build status
[14:24:26.762] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:26.762] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:135:0) after 1m0s
[14:25:26.827] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:135:0)
[14:25:26.827] Timer tick, asking Buildbucket for the build status
[14:25:26.896] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:26.896] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:136:0) after 1m0s
[14:26:26.964] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:136:0)
[14:26:26.964] Timer tick, asking Buildbucket for the build status
[14:26:27.101] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:27.101] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:137:0) after 1m0s
[14:27:27.236] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:137:0)
[14:27:27.236] Timer tick, asking Buildbucket for the build status
[14:27:27.337] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:27.337] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:138:0) after 1m0s
[14:28:27.388] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:138:0)
[14:28:27.388] Timer tick, asking Buildbucket for the build status
[14:28:27.515] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:27.515] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:139:0) after 1m0s
[14:29:27.667] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:139:0)
[14:29:27.667] Timer tick, asking Buildbucket for the build status
[14:29:27.750] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:27.750] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:140:0) after 1m0s
[14:30:27.872] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:140:0)
[14:30:27.872] Timer tick, asking Buildbucket for the build status
[14:30:28.107] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:28.107] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:141:0) after 1m0s
[14:31:28.586] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:141:0)
[14:31:28.587] Timer tick, asking Buildbucket for the build status
[14:31:28.667] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:28.667] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:142:0) after 1m0s
[14:32:28.803] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:142:0)
[14:32:28.803] Timer tick, asking Buildbucket for the build status
[14:32:28.918] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:28.918] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:143:0) after 1m0s
[14:33:29.161] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:143:0)
[14:33:29.161] Timer tick, asking Buildbucket for the build status
[14:33:29.222] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:29.222] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:144:0) after 1m0s
[14:34:29.401] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:144:0)
[14:34:29.401] Timer tick, asking Buildbucket for the build status
[14:34:29.466] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:29.466] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:145:0) after 1m0s
[14:35:29.482] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:145:0)
[14:35:29.482] Timer tick, asking Buildbucket for the build status
[14:35:30.082] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:30.082] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:146:0) after 1m0s
[14:36:30.078] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:146:0)
[14:36:30.078] Timer tick, asking Buildbucket for the build status
[14:36:30.334] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:30.334] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:147:0) after 1m0s
[14:37:30.364] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:147:0)
[14:37:30.364] Timer tick, asking Buildbucket for the build status
[14:37:30.528] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:30.528] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:148:0) after 1m0s
[14:38:30.519] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:148:0)
[14:38:30.519] Timer tick, asking Buildbucket for the build status
[14:38:30.618] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:30.618] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:149:0) after 1m0s
[14:39:30.695] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:149:0)
[14:39:30.695] Timer tick, asking Buildbucket for the build status
[14:39:30.747] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:30.747] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:150:0) after 1m0s
[14:40:30.814] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:150:0)
[14:40:30.814] Timer tick, asking Buildbucket for the build status
[14:40:30.912] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:30.912] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:151:0) after 1m0s
[14:41:30.939] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:151:0)
[14:41:30.939] Timer tick, asking Buildbucket for the build status
[14:41:31.022] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:31.022] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:152:0) after 1m0s
[14:42:31.062] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:152:0)
[14:42:31.062] Timer tick, asking Buildbucket for the build status
[14:42:31.181] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:31.181] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:153:0) after 1m0s
[14:43:31.665] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:153:0)
[14:43:31.665] Timer tick, asking Buildbucket for the build status
[14:43:31.725] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:31.725] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:154:0) after 1m0s
[14:44:32.068] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:154:0)
[14:44:32.068] Timer tick, asking Buildbucket for the build status
[14:44:32.326] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:32.326] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:155:0) after 1m0s
[14:45:32.552] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:155:0)
[14:45:32.552] Timer tick, asking Buildbucket for the build status
[14:45:32.620] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:32.620] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:156:0) after 1m0s
[14:46:32.804] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:156:0)
[14:46:32.804] Timer tick, asking Buildbucket for the build status
[14:46:32.925] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:32.925] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:157:0) after 1m0s
[14:47:32.924] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:157:0)
[14:47:32.924] Timer tick, asking Buildbucket for the build status
[14:47:33.061] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:33.061] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:158:0) after 1m0s
[14:48:33.093] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:158:0)
[14:48:33.093] Timer tick, asking Buildbucket for the build status
[14:48:33.194] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:33.194] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:159:0) after 1m0s
[14:49:33.219] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:159:0)
[14:49:33.219] Timer tick, asking Buildbucket for the build status
[14:49:33.315] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:33.315] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:160:0) after 1m0s
[14:50:33.324] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:160:0)
[14:50:33.324] Timer tick, asking Buildbucket for the build status
[14:50:33.389] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:33.389] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:161:0) after 1m0s
[14:51:33.381] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:161:0)
[14:51:33.381] Timer tick, asking Buildbucket for the build status
[14:51:33.626] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:33.626] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:162:0) after 1m0s
[14:52:33.689] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:162:0)
[14:52:33.689] Timer tick, asking Buildbucket for the build status
[14:52:33.786] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:33.786] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:163:0) after 1m0s
[14:53:33.837] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:163:0)
[14:53:33.837] Timer tick, asking Buildbucket for the build status
[14:53:33.891] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:33.891] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:164:0) after 1m0s
[14:54:33.983] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:164:0)
[14:54:33.983] Timer tick, asking Buildbucket for the build status
[14:54:34.103] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:34.103] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:165:0) after 1m0s
[14:55:34.150] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:165:0)
[14:55:34.150] Timer tick, asking Buildbucket for the build status
[14:55:34.321] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:34.321] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:166:0) after 1m0s
[14:56:34.416] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:166:0)
[14:56:34.416] Timer tick, asking Buildbucket for the build status
[14:56:34.747] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:34.747] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:167:0) after 1m0s
[14:57:34.762] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:167:0)
[14:57:34.762] Timer tick, asking Buildbucket for the build status
[14:57:34.964] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:34.964] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:168:0) after 1m0s
[14:58:34.963] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:168:0)
[14:58:34.963] Timer tick, asking Buildbucket for the build status
[14:58:35.046] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:35.046] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:169:0) after 1m0s
[14:59:35.042] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:169:0)
[14:59:35.042] Timer tick, asking Buildbucket for the build status
[14:59:35.110] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:35.110] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:170:0) after 1m0s
[15:00:35.332] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:170:0)
[15:00:35.332] Timer tick, asking Buildbucket for the build status
[15:00:35.499] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:35.499] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:171:0) after 1m0s
[15:01:35.677] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:171:0)
[15:01:35.677] Timer tick, asking Buildbucket for the build status
[15:01:35.769] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:35.769] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:172:0) after 1m0s
[15:02:36.107] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:172:0)
[15:02:36.107] Timer tick, asking Buildbucket for the build status
[15:02:36.247] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:36.248] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:173:0) after 1m0s
[15:03:36.310] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:173:0)
[15:03:36.310] Timer tick, asking Buildbucket for the build status
[15:03:36.390] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:36.390] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:174:0) after 1m0s
[15:04:36.449] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:174:0)
[15:04:36.449] Timer tick, asking Buildbucket for the build status
[15:04:36.516] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:36.516] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:175:0) after 1m0s
[15:05:36.661] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:175:0)
[15:05:36.661] Timer tick, asking Buildbucket for the build status
[15:05:36.762] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:36.762] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:176:0) after 1m0s
[15:06:36.916] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:176:0)
[15:06:36.916] Timer tick, asking Buildbucket for the build status
[15:06:37.054] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:37.054] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:177:0) after 1m0s
[15:07:37.158] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:177:0)
[15:07:37.158] Timer tick, asking Buildbucket for the build status
[15:07:37.439] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:37.439] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:178:0) after 1m0s
[15:08:37.523] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:178:0)
[15:08:37.523] Timer tick, asking Buildbucket for the build status
[15:08:37.593] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:37.593] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:179:0) after 1m0s
[15:09:37.645] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:179:0)
[15:09:37.645] Timer tick, asking Buildbucket for the build status
[15:09:37.955] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:37.955] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:180:0) after 1m0s
[15:10:38.063] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:180:0)
[15:10:38.063] Timer tick, asking Buildbucket for the build status
[15:10:38.124] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:38.124] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:181:0) after 1m0s
[15:11:38.188] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:181:0)
[15:11:38.188] Timer tick, asking Buildbucket for the build status
[15:11:38.250] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:38.250] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:182:0) after 1m0s
[15:12:38.265] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:182:0)
[15:12:38.265] Timer tick, asking Buildbucket for the build status
[15:12:38.386] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:38.386] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:183:0) after 1m0s
[15:13:38.475] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:183:0)
[15:13:38.475] Timer tick, asking Buildbucket for the build status
[15:13:38.551] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:38.551] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:184:0) after 1m0s
[15:14:39.112] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:184:0)
[15:14:39.112] Timer tick, asking Buildbucket for the build status
[15:14:39.174] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:39.174] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:185:0) after 1m0s
[15:15:39.278] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:185:0)
[15:15:39.278] Timer tick, asking Buildbucket for the build status
[15:15:39.388] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:39.388] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:186:0) after 1m0s
[15:16:39.541] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:186:0)
[15:16:39.541] Timer tick, asking Buildbucket for the build status
[15:16:39.747] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:39.747] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:187:0) after 1m0s
[15:17:40.770] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:187:0)
[15:17:40.771] Timer tick, asking Buildbucket for the build status
[15:17:40.919] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:40.919] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:188:0) after 1m0s
[15:18:41.045] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:188:0)
[15:18:41.045] Timer tick, asking Buildbucket for the build status
[15:18:41.211] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:41.211] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:189:0) after 1m0s
[15:19:41.373] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:189:0)
[15:19:41.373] Timer tick, asking Buildbucket for the build status
[15:19:41.446] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:41.446] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:190:0) after 1m0s
[15:20:41.546] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:190:0)
[15:20:41.546] Timer tick, asking Buildbucket for the build status
[15:20:41.913] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:41.913] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:191:0) after 1m0s
[15:21:42.116] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:191:0)
[15:21:42.116] Timer tick, asking Buildbucket for the build status
[15:21:42.221] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:42.221] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:192:0) after 1m0s
[15:22:42.366] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:192:0)
[15:22:42.366] Timer tick, asking Buildbucket for the build status
[15:22:42.829] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:42.829] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:193:0) after 1m0s
[15:23:42.961] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:193:0)
[15:23:42.961] Timer tick, asking Buildbucket for the build status
[15:23:43.064] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:43.064] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:194:0) after 1m0s
[15:24:43.186] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:194:0)
[15:24:43.186] Timer tick, asking Buildbucket for the build status
[15:24:43.254] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:43.254] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:195:0) after 1m0s
[15:25:43.432] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:195:0)
[15:25:43.432] Timer tick, asking Buildbucket for the build status
[15:25:44.539] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:44.539] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:196:0) after 1m0s
[15:26:44.596] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:196:0)
[15:26:44.596] Timer tick, asking Buildbucket for the build status
[15:26:44.891] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:44.891] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:197:0) after 1m0s
[15:27:44.923] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:197:0)
[15:27:44.923] Timer tick, asking Buildbucket for the build status
[15:27:45.018] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:45.018] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:198:0) after 1m0s
[15:28:45.048] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:198:0)
[15:28:45.048] Timer tick, asking Buildbucket for the build status
[15:28:45.229] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:45.229] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:199:0) after 1m0s
[15:29:45.273] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:199:0)
[15:29:45.273] Timer tick, asking Buildbucket for the build status
[15:29:45.669] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:45.669] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:200:0) after 1m0s
[15:30:45.807] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:200:0)
[15:30:45.807] Timer tick, asking Buildbucket for the build status
[15:30:45.881] Build 8857676643364031072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:45.881] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9023106705275095024:201:0) after 1m0s
[15:30:54.648] Received PubSub notification, asking Buildbucket for the build status
[15:30:54.932] Build 8857676643364031072: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:30:54.932] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611070253497008",
"created_by": "project:chromium",
"created_ts": "1611058304400496",
"id": "8857676643364031072",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4ce9888371cba53fc21702714881d10df2be23ec\"}}",
"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\": \"4ce9888371cba53fc21702714881d10df2be23ec\", \"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-5-pm8t\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1369, \"got_angle_revision\": \"b69f54069cbf700a4646817805ca77c0d2a01292\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"4ce9888371cba53fc21702714881d10df2be23ec\", \"got_revision_cp\": \"refs/heads/master@{#844735}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"ee927aaa58e688ad6aa0256b3929c1eeea0bebd5\", \"got_v8_revision_cp\": \"refs/heads/9.0.8@{#1}\", \"got_webrtc_revision\": \"29bd8638adb0a7294f7b8ae589fdd24077539dbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33030}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4ce9888371cba53fc21702714881d10df2be23ec\"}, \"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-5-pm8t\"], \"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\": [\"5666-679c9bd\"], \"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": "1611058337125792",
"status": "COMPLETED",
"status_changed_ts": "1611070254204594",
"tags": [
"build_address:luci.chromium.ci/win32-official/1369",
"builder:win32-official",
"buildset:commit/git/4ce9888371cba53fc21702714881d10df2be23ec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4ce9888371cba53fc21702714881d10df2be23ec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023106705275095024",
"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/8857676643364031072/+/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:513360a92d350d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611070254214485",
"url": "https://ci.chromium.org/b/8857676643364031072",
"utcnow_ts": "1611070254913492"
}
}
[15:30:54.932] Invocation finished in 3h19m11.738484693s with status SUCCEEDED