[10:24:19.020] New invocation is queued and will start shortly
[10:24:20.191] Starting the invocation (attempt 1)
[10:24:20.325] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:24:20.325] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:24:20.325] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028639877493045072",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6d9d6a35fb0fc20898460989a64a4d69864e0e52\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028639877493045072",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/6d9d6a35fb0fc20898460989a64a4d69864e0e52",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6d9d6a35fb0fc20898460989a64a4d69864e0e52",
"gitiles_ref:refs/heads/master"
]
}
[10:24:21.863] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605781460510483",
"id": "8863209815222791920",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6d9d6a35fb0fc20898460989a64a4d69864e0e52\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605781461393360",
"tags": [
"build_address:luci.chromium.ci/win-asan/15720",
"builder:win-asan",
"buildset:commit/git/6d9d6a35fb0fc20898460989a64a4d69864e0e52",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6d9d6a35fb0fc20898460989a64a4d69864e0e52",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028639877493045072",
"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/8863209815222791920/+/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": "1605781461394266",
"url": "https://ci.chromium.org/b/8863209815222791920",
"utcnow_ts": "1605781461843763"
}
}
[10:24:21.863] Task URL: https://ci.chromium.org/b/8863209815222791920
[10:24:21.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:2:0) after 1m0s
[10:25:21.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:2:0)
[10:25:21.992] Timer tick, asking Buildbucket for the build status
[10:25:22.115] Build 8863209815222791920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:22.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:3:0) after 1m0s
[10:26:22.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:3:0)
[10:26:22.170] Timer tick, asking Buildbucket for the build status
[10:26:22.320] Build 8863209815222791920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:26:22.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:4:0) after 1m0s
[10:27:22.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:4:0)
[10:27:22.372] Timer tick, asking Buildbucket for the build status
[10:27:22.449] Build 8863209815222791920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:27:22.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:5:0) after 1m0s
[10:28:22.472] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:5:0)
[10:28:22.472] Timer tick, asking Buildbucket for the build status
[10:28:22.567] Build 8863209815222791920: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:28:22.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:6:0) after 1m0s
[10:29:16.181] Received PubSub notification, asking Buildbucket for the build status
[10:29:16.290] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:22.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:6:0)
[10:29:22.599] Timer tick, asking Buildbucket for the build status
[10:29:22.687] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:22.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:8:0) after 1m0s
[10:30:22.662] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:8:0)
[10:30:22.662] Timer tick, asking Buildbucket for the build status
[10:30:22.808] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:22.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:9:0) after 1m0s
[10:31:22.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:9:0)
[10:31:22.846] Timer tick, asking Buildbucket for the build status
[10:31:23.297] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:23.297] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:10:0) after 1m0s
[10:32:23.349] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:10:0)
[10:32:23.349] Timer tick, asking Buildbucket for the build status
[10:32:23.406] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:23.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:11:0) after 1m0s
[10:33:23.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:11:0)
[10:33:23.436] Timer tick, asking Buildbucket for the build status
[10:33:23.624] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:23.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:12:0) after 1m0s
[10:34:23.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:12:0)
[10:34:23.668] Timer tick, asking Buildbucket for the build status
[10:34:23.729] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:23.729] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:13:0) after 1m0s
[10:35:23.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:13:0)
[10:35:23.756] Timer tick, asking Buildbucket for the build status
[10:35:23.859] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:23.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:14:0) after 1m0s
[10:36:23.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:14:0)
[10:36:23.855] Timer tick, asking Buildbucket for the build status
[10:36:23.925] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:23.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:15:0) after 1m0s
[10:37:23.973] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:15:0)
[10:37:23.973] Timer tick, asking Buildbucket for the build status
[10:37:24.208] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:24.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:16:0) after 1m0s
[10:38:24.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:16:0)
[10:38:24.309] Timer tick, asking Buildbucket for the build status
[10:38:24.382] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:24.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:17:0) after 1m0s
[10:39:24.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:17:0)
[10:39:24.523] Timer tick, asking Buildbucket for the build status
[10:39:24.589] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:24.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:18:0) after 1m0s
[10:40:24.766] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:18:0)
[10:40:24.766] Timer tick, asking Buildbucket for the build status
[10:40:25.162] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:25.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:19:0) after 1m0s
[10:41:25.340] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:19:0)
[10:41:25.340] Timer tick, asking Buildbucket for the build status
[10:41:25.427] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:25.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:20:0) after 1m0s
[10:42:25.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:20:0)
[10:42:25.612] Timer tick, asking Buildbucket for the build status
[10:42:25.679] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:25.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:21:0) after 1m0s
[10:43:25.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:21:0)
[10:43:25.731] Timer tick, asking Buildbucket for the build status
[10:43:25.808] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:25.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:22:0) after 1m0s
[10:44:25.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:22:0)
[10:44:25.825] Timer tick, asking Buildbucket for the build status
[10:44:25.908] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:25.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:23:0) after 1m0s
[10:45:25.976] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:23:0)
[10:45:25.976] Timer tick, asking Buildbucket for the build status
[10:45:26.102] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:26.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:24:0) after 1m0s
[10:46:27.369] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:24:0)
[10:46:27.369] Timer tick, asking Buildbucket for the build status
[10:46:27.446] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:27.446] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:25:0) after 1m0s
[10:47:30.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:25:0)
[10:47:30.615] Timer tick, asking Buildbucket for the build status
[10:47:30.683] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:30.683] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:26:0) after 1m0s
[10:48:30.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:26:0)
[10:48:30.751] Timer tick, asking Buildbucket for the build status
[10:48:30.874] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:30.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:27:0) after 1m0s
[10:49:30.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:27:0)
[10:49:30.933] Timer tick, asking Buildbucket for the build status
[10:49:31.062] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:31.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:28:0) after 1m0s
[10:50:31.115] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:28:0)
[10:50:31.115] Timer tick, asking Buildbucket for the build status
[10:50:31.191] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:31.191] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:29:0) after 1m0s
[10:51:31.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:29:0)
[10:51:31.283] Timer tick, asking Buildbucket for the build status
[10:51:31.362] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:31.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:30:0) after 1m0s
[10:52:31.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:30:0)
[10:52:31.453] Timer tick, asking Buildbucket for the build status
[10:52:32.291] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:32.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:31:0) after 1m0s
[10:53:32.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:31:0)
[10:53:32.471] Timer tick, asking Buildbucket for the build status
[10:53:32.545] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:32.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:32:0) after 1m0s
[10:54:32.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:32:0)
[10:54:32.645] Timer tick, asking Buildbucket for the build status
[10:54:32.839] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:32.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:33:0) after 1m0s
[10:55:33.195] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:33:0)
[10:55:33.195] Timer tick, asking Buildbucket for the build status
[10:55:33.322] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:33.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:34:0) after 1m0s
[10:56:33.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:34:0)
[10:56:33.514] Timer tick, asking Buildbucket for the build status
[10:56:33.646] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:33.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:35:0) after 1m0s
[10:57:33.988] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:35:0)
[10:57:33.988] Timer tick, asking Buildbucket for the build status
[10:57:34.115] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:34.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:36:0) after 1m0s
[10:58:34.234] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:36:0)
[10:58:34.234] Timer tick, asking Buildbucket for the build status
[10:58:34.299] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:34.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:37:0) after 1m0s
[10:59:34.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:37:0)
[10:59:34.323] Timer tick, asking Buildbucket for the build status
[10:59:34.495] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:34.495] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:38:0) after 1m0s
[11:00:34.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:38:0)
[11:00:34.530] Timer tick, asking Buildbucket for the build status
[11:00:34.694] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:34.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:39:0) after 1m0s
[11:01:34.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:39:0)
[11:01:34.841] Timer tick, asking Buildbucket for the build status
[11:01:34.913] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:34.913] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:40:0) after 1m0s
[11:02:35.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:40:0)
[11:02:35.018] Timer tick, asking Buildbucket for the build status
[11:02:35.128] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:35.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:41:0) after 1m0s
[11:03:35.297] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:41:0)
[11:03:35.297] Timer tick, asking Buildbucket for the build status
[11:03:35.500] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:35.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:42:0) after 1m0s
[11:04:35.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:42:0)
[11:04:35.527] Timer tick, asking Buildbucket for the build status
[11:04:35.632] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:35.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:43:0) after 1m0s
[11:05:35.672] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:43:0)
[11:05:35.672] Timer tick, asking Buildbucket for the build status
[11:05:35.795] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:35.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:44:0) after 1m0s
[11:06:35.915] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:44:0)
[11:06:35.915] Timer tick, asking Buildbucket for the build status
[11:06:36.096] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:36.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:45:0) after 1m0s
[11:07:36.109] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:45:0)
[11:07:36.109] Timer tick, asking Buildbucket for the build status
[11:07:36.219] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:36.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:46:0) after 1m0s
[11:08:36.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:46:0)
[11:08:36.330] Timer tick, asking Buildbucket for the build status
[11:08:36.418] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:36.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:47:0) after 1m0s
[11:09:36.553] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:47:0)
[11:09:36.553] Timer tick, asking Buildbucket for the build status
[11:09:36.933] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:36.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:48:0) after 1m0s
[11:10:37.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:48:0)
[11:10:37.010] Timer tick, asking Buildbucket for the build status
[11:10:37.088] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:37.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:49:0) after 1m0s
[11:11:37.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:49:0)
[11:11:37.179] Timer tick, asking Buildbucket for the build status
[11:11:37.249] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:37.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:50:0) after 1m0s
[11:12:37.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:50:0)
[11:12:37.347] Timer tick, asking Buildbucket for the build status
[11:12:37.536] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:37.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:51:0) after 1m0s
[11:13:37.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:51:0)
[11:13:37.629] Timer tick, asking Buildbucket for the build status
[11:13:37.689] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:37.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:52:0) after 1m0s
[11:14:37.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:52:0)
[11:14:37.804] Timer tick, asking Buildbucket for the build status
[11:14:38.049] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:38.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:53:0) after 1m0s
[11:15:38.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:53:0)
[11:15:38.114] Timer tick, asking Buildbucket for the build status
[11:15:38.237] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:38.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:54:0) after 1m0s
[11:16:38.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:54:0)
[11:16:38.274] Timer tick, asking Buildbucket for the build status
[11:16:38.349] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:38.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:55:0) after 1m0s
[11:17:38.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:55:0)
[11:17:38.407] Timer tick, asking Buildbucket for the build status
[11:17:38.474] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:38.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:56:0) after 1m0s
[11:18:38.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:56:0)
[11:18:38.530] Timer tick, asking Buildbucket for the build status
[11:18:38.705] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:38.705] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:57:0) after 1m0s
[11:19:38.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:57:0)
[11:19:38.698] Timer tick, asking Buildbucket for the build status
[11:19:38.799] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:38.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:58:0) after 1m0s
[11:20:38.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:58:0)
[11:20:38.820] Timer tick, asking Buildbucket for the build status
[11:20:38.887] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:38.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:59:0) after 1m0s
[11:21:38.915] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:59:0)
[11:21:38.915] Timer tick, asking Buildbucket for the build status
[11:21:38.980] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:38.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:60:0) after 1m0s
[11:22:39.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:60:0)
[11:22:39.017] Timer tick, asking Buildbucket for the build status
[11:22:39.213] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:39.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:61:0) after 1m0s
[11:23:39.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:61:0)
[11:23:39.329] Timer tick, asking Buildbucket for the build status
[11:23:39.390] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:39.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:62:0) after 1m0s
[11:24:39.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:62:0)
[11:24:39.454] Timer tick, asking Buildbucket for the build status
[11:24:39.666] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:39.666] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:63:0) after 1m0s
[11:25:39.724] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:63:0)
[11:25:39.724] Timer tick, asking Buildbucket for the build status
[11:25:39.807] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:39.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:64:0) after 1m0s
[11:26:39.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:64:0)
[11:26:39.860] Timer tick, asking Buildbucket for the build status
[11:26:40.028] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:40.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:65:0) after 1m0s
[11:27:40.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:65:0)
[11:27:40.057] Timer tick, asking Buildbucket for the build status
[11:27:40.186] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:40.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:66:0) after 1m0s
[11:28:40.258] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:66:0)
[11:28:40.258] Timer tick, asking Buildbucket for the build status
[11:28:40.367] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:40.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:67:0) after 1m0s
[11:29:40.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:67:0)
[11:29:40.359] Timer tick, asking Buildbucket for the build status
[11:29:41.789] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:41.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:68:0) after 1m0s
[11:30:41.931] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:68:0)
[11:30:41.931] Timer tick, asking Buildbucket for the build status
[11:30:42.046] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:42.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:69:0) after 1m0s
[11:31:42.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:69:0)
[11:31:42.126] Timer tick, asking Buildbucket for the build status
[11:31:42.330] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:42.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:70:0) after 1m0s
[11:32:42.358] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:70:0)
[11:32:42.358] Timer tick, asking Buildbucket for the build status
[11:32:42.481] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:42.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:71:0) after 1m0s
[11:33:42.723] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:71:0)
[11:33:42.723] Timer tick, asking Buildbucket for the build status
[11:33:43.626] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:43.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:72:0) after 1m0s
[11:34:43.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:72:0)
[11:34:43.721] Timer tick, asking Buildbucket for the build status
[11:34:43.901] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:43.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:73:0) after 1m0s
[11:35:44.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:73:0)
[11:35:44.098] Timer tick, asking Buildbucket for the build status
[11:35:44.223] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:44.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:74:0) after 1m0s
[11:36:44.437] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:74:0)
[11:36:44.437] Timer tick, asking Buildbucket for the build status
[11:36:44.637] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:44.637] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:75:0) after 1m0s
[11:37:44.726] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:75:0)
[11:37:44.726] Timer tick, asking Buildbucket for the build status
[11:37:45.112] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:45.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:76:0) after 1m0s
[11:38:45.307] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:76:0)
[11:38:45.307] Timer tick, asking Buildbucket for the build status
[11:38:45.441] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:45.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:77:0) after 1m0s
[11:39:45.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:77:0)
[11:39:45.501] Timer tick, asking Buildbucket for the build status
[11:39:45.636] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:45.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:78:0) after 1m0s
[11:40:45.676] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:78:0)
[11:40:45.676] Timer tick, asking Buildbucket for the build status
[11:40:45.847] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:45.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:79:0) after 1m0s
[11:41:45.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:79:0)
[11:41:45.873] Timer tick, asking Buildbucket for the build status
[11:41:46.355] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:46.355] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:80:0) after 1m0s
[11:42:46.394] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:80:0)
[11:42:46.394] Timer tick, asking Buildbucket for the build status
[11:42:46.973] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:46.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:81:0) after 1m0s
[11:43:47.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:81:0)
[11:43:47.001] Timer tick, asking Buildbucket for the build status
[11:43:47.504] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:47.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:82:0) after 1m0s
[11:44:47.552] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:82:0)
[11:44:47.552] Timer tick, asking Buildbucket for the build status
[11:44:47.687] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:47.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:83:0) after 1m0s
[11:45:47.746] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:83:0)
[11:45:47.746] Timer tick, asking Buildbucket for the build status
[11:45:48.139] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:48.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:84:0) after 1m0s
[11:46:48.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:84:0)
[11:46:48.189] Timer tick, asking Buildbucket for the build status
[11:46:48.352] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:48.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:85:0) after 1m0s
[11:47:48.382] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:85:0)
[11:47:48.382] Timer tick, asking Buildbucket for the build status
[11:47:48.459] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:48.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:86:0) after 1m0s
[11:48:48.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:86:0)
[11:48:48.521] Timer tick, asking Buildbucket for the build status
[11:48:48.682] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:48.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:87:0) after 1m0s
[11:49:48.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:87:0)
[11:49:48.788] Timer tick, asking Buildbucket for the build status
[11:49:48.888] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:48.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:88:0) after 1m0s
[11:50:48.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:88:0)
[11:50:48.957] Timer tick, asking Buildbucket for the build status
[11:50:49.975] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:49.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:89:0) after 1m0s
[11:51:50.019] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:89:0)
[11:51:50.019] Timer tick, asking Buildbucket for the build status
[11:51:50.100] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:50.100] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:90:0) after 1m0s
[11:52:50.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:90:0)
[11:52:50.139] Timer tick, asking Buildbucket for the build status
[11:52:50.262] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:50.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:91:0) after 1m0s
[11:53:50.399] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:91:0)
[11:53:50.399] Timer tick, asking Buildbucket for the build status
[11:53:50.475] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:50.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:92:0) after 1m0s
[11:54:50.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:92:0)
[11:54:50.503] Timer tick, asking Buildbucket for the build status
[11:54:50.708] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:50.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:93:0) after 1m0s
[11:55:50.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:93:0)
[11:55:50.803] Timer tick, asking Buildbucket for the build status
[11:55:50.884] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:50.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:94:0) after 1m0s
[11:56:51.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:94:0)
[11:56:51.231] Timer tick, asking Buildbucket for the build status
[11:56:51.387] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:51.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:95:0) after 1m0s
[11:57:51.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:95:0)
[11:57:51.446] Timer tick, asking Buildbucket for the build status
[11:57:51.565] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:51.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:96:0) after 1m0s
[11:58:51.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:96:0)
[11:58:51.715] Timer tick, asking Buildbucket for the build status
[11:58:51.888] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:51.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:97:0) after 1m0s
[11:59:51.924] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:97:0)
[11:59:51.924] Timer tick, asking Buildbucket for the build status
[11:59:52.076] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:52.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:98:0) after 1m0s
[12:00:52.191] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:98:0)
[12:00:52.192] Timer tick, asking Buildbucket for the build status
[12:00:52.424] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:52.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:99:0) after 1m0s
[12:01:52.473] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:99:0)
[12:01:52.473] Timer tick, asking Buildbucket for the build status
[12:01:53.826] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:53.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:100:0) after 1m0s
[12:02:53.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:100:0)
[12:02:53.933] Timer tick, asking Buildbucket for the build status
[12:02:54.077] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:54.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:101:0) after 1m0s
[12:03:54.100] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:101:0)
[12:03:54.100] Timer tick, asking Buildbucket for the build status
[12:03:54.223] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:54.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:102:0) after 1m0s
[12:04:54.259] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:102:0)
[12:04:54.259] Timer tick, asking Buildbucket for the build status
[12:04:54.393] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:54.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:103:0) after 1m0s
[12:05:54.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:103:0)
[12:05:54.453] Timer tick, asking Buildbucket for the build status
[12:05:54.542] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:54.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:104:0) after 1m0s
[12:06:54.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:104:0)
[12:06:54.574] Timer tick, asking Buildbucket for the build status
[12:06:54.673] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:54.673] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:105:0) after 1m0s
[12:07:54.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:105:0)
[12:07:54.736] Timer tick, asking Buildbucket for the build status
[12:07:55.002] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:55.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:106:0) after 1m0s
[12:08:55.158] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:106:0)
[12:08:55.158] Timer tick, asking Buildbucket for the build status
[12:08:55.265] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:55.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:107:0) after 1m0s
[12:09:55.447] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:107:0)
[12:09:55.448] Timer tick, asking Buildbucket for the build status
[12:09:56.050] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:56.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:108:0) after 1m0s
[12:10:56.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:108:0)
[12:10:56.212] Timer tick, asking Buildbucket for the build status
[12:10:56.283] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:56.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:109:0) after 1m0s
[12:11:56.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:109:0)
[12:11:56.312] Timer tick, asking Buildbucket for the build status
[12:11:56.607] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:56.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:110:0) after 1m0s
[12:12:56.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:110:0)
[12:12:56.736] Timer tick, asking Buildbucket for the build status
[12:12:56.821] Build 8863209815222791920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:56.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028639877493045072:111:0) after 1m0s
[12:13:43.390] Received PubSub notification, asking Buildbucket for the build status
[12:13:43.730] Build 8863209815222791920: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[12:13:43.732] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605788022305311",
"created_by": "project:chromium",
"created_ts": "1605781460510483",
"failure_reason": "BUILD_FAILURE",
"id": "8863209815222791920",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6d9d6a35fb0fc20898460989a64a4d69864e0e52\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- All/DumpAccessibilityEventsTest.AccessibilityEventsAriaDropeffectChanged/uia\"}, \"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\": \"6d9d6a35fb0fc20898460989a64a4d69864e0e52\", \"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-us-central1-b-32-0-7rud\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15720, \"clang_revision\": \"llvmorg-12-init-11780-g6ef07111-1\", \"got_angle_revision\": \"8d63a7fc492471fd9bc4781e6fb9a5ce38dfdcd9\", \"got_dawn_revision\": \"ce207be41fd6d9f1334ca6f251812511dc63faca\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"6d9d6a35fb0fc20898460989a64a4d69864e0e52\", \"got_revision_cp\": \"refs/heads/master@{#829164}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"060020166679a265a2bc8250f4d78a7a8c29de89\", \"got_v8_revision\": \"47d4ef3f896251f8ea86f2f529d46e54a7262278\", \"got_v8_revision_cp\": \"refs/heads/8.9.13@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"6d9d6a35fb0fc20898460989a64a4d69864e0e52\", \"swarm_hashes_refs/heads/master(at){#829164}_without_patch\": {\"absl_hardening_tests\": \"029950a04f61759df69d8679ecbb3c32f9555a3e\", \"accessibility_unittests\": \"a791b9f298c4b2213ac3b55a481a8b1403f7908b\", \"angle_unittests\": \"63ef36ffb5807110ca767030ac4ffcfb379c0fd9\", \"app_shell_unittests\": \"a3f53ed3543ec026905e269b47f2c67274e2afe8\", \"aura_unittests\": \"28b6b4aa90b5e2de9616a55781f3ea46efcc9fe8\", \"base_unittests\": \"23dffa4040df97efc1a3bc30069be4e5162caebe\", \"base_util_unittests\": \"47f755139bee6b7f1d69f07da22d993e493f0d09\", \"blink_common_unittests\": \"7227f443a9aa831b6db7f16bb1616cf0b84ed777\", \"blink_fuzzer_unittests\": \"c99667dc4d867bbdaada01f747961343b1c60ec0\", \"blink_heap_unittests\": \"11de8946e2df59835065a79d160f7a3ad9bf5acc\", \"blink_platform_unittests\": \"e4ff275e9017a775d5f8d6a9705e3aabe33a44b5\", \"blink_unittests\": \"b7f2c111a29e4edd6bd3ded0c136cb81f2f39ae4\", \"boringssl_crypto_tests\": \"3956ed4c1fc512141853362a3f8244d41e094972\", \"boringssl_ssl_tests\": \"1c84d87ff02c84f1ef83bdfadf026e5cb405fcb8\", \"browser_switcher_bho_unittests\": \"4b8d14cd5bb601aacb76b94bd2d1bbc678efcb58\", \"browser_tests\": \"1235712bafd72a73a9f29ea165e0c9c5b0ea2152\", \"capture_unittests\": \"1289c3ddcd77eb46fc9931f7cd5d20995f45cec3\", \"cast_unittests\": \"cbc956e996c8614984507cfbe0f493cb6ed0d32a\", \"cc_unittests\": \"c78dade05cbc18df51cd2c7e56d2f9ad4d8cc8e4\", \"chrome_app_unittests\": \"6c79c05d778c2b97041b34bc9ecf89e935b60a7f\", \"chrome_cleaner_unittests\": \"2cca6b0f5f9c598bfd92a67ea0c8ed5a0968593c\", \"chrome_elf_unittests\": \"50b0aa3410579a6f23ddfc624f17e5547f660a88\", \"chromedriver_unittests\": \"8c7c5741059aa7a9c610611ca0c05f0673236bad\", \"components_browsertests\": \"5b299cbb0708d99d27e2131e1c4ff8fb83e0f8d6\", \"components_unittests\": \"5249a4cc2d9e7252eb658fd0bcdb61f3ef58f840\", \"compositor_unittests\": \"923c77b62701a11a602834c9b58d9e2d9ad16f83\", \"content_browsertests\": \"d1c297623808d5b25d2f90d7ee22aaa846f41107\", \"content_unittests\": \"258891bf71146d8a244a8059f4fbcd343db9f94b\", \"courgette_unittests\": \"ad9795468f6fe738456f407fc8bc7e594245ebfa\", \"crashpad_tests\": \"38b6a09384c0f11e6ac3869537572fed7c82e076\", \"cronet_tests\": \"ffdc573ba600023514fee51b5b8a454f3ad7b2cc\", \"cronet_unittests\": \"604d7bab75f8e690487c454e27ff15f0d0c1e0bd\", \"crypto_unittests\": \"f8747abd4c32e334a4837782753fbbd9006a887c\", \"delayloads_unittests\": \"dda9c645552880bf0927012a641ffa8b9cb4637d\", \"device_unittests\": \"e6651cf362e3d04b8a4600e034d3202477456b8b\", \"display_unittests\": \"4d6647836196580b90c478bee7218222564e3223\", \"elevation_service_unittests\": \"e0052788290598a58f5a90a4783a6d5116dbe27c\", \"events_unittests\": \"53aca7469abeebc645f3cd38e0e1d5b968908ff4\", \"extensions_browsertests\": \"638b88e97c195264df674986fd278aef435a4063\", \"extensions_unittests\": \"dfc50042fd51ba431541cb3f96e8b39e9c95e11b\", \"filesystem_service_unittests\": \"546a097fa5c7096c55339b8de0cb22f289f9183a\", \"gcm_unit_tests\": \"1d869acfa9ed7784998d37e5ba8e7fb94f29b94f\", \"gcp_unittests\": \"10157810d940d4d22ca3e8f43ac92c8a33e0530c\", \"gfx_unittests\": \"24651bff572cf752e707ae3da13cd141e7b361f2\", \"gin_unittests\": \"dc6459ab0ee096db15e98c4d70a59981e53969d7\", \"google_apis_unittests\": \"3e9d9191fec5a180441ef05eedb825a13e7a36af\", \"gpu_unittests\": \"d0575b8292746bd353c955266a4121ff32b9a7f6\", \"gwp_asan_unittests\": \"0219254c8c1ea3ce1c1e9d991a3a545ca230cd8d\", \"headless_browsertests\": \"73387a1035ccfa9587b8be13cf4e5d5583c77498\", \"headless_unittests\": \"dee7859e2ef4fc5039b27516848d89d8828cdef6\", \"install_static_unittests\": \"ac12912d5ccf4c9e2d99565a241b46fd43e99a2c\", \"installer_util_unittests\": \"ba548f82f26cbba21031387c63cb6da11ac94a7d\", \"interactive_ui_tests\": \"88ad97f4ccb7434bcf05b23405d979db26150fde\", \"ipc_tests\": \"cd32d55a1a7607f838d2abb58e4932776837ea7f\", \"jingle_unittests\": \"45340f49940249ad2bb3f6c7e7bb7ec67a45451a\", \"latency_unittests\": \"bf9709a09a54b34ec51ff8c90e75ec77cdadcb73\", \"libjingle_xmpp_unittests\": \"f3d9bcde3f66a819d0523fd3ce11ee3408749f5a\", \"liburlpattern_unittests\": \"923045ebfc815b975ce6fc3d861d087668bb8a7e\", \"media_blink_unittests\": \"7e70d529ee48ab8f100b840ffbe6684f50220ba8\", \"media_unittests\": \"cbb4e513f2154cfb9c9b0ca9fec08e10d875d676\", \"message_center_unittests\": \"6e91b0f8f56cde6d13db8d9b9bbbf9eeed911105\", \"midi_unittests\": \"89f44f3172a1fbd4398c7e9922009602d602b567\", \"mojo_core_unittests\": \"de9597beae290650cf4596cf57c76f5b584942de\", \"mojo_unittests\": \"b14afc408b99b2773bae453899114b40f0cb289d\", \"nacl_loader_unittests\": \"7c7e7467cfc279e49ef2f018a8e6a7817e5cd04c\", \"native_theme_unittests\": \"dad71925cc929d3e2dc6c26a91b8aed5b1722091\", \"net_unittests\": \"6ef8c7005b681bd206ff112b652f0c10f32055fe\", \"notification_helper_unittests\": \"d79d6faa2f53266d54e57b7bb049a26307d59702\", \"pdf_unittests\": \"f81e0feef56a375352b9c941d1d7dde941f3c911\", \"perfetto_unittests\": \"61680b7c42c34ac88115ec4a71c5e12e05ed267a\", \"ppapi_unittests\": \"83d20a410ffd8e567591062dc12734425df74e0b\", \"printing_unittests\": \"819239cc19c670d03f70e94fc4ce1a3db5b2a32f\", \"remoting_unittests\": \"380f0cad4028b328917ef84b3f332548cdaf7bfb\", \"sbox_integration_tests\": \"d2428f0b8ce192f769b8fab3f351073a7416128e\", \"sbox_unittests\": \"bca100f0c32e5d9a15b7528bd2d2734b7c06d4a6\", \"sbox_validation_tests\": \"d82ed8967aa78baf91d3098abc0538ac0efb0941\", \"service_manager_unittests\": \"7d957b3044b9619adcf4b56bd1b58a4df4d42640\", \"services_unittests\": \"9001ddd60d641b614fa4b9fe00deaecc3c421cb1\", \"setup_unittests\": \"6601a9e3ea5a78917ce2b11ee3963a04681bbbfa\", \"shell_dialogs_unittests\": \"4cae478de02d6632cd1700288017d8ff15cf0de0\", \"skia_unittests\": \"8445f6ce6c1a0de9dd7bae84f6a34660ee91cdc9\", \"snapshot_unittests\": \"850915875848e116d0c2d41258e5c915be7f9344\", \"sql_unittests\": \"0106d410be96dcd28fe77915dbfb8a2d96b26e21\", \"storage_unittests\": \"80ff2b7ea81fd28a0f8c438d29f1a493d53abe25\", \"sync_integration_tests\": \"da5d16b1cc138dd5e00b692130f747c8eedb0bb1\", \"traffic_annotation_auditor_unittests\": \"763beddc4ac7b556450cf6eb461d917f0f0e6b78\", \"ui_base_unittests\": \"82ef4b4ba8892f0ee80e70f356d30c1d45aed762\", \"ui_touch_selection_unittests\": \"ab649b82b98d164148cf33eb36ca88dd1f12494e\", \"unit_tests\": \"b86687f5c826a99dbe2afbd7881aae7afdca6067\", \"updater_tests\": \"1d6411b9707d5120b53b10b90522e48b853fe1b0\", \"url_unittests\": \"0d6fa46ceb1d10cfb0bb144de7af71fca0e13344\", \"views_unittests\": \"ae3412d26658d360209cf1548b974f814a3e0ebf\", \"viz_unittests\": \"84c32caf61a79f64b132ecbce439f58b13dd6dac\", \"vr_common_unittests\": \"f226c2af4dd1a7cfc1bd759ddb78c336d2c49326\", \"vr_pixeltests\": \"019ed9f502365143e44d290991b45638aed5fe1e\", \"weblayer_browsertests\": \"88d203795a9110ed4e8c013da3a05fabea6a84a5\", \"weblayer_unittests\": \"a4a398fcea5ca2ef849c8f4ae222d30c403c766a\", \"wm_unittests\": \"9880133a4e9e73932da1f36249a94132d4e99caf\", \"wtf_unittests\": \"50e771aaea1b2d2a3180bce5a71b821c4ac0724a\", \"zlib_unittests\": \"2a40ae0d3088644cb4ae6ad6b9d5d07e50d0129e\", \"zucchini_unittests\": \"dd72cc455495eb7a7780147349b758810e65792c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-0-7rud\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**content_browsertests** failed because of:\\n\\n- All/DumpAccessibilityEventsTest.AccessibilityEventsAriaDropeffectChanged/uia\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605781754020879",
"status": "COMPLETED",
"status_changed_ts": "1605781755535399",
"tags": [
"build_address:luci.chromium.ci/win-asan/15720",
"builder:win-asan",
"buildset:commit/git/6d9d6a35fb0fc20898460989a64a4d69864e0e52",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6d9d6a35fb0fc20898460989a64a4d69864e0e52",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028639877493045072",
"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/8863209815222791920/+/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:4ff8da2d75361c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605788023015442",
"url": "https://ci.chromium.org/b/8863209815222791920",
"utcnow_ts": "1605788023704113"
}
}
[12:13:43.732] Invocation finished in 1h49m24.771373085s with status FAILED