[20:52:44.708] New invocation is queued and will start shortly
[20:52:45.889] Starting the invocation (attempt 1)
[20:52:45.961] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:52:45.961] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:52:45.962] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026063625109928048",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8e2066557d9eaded0df6175ad6ebec1a77abad31\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9026063625109928048",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/8e2066557d9eaded0df6175ad6ebec1a77abad31",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e2066557d9eaded0df6175ad6ebec1a77abad31",
"gitiles_ref:refs/heads/master"
]
}
[20:52:47.438] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608238366097446",
"id": "8860633562989431248",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e2066557d9eaded0df6175ad6ebec1a77abad31\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608238367093617",
"tags": [
"build_address:luci.chromium.ci/win-asan/16288",
"builder:win-asan",
"buildset:commit/git/8e2066557d9eaded0df6175ad6ebec1a77abad31",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e2066557d9eaded0df6175ad6ebec1a77abad31",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026063625109928048",
"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/8860633562989431248/+/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": "1608238367093779",
"url": "https://ci.chromium.org/b/8860633562989431248",
"utcnow_ts": "1608238367425551"
}
}
[20:52:47.438] Task URL: https://ci.chromium.org/b/8860633562989431248
[20:52:47.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:2:0) after 1m0s
[20:52:48.804] Received PubSub notification, asking Buildbucket for the build status
[20:52:48.909] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:47.546] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:2:0)
[20:53:47.546] Timer tick, asking Buildbucket for the build status
[20:53:47.688] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:47.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:4:0) after 1m0s
[20:54:47.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:4:0)
[20:54:47.762] Timer tick, asking Buildbucket for the build status
[20:54:47.915] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:47.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:5:0) after 1m0s
[20:55:47.935] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:5:0)
[20:55:47.935] Timer tick, asking Buildbucket for the build status
[20:55:48.054] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:48.054] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:6:0) after 1m0s
[20:56:48.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:6:0)
[20:56:48.212] Timer tick, asking Buildbucket for the build status
[20:56:48.369] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:48.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:7:0) after 1m0s
[20:57:48.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:7:0)
[20:57:48.347] Timer tick, asking Buildbucket for the build status
[20:57:48.481] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:48.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:8:0) after 1m0s
[20:58:48.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:8:0)
[20:58:48.587] Timer tick, asking Buildbucket for the build status
[20:58:48.715] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:48.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:9:0) after 1m0s
[20:59:48.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:9:0)
[20:59:48.776] Timer tick, asking Buildbucket for the build status
[20:59:48.847] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:48.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:10:0) after 1m0s
[21:00:48.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:10:0)
[21:00:48.886] Timer tick, asking Buildbucket for the build status
[21:00:48.968] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:48.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:11:0) after 1m0s
[21:01:48.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:11:0)
[21:01:48.989] Timer tick, asking Buildbucket for the build status
[21:01:49.065] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:49.065] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:12:0) after 1m0s
[21:02:49.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:12:0)
[21:02:49.130] Timer tick, asking Buildbucket for the build status
[21:02:49.247] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:49.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:13:0) after 1m0s
[21:03:49.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:13:0)
[21:03:49.298] Timer tick, asking Buildbucket for the build status
[21:03:49.353] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:49.353] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:14:0) after 1m0s
[21:04:49.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:14:0)
[21:04:49.388] Timer tick, asking Buildbucket for the build status
[21:04:49.537] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:49.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:15:0) after 1m0s
[21:05:49.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:15:0)
[21:05:49.557] Timer tick, asking Buildbucket for the build status
[21:05:49.687] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:49.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:16:0) after 1m0s
[21:06:49.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:16:0)
[21:06:49.792] Timer tick, asking Buildbucket for the build status
[21:06:49.931] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:49.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:17:0) after 1m0s
[21:07:49.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:17:0)
[21:07:49.985] Timer tick, asking Buildbucket for the build status
[21:07:54.781] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:54.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:18:0) after 1m0s
[21:08:54.854] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:18:0)
[21:08:54.854] Timer tick, asking Buildbucket for the build status
[21:08:54.915] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:54.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:19:0) after 1m0s
[21:09:54.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:19:0)
[21:09:54.996] Timer tick, asking Buildbucket for the build status
[21:09:55.079] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:55.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:20:0) after 1m0s
[21:10:55.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:20:0)
[21:10:55.165] Timer tick, asking Buildbucket for the build status
[21:10:55.249] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:55.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:21:0) after 1m0s
[21:11:55.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:21:0)
[21:11:55.375] Timer tick, asking Buildbucket for the build status
[21:11:55.470] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:55.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:22:0) after 1m0s
[21:12:55.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:22:0)
[21:12:55.618] Timer tick, asking Buildbucket for the build status
[21:12:55.776] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:55.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:23:0) after 1m0s
[21:13:55.977] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:23:0)
[21:13:55.977] Timer tick, asking Buildbucket for the build status
[21:13:56.244] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:56.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:24:0) after 1m0s
[21:14:56.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:24:0)
[21:14:56.279] Timer tick, asking Buildbucket for the build status
[21:14:56.350] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:56.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:25:0) after 1m0s
[21:15:56.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:25:0)
[21:15:56.444] Timer tick, asking Buildbucket for the build status
[21:15:56.587] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:56.587] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:26:0) after 1m0s
[21:16:56.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:26:0)
[21:16:56.697] Timer tick, asking Buildbucket for the build status
[21:16:56.857] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:56.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:27:0) after 1m0s
[21:17:56.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:27:0)
[21:17:56.937] Timer tick, asking Buildbucket for the build status
[21:17:57.073] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:57.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:28:0) after 1m0s
[21:18:57.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:28:0)
[21:18:57.123] Timer tick, asking Buildbucket for the build status
[21:18:57.261] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:57.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:29:0) after 1m0s
[21:19:57.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:29:0)
[21:19:57.287] Timer tick, asking Buildbucket for the build status
[21:19:57.349] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:57.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:30:0) after 1m0s
[21:20:57.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:30:0)
[21:20:57.368] Timer tick, asking Buildbucket for the build status
[21:20:57.548] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:57.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:31:0) after 1m0s
[21:21:57.578] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:31:0)
[21:21:57.578] Timer tick, asking Buildbucket for the build status
[21:21:57.624] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:57.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:32:0) after 1m0s
[21:22:57.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:32:0)
[21:22:57.645] Timer tick, asking Buildbucket for the build status
[21:22:57.751] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:57.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:33:0) after 1m0s
[21:23:57.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:33:0)
[21:23:57.770] Timer tick, asking Buildbucket for the build status
[21:23:57.831] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:57.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:34:0) after 1m0s
[21:24:57.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:34:0)
[21:24:57.875] Timer tick, asking Buildbucket for the build status
[21:24:57.943] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:57.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:35:0) after 1m0s
[21:25:57.980] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:35:0)
[21:25:57.981] Timer tick, asking Buildbucket for the build status
[21:25:58.031] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:58.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:36:0) after 1m0s
[21:26:58.058] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:36:0)
[21:26:58.058] Timer tick, asking Buildbucket for the build status
[21:26:58.131] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:58.131] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:37:0) after 1m0s
[21:27:58.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:37:0)
[21:27:58.264] Timer tick, asking Buildbucket for the build status
[21:27:58.409] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:58.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:38:0) after 1m0s
[21:28:58.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:38:0)
[21:28:58.457] Timer tick, asking Buildbucket for the build status
[21:28:58.616] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:58.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:39:0) after 1m0s
[21:29:58.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:39:0)
[21:29:58.689] Timer tick, asking Buildbucket for the build status
[21:29:58.741] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:58.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:40:0) after 1m0s
[21:30:58.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:40:0)
[21:30:58.851] Timer tick, asking Buildbucket for the build status
[21:30:58.943] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:58.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:41:0) after 1m0s
[21:31:59.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:41:0)
[21:31:59.010] Timer tick, asking Buildbucket for the build status
[21:31:59.082] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:59.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:42:0) after 1m0s
[21:32:59.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:42:0)
[21:32:59.178] Timer tick, asking Buildbucket for the build status
[21:32:59.293] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:59.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:43:0) after 1m0s
[21:33:59.350] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:43:0)
[21:33:59.350] Timer tick, asking Buildbucket for the build status
[21:33:59.446] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:59.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:44:0) after 1m0s
[21:34:59.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:44:0)
[21:34:59.488] Timer tick, asking Buildbucket for the build status
[21:34:59.564] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:59.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:45:0) after 1m0s
[21:35:59.965] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:45:0)
[21:35:59.965] Timer tick, asking Buildbucket for the build status
[21:36:00.193] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:00.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:46:0) after 1m0s
[21:37:00.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:46:0)
[21:37:00.258] Timer tick, asking Buildbucket for the build status
[21:37:00.327] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:00.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:47:0) after 1m0s
[21:38:00.338] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:47:0)
[21:38:00.338] Timer tick, asking Buildbucket for the build status
[21:38:00.474] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:00.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:48:0) after 1m0s
[21:39:00.609] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:48:0)
[21:39:00.609] Timer tick, asking Buildbucket for the build status
[21:39:00.662] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:00.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:49:0) after 1m0s
[21:40:01.867] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:49:0)
[21:40:01.867] Timer tick, asking Buildbucket for the build status
[21:40:01.988] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:01.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:50:0) after 1m0s
[21:41:02.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:50:0)
[21:41:02.753] Timer tick, asking Buildbucket for the build status
[21:41:02.814] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:02.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:51:0) after 1m0s
[21:42:02.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:51:0)
[21:42:02.901] Timer tick, asking Buildbucket for the build status
[21:42:02.955] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:02.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:52:0) after 1m0s
[21:43:02.990] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:52:0)
[21:43:02.990] Timer tick, asking Buildbucket for the build status
[21:43:03.127] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:03.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:53:0) after 1m0s
[21:44:03.263] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:53:0)
[21:44:03.263] Timer tick, asking Buildbucket for the build status
[21:44:03.334] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:03.334] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:54:0) after 1m0s
[21:45:03.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:54:0)
[21:45:03.366] Timer tick, asking Buildbucket for the build status
[21:45:03.453] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:03.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:55:0) after 1m0s
[21:46:03.476] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:55:0)
[21:46:03.476] Timer tick, asking Buildbucket for the build status
[21:46:03.713] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:03.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:56:0) after 1m0s
[21:47:03.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:56:0)
[21:47:03.756] Timer tick, asking Buildbucket for the build status
[21:47:04.073] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:04.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:57:0) after 1m0s
[21:48:04.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:57:0)
[21:48:04.118] Timer tick, asking Buildbucket for the build status
[21:48:04.256] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:04.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:58:0) after 1m0s
[21:49:04.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:58:0)
[21:49:04.311] Timer tick, asking Buildbucket for the build status
[21:49:04.369] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:04.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:59:0) after 1m0s
[21:50:04.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:59:0)
[21:50:04.401] Timer tick, asking Buildbucket for the build status
[21:50:05.232] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:05.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:60:0) after 1m0s
[21:51:05.382] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:60:0)
[21:51:05.382] Timer tick, asking Buildbucket for the build status
[21:51:05.642] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:05.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:61:0) after 1m0s
[21:52:05.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:61:0)
[21:52:05.756] Timer tick, asking Buildbucket for the build status
[21:52:06.097] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:06.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:62:0) after 1m0s
[21:53:06.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:62:0)
[21:53:06.141] Timer tick, asking Buildbucket for the build status
[21:53:06.240] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:06.240] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:63:0) after 1m0s
[21:54:06.310] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:63:0)
[21:54:06.310] Timer tick, asking Buildbucket for the build status
[21:54:06.387] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:06.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:64:0) after 1m0s
[21:55:06.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:64:0)
[21:55:06.435] Timer tick, asking Buildbucket for the build status
[21:55:06.550] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:06.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:65:0) after 1m0s
[21:56:06.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:65:0)
[21:56:06.579] Timer tick, asking Buildbucket for the build status
[21:56:06.968] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:06.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:66:0) after 1m0s
[21:57:07.048] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:66:0)
[21:57:07.048] Timer tick, asking Buildbucket for the build status
[21:57:07.165] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:07.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:67:0) after 1m0s
[21:58:07.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:67:0)
[21:58:07.232] Timer tick, asking Buildbucket for the build status
[21:58:08.530] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:08.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:68:0) after 1m0s
[21:59:08.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:68:0)
[21:59:08.561] Timer tick, asking Buildbucket for the build status
[21:59:08.687] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:08.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:69:0) after 1m0s
[22:00:08.758] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:69:0)
[22:00:08.758] Timer tick, asking Buildbucket for the build status
[22:00:08.893] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:08.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:70:0) after 1m0s
[22:01:08.986] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:70:0)
[22:01:08.986] Timer tick, asking Buildbucket for the build status
[22:01:09.256] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:09.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:71:0) after 1m0s
[22:02:09.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:71:0)
[22:02:09.308] Timer tick, asking Buildbucket for the build status
[22:02:09.998] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:09.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:72:0) after 1m0s
[22:03:09.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:72:0)
[22:03:09.989] Timer tick, asking Buildbucket for the build status
[22:03:10.089] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:10.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:73:0) after 1m0s
[22:04:10.198] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:73:0)
[22:04:10.198] Timer tick, asking Buildbucket for the build status
[22:04:10.711] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:10.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:74:0) after 1m0s
[22:05:10.700] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:74:0)
[22:05:10.700] Timer tick, asking Buildbucket for the build status
[22:05:10.843] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:10.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:75:0) after 1m0s
[22:06:10.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:75:0)
[22:06:10.868] Timer tick, asking Buildbucket for the build status
[22:06:11.001] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:11.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:76:0) after 1m0s
[22:07:11.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:76:0)
[22:07:11.051] Timer tick, asking Buildbucket for the build status
[22:07:11.258] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:11.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:77:0) after 1m0s
[22:08:11.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:77:0)
[22:08:11.369] Timer tick, asking Buildbucket for the build status
[22:08:11.525] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:11.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:78:0) after 1m0s
[22:09:11.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:78:0)
[22:09:11.646] Timer tick, asking Buildbucket for the build status
[22:09:11.789] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:11.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:79:0) after 1m0s
[22:10:11.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:79:0)
[22:10:11.878] Timer tick, asking Buildbucket for the build status
[22:10:12.026] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:12.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:80:0) after 1m0s
[22:11:12.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:80:0)
[22:11:12.234] Timer tick, asking Buildbucket for the build status
[22:11:12.633] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:12.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:81:0) after 1m0s
[22:12:12.656] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:81:0)
[22:12:12.656] Timer tick, asking Buildbucket for the build status
[22:12:12.785] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:12.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:82:0) after 1m0s
[22:13:12.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:82:0)
[22:13:12.797] Timer tick, asking Buildbucket for the build status
[22:13:12.910] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:12.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:83:0) after 1m0s
[22:14:12.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:83:0)
[22:14:12.978] Timer tick, asking Buildbucket for the build status
[22:14:13.077] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:13.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:84:0) after 1m0s
[22:15:13.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:84:0)
[22:15:13.146] Timer tick, asking Buildbucket for the build status
[22:15:13.664] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:13.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:85:0) after 1m0s
[22:16:13.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:85:0)
[22:16:13.736] Timer tick, asking Buildbucket for the build status
[22:16:13.858] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:13.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:86:0) after 1m0s
[22:17:13.946] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:86:0)
[22:17:13.946] Timer tick, asking Buildbucket for the build status
[22:17:14.018] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:14.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:87:0) after 1m0s
[22:18:14.080] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:87:0)
[22:18:14.080] Timer tick, asking Buildbucket for the build status
[22:18:14.223] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:14.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:88:0) after 1m0s
[22:19:14.344] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:88:0)
[22:19:14.344] Timer tick, asking Buildbucket for the build status
[22:19:14.853] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:14.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:89:0) after 1m0s
[22:20:15.164] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:89:0)
[22:20:15.164] Timer tick, asking Buildbucket for the build status
[22:20:15.299] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:15.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:90:0) after 1m0s
[22:21:15.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:90:0)
[22:21:15.401] Timer tick, asking Buildbucket for the build status
[22:21:15.488] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:15.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:91:0) after 1m0s
[22:22:15.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:91:0)
[22:22:15.552] Timer tick, asking Buildbucket for the build status
[22:22:16.108] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:16.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:92:0) after 1m0s
[22:23:16.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:92:0)
[22:23:16.204] Timer tick, asking Buildbucket for the build status
[22:23:16.349] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:16.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:93:0) after 1m0s
[22:24:16.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:93:0)
[22:24:16.441] Timer tick, asking Buildbucket for the build status
[22:24:16.691] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:16.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:94:0) after 1m0s
[22:25:16.785] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:94:0)
[22:25:16.785] Timer tick, asking Buildbucket for the build status
[22:25:16.903] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:16.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:95:0) after 1m0s
[22:26:16.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:95:0)
[22:26:16.911] Timer tick, asking Buildbucket for the build status
[22:26:17.110] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:17.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:96:0) after 1m0s
[22:27:17.169] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:96:0)
[22:27:17.169] Timer tick, asking Buildbucket for the build status
[22:27:17.413] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:17.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:97:0) after 1m0s
[22:28:17.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:97:0)
[22:28:17.454] Timer tick, asking Buildbucket for the build status
[22:28:17.861] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:17.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:98:0) after 1m0s
[22:29:17.967] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:98:0)
[22:29:17.968] Timer tick, asking Buildbucket for the build status
[22:29:18.089] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:18.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:99:0) after 1m0s
[22:30:18.156] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:99:0)
[22:30:18.156] Timer tick, asking Buildbucket for the build status
[22:30:18.447] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:18.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:100:0) after 1m0s
[22:31:18.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:100:0)
[22:31:18.495] Timer tick, asking Buildbucket for the build status
[22:31:18.765] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:18.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:101:0) after 1m0s
[22:32:18.829] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:101:0)
[22:32:18.829] Timer tick, asking Buildbucket for the build status
[22:32:18.905] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:18.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:102:0) after 1m0s
[22:33:19.030] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:102:0)
[22:33:19.030] Timer tick, asking Buildbucket for the build status
[22:33:19.141] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:19.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:103:0) after 1m0s
[22:34:19.470] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:103:0)
[22:34:19.470] Timer tick, asking Buildbucket for the build status
[22:34:19.610] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:19.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:104:0) after 1m0s
[22:35:20.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:104:0)
[22:35:20.130] Timer tick, asking Buildbucket for the build status
[22:35:20.254] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:20.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:105:0) after 1m0s
[22:36:20.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:105:0)
[22:36:20.458] Timer tick, asking Buildbucket for the build status
[22:36:20.523] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:20.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:106:0) after 1m0s
[22:37:20.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:106:0)
[22:37:20.574] Timer tick, asking Buildbucket for the build status
[22:37:20.659] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:20.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:107:0) after 1m0s
[22:38:20.720] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:107:0)
[22:38:20.720] Timer tick, asking Buildbucket for the build status
[22:38:20.898] Build 8860633562989431248: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:20.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026063625109928048:108:0) after 1m0s
[22:39:19.888] Received PubSub notification, asking Buildbucket for the build status
[22:39:20.601] Build 8860633562989431248: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:39:20.601] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608244759155678",
"created_by": "project:chromium",
"created_ts": "1608238366097446",
"id": "8860633562989431248",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e2066557d9eaded0df6175ad6ebec1a77abad31\"}}",
"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\": \"8e2066557d9eaded0df6175ad6ebec1a77abad31\", \"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-5-miap\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16288, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"c47b951ecbcbbba653db801bc7eb5f4fa5d72042\", \"got_dawn_revision\": \"155241b665f8305d54145ca460e0b8cebe888336\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"8e2066557d9eaded0df6175ad6ebec1a77abad31\", \"got_revision_cp\": \"refs/heads/master@{#838221}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"63b0f42110f230571933cf0dd4023a5e8145a3b0\", \"got_v8_revision_cp\": \"refs/heads/8.9.166@{#1}\", \"got_webrtc_revision\": \"8592111e458d253e53806db65d23d21bfe9d9db4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32849}\", \"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\": \"8e2066557d9eaded0df6175ad6ebec1a77abad31\", \"swarm_hashes_refs/heads/master(at){#838221}_without_patch\": {\"absl_hardening_tests\": \"2912c43b272a1ed76941a80eb9734421e8f6ed6f\", \"accessibility_unittests\": \"dc68368751be198fb0e8d7a991f7fd9b0f875072\", \"angle_unittests\": \"34296d73ede020d75d21c53487dc8a32613fca7f\", \"app_shell_unittests\": \"e36664b6d0679e89ab740bc59801cb1899f41046\", \"aura_unittests\": \"f8d142301c9fb12d9c2c0850fd5c3517c0fac753\", \"base_unittests\": \"0fdd2134c562c38b82b4b363bcdec4cada7fb10a\", \"base_util_unittests\": \"ad7040cce07737bb175a7b281e292070ce04ca1c\", \"blink_common_unittests\": \"b5178f69904cb5f5a223fdb9a077b17b53cd6bae\", \"blink_fuzzer_unittests\": \"d6317b5f1a296b3b2f60dff233064dcd4c70f243\", \"blink_heap_unittests\": \"5fcc95c0a7cad84973e8625d01a333701c3cfa2a\", \"blink_platform_unittests\": \"a00672b76ce360dd508dbb77ad4b6c01534c5ac2\", \"blink_unittests\": \"1d0f2d8d4661aed81087f892169c07ce378a3459\", \"boringssl_crypto_tests\": \"d5464834d7c2e7df6ae95aebd29bc666727e8131\", \"boringssl_ssl_tests\": \"80aedd43bc552f5c6bc3c576b282ea500bcbfc88\", \"browser_switcher_bho_unittests\": \"4157709988ab1e68fac80e504222baf90ac2f58f\", \"browser_tests\": \"7b74e68864676fb8b54e2f402f32196940da5353\", \"capture_unittests\": \"ac7726ba54a2a505b3bae77523aea1dd5b7f37cc\", \"cast_unittests\": \"ceffd1f26859fb448c95aea237a507223fa1579d\", \"cc_unittests\": \"c167e9c4b985e05e219f3bad2366541f93139e86\", \"chrome_app_unittests\": \"e03c8cbf2e7205b63099ee163ad7afea79a45f44\", \"chrome_cleaner_unittests\": \"fe15e783cfb43fdee34e8430067e6084aa36e55b\", \"chrome_elf_unittests\": \"4d94b8c60c4f214ba69bdcff47037ede2bbf666a\", \"chromedriver_unittests\": \"d124d0db9a10685e932974f83d6bd8aa41ea03bb\", \"components_browsertests\": \"f810be506e2c7e6ccdcb3c4583774905fb617e93\", \"components_unittests\": \"cce2f31b62ed54839fa9d729bc5cbf2c5085e272\", \"compositor_unittests\": \"10b538cb1c3f77b13ca01a2669c9dd8e101bb116\", \"content_browsertests\": \"810bc6678539a0c4058b08f0f2c8b24ba5802f5a\", \"content_unittests\": \"d81a3df068985ef2be87e34d833246f0c5361e20\", \"courgette_unittests\": \"29b335bf467b00c9af1373932a8081132426d249\", \"crashpad_tests\": \"556dda29366a071706bb30ca0561801ee3d4d5d0\", \"cronet_tests\": \"45581aff1f6dea337de9ce3ea428544026578546\", \"cronet_unittests\": \"15b7547dba3b151564f5d237310ec7bea479532a\", \"crypto_unittests\": \"ff4ee537eb3caec1f548fc18e57b0c7076f929f1\", \"delayloads_unittests\": \"6ad9ac6702c300fc567a76e3c757bf23dc6575de\", \"device_unittests\": \"402dc0b0eb940aa0b952a94de6d0d70323af0c6b\", \"display_unittests\": \"c541174156aeed95489162ec4bb37aefc9922242\", \"elevation_service_unittests\": \"4cbfa6a6364742d97f4a9f8a5634b28ec0105956\", \"events_unittests\": \"98a87aef36d328d79b8cd51ce988dd42cf3798bf\", \"extensions_browsertests\": \"2d3beeb723528e3cb55e1b41fe60799c2b147030\", \"extensions_unittests\": \"08c97a6c4913b80ff6c0b8b9ce963f2a3fba2c3c\", \"filesystem_service_unittests\": \"00e2bfae1864696d83785cddd3e1a3ac5d84698c\", \"gcm_unit_tests\": \"7b06d2a42af85ddd647f5152c391cd6d12ae10e2\", \"gcp_unittests\": \"4d7854dcfdc0a16b1bbee678d2b791369cd8b52d\", \"gfx_unittests\": \"6ee300aca92fd6f30c6a6b072919c801dd5e8470\", \"gin_unittests\": \"b8a1411d8281ad9b261b61fae6b685a83a65bf46\", \"google_apis_unittests\": \"607fd024d4365135cb67c9349c802ab50235356c\", \"gpu_unittests\": \"2aa345af453da4e670c6fdd8d5a897ffd542919f\", \"gwp_asan_unittests\": \"b8ab1fb52d3535644704f8ecb3311b857d2fe42e\", \"headless_browsertests\": \"3899695b3a13d3dec4adbeb7157a01edc5179646\", \"headless_unittests\": \"809ebe72bf169355214792103fad0b7294b37742\", \"install_static_unittests\": \"b039ad79e4c19a362d8022b457e38f1795bf097a\", \"installer_util_unittests\": \"7041edd488c9fc422b68c87670dae4207952b091\", \"interactive_ui_tests\": \"410d354c877c3cf9230e5da8e66f0954aa4f96f9\", \"ipc_tests\": \"588c12bf08ffba22607e35cdd6fa46039cd392cd\", \"jingle_unittests\": \"b5be3078a433b8a6e6268d7de71aa4bc059ba8f2\", \"latency_unittests\": \"f024fbaf159d517cf87514ced9d7ece29b4236f5\", \"libjingle_xmpp_unittests\": \"9b023695bb560d7b9527b6e0e5424c72c023ae4b\", \"liburlpattern_unittests\": \"6c2201ffaf0beb651f6dbb12923ae6a6f050019c\", \"media_blink_unittests\": \"146ffbdcce74761d9f8f37b702a89e7e04538b59\", \"media_unittests\": \"16e2f6d5caedb2bacf47bf63e4837004b6847be4\", \"message_center_unittests\": \"d1caa5025a4d9b00de33662dbba0507f72399ebb\", \"midi_unittests\": \"fa26412ba7623c47fb184aa8d9bf54c76bc55a5e\", \"mojo_core_unittests\": \"bb0536adc646d2a20f8e8d6305aeb3de6486566a\", \"mojo_unittests\": \"ed0c9416ff979eea5ba2a6bbe905b33fd44ca0cd\", \"nacl_loader_unittests\": \"32518f02c1a00e5f804524646a2d52112ae63e38\", \"native_theme_unittests\": \"3703238d549bba0b59c24b330f62bec1f505f822\", \"net_unittests\": \"7b8c1c754c4ebfb4bdbaebb0ba35d210b884d870\", \"notification_helper_unittests\": \"15e21a6345e2b28a9d3ae79550f27cafab99959b\", \"pdf_unittests\": \"b7b38c116e1ee256a1a62ce9f22469a0f4b9cbc3\", \"perfetto_unittests\": \"b272a8b5c54e8744401eb0a581cd757eb87afbf4\", \"ppapi_unittests\": \"1cb5dec55dc7eb42bb20e0ccd6df69478713da21\", \"printing_unittests\": \"cb5a98f585a72f738d88a45074f81c3aad739ff7\", \"remoting_unittests\": \"6d178895290123a3e580eb5f505ef081bfe81e96\", \"sbox_integration_tests\": \"81d4e6a20e889f7c8a2ec2f2a4596e7c87825e56\", \"sbox_unittests\": \"ad6cc285b8b53f67cc61aa087b0452f86c65d8b2\", \"sbox_validation_tests\": \"5d161e1671da2ef8d35bea82739295f785737fab\", \"service_manager_unittests\": \"0411802a71709d858cacb5922bb46a4b564ab6ac\", \"services_unittests\": \"15a3ef7dfc573025c97246178dac135adfa69375\", \"setup_unittests\": \"3e7101092ee7310d9db04dae74b7f6d6ffe19d8c\", \"shell_dialogs_unittests\": \"d0541ce68616812882ec55ff175f958d9d2fc34c\", \"skia_unittests\": \"4c2bb45bd20fa99562d98575c4417246fc270bd4\", \"snapshot_unittests\": \"66ee56e49ac84fc5d6177b9c392240f1427e2f0a\", \"sql_unittests\": \"013b57afb2eafadda89a50bd247a65a4c4dcc683\", \"storage_unittests\": \"ac6aa482217a7952e86128e72aa4e6f34d232993\", \"sync_integration_tests\": \"62d7c311fc06255999703c2b3034cbea68c61c0a\", \"traffic_annotation_auditor_unittests\": \"e1ceafc526af07bc9b777c5bf090b06e973a417d\", \"ui_base_unittests\": \"f4512061710f4f90c4225f606e608fe324f7a87a\", \"ui_touch_selection_unittests\": \"a44a40dba3281a35bdca89779d43c23ab2748b84\", \"unit_tests\": \"1bcebfecaf62c89127dd86372a7fa676c14eecb4\", \"updater_tests\": \"8bf43671da628ea75868ccefa4b31407d126338c\", \"url_unittests\": \"61e4fe1a222f316e248cf7c43bb69a23db3cb2b4\", \"views_unittests\": \"4fd4031c3f58d311788317d4f279d1be810db610\", \"viz_unittests\": \"8894f00a8fced3bc57354818070cc71ed89a7b87\", \"vr_common_unittests\": \"d7326cd4ed3d67388fcf444785d7760392b84db0\", \"vr_pixeltests\": \"c0ebf9f80ea121f7b14f7facaca88b415780242d\", \"weblayer_browsertests\": \"3ae19d0f51eca72f1172c988d8f4eb876b2fe2f2\", \"weblayer_unittests\": \"537745eb59b0e2178f720d1cf69489b001926edf\", \"wm_unittests\": \"77f61f0d5d3a9d4855d2ff5990cfc66064256d26\", \"wtf_unittests\": \"fa85813f6926bbdfff5034f3d24cf9cfe1be6d3b\", \"zlib_unittests\": \"50553437fc99eecb8b2308d0addce70fd969cd30\", \"zucchini_unittests\": \"f8bdf96a691565509cdce2b1910ea17edee1b6e5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_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-5-miap\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608238368023898",
"status": "COMPLETED",
"status_changed_ts": "1608244759506268",
"tags": [
"build_address:luci.chromium.ci/win-asan/16288",
"builder:win-asan",
"buildset:commit/git/8e2066557d9eaded0df6175ad6ebec1a77abad31",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e2066557d9eaded0df6175ad6ebec1a77abad31",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026063625109928048",
"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/8860633562989431248/+/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:508b4b8a8a447f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608244759512089",
"url": "https://ci.chromium.org/b/8860633562989431248",
"utcnow_ts": "1608244760533914"
}
}
[22:39:20.601] Invocation finished in 1h46m35.910211336s with status SUCCEEDED