[19:48:00.544] New invocation is queued and will start shortly
[19:48:02.039] Starting the invocation (attempt 1)
[19:48:02.085] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:48:02.085] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:48:02.085] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026339488850647440",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"47d4c253481111c0743b16f445dacaeeb74d6169\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9026339488850647440",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/47d4c253481111c0743b16f445dacaeeb74d6169",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/47d4c253481111c0743b16f445dacaeeb74d6169",
"gitiles_ref:refs/heads/master"
]
}
[19:48:03.272] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607975282226444",
"id": "8860909426422802928",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"47d4c253481111c0743b16f445dacaeeb74d6169\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607975283026829",
"tags": [
"build_address:luci.chromium.ci/win32-official/1113",
"builder:win32-official",
"buildset:commit/git/47d4c253481111c0743b16f445dacaeeb74d6169",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/47d4c253481111c0743b16f445dacaeeb74d6169",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026339488850647440",
"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/8860909426422802928/+/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": "1607975283027021",
"url": "https://ci.chromium.org/b/8860909426422802928",
"utcnow_ts": "1607975283245806"
}
}
[19:48:03.272] Task URL: https://ci.chromium.org/b/8860909426422802928
[19:48:03.272] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:2:0) after 1m0s
[19:48:45.780] Received PubSub notification, asking Buildbucket for the build status
[19:48:46.055] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:03.303] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:2:0)
[19:49:03.303] Timer tick, asking Buildbucket for the build status
[19:49:03.415] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:03.415] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:4:0) after 1m0s
[19:50:03.465] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:4:0)
[19:50:03.465] Timer tick, asking Buildbucket for the build status
[19:50:03.582] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:03.582] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:5:0) after 1m0s
[19:51:03.644] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:5:0)
[19:51:03.644] Timer tick, asking Buildbucket for the build status
[19:51:03.719] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:03.719] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:6:0) after 1m0s
[19:52:03.763] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:6:0)
[19:52:03.763] Timer tick, asking Buildbucket for the build status
[19:52:03.895] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:03.895] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:7:0) after 1m0s
[19:53:03.917] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:7:0)
[19:53:03.917] Timer tick, asking Buildbucket for the build status
[19:53:04.028] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:04.028] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:8:0) after 1m0s
[19:54:04.093] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:8:0)
[19:54:04.093] Timer tick, asking Buildbucket for the build status
[19:54:04.185] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:04.185] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:9:0) after 1m0s
[19:55:04.208] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:9:0)
[19:55:04.208] Timer tick, asking Buildbucket for the build status
[19:55:04.365] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:04.365] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:10:0) after 1m0s
[19:56:04.411] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:10:0)
[19:56:04.411] Timer tick, asking Buildbucket for the build status
[19:56:04.488] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:04.488] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:11:0) after 1m0s
[19:57:04.509] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:11:0)
[19:57:04.509] Timer tick, asking Buildbucket for the build status
[19:57:04.652] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:04.652] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:12:0) after 1m0s
[19:58:04.712] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:12:0)
[19:58:04.712] Timer tick, asking Buildbucket for the build status
[19:58:04.948] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:04.948] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:13:0) after 1m0s
[19:59:04.995] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:13:0)
[19:59:04.995] Timer tick, asking Buildbucket for the build status
[19:59:05.075] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:05.075] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:14:0) after 1m0s
[20:00:05.155] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:14:0)
[20:00:05.155] Timer tick, asking Buildbucket for the build status
[20:00:05.252] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:05.252] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:15:0) after 1m0s
[20:01:05.506] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:15:0)
[20:01:05.506] Timer tick, asking Buildbucket for the build status
[20:01:05.674] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:05.674] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:16:0) after 1m0s
[20:02:05.716] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:16:0)
[20:02:05.716] Timer tick, asking Buildbucket for the build status
[20:02:05.782] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:05.783] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:17:0) after 1m0s
[20:03:05.871] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:17:0)
[20:03:05.871] Timer tick, asking Buildbucket for the build status
[20:03:05.999] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:05.999] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:18:0) after 1m0s
[20:04:06.019] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:18:0)
[20:04:06.019] Timer tick, asking Buildbucket for the build status
[20:04:06.085] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:06.085] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:19:0) after 1m0s
[20:05:06.118] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:19:0)
[20:05:06.118] Timer tick, asking Buildbucket for the build status
[20:05:06.454] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:06.454] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:20:0) after 1m0s
[20:06:06.507] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:20:0)
[20:06:06.507] Timer tick, asking Buildbucket for the build status
[20:06:07.200] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:07.200] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:21:0) after 1m0s
[20:07:07.265] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:21:0)
[20:07:07.265] Timer tick, asking Buildbucket for the build status
[20:07:07.321] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:07.321] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:22:0) after 1m0s
[20:08:07.419] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:22:0)
[20:08:07.419] Timer tick, asking Buildbucket for the build status
[20:08:07.527] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:07.527] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:23:0) after 1m0s
[20:09:07.602] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:23:0)
[20:09:07.602] Timer tick, asking Buildbucket for the build status
[20:09:07.973] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:07.973] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:24:0) after 1m0s
[20:10:08.002] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:24:0)
[20:10:08.002] Timer tick, asking Buildbucket for the build status
[20:10:08.399] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:08.399] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:25:0) after 1m0s
[20:11:08.463] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:25:0)
[20:11:08.463] Timer tick, asking Buildbucket for the build status
[20:11:08.575] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:08.575] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:26:0) after 1m0s
[20:12:08.705] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:26:0)
[20:12:08.705] Timer tick, asking Buildbucket for the build status
[20:12:08.819] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:08.819] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:27:0) after 1m0s
[20:13:08.798] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:27:0)
[20:13:08.798] Timer tick, asking Buildbucket for the build status
[20:13:08.911] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:08.911] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:28:0) after 1m0s
[20:14:08.960] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:28:0)
[20:14:08.960] Timer tick, asking Buildbucket for the build status
[20:14:09.030] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:09.030] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:29:0) after 1m0s
[20:15:09.164] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:29:0)
[20:15:09.164] Timer tick, asking Buildbucket for the build status
[20:15:09.250] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:09.250] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:30:0) after 1m0s
[20:16:09.288] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:30:0)
[20:16:09.288] Timer tick, asking Buildbucket for the build status
[20:16:09.510] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:09.510] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:31:0) after 1m0s
[20:17:09.583] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:31:0)
[20:17:09.583] Timer tick, asking Buildbucket for the build status
[20:17:09.665] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:09.665] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:32:0) after 1m0s
[20:18:09.787] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:32:0)
[20:18:09.789] Timer tick, asking Buildbucket for the build status
[20:18:09.879] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:09.880] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:33:0) after 1m0s
[20:19:10.112] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:33:0)
[20:19:10.112] Timer tick, asking Buildbucket for the build status
[20:19:10.290] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:10.290] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:34:0) after 1m0s
[20:20:10.520] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:34:0)
[20:20:10.520] Timer tick, asking Buildbucket for the build status
[20:20:10.714] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:10.714] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:35:0) after 1m0s
[20:21:10.785] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:35:0)
[20:21:10.785] Timer tick, asking Buildbucket for the build status
[20:21:10.848] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:10.848] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:36:0) after 1m0s
[20:22:10.905] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:36:0)
[20:22:10.905] Timer tick, asking Buildbucket for the build status
[20:22:10.960] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:10.960] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:37:0) after 1m0s
[20:23:11.037] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:37:0)
[20:23:11.037] Timer tick, asking Buildbucket for the build status
[20:23:11.346] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:11.346] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:38:0) after 1m0s
[20:24:11.379] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:38:0)
[20:24:11.379] Timer tick, asking Buildbucket for the build status
[20:24:11.496] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:11.496] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:39:0) after 1m0s
[20:25:11.550] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:39:0)
[20:25:11.550] Timer tick, asking Buildbucket for the build status
[20:25:11.652] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:11.652] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:40:0) after 1m0s
[20:26:11.689] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:40:0)
[20:26:11.689] Timer tick, asking Buildbucket for the build status
[20:26:11.803] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:11.803] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:41:0) after 1m0s
[20:27:11.837] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:41:0)
[20:27:11.837] Timer tick, asking Buildbucket for the build status
[20:27:11.903] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:11.903] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:42:0) after 1m0s
[20:28:11.997] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:42:0)
[20:28:11.997] Timer tick, asking Buildbucket for the build status
[20:28:12.173] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:12.174] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:43:0) after 1m0s
[20:29:12.158] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:43:0)
[20:29:12.158] Timer tick, asking Buildbucket for the build status
[20:29:12.230] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:12.230] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:44:0) after 1m0s
[20:30:12.318] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:44:0)
[20:30:12.318] Timer tick, asking Buildbucket for the build status
[20:30:12.382] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:12.382] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:45:0) after 1m0s
[20:31:12.408] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:45:0)
[20:31:12.408] Timer tick, asking Buildbucket for the build status
[20:31:12.483] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:12.483] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:46:0) after 1m0s
[20:32:12.577] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:46:0)
[20:32:12.577] Timer tick, asking Buildbucket for the build status
[20:32:12.643] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:12.643] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:47:0) after 1m0s
[20:33:12.684] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:47:0)
[20:33:12.684] Timer tick, asking Buildbucket for the build status
[20:33:12.828] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:12.829] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:48:0) after 1m0s
[20:34:12.880] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:48:0)
[20:34:12.880] Timer tick, asking Buildbucket for the build status
[20:34:12.941] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:12.941] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:49:0) after 1m0s
[20:35:12.948] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:49:0)
[20:35:12.948] Timer tick, asking Buildbucket for the build status
[20:35:13.004] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:13.004] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:50:0) after 1m0s
[20:36:13.048] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:50:0)
[20:36:13.048] Timer tick, asking Buildbucket for the build status
[20:36:13.343] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:13.343] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:51:0) after 1m0s
[20:37:13.372] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:51:0)
[20:37:13.372] Timer tick, asking Buildbucket for the build status
[20:37:13.453] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:13.453] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:52:0) after 1m0s
[20:38:13.530] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:52:0)
[20:38:13.530] Timer tick, asking Buildbucket for the build status
[20:38:13.841] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:13.841] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:53:0) after 1m0s
[20:39:13.867] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:53:0)
[20:39:13.867] Timer tick, asking Buildbucket for the build status
[20:39:13.942] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:13.942] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:54:0) after 1m0s
[20:40:13.963] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:54:0)
[20:40:13.963] Timer tick, asking Buildbucket for the build status
[20:40:14.087] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:14.087] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:55:0) after 1m0s
[20:41:14.132] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:55:0)
[20:41:14.132] Timer tick, asking Buildbucket for the build status
[20:41:14.205] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:14.205] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:56:0) after 1m0s
[20:42:14.205] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:56:0)
[20:42:14.205] Timer tick, asking Buildbucket for the build status
[20:42:14.264] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:14.264] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:57:0) after 1m0s
[20:43:14.292] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:57:0)
[20:43:14.292] Timer tick, asking Buildbucket for the build status
[20:43:14.416] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:14.416] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:58:0) after 1m0s
[20:44:14.435] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:58:0)
[20:44:14.435] Timer tick, asking Buildbucket for the build status
[20:44:14.555] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:14.555] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:59:0) after 1m0s
[20:45:14.619] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:59:0)
[20:45:14.619] Timer tick, asking Buildbucket for the build status
[20:45:14.967] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:14.967] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:60:0) after 1m0s
[20:46:15.012] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:60:0)
[20:46:15.012] Timer tick, asking Buildbucket for the build status
[20:46:15.082] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:15.082] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:61:0) after 1m0s
[20:47:15.127] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:61:0)
[20:47:15.127] Timer tick, asking Buildbucket for the build status
[20:47:15.193] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:15.193] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:62:0) after 1m0s
[20:48:15.228] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:62:0)
[20:48:15.228] Timer tick, asking Buildbucket for the build status
[20:48:15.314] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:15.314] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:63:0) after 1m0s
[20:49:15.325] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:63:0)
[20:49:15.325] Timer tick, asking Buildbucket for the build status
[20:49:15.531] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:15.531] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:64:0) after 1m0s
[20:50:15.592] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:64:0)
[20:50:15.592] Timer tick, asking Buildbucket for the build status
[20:50:15.661] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:15.661] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:65:0) after 1m0s
[20:51:15.711] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:65:0)
[20:51:15.711] Timer tick, asking Buildbucket for the build status
[20:51:15.786] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:15.786] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:66:0) after 1m0s
[20:52:15.861] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:66:0)
[20:52:15.861] Timer tick, asking Buildbucket for the build status
[20:52:15.935] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:15.935] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:67:0) after 1m0s
[20:53:16.061] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:67:0)
[20:53:16.061] Timer tick, asking Buildbucket for the build status
[20:53:16.163] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:16.163] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:68:0) after 1m0s
[20:54:16.252] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:68:0)
[20:54:16.252] Timer tick, asking Buildbucket for the build status
[20:54:16.519] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:16.519] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:69:0) after 1m0s
[20:55:16.619] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:69:0)
[20:55:16.619] Timer tick, asking Buildbucket for the build status
[20:55:16.675] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:16.675] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:70:0) after 1m0s
[20:56:16.713] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:70:0)
[20:56:16.713] Timer tick, asking Buildbucket for the build status
[20:56:17.020] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:17.020] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:71:0) after 1m0s
[20:57:17.005] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:71:0)
[20:57:17.005] Timer tick, asking Buildbucket for the build status
[20:57:17.114] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:17.114] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:72:0) after 1m0s
[20:58:17.199] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:72:0)
[20:58:17.199] Timer tick, asking Buildbucket for the build status
[20:58:17.343] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:17.343] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:73:0) after 1m0s
[20:59:17.360] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:73:0)
[20:59:17.360] Timer tick, asking Buildbucket for the build status
[20:59:17.445] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:17.445] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:74:0) after 1m0s
[21:00:17.470] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:74:0)
[21:00:17.470] Timer tick, asking Buildbucket for the build status
[21:00:17.564] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:17.564] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:75:0) after 1m0s
[21:01:17.636] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:75:0)
[21:01:17.636] Timer tick, asking Buildbucket for the build status
[21:01:17.696] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:17.696] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:76:0) after 1m0s
[21:02:17.722] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:76:0)
[21:02:17.722] Timer tick, asking Buildbucket for the build status
[21:02:17.810] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:17.810] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:77:0) after 1m0s
[21:03:17.867] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:77:0)
[21:03:17.867] Timer tick, asking Buildbucket for the build status
[21:03:17.988] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:17.988] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:78:0) after 1m0s
[21:04:18.018] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:78:0)
[21:04:18.018] Timer tick, asking Buildbucket for the build status
[21:04:18.457] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:18.457] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:79:0) after 1m0s
[21:05:18.549] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:79:0)
[21:05:18.549] Timer tick, asking Buildbucket for the build status
[21:05:18.604] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:18.604] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:80:0) after 1m0s
[21:06:18.626] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:80:0)
[21:06:18.626] Timer tick, asking Buildbucket for the build status
[21:06:18.744] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:18.744] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:81:0) after 1m0s
[21:07:18.843] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:81:0)
[21:07:18.843] Timer tick, asking Buildbucket for the build status
[21:07:18.907] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:18.907] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:82:0) after 1m0s
[21:08:18.998] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:82:0)
[21:08:18.998] Timer tick, asking Buildbucket for the build status
[21:08:19.165] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:19.165] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:83:0) after 1m0s
[21:09:19.283] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:83:0)
[21:09:19.283] Timer tick, asking Buildbucket for the build status
[21:09:19.332] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:19.332] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:84:0) after 1m0s
[21:10:19.442] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:84:0)
[21:10:19.442] Timer tick, asking Buildbucket for the build status
[21:10:19.502] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:19.502] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:85:0) after 1m0s
[21:11:19.597] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:85:0)
[21:11:19.597] Timer tick, asking Buildbucket for the build status
[21:11:19.837] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:19.837] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:86:0) after 1m0s
[21:12:20.058] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:86:0)
[21:12:20.058] Timer tick, asking Buildbucket for the build status
[21:12:20.141] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:20.141] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:87:0) after 1m0s
[21:13:20.211] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:87:0)
[21:13:20.211] Timer tick, asking Buildbucket for the build status
[21:13:20.494] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:20.494] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:88:0) after 1m0s
[21:14:20.533] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:88:0)
[21:14:20.533] Timer tick, asking Buildbucket for the build status
[21:14:20.601] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:20.601] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:89:0) after 1m0s
[21:15:20.637] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:89:0)
[21:15:20.637] Timer tick, asking Buildbucket for the build status
[21:15:20.698] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:20.698] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:90:0) after 1m0s
[21:16:20.724] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:90:0)
[21:16:20.724] Timer tick, asking Buildbucket for the build status
[21:16:20.797] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:20.797] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:91:0) after 1m0s
[21:17:20.924] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:91:0)
[21:17:20.924] Timer tick, asking Buildbucket for the build status
[21:17:21.000] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:21.000] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:92:0) after 1m0s
[21:18:21.183] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:92:0)
[21:18:21.183] Timer tick, asking Buildbucket for the build status
[21:18:21.290] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:21.290] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:93:0) after 1m0s
[21:19:21.393] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:93:0)
[21:19:21.393] Timer tick, asking Buildbucket for the build status
[21:19:21.451] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:21.451] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:94:0) after 1m0s
[21:20:21.633] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:94:0)
[21:20:21.633] Timer tick, asking Buildbucket for the build status
[21:20:21.706] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:21.706] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:95:0) after 1m0s
[21:21:21.918] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:95:0)
[21:21:21.918] Timer tick, asking Buildbucket for the build status
[21:21:22.005] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:22.005] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:96:0) after 1m0s
[21:22:22.090] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:96:0)
[21:22:22.090] Timer tick, asking Buildbucket for the build status
[21:22:22.220] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:22.220] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:97:0) after 1m0s
[21:23:22.319] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:97:0)
[21:23:22.319] Timer tick, asking Buildbucket for the build status
[21:23:22.443] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:22.443] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:98:0) after 1m0s
[21:24:22.539] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:98:0)
[21:24:22.539] Timer tick, asking Buildbucket for the build status
[21:24:22.660] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:22.660] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:99:0) after 1m0s
[21:25:22.710] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:99:0)
[21:25:22.710] Timer tick, asking Buildbucket for the build status
[21:25:22.844] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:22.844] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:100:0) after 1m0s
[21:26:22.900] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:100:0)
[21:26:22.900] Timer tick, asking Buildbucket for the build status
[21:26:22.962] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:22.962] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:101:0) after 1m0s
[21:27:23.008] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:101:0)
[21:27:23.008] Timer tick, asking Buildbucket for the build status
[21:27:23.071] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:23.071] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:102:0) after 1m0s
[21:28:23.095] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:102:0)
[21:28:23.095] Timer tick, asking Buildbucket for the build status
[21:28:23.185] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:23.185] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:103:0) after 1m0s
[21:29:23.316] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:103:0)
[21:29:23.316] Timer tick, asking Buildbucket for the build status
[21:29:23.373] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:23.373] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:104:0) after 1m0s
[21:30:23.422] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:104:0)
[21:30:23.423] Timer tick, asking Buildbucket for the build status
[21:30:23.473] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:23.473] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:105:0) after 1m0s
[21:31:23.707] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:105:0)
[21:31:23.707] Timer tick, asking Buildbucket for the build status
[21:31:23.828] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:23.828] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:106:0) after 1m0s
[21:32:23.962] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:106:0)
[21:32:23.962] Timer tick, asking Buildbucket for the build status
[21:32:24.011] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:24.011] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:107:0) after 1m0s
[21:33:24.040] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:107:0)
[21:33:24.040] Timer tick, asking Buildbucket for the build status
[21:33:24.207] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:24.207] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:108:0) after 1m0s
[21:34:24.252] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:108:0)
[21:34:24.252] Timer tick, asking Buildbucket for the build status
[21:34:24.374] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:24.374] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:109:0) after 1m0s
[21:35:24.401] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:109:0)
[21:35:24.401] Timer tick, asking Buildbucket for the build status
[21:35:24.466] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:24.466] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:110:0) after 1m0s
[21:36:24.493] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:110:0)
[21:36:24.494] Timer tick, asking Buildbucket for the build status
[21:36:24.869] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:24.869] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:111:0) after 1m0s
[21:37:24.899] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:111:0)
[21:37:24.899] Timer tick, asking Buildbucket for the build status
[21:37:24.980] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:24.980] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:112:0) after 1m0s
[21:38:25.176] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:112:0)
[21:38:25.176] Timer tick, asking Buildbucket for the build status
[21:38:25.285] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:25.285] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:113:0) after 1m0s
[21:39:25.335] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:113:0)
[21:39:25.335] Timer tick, asking Buildbucket for the build status
[21:39:25.401] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:25.401] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:114:0) after 1m0s
[21:40:25.522] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:114:0)
[21:40:25.522] Timer tick, asking Buildbucket for the build status
[21:40:25.635] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:25.635] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:115:0) after 1m0s
[21:41:25.724] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:115:0)
[21:41:25.724] Timer tick, asking Buildbucket for the build status
[21:41:25.841] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:25.841] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:116:0) after 1m0s
[21:42:25.986] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:116:0)
[21:42:25.986] Timer tick, asking Buildbucket for the build status
[21:42:26.060] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:26.060] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:117:0) after 1m0s
[21:43:26.213] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:117:0)
[21:43:26.213] Timer tick, asking Buildbucket for the build status
[21:43:26.303] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:26.303] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:118:0) after 1m0s
[21:44:26.384] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:118:0)
[21:44:26.384] Timer tick, asking Buildbucket for the build status
[21:44:26.534] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:26.534] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:119:0) after 1m0s
[21:45:26.567] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:119:0)
[21:45:26.567] Timer tick, asking Buildbucket for the build status
[21:45:26.862] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:26.862] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:120:0) after 1m0s
[21:46:26.907] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:120:0)
[21:46:26.907] Timer tick, asking Buildbucket for the build status
[21:46:26.967] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:26.967] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:121:0) after 1m0s
[21:47:27.023] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:121:0)
[21:47:27.023] Timer tick, asking Buildbucket for the build status
[21:47:27.080] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:27.080] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:122:0) after 1m0s
[21:48:27.122] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:122:0)
[21:48:27.122] Timer tick, asking Buildbucket for the build status
[21:48:27.443] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:27.443] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:123:0) after 1m0s
[21:49:27.529] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:123:0)
[21:49:27.529] Timer tick, asking Buildbucket for the build status
[21:49:27.606] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:27.606] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:124:0) after 1m0s
[21:50:27.687] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:124:0)
[21:50:27.687] Timer tick, asking Buildbucket for the build status
[21:50:28.054] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:28.054] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:125:0) after 1m0s
[21:51:28.151] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:125:0)
[21:51:28.151] Timer tick, asking Buildbucket for the build status
[21:51:28.227] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:28.227] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:126:0) after 1m0s
[21:52:28.278] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:126:0)
[21:52:28.278] Timer tick, asking Buildbucket for the build status
[21:52:29.211] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:29.211] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:127:0) after 1m0s
[21:53:29.253] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:127:0)
[21:53:29.254] Timer tick, asking Buildbucket for the build status
[21:53:31.090] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:31.090] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:128:0) after 1m0s
[21:54:31.167] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:128:0)
[21:54:31.167] Timer tick, asking Buildbucket for the build status
[21:54:31.251] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:31.251] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:129:0) after 1m0s
[21:55:31.308] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:129:0)
[21:55:31.308] Timer tick, asking Buildbucket for the build status
[21:55:31.374] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:31.374] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:130:0) after 1m0s
[21:56:31.433] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:130:0)
[21:56:31.433] Timer tick, asking Buildbucket for the build status
[21:56:31.483] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:31.483] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:131:0) after 1m0s
[21:57:31.471] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:131:0)
[21:57:31.471] Timer tick, asking Buildbucket for the build status
[21:57:31.526] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:31.526] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:132:0) after 1m0s
[21:58:31.510] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:132:0)
[21:58:31.510] Timer tick, asking Buildbucket for the build status
[21:58:31.619] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:31.619] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:133:0) after 1m0s
[21:59:31.695] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:133:0)
[21:59:31.695] Timer tick, asking Buildbucket for the build status
[21:59:32.075] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:32.076] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:134:0) after 1m0s
[22:00:32.166] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:134:0)
[22:00:32.166] Timer tick, asking Buildbucket for the build status
[22:00:32.237] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:32.237] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:135:0) after 1m0s
[22:01:32.296] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:135:0)
[22:01:32.296] Timer tick, asking Buildbucket for the build status
[22:01:32.371] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:32.371] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:136:0) after 1m0s
[22:02:32.463] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:136:0)
[22:02:32.463] Timer tick, asking Buildbucket for the build status
[22:02:32.701] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:32.701] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:137:0) after 1m0s
[22:03:32.863] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:137:0)
[22:03:32.863] Timer tick, asking Buildbucket for the build status
[22:03:33.596] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:33.596] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:138:0) after 1m0s
[22:04:33.675] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:138:0)
[22:04:33.675] Timer tick, asking Buildbucket for the build status
[22:04:33.762] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:33.762] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:139:0) after 1m0s
[22:05:33.818] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:139:0)
[22:05:33.818] Timer tick, asking Buildbucket for the build status
[22:05:33.929] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:33.929] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:140:0) after 1m0s
[22:06:34.013] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:140:0)
[22:06:34.013] Timer tick, asking Buildbucket for the build status
[22:06:34.067] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:34.067] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:141:0) after 1m0s
[22:07:34.194] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:141:0)
[22:07:34.195] Timer tick, asking Buildbucket for the build status
[22:07:34.333] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:34.333] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:142:0) after 1m0s
[22:08:34.416] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:142:0)
[22:08:34.416] Timer tick, asking Buildbucket for the build status
[22:08:34.739] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:34.739] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:143:0) after 1m0s
[22:09:34.773] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:143:0)
[22:09:34.773] Timer tick, asking Buildbucket for the build status
[22:09:34.898] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:34.898] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:144:0) after 1m0s
[22:10:34.960] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:144:0)
[22:10:34.960] Timer tick, asking Buildbucket for the build status
[22:10:35.034] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:35.034] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:145:0) after 1m0s
[22:11:35.058] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:145:0)
[22:11:35.058] Timer tick, asking Buildbucket for the build status
[22:11:35.258] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:35.258] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:146:0) after 1m0s
[22:12:35.295] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:146:0)
[22:12:35.295] Timer tick, asking Buildbucket for the build status
[22:12:35.488] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:35.488] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:147:0) after 1m0s
[22:13:35.555] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:147:0)
[22:13:35.555] Timer tick, asking Buildbucket for the build status
[22:13:35.885] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:35.885] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:148:0) after 1m0s
[22:14:35.888] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:148:0)
[22:14:35.888] Timer tick, asking Buildbucket for the build status
[22:14:35.956] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:35.956] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:149:0) after 1m0s
[22:15:36.006] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:149:0)
[22:15:36.006] Timer tick, asking Buildbucket for the build status
[22:15:36.152] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:36.152] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:150:0) after 1m0s
[22:16:36.225] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:150:0)
[22:16:36.225] Timer tick, asking Buildbucket for the build status
[22:16:36.731] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:36.731] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:151:0) after 1m0s
[22:17:36.789] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:151:0)
[22:17:36.789] Timer tick, asking Buildbucket for the build status
[22:17:36.913] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:36.913] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:152:0) after 1m0s
[22:18:36.989] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:152:0)
[22:18:36.989] Timer tick, asking Buildbucket for the build status
[22:18:37.661] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:37.661] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:153:0) after 1m0s
[22:19:37.695] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:153:0)
[22:19:37.695] Timer tick, asking Buildbucket for the build status
[22:19:37.755] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:37.756] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:154:0) after 1m0s
[22:20:37.872] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:154:0)
[22:20:37.872] Timer tick, asking Buildbucket for the build status
[22:20:38.099] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:38.099] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:155:0) after 1m0s
[22:21:38.220] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:155:0)
[22:21:38.220] Timer tick, asking Buildbucket for the build status
[22:21:38.362] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:38.362] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:156:0) after 1m0s
[22:22:38.449] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:156:0)
[22:22:38.449] Timer tick, asking Buildbucket for the build status
[22:22:38.914] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:38.914] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:157:0) after 1m0s
[22:23:38.970] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:157:0)
[22:23:38.970] Timer tick, asking Buildbucket for the build status
[22:23:39.214] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:39.214] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:158:0) after 1m0s
[22:24:39.274] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:158:0)
[22:24:39.274] Timer tick, asking Buildbucket for the build status
[22:24:39.346] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:39.346] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:159:0) after 1m0s
[22:25:39.409] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:159:0)
[22:25:39.409] Timer tick, asking Buildbucket for the build status
[22:25:39.642] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:39.642] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:160:0) after 1m0s
[22:26:39.665] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:160:0)
[22:26:39.665] Timer tick, asking Buildbucket for the build status
[22:26:39.868] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:39.868] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:161:0) after 1m0s
[22:27:39.905] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:161:0)
[22:27:39.905] Timer tick, asking Buildbucket for the build status
[22:27:39.964] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:39.964] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:162:0) after 1m0s
[22:28:40.017] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:162:0)
[22:28:40.017] Timer tick, asking Buildbucket for the build status
[22:28:40.118] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:40.118] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:163:0) after 1m0s
[22:29:40.152] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:163:0)
[22:29:40.152] Timer tick, asking Buildbucket for the build status
[22:29:40.444] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:40.444] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:164:0) after 1m0s
[22:30:40.490] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:164:0)
[22:30:40.490] Timer tick, asking Buildbucket for the build status
[22:30:40.920] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:40.920] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:165:0) after 1m0s
[22:31:40.969] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:165:0)
[22:31:40.969] Timer tick, asking Buildbucket for the build status
[22:31:41.029] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:41.029] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:166:0) after 1m0s
[22:32:41.050] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:166:0)
[22:32:41.050] Timer tick, asking Buildbucket for the build status
[22:32:41.115] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:41.115] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:167:0) after 1m0s
[22:33:41.175] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:167:0)
[22:33:41.175] Timer tick, asking Buildbucket for the build status
[22:33:41.355] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:41.355] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:168:0) after 1m0s
[22:34:41.424] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:168:0)
[22:34:41.424] Timer tick, asking Buildbucket for the build status
[22:34:41.491] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:41.491] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:169:0) after 1m0s
[22:35:41.647] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:169:0)
[22:35:41.647] Timer tick, asking Buildbucket for the build status
[22:35:41.699] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:41.699] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:170:0) after 1m0s
[22:36:41.755] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:170:0)
[22:36:41.755] Timer tick, asking Buildbucket for the build status
[22:36:41.822] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:41.822] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:171:0) after 1m0s
[22:37:41.943] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:171:0)
[22:37:41.943] Timer tick, asking Buildbucket for the build status
[22:37:41.999] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:41.999] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:172:0) after 1m0s
[22:38:42.148] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:172:0)
[22:38:42.148] Timer tick, asking Buildbucket for the build status
[22:38:42.282] Build 8860909426422802928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:42.282] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9026339488850647440:173:0) after 1m0s
[22:39:08.617] Received PubSub notification, asking Buildbucket for the build status
[22:39:08.684] Build 8860909426422802928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:39:08.684] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607985547950706",
"created_by": "project:chromium",
"created_ts": "1607975282226444",
"id": "8860909426422802928",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"47d4c253481111c0743b16f445dacaeeb74d6169\"}}",
"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\": \"47d4c253481111c0743b16f445dacaeeb74d6169\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"win-dbg-2-zd44\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1113, \"got_angle_revision\": \"3df29be284458dde76dc1b1e30793d682f9a60ff\", \"got_dawn_revision\": \"12c78cbc820a52c4ca2da8e92d9faf815d9b3e93\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"47d4c253481111c0743b16f445dacaeeb74d6169\", \"got_revision_cp\": \"refs/heads/master@{#836721}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"c16dc7107fd329b815c700b002d1ba40372b16dc\", \"got_v8_revision\": \"afdda12d2c531c8d2064d5f9062d2c0c23f63e33\", \"got_v8_revision_cp\": \"refs/heads/8.9.145@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"47d4c253481111c0743b16f445dacaeeb74d6169\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_f6b49936a2965b3cdad8f63ce13313d0c4b82119a9acfffbfe199e91c26d0c88_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-2-zd44\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607975324321161",
"status": "COMPLETED",
"status_changed_ts": "1607985548334913",
"tags": [
"build_address:luci.chromium.ci/win32-official/1113",
"builder:win32-official",
"buildset:commit/git/47d4c253481111c0743b16f445dacaeeb74d6169",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/47d4c253481111c0743b16f445dacaeeb74d6169",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026339488850647440",
"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/8860909426422802928/+/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:507b9d3239410c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1607985548339067",
"url": "https://ci.chromium.org/b/8860909426422802928",
"utcnow_ts": "1607985548673948"
}
}
[22:39:08.684] Invocation finished in 2h51m8.15705094s with status SUCCEEDED