[21:32:54.292] New invocation is queued and will start shortly
[21:32:55.484] Starting the invocation (attempt 1)
[21:32:55.516] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:32:55.516] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:32:55.516] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9036298555684638048",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5124e464bba33df0ed6b28ce4a8aa938cdc26253\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9036298555684638048",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/5124e464bba33df0ed6b28ce4a8aa938cdc26253",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5124e464bba33df0ed6b28ce4a8aa938cdc26253",
"gitiles_ref:refs/heads/master"
]
}
[21:32:56.169] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1598477575608668",
"id": "8870868493637159376",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5124e464bba33df0ed6b28ce4a8aa938cdc26253\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1598477575981420",
"tags": [
"build_address:luci.chromium.ci/win-official/431",
"builder:win-official",
"buildset:commit/git/5124e464bba33df0ed6b28ce4a8aa938cdc26253",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5124e464bba33df0ed6b28ce4a8aa938cdc26253",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036298555684638048",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8870868493637159376/+/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": "1598477575981646",
"url": "https://ci.chromium.org/b/8870868493637159376",
"utcnow_ts": "1598477576162484"
}
}
[21:32:56.169] Task URL: https://ci.chromium.org/b/8870868493637159376
[21:32:56.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:2:0) after 1m0s
[21:33:36.649] Received PubSub notification, asking Buildbucket for the build status
[21:33:36.759] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:56.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:2:0)
[21:33:56.157] Timer tick, asking Buildbucket for the build status
[21:33:56.333] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:56.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:4:0) after 1m0s
[21:34:56.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:4:0)
[21:34:56.393] Timer tick, asking Buildbucket for the build status
[21:34:56.736] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:56.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:5:0) after 1m0s
[21:35:56.878] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:5:0)
[21:35:56.878] Timer tick, asking Buildbucket for the build status
[21:35:57.114] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:57.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:6:0) after 1m0s
[21:36:57.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:6:0)
[21:36:57.137] Timer tick, asking Buildbucket for the build status
[21:36:57.490] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:57.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:7:0) after 1m0s
[21:37:57.539] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:7:0)
[21:37:57.539] Timer tick, asking Buildbucket for the build status
[21:37:57.871] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:57.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:8:0) after 1m0s
[21:38:57.931] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:8:0)
[21:38:57.931] Timer tick, asking Buildbucket for the build status
[21:38:58.094] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:58.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:9:0) after 1m0s
[21:39:58.161] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:9:0)
[21:39:58.161] Timer tick, asking Buildbucket for the build status
[21:39:58.237] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:58.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:10:0) after 1m0s
[21:40:58.223] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:10:0)
[21:40:58.223] Timer tick, asking Buildbucket for the build status
[21:40:58.303] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:58.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:11:0) after 1m0s
[21:41:58.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:11:0)
[21:41:58.361] Timer tick, asking Buildbucket for the build status
[21:41:58.458] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:58.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:12:0) after 1m0s
[21:42:58.553] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:12:0)
[21:42:58.553] Timer tick, asking Buildbucket for the build status
[21:42:58.667] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:58.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:13:0) after 1m0s
[21:43:58.697] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:13:0)
[21:43:58.697] Timer tick, asking Buildbucket for the build status
[21:43:58.851] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:58.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:14:0) after 1m0s
[21:44:58.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:14:0)
[21:44:58.887] Timer tick, asking Buildbucket for the build status
[21:44:58.959] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:58.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:15:0) after 1m0s
[21:45:58.973] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:15:0)
[21:45:58.973] Timer tick, asking Buildbucket for the build status
[21:45:59.224] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:59.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:16:0) after 1m0s
[21:46:59.234] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:16:0)
[21:46:59.234] Timer tick, asking Buildbucket for the build status
[21:46:59.447] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:59.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:17:0) after 1m0s
[21:47:59.520] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:17:0)
[21:47:59.520] Timer tick, asking Buildbucket for the build status
[21:47:59.658] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:59.658] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:18:0) after 1m0s
[21:48:59.679] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:18:0)
[21:48:59.679] Timer tick, asking Buildbucket for the build status
[21:48:59.743] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:59.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:19:0) after 1m0s
[21:49:59.771] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:19:0)
[21:49:59.771] Timer tick, asking Buildbucket for the build status
[21:50:00.087] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:00.087] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:20:0) after 1m0s
[21:51:00.162] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:20:0)
[21:51:00.162] Timer tick, asking Buildbucket for the build status
[21:51:00.269] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:00.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:21:0) after 1m0s
[21:52:00.312] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:21:0)
[21:52:00.312] Timer tick, asking Buildbucket for the build status
[21:52:00.462] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:00.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:22:0) after 1m0s
[21:53:00.650] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:22:0)
[21:53:00.650] Timer tick, asking Buildbucket for the build status
[21:53:00.783] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:00.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:23:0) after 1m0s
[21:54:02.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:23:0)
[21:54:02.301] Timer tick, asking Buildbucket for the build status
[21:54:02.480] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:02.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:24:0) after 1m0s
[21:55:02.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:24:0)
[21:55:02.802] Timer tick, asking Buildbucket for the build status
[21:55:03.186] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:03.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:25:0) after 1m0s
[21:56:03.237] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:25:0)
[21:56:03.237] Timer tick, asking Buildbucket for the build status
[21:56:03.484] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:03.484] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:26:0) after 1m0s
[21:57:03.542] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:26:0)
[21:57:03.542] Timer tick, asking Buildbucket for the build status
[21:57:03.626] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:03.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:27:0) after 1m0s
[21:58:03.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:27:0)
[21:58:03.633] Timer tick, asking Buildbucket for the build status
[21:58:03.769] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:03.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:28:0) after 1m0s
[21:59:03.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:28:0)
[21:59:03.915] Timer tick, asking Buildbucket for the build status
[21:59:04.016] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:04.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:29:0) after 1m0s
[22:00:04.144] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:29:0)
[22:00:04.144] Timer tick, asking Buildbucket for the build status
[22:00:04.296] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:04.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:30:0) after 1m0s
[22:01:04.413] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:30:0)
[22:01:04.413] Timer tick, asking Buildbucket for the build status
[22:01:04.582] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:04.582] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:31:0) after 1m0s
[22:02:04.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:31:0)
[22:02:04.639] Timer tick, asking Buildbucket for the build status
[22:02:04.742] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:04.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:32:0) after 1m0s
[22:03:04.782] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:32:0)
[22:03:04.782] Timer tick, asking Buildbucket for the build status
[22:03:05.593] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:05.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:33:0) after 1m0s
[22:04:05.620] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:33:0)
[22:04:05.620] Timer tick, asking Buildbucket for the build status
[22:04:05.699] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:05.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:34:0) after 1m0s
[22:05:05.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:34:0)
[22:05:05.850] Timer tick, asking Buildbucket for the build status
[22:05:05.928] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:05.928] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:35:0) after 1m0s
[22:06:06.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:35:0)
[22:06:06.107] Timer tick, asking Buildbucket for the build status
[22:06:06.185] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:06.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:36:0) after 1m0s
[22:07:06.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:36:0)
[22:07:06.334] Timer tick, asking Buildbucket for the build status
[22:07:06.480] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:06.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:37:0) after 1m0s
[22:08:06.558] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:37:0)
[22:08:06.558] Timer tick, asking Buildbucket for the build status
[22:08:06.712] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:06.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:38:0) after 1m0s
[22:09:06.836] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:38:0)
[22:09:06.836] Timer tick, asking Buildbucket for the build status
[22:09:06.896] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:06.896] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:39:0) after 1m0s
[22:10:06.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:39:0)
[22:10:06.909] Timer tick, asking Buildbucket for the build status
[22:10:07.302] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:07.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:40:0) after 1m0s
[22:11:07.308] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:40:0)
[22:11:07.309] Timer tick, asking Buildbucket for the build status
[22:11:07.455] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:07.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:41:0) after 1m0s
[22:12:07.504] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:41:0)
[22:12:07.504] Timer tick, asking Buildbucket for the build status
[22:12:07.914] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:07.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:42:0) after 1m0s
[22:13:08.004] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:42:0)
[22:13:08.004] Timer tick, asking Buildbucket for the build status
[22:13:08.451] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:08.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:43:0) after 1m0s
[22:14:08.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:43:0)
[22:14:08.524] Timer tick, asking Buildbucket for the build status
[22:14:08.592] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:08.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:44:0) after 1m0s
[22:15:08.635] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:44:0)
[22:15:08.635] Timer tick, asking Buildbucket for the build status
[22:15:09.003] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:09.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:45:0) after 1m0s
[22:16:09.103] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:45:0)
[22:16:09.103] Timer tick, asking Buildbucket for the build status
[22:16:09.226] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:09.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:46:0) after 1m0s
[22:17:09.221] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:46:0)
[22:17:09.221] Timer tick, asking Buildbucket for the build status
[22:17:09.387] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:09.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:47:0) after 1m0s
[22:18:09.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:47:0)
[22:18:09.495] Timer tick, asking Buildbucket for the build status
[22:18:09.647] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:09.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:48:0) after 1m0s
[22:19:09.685] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:48:0)
[22:19:09.685] Timer tick, asking Buildbucket for the build status
[22:19:09.845] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:09.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:49:0) after 1m0s
[22:20:09.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:49:0)
[22:20:09.877] Timer tick, asking Buildbucket for the build status
[22:20:10.089] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:10.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:50:0) after 1m0s
[22:21:10.138] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:50:0)
[22:21:10.138] Timer tick, asking Buildbucket for the build status
[22:21:10.208] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:10.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:51:0) after 1m0s
[22:22:10.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:51:0)
[22:22:10.242] Timer tick, asking Buildbucket for the build status
[22:22:10.324] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:10.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:52:0) after 1m0s
[22:23:10.331] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:52:0)
[22:23:10.331] Timer tick, asking Buildbucket for the build status
[22:23:10.432] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:10.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:53:0) after 1m0s
[22:24:10.457] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:53:0)
[22:24:10.457] Timer tick, asking Buildbucket for the build status
[22:24:10.597] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:10.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:54:0) after 1m0s
[22:25:10.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:54:0)
[22:25:10.672] Timer tick, asking Buildbucket for the build status
[22:25:10.843] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:10.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:55:0) after 1m0s
[22:26:10.904] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:55:0)
[22:26:10.904] Timer tick, asking Buildbucket for the build status
[22:26:11.019] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:11.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:56:0) after 1m0s
[22:27:11.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:56:0)
[22:27:11.107] Timer tick, asking Buildbucket for the build status
[22:27:11.175] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:11.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:57:0) after 1m0s
[22:28:11.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:57:0)
[22:28:11.260] Timer tick, asking Buildbucket for the build status
[22:28:11.462] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:11.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:58:0) after 1m0s
[22:29:11.492] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:58:0)
[22:29:11.492] Timer tick, asking Buildbucket for the build status
[22:29:11.812] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:11.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:59:0) after 1m0s
[22:30:11.817] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:59:0)
[22:30:11.817] Timer tick, asking Buildbucket for the build status
[22:30:11.976] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:11.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:60:0) after 1m0s
[22:31:12.041] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:60:0)
[22:31:12.041] Timer tick, asking Buildbucket for the build status
[22:31:12.151] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:12.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:61:0) after 1m0s
[22:32:12.195] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:61:0)
[22:32:12.195] Timer tick, asking Buildbucket for the build status
[22:32:12.401] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:12.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:62:0) after 1m0s
[22:33:12.471] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:62:0)
[22:33:12.471] Timer tick, asking Buildbucket for the build status
[22:33:13.536] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:13.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:63:0) after 1m0s
[22:34:13.599] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:63:0)
[22:34:13.599] Timer tick, asking Buildbucket for the build status
[22:34:13.749] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:13.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:64:0) after 1m0s
[22:35:13.801] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:64:0)
[22:35:13.801] Timer tick, asking Buildbucket for the build status
[22:35:13.887] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:13.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:65:0) after 1m0s
[22:36:13.915] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:65:0)
[22:36:13.915] Timer tick, asking Buildbucket for the build status
[22:36:14.007] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:14.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:66:0) after 1m0s
[22:37:14.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:66:0)
[22:37:14.106] Timer tick, asking Buildbucket for the build status
[22:37:14.186] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:14.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:67:0) after 1m0s
[22:38:14.321] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:67:0)
[22:38:14.321] Timer tick, asking Buildbucket for the build status
[22:38:14.580] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:14.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:68:0) after 1m0s
[22:39:14.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:68:0)
[22:39:14.611] Timer tick, asking Buildbucket for the build status
[22:39:14.703] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:14.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:69:0) after 1m0s
[22:40:14.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:69:0)
[22:40:14.819] Timer tick, asking Buildbucket for the build status
[22:40:15.194] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:15.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:70:0) after 1m0s
[22:41:15.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:70:0)
[22:41:15.221] Timer tick, asking Buildbucket for the build status
[22:41:15.343] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:15.343] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:71:0) after 1m0s
[22:42:15.368] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:71:0)
[22:42:15.368] Timer tick, asking Buildbucket for the build status
[22:42:15.476] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:15.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:72:0) after 1m0s
[22:43:15.567] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:72:0)
[22:43:15.567] Timer tick, asking Buildbucket for the build status
[22:43:15.894] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:15.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:73:0) after 1m0s
[22:44:15.910] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:73:0)
[22:44:15.910] Timer tick, asking Buildbucket for the build status
[22:44:16.004] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:16.004] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:74:0) after 1m0s
[22:45:16.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:74:0)
[22:45:16.159] Timer tick, asking Buildbucket for the build status
[22:45:16.253] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:16.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:75:0) after 1m0s
[22:46:16.265] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:75:0)
[22:46:16.265] Timer tick, asking Buildbucket for the build status
[22:46:16.471] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:16.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:76:0) after 1m0s
[22:47:16.530] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:76:0)
[22:47:16.530] Timer tick, asking Buildbucket for the build status
[22:47:16.936] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:16.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:77:0) after 1m0s
[22:48:16.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:77:0)
[22:48:16.961] Timer tick, asking Buildbucket for the build status
[22:48:17.093] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:17.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:78:0) after 1m0s
[22:49:17.134] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:78:0)
[22:49:17.134] Timer tick, asking Buildbucket for the build status
[22:49:17.209] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:17.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:79:0) after 1m0s
[22:50:17.239] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:79:0)
[22:50:17.239] Timer tick, asking Buildbucket for the build status
[22:50:17.298] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:17.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:80:0) after 1m0s
[22:51:17.384] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:80:0)
[22:51:17.384] Timer tick, asking Buildbucket for the build status
[22:51:17.459] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:17.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:81:0) after 1m0s
[22:52:17.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:81:0)
[22:52:17.559] Timer tick, asking Buildbucket for the build status
[22:52:17.631] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:17.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:82:0) after 1m0s
[22:53:17.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:82:0)
[22:53:17.791] Timer tick, asking Buildbucket for the build status
[22:53:17.922] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:17.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:83:0) after 1m0s
[22:54:17.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:83:0)
[22:54:17.936] Timer tick, asking Buildbucket for the build status
[22:54:18.015] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:18.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:84:0) after 1m0s
[22:55:18.022] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:84:0)
[22:55:18.022] Timer tick, asking Buildbucket for the build status
[22:55:18.119] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:18.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:85:0) after 1m0s
[22:56:18.152] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:85:0)
[22:56:18.152] Timer tick, asking Buildbucket for the build status
[22:56:18.274] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:18.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:86:0) after 1m0s
[22:57:18.307] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:86:0)
[22:57:18.307] Timer tick, asking Buildbucket for the build status
[22:57:18.451] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:18.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:87:0) after 1m0s
[22:58:18.580] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:87:0)
[22:58:18.580] Timer tick, asking Buildbucket for the build status
[22:58:18.696] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:18.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:88:0) after 1m0s
[22:59:18.740] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:88:0)
[22:59:18.740] Timer tick, asking Buildbucket for the build status
[22:59:18.934] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:18.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:89:0) after 1m0s
[23:00:18.957] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:89:0)
[23:00:18.957] Timer tick, asking Buildbucket for the build status
[23:00:19.319] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:19.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:90:0) after 1m0s
[23:01:19.353] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:90:0)
[23:01:19.353] Timer tick, asking Buildbucket for the build status
[23:01:19.436] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:19.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:91:0) after 1m0s
[23:02:19.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:91:0)
[23:02:19.517] Timer tick, asking Buildbucket for the build status
[23:02:19.588] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:19.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:92:0) after 1m0s
[23:03:19.664] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:92:0)
[23:03:19.664] Timer tick, asking Buildbucket for the build status
[23:03:19.918] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:19.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:93:0) after 1m0s
[23:04:20.018] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:93:0)
[23:04:20.018] Timer tick, asking Buildbucket for the build status
[23:04:20.101] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:20.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:94:0) after 1m0s
[23:05:20.080] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:94:0)
[23:05:20.080] Timer tick, asking Buildbucket for the build status
[23:05:20.154] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:20.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:95:0) after 1m0s
[23:06:20.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:95:0)
[23:06:20.254] Timer tick, asking Buildbucket for the build status
[23:06:20.395] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:20.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:96:0) after 1m0s
[23:07:20.451] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:96:0)
[23:07:20.451] Timer tick, asking Buildbucket for the build status
[23:07:20.744] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:20.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:97:0) after 1m0s
[23:08:20.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:97:0)
[23:08:20.784] Timer tick, asking Buildbucket for the build status
[23:08:20.933] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:20.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:98:0) after 1m0s
[23:09:20.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:98:0)
[23:09:20.959] Timer tick, asking Buildbucket for the build status
[23:09:21.015] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:21.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:99:0) after 1m0s
[23:10:21.048] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:99:0)
[23:10:21.048] Timer tick, asking Buildbucket for the build status
[23:10:21.142] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:21.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:100:0) after 1m0s
[23:11:21.285] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:100:0)
[23:11:21.285] Timer tick, asking Buildbucket for the build status
[23:11:21.424] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:21.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:101:0) after 1m0s
[23:12:21.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:101:0)
[23:12:21.680] Timer tick, asking Buildbucket for the build status
[23:12:21.768] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:21.768] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:102:0) after 1m0s
[23:13:21.866] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:102:0)
[23:13:21.866] Timer tick, asking Buildbucket for the build status
[23:13:22.020] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:22.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:103:0) after 1m0s
[23:14:22.157] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:103:0)
[23:14:22.157] Timer tick, asking Buildbucket for the build status
[23:14:22.304] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:22.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:104:0) after 1m0s
[23:15:22.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:104:0)
[23:15:22.475] Timer tick, asking Buildbucket for the build status
[23:15:22.580] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:22.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:105:0) after 1m0s
[23:16:22.712] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:105:0)
[23:16:22.712] Timer tick, asking Buildbucket for the build status
[23:16:22.828] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:22.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:106:0) after 1m0s
[23:17:22.955] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:106:0)
[23:17:22.955] Timer tick, asking Buildbucket for the build status
[23:17:23.053] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:23.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:107:0) after 1m0s
[23:18:23.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:107:0)
[23:18:23.128] Timer tick, asking Buildbucket for the build status
[23:18:23.336] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:23.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:108:0) after 1m0s
[23:19:23.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:108:0)
[23:19:23.389] Timer tick, asking Buildbucket for the build status
[23:19:23.537] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:23.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:109:0) after 1m0s
[23:20:23.583] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:109:0)
[23:20:23.583] Timer tick, asking Buildbucket for the build status
[23:20:23.773] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:23.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:110:0) after 1m0s
[23:21:23.802] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:110:0)
[23:21:23.802] Timer tick, asking Buildbucket for the build status
[23:21:23.862] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:23.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:111:0) after 1m0s
[23:22:23.978] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:111:0)
[23:22:23.978] Timer tick, asking Buildbucket for the build status
[23:22:24.201] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:24.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:112:0) after 1m0s
[23:23:24.421] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:112:0)
[23:23:24.421] Timer tick, asking Buildbucket for the build status
[23:23:34.379] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:34.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:113:0) after 1m0s
[23:24:34.870] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:113:0)
[23:24:34.870] Timer tick, asking Buildbucket for the build status
[23:24:34.926] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:34.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:114:0) after 1m0s
[23:25:35.246] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:114:0)
[23:25:35.246] Timer tick, asking Buildbucket for the build status
[23:25:35.382] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:35.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:115:0) after 1m0s
[23:26:35.439] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:115:0)
[23:26:35.439] Timer tick, asking Buildbucket for the build status
[23:26:35.533] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:35.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:116:0) after 1m0s
[23:27:35.559] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:116:0)
[23:27:35.559] Timer tick, asking Buildbucket for the build status
[23:27:35.672] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:35.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:117:0) after 1m0s
[23:28:35.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:117:0)
[23:28:35.715] Timer tick, asking Buildbucket for the build status
[23:28:36.313] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:36.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:118:0) after 1m0s
[23:29:36.343] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:118:0)
[23:29:36.343] Timer tick, asking Buildbucket for the build status
[23:29:36.498] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:36.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:119:0) after 1m0s
[23:30:36.558] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:119:0)
[23:30:36.558] Timer tick, asking Buildbucket for the build status
[23:30:36.631] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:36.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:120:0) after 1m0s
[23:31:36.688] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:120:0)
[23:31:36.688] Timer tick, asking Buildbucket for the build status
[23:31:36.762] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:36.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:121:0) after 1m0s
[23:32:36.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:121:0)
[23:32:36.805] Timer tick, asking Buildbucket for the build status
[23:32:36.875] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:36.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:122:0) after 1m0s
[23:33:36.923] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:122:0)
[23:33:36.923] Timer tick, asking Buildbucket for the build status
[23:33:37.376] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:37.376] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:123:0) after 1m0s
[23:34:37.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:123:0)
[23:34:37.472] Timer tick, asking Buildbucket for the build status
[23:34:37.610] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:37.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:124:0) after 1m0s
[23:35:37.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:124:0)
[23:35:37.676] Timer tick, asking Buildbucket for the build status
[23:35:37.753] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:37.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:125:0) after 1m0s
[23:36:37.949] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:125:0)
[23:36:37.949] Timer tick, asking Buildbucket for the build status
[23:36:38.076] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:38.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:126:0) after 1m0s
[23:37:38.095] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:126:0)
[23:37:38.095] Timer tick, asking Buildbucket for the build status
[23:37:38.173] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:38.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:127:0) after 1m0s
[23:38:38.242] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:127:0)
[23:38:38.242] Timer tick, asking Buildbucket for the build status
[23:38:38.416] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:38.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:128:0) after 1m0s
[23:39:38.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:128:0)
[23:39:38.529] Timer tick, asking Buildbucket for the build status
[23:39:38.738] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:38.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:129:0) after 1m0s
[23:40:38.803] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:129:0)
[23:40:38.803] Timer tick, asking Buildbucket for the build status
[23:40:38.873] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:38.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:130:0) after 1m0s
[23:41:38.936] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:130:0)
[23:41:38.936] Timer tick, asking Buildbucket for the build status
[23:41:39.005] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:39.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:131:0) after 1m0s
[23:42:39.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:131:0)
[23:42:39.079] Timer tick, asking Buildbucket for the build status
[23:42:39.143] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:39.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:132:0) after 1m0s
[23:43:39.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:132:0)
[23:43:39.259] Timer tick, asking Buildbucket for the build status
[23:43:39.413] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:39.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:133:0) after 1m0s
[23:44:39.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:133:0)
[23:44:39.483] Timer tick, asking Buildbucket for the build status
[23:44:39.662] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:39.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:134:0) after 1m0s
[23:45:39.743] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:134:0)
[23:45:39.743] Timer tick, asking Buildbucket for the build status
[23:45:39.811] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:39.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:135:0) after 1m0s
[23:46:39.870] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:135:0)
[23:46:39.870] Timer tick, asking Buildbucket for the build status
[23:46:40.053] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:40.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:136:0) after 1m0s
[23:47:40.101] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:136:0)
[23:47:40.101] Timer tick, asking Buildbucket for the build status
[23:47:40.159] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:40.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:137:0) after 1m0s
[23:48:40.196] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:137:0)
[23:48:40.196] Timer tick, asking Buildbucket for the build status
[23:48:40.504] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:40.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:138:0) after 1m0s
[23:49:40.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:138:0)
[23:49:40.575] Timer tick, asking Buildbucket for the build status
[23:49:40.655] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:40.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:139:0) after 1m0s
[23:50:40.649] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:139:0)
[23:50:40.649] Timer tick, asking Buildbucket for the build status
[23:50:40.728] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:40.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:140:0) after 1m0s
[23:51:40.765] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:140:0)
[23:51:40.765] Timer tick, asking Buildbucket for the build status
[23:51:40.951] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:40.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:141:0) after 1m0s
[23:52:40.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:141:0)
[23:52:40.989] Timer tick, asking Buildbucket for the build status
[23:52:41.327] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:41.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:142:0) after 1m0s
[23:53:41.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:142:0)
[23:53:41.361] Timer tick, asking Buildbucket for the build status
[23:53:42.798] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:42.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:143:0) after 1m0s
[23:54:42.873] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:143:0)
[23:54:42.873] Timer tick, asking Buildbucket for the build status
[23:54:43.033] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:43.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:144:0) after 1m0s
[23:55:43.142] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:144:0)
[23:55:43.142] Timer tick, asking Buildbucket for the build status
[23:55:43.281] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:43.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:145:0) after 1m0s
[23:56:43.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:145:0)
[23:56:43.350] Timer tick, asking Buildbucket for the build status
[23:56:43.589] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:43.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:146:0) after 1m0s
[23:57:43.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:146:0)
[23:57:43.622] Timer tick, asking Buildbucket for the build status
[23:57:43.963] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:43.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:147:0) after 1m0s
[23:58:43.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:147:0)
[23:58:43.998] Timer tick, asking Buildbucket for the build status
[23:58:44.173] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:44.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:148:0) after 1m0s
[23:59:44.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:148:0)
[23:59:44.243] Timer tick, asking Buildbucket for the build status
[23:59:44.310] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:44.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:149:0) after 1m0s
[00:00:44.334] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:149:0)
[00:00:44.334] Timer tick, asking Buildbucket for the build status
[00:00:44.680] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:44.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:150:0) after 1m0s
[00:01:44.719] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:150:0)
[00:01:44.719] Timer tick, asking Buildbucket for the build status
[00:01:44.835] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:44.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:151:0) after 1m0s
[00:02:44.872] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:151:0)
[00:02:44.872] Timer tick, asking Buildbucket for the build status
[00:02:44.944] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:44.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:152:0) after 1m0s
[00:03:44.969] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:152:0)
[00:03:44.969] Timer tick, asking Buildbucket for the build status
[00:03:45.296] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:45.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:153:0) after 1m0s
[00:04:45.382] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:153:0)
[00:04:45.382] Timer tick, asking Buildbucket for the build status
[00:04:45.452] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:45.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:154:0) after 1m0s
[00:05:45.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:154:0)
[00:05:45.538] Timer tick, asking Buildbucket for the build status
[00:05:45.636] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:45.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:155:0) after 1m0s
[00:06:45.647] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:155:0)
[00:06:45.647] Timer tick, asking Buildbucket for the build status
[00:06:45.898] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:45.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:156:0) after 1m0s
[00:07:45.941] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:156:0)
[00:07:45.941] Timer tick, asking Buildbucket for the build status
[00:07:46.005] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:46.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:157:0) after 1m0s
[00:08:46.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:157:0)
[00:08:46.069] Timer tick, asking Buildbucket for the build status
[00:08:46.199] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:46.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:158:0) after 1m0s
[00:09:46.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:158:0)
[00:09:46.218] Timer tick, asking Buildbucket for the build status
[00:09:46.314] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:46.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:159:0) after 1m0s
[00:10:46.416] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:159:0)
[00:10:46.416] Timer tick, asking Buildbucket for the build status
[00:10:46.669] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:46.669] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:160:0) after 1m0s
[00:11:46.763] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:160:0)
[00:11:46.763] Timer tick, asking Buildbucket for the build status
[00:11:46.856] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:46.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:161:0) after 1m0s
[00:12:46.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:161:0)
[00:12:46.935] Timer tick, asking Buildbucket for the build status
[00:12:47.449] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:47.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:162:0) after 1m0s
[00:13:47.615] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:162:0)
[00:13:47.615] Timer tick, asking Buildbucket for the build status
[00:13:47.743] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:47.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:163:0) after 1m0s
[00:14:47.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:163:0)
[00:14:47.800] Timer tick, asking Buildbucket for the build status
[00:14:48.152] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:48.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:164:0) after 1m0s
[00:15:48.230] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:164:0)
[00:15:48.230] Timer tick, asking Buildbucket for the build status
[00:15:48.298] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:48.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:165:0) after 1m0s
[00:16:48.366] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:165:0)
[00:16:48.366] Timer tick, asking Buildbucket for the build status
[00:16:48.427] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:48.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:166:0) after 1m0s
[00:17:48.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:166:0)
[00:17:48.468] Timer tick, asking Buildbucket for the build status
[00:17:48.590] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:48.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:167:0) after 1m0s
[00:18:48.631] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:167:0)
[00:18:48.631] Timer tick, asking Buildbucket for the build status
[00:18:49.393] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:49.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:168:0) after 1m0s
[00:19:49.417] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:168:0)
[00:19:49.417] Timer tick, asking Buildbucket for the build status
[00:19:49.579] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:49.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:169:0) after 1m0s
[00:20:49.612] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:169:0)
[00:20:49.612] Timer tick, asking Buildbucket for the build status
[00:20:49.882] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:49.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:170:0) after 1m0s
[00:21:50.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:170:0)
[00:21:50.005] Timer tick, asking Buildbucket for the build status
[00:21:50.189] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:50.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:171:0) after 1m0s
[00:22:50.281] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:171:0)
[00:22:50.281] Timer tick, asking Buildbucket for the build status
[00:22:50.591] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:50.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:172:0) after 1m0s
[00:23:50.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:172:0)
[00:23:50.731] Timer tick, asking Buildbucket for the build status
[00:23:51.027] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:51.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:173:0) after 1m0s
[00:24:51.098] Handling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:173:0)
[00:24:51.098] Timer tick, asking Buildbucket for the build status
[00:24:51.171] Build 8870868493637159376: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:51.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9036298555684638048:174:0) after 1m0s
[00:25:35.342] Received PubSub notification, asking Buildbucket for the build status
[00:25:35.614] Build 8870868493637159376: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:25:35.614] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1598487934113447",
"created_by": "project:chromium",
"created_ts": "1598477575608668",
"id": "8870868493637159376",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5124e464bba33df0ed6b28ce4a8aa938cdc26253\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-6-86zm\", \"branch\": \"refs/heads/master\", \"buildername\": \"win-official\", \"buildnumber\": 431, \"got_angle_revision\": \"3d1609516687c6040bcfaa2ba94454f102076171\", \"got_dawn_revision\": \"320c6c87b2ed980d4c7622230976d40ad0fc54a1\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"5124e464bba33df0ed6b28ce4a8aa938cdc26253\", \"got_revision_cp\": \"refs/heads/master@{#801937}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"1f48854dae26a2d129ae771e671a2172acb2da86\", \"got_v8_revision\": \"54d60a59e92d5f4c8695e497de5f972d3e4fb631\", \"got_v8_revision_cp\": \"refs/heads/8.7.24@{#1}\", \"got_webrtc_revision\": \"c75c4280763435eeb44785dfc76f098bf06743bb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31999}\", \"mastername\": \"chromium\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5124e464bba33df0ed6b28ce4a8aa938cdc26253\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-6-86zm\"], \"image\": [\"chrome-win10-1703-20081700-d9392568d25\"], \"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\": [\"5498-3454aa6\"], \"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": "1598477615867815",
"status": "COMPLETED",
"status_changed_ts": "1598487934485263",
"tags": [
"build_address:luci.chromium.ci/win-official/431",
"builder:win-official",
"buildset:commit/git/5124e464bba33df0ed6b28ce4a8aa938cdc26253",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5124e464bba33df0ed6b28ce4a8aa938cdc26253",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036298555684638048",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8870868493637159376/+/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:4e4581b10e5a0210",
"user_agent:luci-scheduler"
],
"updated_ts": "1598487934490384",
"url": "https://ci.chromium.org/b/8870868493637159376",
"utcnow_ts": "1598487935598338"
}
}
[00:25:35.614] Invocation finished in 2h52m41.342756965s with status SUCCEEDED