[11:15:15.801] New invocation is queued and will start shortly
[11:15:16.902] Starting the invocation (attempt 1)
[11:15:16.976] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:15:16.976] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:15:16.976] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021026527002348304",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3de2e89510f43e59eb7c763c0508431c7929808e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9021026527002348304",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/3de2e89510f43e59eb7c763c0508431c7929808e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3de2e89510f43e59eb7c763c0508431c7929808e",
"gitiles_ref:refs/heads/master"
]
}
[11:15:18.052] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613042117088273",
"id": "8855596464990608944",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3de2e89510f43e59eb7c763c0508431c7929808e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613042117822594",
"tags": [
"build_address:luci.chromium.ci/win-asan/17284",
"builder:win-asan",
"buildset:commit/git/3de2e89510f43e59eb7c763c0508431c7929808e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3de2e89510f43e59eb7c763c0508431c7929808e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021026527002348304",
"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/8855596464990608944/+/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": "1613042117822817",
"url": "https://ci.chromium.org/b/8855596464990608944",
"utcnow_ts": "1613042118036841"
}
}
[11:15:18.052] Task URL: https://ci.chromium.org/b/8855596464990608944
[11:15:18.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:2:0) after 1m0s
[11:16:18.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:2:0)
[11:16:18.167] Timer tick, asking Buildbucket for the build status
[11:16:18.299] Build 8855596464990608944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:16:18.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:3:0) after 1m0s
[11:17:18.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:3:0)
[11:17:18.386] Timer tick, asking Buildbucket for the build status
[11:17:18.620] Build 8855596464990608944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:17:18.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:4:0) after 1m0s
[11:18:18.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:4:0)
[11:18:18.755] Timer tick, asking Buildbucket for the build status
[11:18:18.840] Build 8855596464990608944: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:18:18.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:5:0) after 1m0s
[11:18:48.685] Received PubSub notification, asking Buildbucket for the build status
[11:18:48.797] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:18.940] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:5:0)
[11:19:18.940] Timer tick, asking Buildbucket for the build status
[11:19:19.016] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:19.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:7:0) after 1m0s
[11:20:19.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:7:0)
[11:20:19.094] Timer tick, asking Buildbucket for the build status
[11:20:19.188] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:19.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:8:0) after 1m0s
[11:21:19.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:8:0)
[11:21:19.217] Timer tick, asking Buildbucket for the build status
[11:21:19.284] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:19.284] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:9:0) after 1m0s
[11:22:19.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:9:0)
[11:22:19.343] Timer tick, asking Buildbucket for the build status
[11:22:19.418] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:19.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:10:0) after 1m0s
[11:23:19.419] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:10:0)
[11:23:19.419] Timer tick, asking Buildbucket for the build status
[11:23:19.497] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:19.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:11:0) after 1m0s
[11:24:19.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:11:0)
[11:24:19.589] Timer tick, asking Buildbucket for the build status
[11:24:20.575] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:20.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:12:0) after 1m0s
[11:25:20.688] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:12:0)
[11:25:20.688] Timer tick, asking Buildbucket for the build status
[11:25:20.825] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:20.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:13:0) after 1m0s
[11:26:21.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:13:0)
[11:26:21.046] Timer tick, asking Buildbucket for the build status
[11:26:21.304] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:21.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:14:0) after 1m0s
[11:27:21.508] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:14:0)
[11:27:21.508] Timer tick, asking Buildbucket for the build status
[11:27:21.615] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:21.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:15:0) after 1m0s
[11:28:21.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:15:0)
[11:28:21.674] Timer tick, asking Buildbucket for the build status
[11:28:21.750] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:21.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:16:0) after 1m0s
[11:29:21.795] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:16:0)
[11:29:21.795] Timer tick, asking Buildbucket for the build status
[11:29:21.924] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:21.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:17:0) after 1m0s
[11:30:22.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:17:0)
[11:30:22.005] Timer tick, asking Buildbucket for the build status
[11:30:22.121] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:22.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:18:0) after 1m0s
[11:31:22.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:18:0)
[11:31:22.213] Timer tick, asking Buildbucket for the build status
[11:31:22.428] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:22.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:19:0) after 1m0s
[11:32:22.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:19:0)
[11:32:22.446] Timer tick, asking Buildbucket for the build status
[11:32:22.655] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:22.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:20:0) after 1m0s
[11:33:22.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:20:0)
[11:33:22.668] Timer tick, asking Buildbucket for the build status
[11:33:22.751] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:22.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:21:0) after 1m0s
[11:34:22.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:21:0)
[11:34:22.784] Timer tick, asking Buildbucket for the build status
[11:34:22.883] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:22.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:22:0) after 1m0s
[11:35:22.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:22:0)
[11:35:22.929] Timer tick, asking Buildbucket for the build status
[11:35:23.050] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:23.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:23:0) after 1m0s
[11:36:23.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:23:0)
[11:36:23.066] Timer tick, asking Buildbucket for the build status
[11:36:23.146] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:23.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:24:0) after 1m0s
[11:37:23.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:24:0)
[11:37:23.146] Timer tick, asking Buildbucket for the build status
[11:37:23.266] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:23.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:25:0) after 1m0s
[11:38:23.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:25:0)
[11:38:23.354] Timer tick, asking Buildbucket for the build status
[11:38:23.512] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:23.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:26:0) after 1m0s
[11:39:23.533] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:26:0)
[11:39:23.533] Timer tick, asking Buildbucket for the build status
[11:39:23.608] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:23.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:27:0) after 1m0s
[11:40:23.682] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:27:0)
[11:40:23.682] Timer tick, asking Buildbucket for the build status
[11:40:23.827] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:23.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:28:0) after 1m0s
[11:41:23.885] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:28:0)
[11:41:23.885] Timer tick, asking Buildbucket for the build status
[11:41:23.983] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:23.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:29:0) after 1m0s
[11:42:24.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:29:0)
[11:42:24.035] Timer tick, asking Buildbucket for the build status
[11:42:24.210] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:24.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:30:0) after 1m0s
[11:43:24.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:30:0)
[11:43:24.370] Timer tick, asking Buildbucket for the build status
[11:43:24.468] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:24.468] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:31:0) after 1m0s
[11:44:24.541] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:31:0)
[11:44:24.541] Timer tick, asking Buildbucket for the build status
[11:44:24.718] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:24.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:32:0) after 1m0s
[11:45:24.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:32:0)
[11:45:24.820] Timer tick, asking Buildbucket for the build status
[11:45:24.946] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:24.947] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:33:0) after 1m0s
[11:46:24.959] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:33:0)
[11:46:24.959] Timer tick, asking Buildbucket for the build status
[11:46:25.063] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:25.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:34:0) after 1m0s
[11:47:25.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:34:0)
[11:47:25.195] Timer tick, asking Buildbucket for the build status
[11:47:25.276] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:25.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:35:0) after 1m0s
[11:48:25.421] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:35:0)
[11:48:25.421] Timer tick, asking Buildbucket for the build status
[11:48:26.016] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:26.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:36:0) after 1m0s
[11:49:26.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:36:0)
[11:49:26.028] Timer tick, asking Buildbucket for the build status
[11:49:26.118] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:26.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:37:0) after 1m0s
[11:50:26.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:37:0)
[11:50:26.260] Timer tick, asking Buildbucket for the build status
[11:50:26.363] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:26.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:38:0) after 1m0s
[11:51:26.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:38:0)
[11:51:26.375] Timer tick, asking Buildbucket for the build status
[11:51:26.606] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:26.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:39:0) after 1m0s
[11:52:26.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:39:0)
[11:52:26.645] Timer tick, asking Buildbucket for the build status
[11:52:26.773] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:26.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:40:0) after 1m0s
[11:53:26.833] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:40:0)
[11:53:26.833] Timer tick, asking Buildbucket for the build status
[11:53:26.912] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:26.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:41:0) after 1m0s
[11:54:26.908] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:41:0)
[11:54:26.908] Timer tick, asking Buildbucket for the build status
[11:54:27.016] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:27.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:42:0) after 1m0s
[11:55:27.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:42:0)
[11:55:27.143] Timer tick, asking Buildbucket for the build status
[11:55:27.252] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:27.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:43:0) after 1m0s
[11:56:27.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:43:0)
[11:56:27.273] Timer tick, asking Buildbucket for the build status
[11:56:27.495] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:27.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:44:0) after 1m0s
[11:57:27.533] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:44:0)
[11:57:27.533] Timer tick, asking Buildbucket for the build status
[11:57:27.731] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:27.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:45:0) after 1m0s
[11:58:27.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:45:0)
[11:58:27.718] Timer tick, asking Buildbucket for the build status
[11:58:27.787] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:27.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:46:0) after 1m0s
[11:59:27.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:46:0)
[11:59:27.813] Timer tick, asking Buildbucket for the build status
[11:59:27.881] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:27.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:47:0) after 1m0s
[12:00:27.894] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:47:0)
[12:00:27.894] Timer tick, asking Buildbucket for the build status
[12:00:27.993] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:27.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:48:0) after 1m0s
[12:01:28.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:48:0)
[12:01:28.078] Timer tick, asking Buildbucket for the build status
[12:01:28.424] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:28.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:49:0) after 1m0s
[12:02:28.456] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:49:0)
[12:02:28.456] Timer tick, asking Buildbucket for the build status
[12:02:28.846] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:28.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:50:0) after 1m0s
[12:03:28.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:50:0)
[12:03:28.916] Timer tick, asking Buildbucket for the build status
[12:03:29.148] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:29.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:51:0) after 1m0s
[12:04:29.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:51:0)
[12:04:29.141] Timer tick, asking Buildbucket for the build status
[12:04:29.219] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:29.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:52:0) after 1m0s
[12:05:29.243] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:52:0)
[12:05:29.243] Timer tick, asking Buildbucket for the build status
[12:05:29.320] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:29.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:53:0) after 1m0s
[12:06:29.340] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:53:0)
[12:06:29.340] Timer tick, asking Buildbucket for the build status
[12:06:29.438] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:29.438] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:54:0) after 1m0s
[12:07:29.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:54:0)
[12:07:29.484] Timer tick, asking Buildbucket for the build status
[12:07:29.724] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:29.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:55:0) after 1m0s
[12:08:29.743] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:55:0)
[12:08:29.743] Timer tick, asking Buildbucket for the build status
[12:08:30.117] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:30.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:56:0) after 1m0s
[12:09:30.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:56:0)
[12:09:30.283] Timer tick, asking Buildbucket for the build status
[12:09:30.444] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:30.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:57:0) after 1m0s
[12:10:30.450] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:57:0)
[12:10:30.450] Timer tick, asking Buildbucket for the build status
[12:10:30.551] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:30.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:58:0) after 1m0s
[12:11:30.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:58:0)
[12:11:30.600] Timer tick, asking Buildbucket for the build status
[12:11:30.692] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:30.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:59:0) after 1m0s
[12:12:30.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:59:0)
[12:12:30.715] Timer tick, asking Buildbucket for the build status
[12:12:30.871] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:30.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:60:0) after 1m0s
[12:13:30.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:60:0)
[12:13:30.937] Timer tick, asking Buildbucket for the build status
[12:13:31.239] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:31.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:61:0) after 1m0s
[12:14:31.275] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:61:0)
[12:14:31.275] Timer tick, asking Buildbucket for the build status
[12:14:31.402] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:31.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:62:0) after 1m0s
[12:15:31.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:62:0)
[12:15:31.591] Timer tick, asking Buildbucket for the build status
[12:15:31.892] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:31.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:63:0) after 1m0s
[12:16:31.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:63:0)
[12:16:31.966] Timer tick, asking Buildbucket for the build status
[12:16:32.109] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:32.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:64:0) after 1m0s
[12:17:32.188] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:64:0)
[12:17:32.188] Timer tick, asking Buildbucket for the build status
[12:17:32.279] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:32.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:65:0) after 1m0s
[12:18:32.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:65:0)
[12:18:32.339] Timer tick, asking Buildbucket for the build status
[12:18:32.410] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:32.410] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:66:0) after 1m0s
[12:19:32.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:66:0)
[12:19:32.512] Timer tick, asking Buildbucket for the build status
[12:19:32.594] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:32.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:67:0) after 1m0s
[12:20:32.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:67:0)
[12:20:32.618] Timer tick, asking Buildbucket for the build status
[12:20:32.726] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:32.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:68:0) after 1m0s
[12:21:32.800] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:68:0)
[12:21:32.800] Timer tick, asking Buildbucket for the build status
[12:21:32.883] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:32.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:69:0) after 1m0s
[12:22:32.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:69:0)
[12:22:32.921] Timer tick, asking Buildbucket for the build status
[12:22:33.010] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:33.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:70:0) after 1m0s
[12:23:33.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:70:0)
[12:23:33.112] Timer tick, asking Buildbucket for the build status
[12:23:33.234] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:33.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:71:0) after 1m0s
[12:24:33.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:71:0)
[12:24:33.277] Timer tick, asking Buildbucket for the build status
[12:24:33.432] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:33.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:72:0) after 1m0s
[12:25:33.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:72:0)
[12:25:33.534] Timer tick, asking Buildbucket for the build status
[12:25:33.709] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:33.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:73:0) after 1m0s
[12:26:33.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:73:0)
[12:26:33.729] Timer tick, asking Buildbucket for the build status
[12:26:33.916] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:33.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:74:0) after 1m0s
[12:27:33.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:74:0)
[12:27:33.937] Timer tick, asking Buildbucket for the build status
[12:27:34.124] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:34.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:75:0) after 1m0s
[12:28:34.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:75:0)
[12:28:34.134] Timer tick, asking Buildbucket for the build status
[12:28:34.812] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:34.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:76:0) after 1m0s
[12:29:34.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:76:0)
[12:29:34.911] Timer tick, asking Buildbucket for the build status
[12:29:34.995] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:34.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:77:0) after 1m0s
[12:30:35.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:77:0)
[12:30:35.113] Timer tick, asking Buildbucket for the build status
[12:30:35.208] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:35.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:78:0) after 1m0s
[12:31:35.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:78:0)
[12:31:35.329] Timer tick, asking Buildbucket for the build status
[12:31:35.795] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:35.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:79:0) after 1m0s
[12:32:35.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:79:0)
[12:32:35.963] Timer tick, asking Buildbucket for the build status
[12:32:36.151] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:36.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:80:0) after 1m0s
[12:33:36.225] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:80:0)
[12:33:36.225] Timer tick, asking Buildbucket for the build status
[12:33:36.637] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:36.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:81:0) after 1m0s
[12:34:36.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:81:0)
[12:34:36.855] Timer tick, asking Buildbucket for the build status
[12:34:36.954] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:36.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:82:0) after 1m0s
[12:35:37.058] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:82:0)
[12:35:37.058] Timer tick, asking Buildbucket for the build status
[12:35:37.148] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:37.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:83:0) after 1m0s
[12:36:37.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:83:0)
[12:36:37.291] Timer tick, asking Buildbucket for the build status
[12:36:37.704] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:37.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:84:0) after 1m0s
[12:37:37.737] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:84:0)
[12:37:37.737] Timer tick, asking Buildbucket for the build status
[12:37:37.838] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:37.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:85:0) after 1m0s
[12:38:37.997] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:85:0)
[12:38:37.997] Timer tick, asking Buildbucket for the build status
[12:38:38.103] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:86:0) after 1m0s
[12:39:38.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:86:0)
[12:39:38.118] Timer tick, asking Buildbucket for the build status
[12:39:38.405] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:38.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:87:0) after 1m0s
[12:40:38.428] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:87:0)
[12:40:38.428] Timer tick, asking Buildbucket for the build status
[12:40:38.603] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:38.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:88:0) after 1m0s
[12:41:38.691] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:88:0)
[12:41:38.691] Timer tick, asking Buildbucket for the build status
[12:41:38.851] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:38.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:89:0) after 1m0s
[12:42:38.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:89:0)
[12:42:38.964] Timer tick, asking Buildbucket for the build status
[12:42:39.082] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:39.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:90:0) after 1m0s
[12:43:39.197] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:90:0)
[12:43:39.197] Timer tick, asking Buildbucket for the build status
[12:43:39.414] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:39.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:91:0) after 1m0s
[12:44:39.483] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:91:0)
[12:44:39.483] Timer tick, asking Buildbucket for the build status
[12:44:39.610] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:39.610] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:92:0) after 1m0s
[12:45:39.735] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:92:0)
[12:45:39.735] Timer tick, asking Buildbucket for the build status
[12:45:39.849] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:39.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:93:0) after 1m0s
[12:46:39.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:93:0)
[12:46:39.884] Timer tick, asking Buildbucket for the build status
[12:46:40.019] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:40.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:94:0) after 1m0s
[12:47:40.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:94:0)
[12:47:40.089] Timer tick, asking Buildbucket for the build status
[12:47:40.210] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:40.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:95:0) after 1m0s
[12:48:40.239] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:95:0)
[12:48:40.239] Timer tick, asking Buildbucket for the build status
[12:48:40.499] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:40.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:96:0) after 1m0s
[12:49:40.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:96:0)
[12:49:40.657] Timer tick, asking Buildbucket for the build status
[12:49:40.766] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:40.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:97:0) after 1m0s
[12:50:40.815] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:97:0)
[12:50:40.815] Timer tick, asking Buildbucket for the build status
[12:50:40.916] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:40.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:98:0) after 1m0s
[12:51:41.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:98:0)
[12:51:41.057] Timer tick, asking Buildbucket for the build status
[12:51:41.144] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:41.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:99:0) after 1m0s
[12:52:41.199] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:99:0)
[12:52:41.199] Timer tick, asking Buildbucket for the build status
[12:52:41.289] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:41.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:100:0) after 1m0s
[12:53:41.348] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:100:0)
[12:53:41.348] Timer tick, asking Buildbucket for the build status
[12:53:41.935] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:41.935] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:101:0) after 1m0s
[12:54:41.995] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:101:0)
[12:54:41.995] Timer tick, asking Buildbucket for the build status
[12:54:42.127] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:42.127] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:102:0) after 1m0s
[12:55:42.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:102:0)
[12:55:42.173] Timer tick, asking Buildbucket for the build status
[12:55:42.265] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:42.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:103:0) after 1m0s
[12:56:42.313] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:103:0)
[12:56:42.313] Timer tick, asking Buildbucket for the build status
[12:56:42.522] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:42.522] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:104:0) after 1m0s
[12:57:42.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:104:0)
[12:57:42.558] Timer tick, asking Buildbucket for the build status
[12:57:42.651] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:42.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:105:0) after 1m0s
[12:58:42.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:105:0)
[12:58:42.696] Timer tick, asking Buildbucket for the build status
[12:58:42.828] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:42.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:106:0) after 1m0s
[12:59:42.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:106:0)
[12:59:42.847] Timer tick, asking Buildbucket for the build status
[12:59:42.964] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:42.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:107:0) after 1m0s
[13:00:42.984] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:107:0)
[13:00:42.984] Timer tick, asking Buildbucket for the build status
[13:00:43.107] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:43.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:108:0) after 1m0s
[13:01:43.157] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:108:0)
[13:01:43.157] Timer tick, asking Buildbucket for the build status
[13:01:43.331] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:43.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:109:0) after 1m0s
[13:02:43.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:109:0)
[13:02:43.360] Timer tick, asking Buildbucket for the build status
[13:02:43.793] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:43.793] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:110:0) after 1m0s
[13:03:43.823] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:110:0)
[13:03:43.823] Timer tick, asking Buildbucket for the build status
[13:03:43.919] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:43.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:111:0) after 1m0s
[13:04:43.999] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:111:0)
[13:04:43.999] Timer tick, asking Buildbucket for the build status
[13:04:44.105] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:44.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:112:0) after 1m0s
[13:05:44.132] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:112:0)
[13:05:44.132] Timer tick, asking Buildbucket for the build status
[13:05:44.215] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:44.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:113:0) after 1m0s
[13:06:44.261] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:113:0)
[13:06:44.261] Timer tick, asking Buildbucket for the build status
[13:06:44.391] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:44.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:114:0) after 1m0s
[13:07:44.418] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:114:0)
[13:07:44.418] Timer tick, asking Buildbucket for the build status
[13:07:44.529] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:44.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:115:0) after 1m0s
[13:08:44.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:115:0)
[13:08:44.683] Timer tick, asking Buildbucket for the build status
[13:08:44.949] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:44.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:116:0) after 1m0s
[13:09:45.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:116:0)
[13:09:45.162] Timer tick, asking Buildbucket for the build status
[13:09:45.266] Build 8855596464990608944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:45.266] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021026527002348304:117:0) after 1m0s
[13:10:05.779] Received PubSub notification, asking Buildbucket for the build status
[13:10:06.003] Build 8855596464990608944: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:10:06.004] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613049004553850",
"created_by": "project:chromium",
"created_ts": "1613042117088273",
"failure_reason": "BUILD_FAILURE",
"id": "8855596464990608944",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3de2e89510f43e59eb7c763c0508431c7929808e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- PersistentBackground/ExecuteScriptApiTest.ExecuteScriptInFrame/0\\n\\n- ServiceWorker/ExecuteScriptApiTest.ExecuteScriptInFrame/0\"}, \"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\": \"3de2e89510f43e59eb7c763c0508431c7929808e\", \"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-6-wuow\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17284, \"clang_revision\": \"llvmorg-13-init-794-g83e2710e-1\", \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"aa0e1be0e8034511ba38edf9789cbbaa52888ae0\", \"got_nacl_revision\": \"82ac8c0a6f0d3ffc843c693dd5149a356b866ae5\", \"got_revision\": \"3de2e89510f43e59eb7c763c0508431c7929808e\", \"got_revision_cp\": \"refs/heads/master@{#853075}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"ef6896f42d709cf53b8b4fe49cef4dedb2c81e32\", \"got_v8_revision_cp\": \"refs/heads/9.0.163@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"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\": \"3de2e89510f43e59eb7c763c0508431c7929808e\", \"swarm_hashes_refs/heads/master(at){#853075}_without_patch\": {\"absl_hardening_tests\": \"183a5ac1b5a775454bf5e9ed4cf29e0e3d11b686\", \"accessibility_unittests\": \"6e718109c8c6a6673ce1197adb58bbfbafa90cd3\", \"angle_unittests\": \"f8a311b71d6f72b448d80449797e51d3c41f3a46\", \"app_shell_unittests\": \"0a693710bfba816379dae8a5c08b68bdd09a7259\", \"aura_unittests\": \"1627d49b4cda6d6d8252c33f359b85d31188df49\", \"base_unittests\": \"1b315f39b0919d7c9c2e7a3078d03f38618ec1ed\", \"base_util_unittests\": \"a962b1898168f8fd765b79a4087e735d74918ec0\", \"blink_common_unittests\": \"849b71fd522de56e8ccda696283f144c3809d60f\", \"blink_fuzzer_unittests\": \"7a1112edf3a38ad0606fa3a9bf923ff3e04fc4df\", \"blink_heap_unittests\": \"f04d63f306ac726b124bafdc923cbca0bebea514\", \"blink_platform_unittests\": \"feb608670a3dc8b3a774f078ea9c807cff7a58fd\", \"blink_unittests\": \"1add1b7b272e11fa67af69847687eca0c7212276\", \"boringssl_crypto_tests\": \"f7a05caf5fc7695fcb000032970d6ffc8c1b5e7d\", \"boringssl_ssl_tests\": \"2bb15d070a8bcd316245651a1fb9cf26673539c4\", \"browser_switcher_bho_unittests\": \"d3d4a1f6acd6ee0b63580bc9efc9303580181e31\", \"browser_tests\": \"f495ade585adf56c03a8f3aaacd1a76a8fba91a2\", \"capture_unittests\": \"abbf1ede50b9f528de21c9f86eb7306bda9a4da8\", \"cast_unittests\": \"a2368a8e5df3ad984f427c094e6e58810b294560\", \"cc_unittests\": \"6c8aa324495230c8c5e6a5520f90fd89a7246376\", \"chrome_app_unittests\": \"37456499c2af65b456053c17a1f2c9350f723ec7\", \"chrome_cleaner_unittests\": \"ac9eb55b5e09e94b8b7290417dfece88422df1c7\", \"chrome_elf_unittests\": \"ab5a043d3bb0807df4166ecb1b1c956b42f87c7a\", \"chromedriver_unittests\": \"fd2035b197bfe49083f6d9080059bb35e65eb7bd\", \"components_browsertests\": \"d1271140434e10bcd39c0e3c684e5a0affde8b6a\", \"components_unittests\": \"a258b6f6a14b1384caf4f5ec1b2135f1ca97c6e2\", \"compositor_unittests\": \"4fca35b456aa8693291177da68266a2a45ff2ebb\", \"content_browsertests\": \"2504247ff382f71be861e94a1fefe7ff58bdeea7\", \"content_unittests\": \"d8a9deee544dfd947e8b4e3073df79d2400c98cf\", \"courgette_unittests\": \"d55404ddfc6db42e37fe4ba9f9b7c32840456d3d\", \"crashpad_tests\": \"f864fb34b35cf9e3d36690286d49091de4aea7cf\", \"cronet_tests\": \"745f4aae68f30a4f7e516c29a47292733f5ad3d6\", \"cronet_unittests\": \"8bfae1b3bd75fde97af4bd2878982cfc75188bc4\", \"crypto_unittests\": \"803b768b63e2212dcaa31883eb64371ec582763d\", \"delayloads_unittests\": \"621402d962f0631f5db520ad2cdd8669fc6336ae\", \"device_unittests\": \"f2965dd2876eb958e929b3d0c7472235ddb73012\", \"display_unittests\": \"d96fc2c22be21cf55a9a325bb33d2dd96bca4447\", \"elevation_service_unittests\": \"f5eb801cb7906a7484db12ee9a7c3439334cd75f\", \"events_unittests\": \"a055d2bd5e657b06926d8742c1fff8410daeaecf\", \"extensions_browsertests\": \"5ebf719c590ad03acd38ae4c74cbf75bc547aab6\", \"extensions_unittests\": \"6202e310884e17ae18df199f7db0d5a186d28c34\", \"filesystem_service_unittests\": \"471f9e407e94e9f979e3f974dae147c871e6db3b\", \"gcm_unit_tests\": \"c27005b1f7187eb68f3de8347786aa2a9b1d7ef9\", \"gcp_unittests\": \"54fd5584324a2549187a547ca60ecda26dd75713\", \"gfx_unittests\": \"7b83a2a47cb0900f275bc28d00005340f30c1d7d\", \"gin_unittests\": \"33e266462945c1cf462e0906ef6030a32ef03f46\", \"google_apis_unittests\": \"08f4fab245d1c8f9323e15aa73e5f575360b1fe9\", \"gpu_unittests\": \"599dd05b18daac8c9676094b0865f4f2571d5a5f\", \"gwp_asan_unittests\": \"1fc10097925862b98a9f3110f5e9eed21981f0b1\", \"headless_browsertests\": \"ce1639d8b50829d4f675a11a99fcec8897881270\", \"headless_unittests\": \"09573ac041cc904aeae8dfaca2eef1149371abf0\", \"install_static_unittests\": \"0b6890b8b9d1213e009edf2c62e87b2509563ea2\", \"installer_util_unittests\": \"53b88955c8b2268080728aa0791eb598bf614e78\", \"interactive_ui_tests\": \"1f68254ce3329166d68b08aa5e523291e7001245\", \"ipc_tests\": \"2a961bd95add56f493bc5cfca79226e379c5bb7e\", \"jingle_unittests\": \"a4df9a61e5ed4cfc06b25d0a22865c4a6690eb5b\", \"latency_unittests\": \"22dea351b2a232ab687f3966e49490b3f7395384\", \"libjingle_xmpp_unittests\": \"604e0c7f02d4c9559897033f341a3fdc8eb686aa\", \"liburlpattern_unittests\": \"90859241236b7613e3558e545ec5990afd0eb21f\", \"media_blink_unittests\": \"14a086abdf81a6bec248a0fc94da866e61fca4e6\", \"media_unittests\": \"3ac3c2878dbb764d2de73d1fcab787cc96481feb\", \"message_center_unittests\": \"67cbbf5c2ae722cfe4cfd870f1f13e6b001dd3a4\", \"midi_unittests\": \"486139c8a39c8ef29a9b57063127d82fc98f28ad\", \"mojo_core_unittests\": \"c8a444a2b74a8d323a77fa65c351de3ad5ac8540\", \"mojo_unittests\": \"981d585483370e809baf596ebddbc567cfaf0409\", \"nacl_loader_unittests\": \"15ec8aef51e607b4c8da1de32923180b3074ce2a\", \"native_theme_unittests\": \"6d38df27234a5dfa0c9beb67398868af5a73130a\", \"net_unittests\": \"9282fa3b15939a5328d74b6ded5d994925153619\", \"notification_helper_unittests\": \"9f14c0934c44d32725c9a6df6bd288a78210583f\", \"pdf_unittests\": \"9802982f227ee632faf49ea31fc310816ed42a52\", \"perfetto_unittests\": \"c72bf70233d38d7d3d6f218df74aeb6cd1b70415\", \"ppapi_unittests\": \"76770cfb2fd68451c1fb6eedd1a5e28f01b2294d\", \"printing_unittests\": \"bf1dc79cfe81b945ef7ba1ce6771ed3a70055ec8\", \"remoting_unittests\": \"d3afb0ede0044a9b0a1551a1d3b37655976c1625\", \"sbox_integration_tests\": \"a371cebe0b98c2c68a37fb8334d250703e3506fb\", \"sbox_unittests\": \"686e956297591d54e80e3e93b2d65cbfe0226f52\", \"sbox_validation_tests\": \"e52b244a4bb163b152efb0c166f77e7cd93b0e81\", \"service_manager_unittests\": \"1c577d0de5f4fa0d1ce4706d81e3405b4c281b89\", \"services_unittests\": \"0519e38bddbd4b685428fd79a57c561df7736afc\", \"setup_unittests\": \"496028a4516b9aeabb019d9e59eb65e0fd1c4d36\", \"shell_dialogs_unittests\": \"5b3555a3a925e11280a90813b237a4b9fdbbd156\", \"skia_unittests\": \"47097b9d12551ebe3f5926bd4b715ba95f163fa2\", \"snapshot_unittests\": \"9fd48d42f1aecb9d11a2c0db6cf6021f0508b36b\", \"sql_unittests\": \"d4b02038a4c4fe0d1753e595836643fbd99375f6\", \"storage_unittests\": \"c6d1606ff47d3cfd6e9c2d2673028b9cdbfd22be\", \"sync_integration_tests\": \"bed74eb78073c015a486c35d2738265794466b04\", \"traffic_annotation_auditor_unittests\": \"8f2f00210841092216d33709b758f222c2264469\", \"ui_base_unittests\": \"493f9a1c3ac352d16de035068d9eca4aa04c3b09\", \"ui_touch_selection_unittests\": \"2711451a4f0e06194164bfe8c459a3d9eef8c258\", \"unit_tests\": \"f9f6165ae1643496535685b10d789aaef402b87a\", \"updater_tests\": \"ae4983bf7bd6492dc7b101d0e0c385a6c9e2c10e\", \"url_unittests\": \"80c4ecf5ca420705bc4e76ff10d7b1ec6163fb74\", \"views_unittests\": \"bee93a8ecd3d0d6c9f6de7a22424cf0fa9072ea3\", \"viz_unittests\": \"4b6729188fd36fec1c76578a8a55ac44f8818f3e\", \"vr_common_unittests\": \"e2bd8193997846c722122d70fd4a7a4ab0f9ce2d\", \"vr_pixeltests\": \"399d59d56d5cc8706a38c3cc9e3c517d2fbca00a\", \"weblayer_browsertests\": \"117184a42be2c010e2223f0804f817d6123851d9\", \"weblayer_unittests\": \"6a2922e9001707dc35ffc531424e7dfe383539ca\", \"wm_unittests\": \"66730ef1d6c3fcb102db603b02f5c25beae96c96\", \"wtf_unittests\": \"0454b813c984e97d789cc2818a0ee45f1c010d13\", \"zlib_unittests\": \"14f3851554b369a841b005b9fb0a0886b0415ab3\", \"zucchini_unittests\": \"6287f3e347cc30fec5774afd87d24f5e0ba80946\"}}, \"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-6-wuow\"], \"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\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- PersistentBackground/ExecuteScriptApiTest.ExecuteScriptInFrame/0\\n\\n- ServiceWorker/ExecuteScriptApiTest.ExecuteScriptInFrame/0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613042328137664",
"status": "COMPLETED",
"status_changed_ts": "1613042328502000",
"tags": [
"build_address:luci.chromium.ci/win-asan/17284",
"builder:win-asan",
"buildset:commit/git/3de2e89510f43e59eb7c763c0508431c7929808e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3de2e89510f43e59eb7c763c0508431c7929808e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021026527002348304",
"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/8855596464990608944/+/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:51a99ef5e70f2d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613049005382269",
"url": "https://ci.chromium.org/b/8855596464990608944",
"utcnow_ts": "1613049005871762"
}
}
[13:10:06.005] Invocation finished in 1h54m50.218291103s with status FAILED