[06:14:52.683] New invocation is queued and will start shortly
[06:14:53.771] Starting the invocation (attempt 1)
[06:14:53.807] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:14:53.807] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:14:53.807] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022404380108284832",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d33e6f5fdac171fca916c06a6cb6d3445e937f76\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9022404380108284832",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/d33e6f5fdac171fca916c06a6cb6d3445e937f76",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d33e6f5fdac171fca916c06a6cb6d3445e937f76",
"gitiles_ref:refs/heads/master"
]
}
[06:14:54.472] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611728093874565",
"id": "8856974318196167664",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d33e6f5fdac171fca916c06a6cb6d3445e937f76\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611728094324669",
"tags": [
"build_address:luci.chromium.ci/win-asan/17031",
"builder:win-asan",
"buildset:commit/git/d33e6f5fdac171fca916c06a6cb6d3445e937f76",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d33e6f5fdac171fca916c06a6cb6d3445e937f76",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022404380108284832",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856974318196167664/+/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": "1611728094324904",
"url": "https://ci.chromium.org/b/8856974318196167664",
"utcnow_ts": "1611728094462969"
}
}
[06:14:54.472] Task URL: https://ci.chromium.org/b/8856974318196167664
[06:14:54.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:2:0) after 1m0s
[06:15:54.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:2:0)
[06:15:54.513] Timer tick, asking Buildbucket for the build status
[06:15:54.635] Build 8856974318196167664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:15:54.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:3:0) after 1m0s
[06:16:54.754] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:3:0)
[06:16:54.754] Timer tick, asking Buildbucket for the build status
[06:16:54.847] Build 8856974318196167664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:16:54.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:4:0) after 1m0s
[06:17:54.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:4:0)
[06:17:54.880] Timer tick, asking Buildbucket for the build status
[06:17:55.197] Build 8856974318196167664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:55.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:5:0) after 1m0s
[06:18:55.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:5:0)
[06:18:55.293] Timer tick, asking Buildbucket for the build status
[06:18:55.360] Build 8856974318196167664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:55.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:6:0) after 1m0s
[06:19:55.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:6:0)
[06:19:55.448] Timer tick, asking Buildbucket for the build status
[06:19:55.546] Build 8856974318196167664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:55.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:7:0) after 1m0s
[06:20:49.756] Received PubSub notification, asking Buildbucket for the build status
[06:20:49.922] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:55.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:7:0)
[06:20:55.611] Timer tick, asking Buildbucket for the build status
[06:20:55.835] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:55.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:9:0) after 1m0s
[06:21:56.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:9:0)
[06:21:56.108] Timer tick, asking Buildbucket for the build status
[06:21:56.235] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:56.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:10:0) after 1m0s
[06:22:56.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:10:0)
[06:22:56.329] Timer tick, asking Buildbucket for the build status
[06:22:56.747] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:56.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:11:0) after 1m0s
[06:23:56.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:11:0)
[06:23:56.785] Timer tick, asking Buildbucket for the build status
[06:23:56.846] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:56.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:12:0) after 1m0s
[06:24:56.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:12:0)
[06:24:56.872] Timer tick, asking Buildbucket for the build status
[06:24:56.991] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:56.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:13:0) after 1m0s
[06:25:57.101] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:13:0)
[06:25:57.101] Timer tick, asking Buildbucket for the build status
[06:25:57.186] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:57.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:14:0) after 1m0s
[06:26:57.609] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:14:0)
[06:26:57.609] Timer tick, asking Buildbucket for the build status
[06:26:59.269] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:59.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:15:0) after 1m0s
[06:27:59.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:15:0)
[06:27:59.408] Timer tick, asking Buildbucket for the build status
[06:27:59.525] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:59.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:16:0) after 1m0s
[06:28:59.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:16:0)
[06:28:59.577] Timer tick, asking Buildbucket for the build status
[06:28:59.828] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:59.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:17:0) after 1m0s
[06:30:00.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:17:0)
[06:30:00.044] Timer tick, asking Buildbucket for the build status
[06:30:00.189] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:00.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:18:0) after 1m0s
[06:31:00.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:18:0)
[06:31:00.236] Timer tick, asking Buildbucket for the build status
[06:31:00.413] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:00.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:19:0) after 1m0s
[06:32:00.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:19:0)
[06:32:00.441] Timer tick, asking Buildbucket for the build status
[06:32:00.500] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:00.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:20:0) after 1m0s
[06:33:01.242] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:20:0)
[06:33:01.242] Timer tick, asking Buildbucket for the build status
[06:33:01.841] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:01.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:21:0) after 1m0s
[06:34:01.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:21:0)
[06:34:01.953] Timer tick, asking Buildbucket for the build status
[06:34:02.032] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:02.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:22:0) after 1m0s
[06:35:02.199] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:22:0)
[06:35:02.199] Timer tick, asking Buildbucket for the build status
[06:35:02.306] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:02.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:23:0) after 1m0s
[06:36:02.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:23:0)
[06:36:02.357] Timer tick, asking Buildbucket for the build status
[06:36:02.449] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:02.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:24:0) after 1m0s
[06:37:02.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:24:0)
[06:37:02.455] Timer tick, asking Buildbucket for the build status
[06:37:02.522] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:02.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:25:0) after 1m0s
[06:38:02.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:25:0)
[06:38:02.492] Timer tick, asking Buildbucket for the build status
[06:38:02.549] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:02.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:26:0) after 1m0s
[06:39:02.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:26:0)
[06:39:02.568] Timer tick, asking Buildbucket for the build status
[06:39:02.620] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:02.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:27:0) after 1m0s
[06:40:02.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:27:0)
[06:40:02.657] Timer tick, asking Buildbucket for the build status
[06:40:02.814] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:02.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:28:0) after 1m0s
[06:41:03.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:28:0)
[06:41:03.162] Timer tick, asking Buildbucket for the build status
[06:41:03.273] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:03.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:29:0) after 1m0s
[06:42:03.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:29:0)
[06:42:03.573] Timer tick, asking Buildbucket for the build status
[06:42:03.636] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:03.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:30:0) after 1m0s
[06:43:03.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:30:0)
[06:43:03.715] Timer tick, asking Buildbucket for the build status
[06:43:04.357] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:04.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:31:0) after 1m0s
[06:44:04.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:31:0)
[06:44:04.685] Timer tick, asking Buildbucket for the build status
[06:44:06.566] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:06.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:32:0) after 1m0s
[06:45:06.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:32:0)
[06:45:06.693] Timer tick, asking Buildbucket for the build status
[06:45:06.908] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:06.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:33:0) after 1m0s
[06:46:06.922] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:33:0)
[06:46:06.922] Timer tick, asking Buildbucket for the build status
[06:46:06.992] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:06.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:34:0) after 1m0s
[06:47:07.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:34:0)
[06:47:07.082] Timer tick, asking Buildbucket for the build status
[06:47:07.155] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:07.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:35:0) after 1m0s
[06:48:07.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:35:0)
[06:48:07.210] Timer tick, asking Buildbucket for the build status
[06:48:07.296] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:07.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:36:0) after 1m0s
[06:49:07.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:36:0)
[06:49:07.425] Timer tick, asking Buildbucket for the build status
[06:49:07.498] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:07.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:37:0) after 1m0s
[06:50:07.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:37:0)
[06:50:07.654] Timer tick, asking Buildbucket for the build status
[06:50:07.806] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:07.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:38:0) after 1m0s
[06:51:07.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:38:0)
[06:51:07.899] Timer tick, asking Buildbucket for the build status
[06:51:08.213] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:08.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:39:0) after 1m0s
[06:52:08.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:39:0)
[06:52:08.341] Timer tick, asking Buildbucket for the build status
[06:52:08.448] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:08.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:40:0) after 1m0s
[06:53:08.555] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:40:0)
[06:53:08.555] Timer tick, asking Buildbucket for the build status
[06:53:08.719] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:08.719] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:41:0) after 1m0s
[06:54:08.741] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:41:0)
[06:54:08.742] Timer tick, asking Buildbucket for the build status
[06:54:08.879] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:08.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:42:0) after 1m0s
[06:55:08.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:42:0)
[06:55:08.991] Timer tick, asking Buildbucket for the build status
[06:55:09.102] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:09.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:43:0) after 1m0s
[06:56:09.460] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:43:0)
[06:56:09.460] Timer tick, asking Buildbucket for the build status
[06:56:09.545] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:09.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:44:0) after 1m0s
[06:57:09.787] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:44:0)
[06:57:09.787] Timer tick, asking Buildbucket for the build status
[06:57:09.856] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:09.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:45:0) after 1m0s
[06:58:09.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:45:0)
[06:58:09.978] Timer tick, asking Buildbucket for the build status
[06:58:10.072] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:10.072] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:46:0) after 1m0s
[06:59:10.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:46:0)
[06:59:10.150] Timer tick, asking Buildbucket for the build status
[06:59:10.231] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:10.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:47:0) after 1m0s
[07:00:10.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:47:0)
[07:00:10.584] Timer tick, asking Buildbucket for the build status
[07:00:10.927] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:10.927] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:48:0) after 1m0s
[07:01:11.961] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:48:0)
[07:01:11.961] Timer tick, asking Buildbucket for the build status
[07:01:12.033] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:12.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:49:0) after 1m0s
[07:02:12.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:49:0)
[07:02:12.124] Timer tick, asking Buildbucket for the build status
[07:02:12.179] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:12.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:50:0) after 1m0s
[07:03:12.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:50:0)
[07:03:12.226] Timer tick, asking Buildbucket for the build status
[07:03:12.419] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:12.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:51:0) after 1m0s
[07:04:12.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:51:0)
[07:04:12.459] Timer tick, asking Buildbucket for the build status
[07:04:12.542] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:12.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:52:0) after 1m0s
[07:05:12.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:52:0)
[07:05:12.556] Timer tick, asking Buildbucket for the build status
[07:05:12.684] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:12.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:53:0) after 1m0s
[07:06:12.730] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:53:0)
[07:06:12.730] Timer tick, asking Buildbucket for the build status
[07:06:12.827] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:12.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:54:0) after 1m0s
[07:07:12.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:54:0)
[07:07:12.836] Timer tick, asking Buildbucket for the build status
[07:07:13.074] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:13.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:55:0) after 1m0s
[07:08:13.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:55:0)
[07:08:13.085] Timer tick, asking Buildbucket for the build status
[07:08:13.168] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:13.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:56:0) after 1m0s
[07:09:13.225] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:56:0)
[07:09:13.225] Timer tick, asking Buildbucket for the build status
[07:09:13.274] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:13.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:57:0) after 1m0s
[07:10:13.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:57:0)
[07:10:13.329] Timer tick, asking Buildbucket for the build status
[07:10:13.496] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:13.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:58:0) after 1m0s
[07:11:13.588] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:58:0)
[07:11:13.588] Timer tick, asking Buildbucket for the build status
[07:11:13.744] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:13.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:59:0) after 1m0s
[07:12:13.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:59:0)
[07:12:13.849] Timer tick, asking Buildbucket for the build status
[07:12:13.940] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:13.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:60:0) after 1m0s
[07:13:13.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:60:0)
[07:13:13.987] Timer tick, asking Buildbucket for the build status
[07:13:14.174] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:14.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:61:0) after 1m0s
[07:14:14.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:61:0)
[07:14:14.321] Timer tick, asking Buildbucket for the build status
[07:14:14.476] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:14.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:62:0) after 1m0s
[07:15:14.910] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:62:0)
[07:15:14.910] Timer tick, asking Buildbucket for the build status
[07:15:15.075] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:15.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:63:0) after 1m0s
[07:16:15.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:63:0)
[07:16:15.168] Timer tick, asking Buildbucket for the build status
[07:16:15.308] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:15.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:64:0) after 1m0s
[07:17:15.335] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:64:0)
[07:17:15.335] Timer tick, asking Buildbucket for the build status
[07:17:15.531] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:15.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:65:0) after 1m0s
[07:18:15.554] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:65:0)
[07:18:15.554] Timer tick, asking Buildbucket for the build status
[07:18:15.715] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:15.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:66:0) after 1m0s
[07:19:15.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:66:0)
[07:19:15.774] Timer tick, asking Buildbucket for the build status
[07:19:15.965] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:15.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:67:0) after 1m0s
[07:20:15.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:67:0)
[07:20:15.999] Timer tick, asking Buildbucket for the build status
[07:20:16.232] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:16.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:68:0) after 1m0s
[07:21:16.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:68:0)
[07:21:16.248] Timer tick, asking Buildbucket for the build status
[07:21:16.378] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:16.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:69:0) after 1m0s
[07:22:16.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:69:0)
[07:22:16.431] Timer tick, asking Buildbucket for the build status
[07:22:16.722] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:16.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:70:0) after 1m0s
[07:23:16.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:70:0)
[07:23:16.803] Timer tick, asking Buildbucket for the build status
[07:23:17.051] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:17.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:71:0) after 1m0s
[07:24:17.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:71:0)
[07:24:17.104] Timer tick, asking Buildbucket for the build status
[07:24:17.262] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:17.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:72:0) after 1m0s
[07:25:17.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:72:0)
[07:25:17.392] Timer tick, asking Buildbucket for the build status
[07:25:17.536] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:17.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:73:0) after 1m0s
[07:26:17.580] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:73:0)
[07:26:17.580] Timer tick, asking Buildbucket for the build status
[07:26:17.830] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:17.830] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:74:0) after 1m0s
[07:27:17.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:74:0)
[07:27:17.906] Timer tick, asking Buildbucket for the build status
[07:27:18.062] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:18.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:75:0) after 1m0s
[07:28:18.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:75:0)
[07:28:18.123] Timer tick, asking Buildbucket for the build status
[07:28:18.278] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:18.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:76:0) after 1m0s
[07:29:18.261] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:76:0)
[07:29:18.261] Timer tick, asking Buildbucket for the build status
[07:29:18.397] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:18.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:77:0) after 1m0s
[07:30:18.438] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:77:0)
[07:30:18.438] Timer tick, asking Buildbucket for the build status
[07:30:19.041] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:19.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:78:0) after 1m0s
[07:31:19.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:78:0)
[07:31:19.085] Timer tick, asking Buildbucket for the build status
[07:31:19.219] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:19.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:79:0) after 1m0s
[07:32:19.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:79:0)
[07:32:19.260] Timer tick, asking Buildbucket for the build status
[07:32:19.374] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:19.374] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:80:0) after 1m0s
[07:33:19.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:80:0)
[07:33:19.448] Timer tick, asking Buildbucket for the build status
[07:33:19.813] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:19.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:81:0) after 1m0s
[07:34:19.841] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:81:0)
[07:34:19.841] Timer tick, asking Buildbucket for the build status
[07:34:22.458] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:22.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:82:0) after 1m0s
[07:35:22.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:82:0)
[07:35:22.524] Timer tick, asking Buildbucket for the build status
[07:35:22.716] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:22.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:83:0) after 1m0s
[07:36:23.103] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:83:0)
[07:36:23.103] Timer tick, asking Buildbucket for the build status
[07:36:23.168] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:23.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:84:0) after 1m0s
[07:37:23.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:84:0)
[07:37:23.258] Timer tick, asking Buildbucket for the build status
[07:37:23.329] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:23.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:85:0) after 1m0s
[07:38:23.449] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:85:0)
[07:38:23.449] Timer tick, asking Buildbucket for the build status
[07:38:23.623] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:23.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:86:0) after 1m0s
[07:39:23.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:86:0)
[07:39:23.714] Timer tick, asking Buildbucket for the build status
[07:39:23.787] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:23.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:87:0) after 1m0s
[07:40:23.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:87:0)
[07:40:23.824] Timer tick, asking Buildbucket for the build status
[07:40:24.022] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:24.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:88:0) after 1m0s
[07:41:24.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:88:0)
[07:41:24.175] Timer tick, asking Buildbucket for the build status
[07:41:24.261] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:24.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:89:0) after 1m0s
[07:42:24.318] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:89:0)
[07:42:24.318] Timer tick, asking Buildbucket for the build status
[07:42:24.464] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:24.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:90:0) after 1m0s
[07:43:24.470] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:90:0)
[07:43:24.470] Timer tick, asking Buildbucket for the build status
[07:43:24.736] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:24.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:91:0) after 1m0s
[07:44:24.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:91:0)
[07:44:24.774] Timer tick, asking Buildbucket for the build status
[07:44:25.011] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:25.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:92:0) after 1m0s
[07:45:25.091] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:92:0)
[07:45:25.091] Timer tick, asking Buildbucket for the build status
[07:45:25.785] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:25.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:93:0) after 1m0s
[07:46:25.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:93:0)
[07:46:25.888] Timer tick, asking Buildbucket for the build status
[07:46:27.252] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:27.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:94:0) after 1m0s
[07:47:27.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:94:0)
[07:47:27.375] Timer tick, asking Buildbucket for the build status
[07:47:27.533] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:27.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:95:0) after 1m0s
[07:48:27.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:95:0)
[07:48:27.574] Timer tick, asking Buildbucket for the build status
[07:48:27.737] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:27.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:96:0) after 1m0s
[07:49:27.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:96:0)
[07:49:27.774] Timer tick, asking Buildbucket for the build status
[07:49:27.850] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:27.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:97:0) after 1m0s
[07:50:27.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:97:0)
[07:50:27.880] Timer tick, asking Buildbucket for the build status
[07:50:28.003] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:28.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:98:0) after 1m0s
[07:51:28.050] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:98:0)
[07:51:28.050] Timer tick, asking Buildbucket for the build status
[07:51:28.169] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:28.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:99:0) after 1m0s
[07:52:28.222] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:99:0)
[07:52:28.222] Timer tick, asking Buildbucket for the build status
[07:52:28.364] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:28.364] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:100:0) after 1m0s
[07:53:28.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:100:0)
[07:53:28.481] Timer tick, asking Buildbucket for the build status
[07:53:28.640] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:28.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:101:0) after 1m0s
[07:54:28.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:101:0)
[07:54:28.755] Timer tick, asking Buildbucket for the build status
[07:54:28.844] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:28.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:102:0) after 1m0s
[07:55:28.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:102:0)
[07:55:28.878] Timer tick, asking Buildbucket for the build status
[07:55:28.973] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:28.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:103:0) after 1m0s
[07:56:29.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:103:0)
[07:56:29.116] Timer tick, asking Buildbucket for the build status
[07:56:30.601] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:30.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:104:0) after 1m0s
[07:57:30.669] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:104:0)
[07:57:30.670] Timer tick, asking Buildbucket for the build status
[07:57:30.783] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:30.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:105:0) after 1m0s
[07:58:30.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:105:0)
[07:58:30.797] Timer tick, asking Buildbucket for the build status
[07:58:30.860] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:30.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:106:0) after 1m0s
[07:59:30.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:106:0)
[07:59:30.886] Timer tick, asking Buildbucket for the build status
[07:59:33.881] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:33.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:107:0) after 1m0s
[08:00:33.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:107:0)
[08:00:33.905] Timer tick, asking Buildbucket for the build status
[08:00:34.328] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:34.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:108:0) after 1m0s
[08:01:34.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:108:0)
[08:01:34.428] Timer tick, asking Buildbucket for the build status
[08:01:34.559] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:34.559] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:109:0) after 1m0s
[08:02:34.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:109:0)
[08:02:34.630] Timer tick, asking Buildbucket for the build status
[08:02:34.729] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:34.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:110:0) after 1m0s
[08:03:34.723] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:110:0)
[08:03:34.723] Timer tick, asking Buildbucket for the build status
[08:03:34.891] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:34.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:111:0) after 1m0s
[08:04:34.922] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:111:0)
[08:04:34.922] Timer tick, asking Buildbucket for the build status
[08:04:35.040] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:35.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:112:0) after 1m0s
[08:05:35.109] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:112:0)
[08:05:35.109] Timer tick, asking Buildbucket for the build status
[08:05:35.232] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:35.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:113:0) after 1m0s
[08:06:35.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:113:0)
[08:06:35.284] Timer tick, asking Buildbucket for the build status
[08:06:35.387] Build 8856974318196167664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:35.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9022404380108284832:114:0) after 1m0s
[08:07:34.843] Received PubSub notification, asking Buildbucket for the build status
[08:07:34.920] Build 8856974318196167664: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:07:34.920] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611734853397637",
"created_by": "project:chromium",
"created_ts": "1611728093874565",
"id": "8856974318196167664",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d33e6f5fdac171fca916c06a6cb6d3445e937f76\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"d33e6f5fdac171fca916c06a6cb6d3445e937f76\", \"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\": \"luci-chromium-ci-win10-32-2-2zr0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17031, \"clang_revision\": \"llvmorg-12-init-17251-g6de48655-1\", \"got_angle_revision\": \"f9afaaeedee68302e9936532de16126313a3bd02\", \"got_dawn_revision\": \"2df77f4325841e667e6b9ff9921fd626496a3b64\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"d33e6f5fdac171fca916c06a6cb6d3445e937f76\", \"got_revision_cp\": \"refs/heads/master@{#847512}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"aec0826aba0db51914209ec85a515d3a99311f07\", \"got_v8_revision\": \"5a6bbde4f5b86e56cbb0827de847a936161efbfe\", \"got_v8_revision_cp\": \"refs/heads/9.0.80@{#1}\", \"got_webrtc_revision\": \"fae4fb13451bea44ae1a94509befe8d7c6b11eb6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33077}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d33e6f5fdac171fca916c06a6cb6d3445e937f76\", \"swarm_hashes_refs/heads/master(at){#847512}_without_patch\": {\"absl_hardening_tests\": \"672c303005c47fb6f6242d0f1fc5bce6f2e2e605\", \"accessibility_unittests\": \"722c62492d8121a260d1eae6fd387cae6cba6831\", \"angle_unittests\": \"45fc023b0c9f097902620b7632635f752087aff5\", \"app_shell_unittests\": \"fcdaadd42f754257d8b66490d4a34159e3f29c40\", \"aura_unittests\": \"0c33c7273244cfda90774a54939cfc5c0c6a86a1\", \"base_unittests\": \"13a47174ba47cc5f5b0d25cebad0c2d73322ee9d\", \"base_util_unittests\": \"0d3151cefc9fe440fd12c9fdf67b27cc3b72f5ca\", \"blink_common_unittests\": \"3852c579ddc340706eb5f1817725c3d181e8cbd8\", \"blink_fuzzer_unittests\": \"26ed7529f969466b7eba1bf398ee0c141e0cd6a8\", \"blink_heap_unittests\": \"e560ba32df0800fd632e81468c0cb9660d8412ef\", \"blink_platform_unittests\": \"64a094a3a7489c417b523cf30a37d7d5661d5656\", \"blink_unittests\": \"acd8e85b7bca1bcd40a9aada45a851abe98f1d0b\", \"boringssl_crypto_tests\": \"ae3610b923def3082a94fb27747f4797d572ffdc\", \"boringssl_ssl_tests\": \"6fdc02976037655b38d3ec74b0c0b65188845c4a\", \"browser_switcher_bho_unittests\": \"9ab408d8df28e9a607f54a563816ce54991a0e7b\", \"browser_tests\": \"6850a012d6d77896da4bcb347b889a47af97eb0b\", \"capture_unittests\": \"da57f37ee6ffea87f11ffa5ca7f3b6e0de462d10\", \"cast_unittests\": \"8a4e5cddfd984885e0e4651e3f9d47a1f67edb64\", \"cc_unittests\": \"8cff48e2c8f64f22d90a27459b556e371e33e793\", \"chrome_app_unittests\": \"f01adf09df003b13cd3eeb3427ed2438e7aaa06f\", \"chrome_cleaner_unittests\": \"5496edc11d178b1b3fc6b507df740024f833df74\", \"chrome_elf_unittests\": \"6e656a8477d162c9ce77f4835cee26b45cfd940f\", \"chromedriver_unittests\": \"7892bf39c943eff30f62d438c0f3a40dbcc17e3f\", \"components_browsertests\": \"9b51297fff84af2c93df2b9439731fd95cb2657a\", \"components_unittests\": \"a4f8c20e39c6b83f06dc72b9940eef4c6cfc93cb\", \"compositor_unittests\": \"2dcb7981a22c6013adc0187d2d7b05ee57be1b10\", \"content_browsertests\": \"8e4a0d60fc5ec21688d20b4298bacca137291c3c\", \"content_unittests\": \"b2a285dc3781006d94d27fbf2e3897bc936945c0\", \"courgette_unittests\": \"d978fda8431adc4f634804ad71f226d34e276e34\", \"crashpad_tests\": \"946d2223d1b1d93199d6a543f4584c3cdce8aa3b\", \"cronet_tests\": \"49cec3c3764e1a992caaca42e2c2b330f45ebb75\", \"cronet_unittests\": \"86145917e71cab363cdc79b2d6098b94e3dbaa33\", \"crypto_unittests\": \"3879dd7ec251680f307217c6512fb64d12f37a6b\", \"delayloads_unittests\": \"4465c03490cfbeca9329d2a6e0d470a5a5e53574\", \"device_unittests\": \"3d0a6a0562068f34d7405e4c214ee50b2386795b\", \"display_unittests\": \"b94b8050da114f5f101c70c9dd483f213e988fdb\", \"elevation_service_unittests\": \"b3ea4c5b57cf7ec50fc731352c883f34468a69e0\", \"events_unittests\": \"021b75eacd3b18e50b6fbec2b86888d2fceca051\", \"extensions_browsertests\": \"c41078febf59170bbdb7f5e80548d96a14b02ef3\", \"extensions_unittests\": \"ddcea9143c121c817852f5dad15630fd041a65fb\", \"filesystem_service_unittests\": \"239df9b860052caa089ba4b757e4dbd49950745c\", \"gcm_unit_tests\": \"45d10c0035591efebbc269c9d48fad42bc394ec9\", \"gcp_unittests\": \"97b240d3d8ebe742942f74bbb2ddb837722407f3\", \"gfx_unittests\": \"c18c47ca4df0909bf9aabeeaf00d8f741e857edc\", \"gin_unittests\": \"3ec36bab61101ba597bb4e8f179c221662c6daf9\", \"google_apis_unittests\": \"455f8e2c7d863e1f618c21bea0e313d813272713\", \"gpu_unittests\": \"be9e06f1217f90230acdaa77c1aedfbff9429889\", \"gwp_asan_unittests\": \"3abd3099e52a6004e5bef9a345defdb129a16d57\", \"headless_browsertests\": \"5cb4c3403f3d749e3c82b977e153795491592f23\", \"headless_unittests\": \"53fcb76fc8a6a0b334c233f9c5ab2a14b1ed1d47\", \"install_static_unittests\": \"d7afe35b44df9d0cb50bfbc9353edc6b20ad4b84\", \"installer_util_unittests\": \"300c2a65201a02c1c52acfa2a49897b02238d34f\", \"interactive_ui_tests\": \"db424d98e011fcc44cdabaef830369360ee2c7ee\", \"ipc_tests\": \"db9384b72b3173d40e016308e5290e2ea72204f6\", \"jingle_unittests\": \"ec25e6ea3d37e153e9dd52fd529951a4399b5608\", \"latency_unittests\": \"0106b1ab0bcfc76bfb27416aa2deb716ac3341d5\", \"libjingle_xmpp_unittests\": \"79deeddc0a009b7c43644fa75aebcab1da9e6de8\", \"liburlpattern_unittests\": \"4604f93e6ce9891e552257f0cff12d8852846646\", \"media_blink_unittests\": \"5bcec58694f33f409940ddf1206335df57d27ecc\", \"media_unittests\": \"6534fcba4fe5b828780cd7cb1ae9a4729b6a58c0\", \"message_center_unittests\": \"2e36adab6202e80d578e6238342b34c541db5fcb\", \"midi_unittests\": \"80431f09e34d96966704629dbaf3ee39a553c856\", \"mojo_core_unittests\": \"69ec23f1599e568b6305a1f7f76ce21297df8cd0\", \"mojo_unittests\": \"973b0777a387c91a00a31217eff4a3aaa58a6efe\", \"nacl_loader_unittests\": \"2954043e0b282ceba07740f7f8722f632e3da2c2\", \"native_theme_unittests\": \"18d49e769e3dfb14f0c6708becca6f4280ccec49\", \"net_unittests\": \"fc02a8037fa1d3c4833fa5527e063155385fe9ba\", \"notification_helper_unittests\": \"8d73e173e8d1e47d8682dd989c6bcd8c49dee4a7\", \"pdf_unittests\": \"f4583070ac38f2e9577d6410847a057b31eca19c\", \"perfetto_unittests\": \"8bfa66543746df67e5c337b5e06042f9d0204ad5\", \"ppapi_unittests\": \"b192b307a646f093ae530bc046f783a16b5567bb\", \"printing_unittests\": \"b6ac220f7fcbc69c4cf1c261d69fb8f8702bfa96\", \"remoting_unittests\": \"1df030866a22e2e3f835aa41409f01ca78999232\", \"sbox_integration_tests\": \"28a8cae8c3bd449d0dffb0c2dc92df7337d4e778\", \"sbox_unittests\": \"46feba20babcbabf0122301e7d948dd3f28beb77\", \"sbox_validation_tests\": \"fca9b9ebfbd940da602937f72e3654ed880a75ac\", \"service_manager_unittests\": \"272ef1f9cf629d6d136e6ce6a6ac7d0ba015beb3\", \"services_unittests\": \"570465b816f2b2341339c1dc5ba95581c778afc7\", \"setup_unittests\": \"54bb0d9639569d5fa1e38a38f6864054a5ad7f7b\", \"shell_dialogs_unittests\": \"a13176678f3ea91cb0cdd8033c3567623abeac56\", \"skia_unittests\": \"c0cc7937e97ccd3dffec87c15e84ec38cf1cd2e6\", \"snapshot_unittests\": \"757a019c9b21737e5b234bd86d3ed5a08e10265a\", \"sql_unittests\": \"1236c5ebaa85e237a10cc53168ff2cb4626c3096\", \"storage_unittests\": \"ba5ff0c7e3490554fe277a21aa5485bffb5c4218\", \"sync_integration_tests\": \"f4eb39d9020aa8a83b5ffe72c3fac4b80ba18b98\", \"traffic_annotation_auditor_unittests\": \"a98cefcf94bf26e07f9e96709322a89006a363b6\", \"ui_base_unittests\": \"93e4cdbbe9ac4fb9d02e3fec6fde9912e330e3e3\", \"ui_touch_selection_unittests\": \"9fd145d597e4d8996b592db369935b626cf2831c\", \"unit_tests\": \"1981edeb2b00f87aeb943df13261d4537c8dd205\", \"updater_tests\": \"78f70b82b44e9a8b5774cb79a52de62a1690fa96\", \"url_unittests\": \"265297fd5f428f68d51e108243dc68124dd5564f\", \"views_unittests\": \"1ad90f39a92e7d654b2a51e2cdbdbf88f671bde8\", \"viz_unittests\": \"6644be4dcbc8e0463e90da548886ce9b0ce7052e\", \"vr_common_unittests\": \"4116df45995a4e00781d8da1ee9a722f7bc73fdc\", \"vr_pixeltests\": \"e185beefe69fd258443405337b2f1fba801620fc\", \"weblayer_browsertests\": \"f7bd8007e8a828f03107180f6a65c832a92c1d30\", \"weblayer_unittests\": \"86d2cae09375043006f9b85a2f539bba30bc2a01\", \"wm_unittests\": \"f424bd05834be796e6379081f0716a997e290dac\", \"wtf_unittests\": \"3075e7a20b5f373e61ef1c5efa57c66dbc359d80\", \"zlib_unittests\": \"4f19e9af9a146541485a26dd8fe18e277230151f\", \"zucchini_unittests\": \"3e542fdba20eb6f7d2d4b31d446eb891e9b04181\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-2-2zr0\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5672-4713de1\"], \"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": "1611728449182524",
"status": "COMPLETED",
"status_changed_ts": "1611734853854050",
"tags": [
"build_address:luci.chromium.ci/win-asan/17031",
"builder:win-asan",
"buildset:commit/git/d33e6f5fdac171fca916c06a6cb6d3445e937f76",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d33e6f5fdac171fca916c06a6cb6d3445e937f76",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022404380108284832",
"scheduler_job_id:chromium/win-asan",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856974318196167664/+/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:515b4c8eb3256c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611734853878255",
"url": "https://ci.chromium.org/b/8856974318196167664",
"utcnow_ts": "1611734854909144"
}
}
[08:07:34.920] Invocation finished in 1h52m42.253537688s with status SUCCEEDED