[05:51:12.513] New invocation is queued and will start shortly
[05:51:13.653] Starting the invocation (attempt 1)
[05:51:13.704] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:51:13.704] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:51:13.704] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029200641746435280",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ba706a33d708bbcf13a6150a0748ce347b488279\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029200641746435280",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/ba706a33d708bbcf13a6150a0748ce347b488279",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ba706a33d708bbcf13a6150a0748ce347b488279",
"gitiles_ref:refs/heads/master"
]
}
[05:51:14.517] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1605246673803617",
"id": "8863770579728394544",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ba706a33d708bbcf13a6150a0748ce347b488279\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605246674367049",
"tags": [
"build_address:luci.chromium.ci/win-asan/15615",
"builder:win-asan",
"buildset:commit/git/ba706a33d708bbcf13a6150a0748ce347b488279",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ba706a33d708bbcf13a6150a0748ce347b488279",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029200641746435280",
"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/8863770579728394544/+/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": "1605246674367183",
"url": "https://ci.chromium.org/b/8863770579728394544",
"utcnow_ts": "1605246674509487"
}
}
[05:51:14.517] Task URL: https://ci.chromium.org/b/8863770579728394544
[05:51:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:2:0) after 1m0s
[05:52:14.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:2:0)
[05:52:14.633] Timer tick, asking Buildbucket for the build status
[05:52:14.732] Build 8863770579728394544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:14.732] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:3:0) after 1m0s
[05:53:14.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:3:0)
[05:53:14.802] Timer tick, asking Buildbucket for the build status
[05:53:14.864] Build 8863770579728394544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:14.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:4:0) after 1m0s
[05:54:14.952] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:4:0)
[05:54:14.952] Timer tick, asking Buildbucket for the build status
[05:54:15.195] Build 8863770579728394544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:15.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:5:0) after 1m0s
[05:55:15.199] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:5:0)
[05:55:15.199] Timer tick, asking Buildbucket for the build status
[05:55:15.303] Build 8863770579728394544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:15.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:6:0) after 1m0s
[05:55:44.358] Received PubSub notification, asking Buildbucket for the build status
[05:55:44.446] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:15.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:6:0)
[05:56:15.352] Timer tick, asking Buildbucket for the build status
[05:56:15.456] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:15.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:8:0) after 1m0s
[05:57:15.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:8:0)
[05:57:15.532] Timer tick, asking Buildbucket for the build status
[05:57:15.639] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:15.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:9:0) after 1m0s
[05:58:15.721] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:9:0)
[05:58:15.721] Timer tick, asking Buildbucket for the build status
[05:58:15.806] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:15.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:10:0) after 1m0s
[05:59:15.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:10:0)
[05:59:15.846] Timer tick, asking Buildbucket for the build status
[05:59:15.906] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:15.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:11:0) after 1m0s
[06:00:15.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:11:0)
[06:00:15.930] Timer tick, asking Buildbucket for the build status
[06:00:16.006] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:16.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:12:0) after 1m0s
[06:01:20.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:12:0)
[06:01:20.751] Timer tick, asking Buildbucket for the build status
[06:01:20.874] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:20.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:13:0) after 1m0s
[06:02:20.904] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:13:0)
[06:02:20.904] Timer tick, asking Buildbucket for the build status
[06:02:21.003] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:21.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:14:0) after 1m0s
[06:03:21.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:14:0)
[06:03:21.053] Timer tick, asking Buildbucket for the build status
[06:03:21.145] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:21.145] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:15:0) after 1m0s
[06:04:21.219] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:15:0)
[06:04:21.219] Timer tick, asking Buildbucket for the build status
[06:04:22.771] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:22.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:16:0) after 1m0s
[06:05:22.860] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:16:0)
[06:05:22.860] Timer tick, asking Buildbucket for the build status
[06:05:23.083] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:23.083] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:17:0) after 1m0s
[06:06:23.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:17:0)
[06:06:23.168] Timer tick, asking Buildbucket for the build status
[06:06:23.632] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:23.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:18:0) after 1m0s
[06:07:23.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:18:0)
[06:07:23.625] Timer tick, asking Buildbucket for the build status
[06:07:23.765] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:23.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:19:0) after 1m0s
[06:08:23.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:19:0)
[06:08:23.846] Timer tick, asking Buildbucket for the build status
[06:08:23.963] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:23.963] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:20:0) after 1m0s
[06:09:24.085] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:20:0)
[06:09:24.085] Timer tick, asking Buildbucket for the build status
[06:09:24.153] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:24.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:21:0) after 1m0s
[06:10:24.390] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:21:0)
[06:10:24.390] Timer tick, asking Buildbucket for the build status
[06:10:24.515] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:24.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:22:0) after 1m0s
[06:11:24.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:22:0)
[06:11:24.670] Timer tick, asking Buildbucket for the build status
[06:11:25.561] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:25.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:23:0) after 1m0s
[06:12:25.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:23:0)
[06:12:25.725] Timer tick, asking Buildbucket for the build status
[06:12:25.811] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:25.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:24:0) after 1m0s
[06:13:25.953] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:24:0)
[06:13:25.953] Timer tick, asking Buildbucket for the build status
[06:13:26.018] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:26.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:25:0) after 1m0s
[06:14:26.197] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:25:0)
[06:14:26.197] Timer tick, asking Buildbucket for the build status
[06:14:26.448] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:26.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:26:0) after 1m0s
[06:15:26.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:26:0)
[06:15:26.531] Timer tick, asking Buildbucket for the build status
[06:15:26.681] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:26.681] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:27:0) after 1m0s
[06:16:26.712] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:27:0)
[06:16:26.712] Timer tick, asking Buildbucket for the build status
[06:16:27.918] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:27.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:28:0) after 1m0s
[06:17:27.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:28:0)
[06:17:27.979] Timer tick, asking Buildbucket for the build status
[06:17:28.151] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:28.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:29:0) after 1m0s
[06:18:28.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:29:0)
[06:18:28.214] Timer tick, asking Buildbucket for the build status
[06:18:28.481] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:28.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:30:0) after 1m0s
[06:19:28.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:30:0)
[06:19:28.502] Timer tick, asking Buildbucket for the build status
[06:19:28.569] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:28.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:31:0) after 1m0s
[06:20:28.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:31:0)
[06:20:28.677] Timer tick, asking Buildbucket for the build status
[06:20:28.739] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:28.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:32:0) after 1m0s
[06:21:28.789] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:32:0)
[06:21:28.789] Timer tick, asking Buildbucket for the build status
[06:21:29.182] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:29.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:33:0) after 1m0s
[06:22:29.205] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:33:0)
[06:22:29.205] Timer tick, asking Buildbucket for the build status
[06:22:29.287] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:29.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:34:0) after 1m0s
[06:23:29.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:34:0)
[06:23:29.355] Timer tick, asking Buildbucket for the build status
[06:23:29.432] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:29.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:35:0) after 1m0s
[06:24:29.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:35:0)
[06:24:29.484] Timer tick, asking Buildbucket for the build status
[06:24:29.841] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:29.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:36:0) after 1m0s
[06:25:29.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:36:0)
[06:25:29.847] Timer tick, asking Buildbucket for the build status
[06:25:30.017] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:30.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:37:0) after 1m0s
[06:26:30.031] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:37:0)
[06:26:30.031] Timer tick, asking Buildbucket for the build status
[06:26:30.137] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:30.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:38:0) after 1m0s
[06:27:30.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:38:0)
[06:27:30.159] Timer tick, asking Buildbucket for the build status
[06:27:30.378] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:30.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:39:0) after 1m0s
[06:28:30.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:39:0)
[06:28:30.444] Timer tick, asking Buildbucket for the build status
[06:28:30.517] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:30.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:40:0) after 1m0s
[06:29:30.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:40:0)
[06:29:30.523] Timer tick, asking Buildbucket for the build status
[06:29:30.614] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:30.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:41:0) after 1m0s
[06:30:30.648] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:41:0)
[06:30:30.648] Timer tick, asking Buildbucket for the build status
[06:30:30.735] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:30.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:42:0) after 1m0s
[06:31:30.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:42:0)
[06:31:30.759] Timer tick, asking Buildbucket for the build status
[06:31:30.870] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:30.870] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:43:0) after 1m0s
[06:32:30.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:43:0)
[06:32:30.895] Timer tick, asking Buildbucket for the build status
[06:32:31.051] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:31.051] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:44:0) after 1m0s
[06:33:31.093] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:44:0)
[06:33:31.093] Timer tick, asking Buildbucket for the build status
[06:33:31.289] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:31.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:45:0) after 1m0s
[06:34:31.351] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:45:0)
[06:34:31.351] Timer tick, asking Buildbucket for the build status
[06:34:31.434] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:31.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:46:0) after 1m0s
[06:35:31.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:46:0)
[06:35:31.455] Timer tick, asking Buildbucket for the build status
[06:35:31.593] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:31.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:47:0) after 1m0s
[06:36:31.607] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:47:0)
[06:36:31.607] Timer tick, asking Buildbucket for the build status
[06:36:31.706] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:31.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:48:0) after 1m0s
[06:37:31.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:48:0)
[06:37:31.762] Timer tick, asking Buildbucket for the build status
[06:37:31.821] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:31.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:49:0) after 1m0s
[06:38:31.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:49:0)
[06:38:31.840] Timer tick, asking Buildbucket for the build status
[06:38:32.200] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:32.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:50:0) after 1m0s
[06:39:32.276] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:50:0)
[06:39:32.276] Timer tick, asking Buildbucket for the build status
[06:39:32.427] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:32.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:51:0) after 1m0s
[06:40:32.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:51:0)
[06:40:32.484] Timer tick, asking Buildbucket for the build status
[06:40:32.611] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:32.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:52:0) after 1m0s
[06:41:32.681] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:52:0)
[06:41:32.681] Timer tick, asking Buildbucket for the build status
[06:41:32.932] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:32.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:53:0) after 1m0s
[06:42:32.973] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:53:0)
[06:42:32.973] Timer tick, asking Buildbucket for the build status
[06:42:33.052] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:33.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:54:0) after 1m0s
[06:43:33.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:54:0)
[06:43:33.066] Timer tick, asking Buildbucket for the build status
[06:43:33.884] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:33.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:55:0) after 1m0s
[06:44:33.931] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:55:0)
[06:44:33.931] Timer tick, asking Buildbucket for the build status
[06:44:34.040] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:34.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:56:0) after 1m0s
[06:45:34.074] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:56:0)
[06:45:34.074] Timer tick, asking Buildbucket for the build status
[06:45:34.195] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:34.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:57:0) after 1m0s
[06:46:34.219] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:57:0)
[06:46:34.219] Timer tick, asking Buildbucket for the build status
[06:46:34.393] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:34.393] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:58:0) after 1m0s
[06:47:34.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:58:0)
[06:47:34.409] Timer tick, asking Buildbucket for the build status
[06:47:34.628] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:34.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:59:0) after 1m0s
[06:48:34.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:59:0)
[06:48:34.674] Timer tick, asking Buildbucket for the build status
[06:48:34.811] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:34.811] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:60:0) after 1m0s
[06:49:34.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:60:0)
[06:49:34.972] Timer tick, asking Buildbucket for the build status
[06:49:35.101] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:35.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:61:0) after 1m0s
[06:50:35.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:61:0)
[06:50:35.151] Timer tick, asking Buildbucket for the build status
[06:50:36.014] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:36.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:62:0) after 1m0s
[06:51:36.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:62:0)
[06:51:36.073] Timer tick, asking Buildbucket for the build status
[06:51:36.181] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:36.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:63:0) after 1m0s
[06:52:36.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:63:0)
[06:52:36.288] Timer tick, asking Buildbucket for the build status
[06:52:37.270] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:37.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:64:0) after 1m0s
[06:53:37.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:64:0)
[06:53:37.311] Timer tick, asking Buildbucket for the build status
[06:53:37.473] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:37.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:65:0) after 1m0s
[06:54:37.548] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:65:0)
[06:54:37.548] Timer tick, asking Buildbucket for the build status
[06:54:37.674] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:37.674] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:66:0) after 1m0s
[06:55:37.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:66:0)
[06:55:37.694] Timer tick, asking Buildbucket for the build status
[06:55:38.001] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:38.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:67:0) after 1m0s
[06:56:38.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:67:0)
[06:56:38.047] Timer tick, asking Buildbucket for the build status
[06:56:38.198] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:38.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:68:0) after 1m0s
[06:57:38.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:68:0)
[06:57:38.223] Timer tick, asking Buildbucket for the build status
[06:57:38.342] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:38.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:69:0) after 1m0s
[06:58:38.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:69:0)
[06:58:38.505] Timer tick, asking Buildbucket for the build status
[06:58:38.688] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:38.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:70:0) after 1m0s
[06:59:38.821] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:70:0)
[06:59:38.821] Timer tick, asking Buildbucket for the build status
[06:59:38.985] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:38.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:71:0) after 1m0s
[07:00:39.100] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:71:0)
[07:00:39.100] Timer tick, asking Buildbucket for the build status
[07:00:39.249] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:39.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:72:0) after 1m0s
[07:01:39.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:72:0)
[07:01:39.326] Timer tick, asking Buildbucket for the build status
[07:01:39.467] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:39.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:73:0) after 1m0s
[07:02:39.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:73:0)
[07:02:39.520] Timer tick, asking Buildbucket for the build status
[07:02:39.616] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:39.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:74:0) after 1m0s
[07:03:39.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:74:0)
[07:03:39.619] Timer tick, asking Buildbucket for the build status
[07:03:39.749] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:39.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:75:0) after 1m0s
[07:04:39.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:75:0)
[07:04:39.782] Timer tick, asking Buildbucket for the build status
[07:04:39.902] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:39.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:76:0) after 1m0s
[07:05:39.948] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:76:0)
[07:05:39.948] Timer tick, asking Buildbucket for the build status
[07:05:40.429] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:40.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:77:0) after 1m0s
[07:06:40.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:77:0)
[07:06:40.432] Timer tick, asking Buildbucket for the build status
[07:06:40.561] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:40.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:78:0) after 1m0s
[07:07:40.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:78:0)
[07:07:40.584] Timer tick, asking Buildbucket for the build status
[07:07:40.931] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:40.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:79:0) after 1m0s
[07:08:41.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:79:0)
[07:08:41.001] Timer tick, asking Buildbucket for the build status
[07:08:41.352] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:41.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:80:0) after 1m0s
[07:09:41.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:80:0)
[07:09:41.361] Timer tick, asking Buildbucket for the build status
[07:09:41.518] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:41.518] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:81:0) after 1m0s
[07:10:41.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:81:0)
[07:10:41.569] Timer tick, asking Buildbucket for the build status
[07:10:41.654] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:41.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:82:0) after 1m0s
[07:11:41.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:82:0)
[07:11:41.989] Timer tick, asking Buildbucket for the build status
[07:11:42.398] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:42.398] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:83:0) after 1m0s
[07:12:42.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:83:0)
[07:12:42.516] Timer tick, asking Buildbucket for the build status
[07:12:44.170] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:44.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:84:0) after 1m0s
[07:13:44.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:84:0)
[07:13:44.194] Timer tick, asking Buildbucket for the build status
[07:13:44.590] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:44.590] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:85:0) after 1m0s
[07:14:44.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:85:0)
[07:14:44.601] Timer tick, asking Buildbucket for the build status
[07:14:44.906] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:44.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:86:0) after 1m0s
[07:15:44.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:86:0)
[07:15:44.929] Timer tick, asking Buildbucket for the build status
[07:15:45.216] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:45.216] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:87:0) after 1m0s
[07:16:45.253] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:87:0)
[07:16:45.253] Timer tick, asking Buildbucket for the build status
[07:16:45.887] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:45.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:88:0) after 1m0s
[07:17:45.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:88:0)
[07:17:45.975] Timer tick, asking Buildbucket for the build status
[07:17:46.137] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:46.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:89:0) after 1m0s
[07:18:46.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:89:0)
[07:18:46.212] Timer tick, asking Buildbucket for the build status
[07:18:46.339] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:46.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:90:0) after 1m0s
[07:19:46.397] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:90:0)
[07:19:46.397] Timer tick, asking Buildbucket for the build status
[07:19:46.487] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:46.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:91:0) after 1m0s
[07:20:46.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:91:0)
[07:20:46.493] Timer tick, asking Buildbucket for the build status
[07:20:46.581] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:46.581] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:92:0) after 1m0s
[07:21:46.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:92:0)
[07:21:46.616] Timer tick, asking Buildbucket for the build status
[07:21:46.737] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:46.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:93:0) after 1m0s
[07:22:46.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:93:0)
[07:22:46.774] Timer tick, asking Buildbucket for the build status
[07:22:47.212] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:47.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:94:0) after 1m0s
[07:23:47.207] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:94:0)
[07:23:47.207] Timer tick, asking Buildbucket for the build status
[07:23:47.318] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:47.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:95:0) after 1m0s
[07:24:47.348] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:95:0)
[07:24:47.348] Timer tick, asking Buildbucket for the build status
[07:24:47.429] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:47.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:96:0) after 1m0s
[07:25:47.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:96:0)
[07:25:47.503] Timer tick, asking Buildbucket for the build status
[07:25:47.583] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:47.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:97:0) after 1m0s
[07:26:47.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:97:0)
[07:26:47.884] Timer tick, asking Buildbucket for the build status
[07:26:48.001] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:48.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:98:0) after 1m0s
[07:27:48.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:98:0)
[07:27:48.196] Timer tick, asking Buildbucket for the build status
[07:27:48.284] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:48.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:99:0) after 1m0s
[07:28:48.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:99:0)
[07:28:48.360] Timer tick, asking Buildbucket for the build status
[07:28:48.555] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:48.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:100:0) after 1m0s
[07:29:48.635] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:100:0)
[07:29:48.635] Timer tick, asking Buildbucket for the build status
[07:29:48.844] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:48.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:101:0) after 1m0s
[07:30:48.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:101:0)
[07:30:48.853] Timer tick, asking Buildbucket for the build status
[07:30:48.981] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:48.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:102:0) after 1m0s
[07:31:49.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:102:0)
[07:31:49.017] Timer tick, asking Buildbucket for the build status
[07:31:49.165] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:49.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:103:0) after 1m0s
[07:32:49.275] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:103:0)
[07:32:49.275] Timer tick, asking Buildbucket for the build status
[07:32:49.429] Build 8863770579728394544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:49.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029200641746435280:104:0) after 1m0s
[07:33:03.935] Received PubSub notification, asking Buildbucket for the build status
[07:33:04.042] Build 8863770579728394544: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[07:33:04.042] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1605252782588958",
"created_by": "project:chromium",
"created_ts": "1605246673803617",
"failure_reason": "BUILD_FAILURE",
"id": "8863770579728394544",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ba706a33d708bbcf13a6150a0748ce347b488279\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- PDFExtensionTestWithParam.ExtensionlessPDFLocalFileLoads/1\\n\\n- PDFExtensionTestWithParam.ExtensionlessPDFLocalFileLoads/0\\n\\n- All/PDFExtensionAccessibilityTreeDumpTest.TextFields/win_updateEnabled\\n\\n- All/PDFExtensionAccessibilityTreeDumpTest.DirectionalTextRuns/win_updateDisabled\\n\\n- ...242 more failure(s) (246 total)...\"}, \"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\": \"ba706a33d708bbcf13a6150a0748ce347b488279\", \"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-0-4yp8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15615, \"clang_revision\": \"llvmorg-12-init-11462-g418f18c6-1\", \"got_angle_revision\": \"f9e59ad078552424ca165644f4da3b4e2687c3dc\", \"got_dawn_revision\": \"8d69298d9b2938dcac52a08451b4f63fb61c31cb\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"ba706a33d708bbcf13a6150a0748ce347b488279\", \"got_revision_cp\": \"refs/heads/master@{#827167}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e4c1a25cc6797a47043fc415c53b8edcd7b3e37e\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"daab6896e2938e28f01e305ce2fff038f47554c4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32599}\", \"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\": \"ba706a33d708bbcf13a6150a0748ce347b488279\", \"swarm_hashes_refs/heads/master(at){#827167}_without_patch\": {\"absl_hardening_tests\": \"f06e6a5cf511522351ba8523d71e5cae684cdd8f\", \"accessibility_unittests\": \"32457e4c4402e5412176d6d0e3537a17c22c19bc\", \"angle_unittests\": \"ea027ee8eb7dfb9721a2cdac3e0079676ae5d30e\", \"app_shell_unittests\": \"8a62db14fdfc2a8b9506ab70808d142a6c0e7859\", \"aura_unittests\": \"2428c6204059f7e38c78fd032c7535993a780c78\", \"base_unittests\": \"2d87c8a49b3531656a3f2da8668398d10d60593b\", \"base_util_unittests\": \"904636f08b9dd9276bb58c01e9ba27358cf35bbc\", \"blink_common_unittests\": \"35f534fdad01d7d463dc64bb0f1b7f69ad2b400e\", \"blink_fuzzer_unittests\": \"b7aa2fada7a044d463cc5702b23d32790e38fab6\", \"blink_heap_unittests\": \"8ec6a990a5a7115c45e490a451d44f55b9642f21\", \"blink_platform_unittests\": \"0bc90672688e49b184b354fd0d987e3243069363\", \"blink_unittests\": \"d0b2fa2975cc17312a4c5b5c183a0fb56227d096\", \"boringssl_crypto_tests\": \"2d9e59d8cf7e8fb0e4e41cb01287c4a338245c3f\", \"boringssl_ssl_tests\": \"9f9e7144497e466b4c9655a3d95b688302937ccc\", \"browser_switcher_bho_unittests\": \"a93090d86ab003615f9f0fb62ca21c45102e6d48\", \"browser_tests\": \"bab121a75bd34302e48819c58aefa9baf23df87f\", \"capture_unittests\": \"65e3f0620b5e36e9aa694743c61318ba456d101f\", \"cast_unittests\": \"ceb94757a4633b383975af8095e6bb7d3d48aa1a\", \"cc_unittests\": \"58c533d66e3ca9ec2926251ee753f460c502ad25\", \"chrome_app_unittests\": \"b05169bf3c932c784463b801f292370474162677\", \"chrome_cleaner_unittests\": \"6c72f7037493578413c9b9adc87785fa1d1a9e4f\", \"chrome_elf_unittests\": \"02c060dd11bbe27d30fc87287a8ee498096680e6\", \"chromedriver_unittests\": \"88c42e0d702b1c1a5959a175fd1ae8383fdf1432\", \"components_browsertests\": \"dcbf5269725e34d52bf191cc81c8b7774780e2ac\", \"components_unittests\": \"0636b0890eed03b03e7f58feece04619c5f29dd0\", \"compositor_unittests\": \"b7e7f44ddddb0e248ad6a21ae29a8ecad0eb06a7\", \"content_browsertests\": \"a508e98fc0d336c9bd0d61ee1bdbc486d0781864\", \"content_unittests\": \"eb3b2c21af7daf1c79fb7fa205b3aad3125febcd\", \"courgette_unittests\": \"1472a494db543eaaa987bef2e47e4d58018162d7\", \"crashpad_tests\": \"b102cf9ded7136c9bb954323e1d2545eb3ad8f37\", \"cronet_tests\": \"00820500b630ec11d3150134f32221b35945cd68\", \"cronet_unittests\": \"a770d962178f3ef29f020daed1b3ded7ce865e60\", \"crypto_unittests\": \"7995757b632eb576b18fbd78b8c8b88395703d94\", \"delayloads_unittests\": \"958f100672c6b4d81822ef44305c7b488ccbc575\", \"device_unittests\": \"e6e15d9a4139fc1e4fc93e124e30a86288fc8296\", \"display_unittests\": \"88e3911bfbad69c8ba816a3145cf4363bcf53251\", \"elevation_service_unittests\": \"4ae424852a950918f3dd1ef566c73f7123910e53\", \"events_unittests\": \"95a32a904ec92fecc2851aeb8a39fb6cb747cc0d\", \"extensions_browsertests\": \"55044bb023c90aeaf5600421f2a643fc28d34949\", \"extensions_unittests\": \"bee4c8883cbb5831d5debe78ece0d14066fb9541\", \"filesystem_service_unittests\": \"522f2f23b37a9aa0abb025f0670df49ae10dc6bc\", \"gcm_unit_tests\": \"f2c3df462cecb23948ec8e1ac226e7120fa70dbf\", \"gcp_unittests\": \"f2373695f6446abf487c5908358177deee74057e\", \"gfx_unittests\": \"a8ea9ed4d6c9a6f0bc228068676e5cbe98c55190\", \"gin_unittests\": \"719dcae801d3c26228b25edd43cd89fc630e1576\", \"google_apis_unittests\": \"191483c5b87e9c34eb07b11624832c1276fcd2a4\", \"gpu_unittests\": \"605b121dcbc83b8c03d0e54a2240fa75eb8a3740\", \"gwp_asan_unittests\": \"4bde365390f682dfee035a0a6b1591c02a6eaa69\", \"headless_browsertests\": \"ddcce2abae4633a5f509337cf3ea4f1228392657\", \"headless_unittests\": \"8db36e24c653961d85edae1df3d2d3a5042e4793\", \"install_static_unittests\": \"f700edaa415a389ada6237bee7d827480a62e997\", \"installer_util_unittests\": \"ad04b7248b1e158dd433520c174904b9b3dfb25b\", \"interactive_ui_tests\": \"77ba8af206946e94f94049161d02cdb4e4882532\", \"ipc_tests\": \"89571adbd1832b4a9e4f674c6887a117ac8e483d\", \"jingle_unittests\": \"196b96d6b5b71b5939ead98c3cb886f7b694cfe2\", \"latency_unittests\": \"fe629931a0ee5bbe89644d9967855010cda8cd83\", \"libjingle_xmpp_unittests\": \"9c0949d8141f9c67c096dd9f5966dc6a9885b1e0\", \"liburlpattern_unittests\": \"8749974861f155c45610fd011afc550816569804\", \"media_blink_unittests\": \"3c29d4f6c27fc9cf5efe901b5a6264c64208c513\", \"media_unittests\": \"92c31165acb813186e3ea4d8f4da88d875a4c51c\", \"message_center_unittests\": \"f630633a7288b064837b84e1fba2a8f091f9c84a\", \"midi_unittests\": \"c1fcdac19aec381a39fde7e9d16eb44133c3c37c\", \"mojo_core_unittests\": \"79907c7b0bedf2621b9c276b90d53c2c1151cdb4\", \"mojo_unittests\": \"ad7ba93a00ab49af2d2decd77c9bc3dd4fbf14d3\", \"nacl_loader_unittests\": \"ab37a63892da33e5b5dbee1e1768ad5fbc5f29c3\", \"native_theme_unittests\": \"d9486c04062ab965b8670422938456edb9126a3e\", \"net_unittests\": \"a03f024f87308ce01598a3a12ac92443bb1183be\", \"notification_helper_unittests\": \"9513391f65dcb7af139fc79c96671022db09b582\", \"pdf_unittests\": \"eaf1d5b766809aa74d97a11dbf5f64084d0365d3\", \"perfetto_unittests\": \"8f63a7ee5ab4ef847ffe6ab68d65ae852089588d\", \"ppapi_unittests\": \"237b80b03f12acb74ecb71b4370c1314f820b4b4\", \"printing_unittests\": \"733b552dd1e483e6630ac9817ffdf03f17fc82be\", \"remoting_unittests\": \"4c6b22c5b8c3435748249a3cd19828cff358817d\", \"sbox_integration_tests\": \"2beac925595d5c753a03bc29c9c5d0e17a851c03\", \"sbox_unittests\": \"23d79732eb4bfbd2333f2015670ed690fbf3a809\", \"sbox_validation_tests\": \"727691c5278d1d1235ef5667fc42c55e671ad5f4\", \"service_manager_unittests\": \"8fc26e91940c3f095e31ab9f65beb60b9a5b88cf\", \"services_unittests\": \"9c96594dd07eb107b75be5f7020985e80b5a72cb\", \"setup_unittests\": \"33d66683115d6d71d3dc9741be419b8fc3a2fe22\", \"shell_dialogs_unittests\": \"c940d4d3366b1d61a6c1094ccef06654f8bc2b60\", \"skia_unittests\": \"1a067a88a1a2bb219475e5ff73c53ca07c0a5999\", \"snapshot_unittests\": \"a9ec20859141de762210f3b3be6108c0ace1744e\", \"sql_unittests\": \"97715048525b06352319e7b6380e652cf7b31943\", \"storage_unittests\": \"035a206937c591939ad1df91674ec930e02c511e\", \"sync_integration_tests\": \"30b6ccc7995a4e09d206a8ecceceb9f78ae74597\", \"traffic_annotation_auditor_unittests\": \"ee0df36e4f61ea576714b4b3fcbb77635f7cd451\", \"ui_base_unittests\": \"715d3eb5d20505c09b4bcfe38d68537f697029e4\", \"ui_touch_selection_unittests\": \"231e509404043ff3c98a6f30521bc48bd587dbdc\", \"unit_tests\": \"5e2e3c9d150200491f477e261500c66ab7db3293\", \"updater_tests\": \"bf8a44f80f62d3c79ecc95a94b225f4f83e5c5ad\", \"url_unittests\": \"f0f1060b9a24030b0e96da58a2f164beef33fb94\", \"views_unittests\": \"7fdff1fd25836b99c0b6904873914159cbefd393\", \"viz_unittests\": \"ba27ab77553cef44007c44f2abeeb61e8bf9b43f\", \"vr_common_unittests\": \"c71e6855aa762a5c4d7ea1b77e29048dd31f6111\", \"vr_pixeltests\": \"1c45654f17cd961cc4183835c169ea98b7100502\", \"weblayer_browsertests\": \"59cb5422726cc4de213d91bb897642deba385c1f\", \"weblayer_unittests\": \"b0eccc3174a3cd6ca84b072b0369eac3215218e5\", \"wm_unittests\": \"8c609e4d5a8e2f81bc9abdce81381f8fc61a1f8d\", \"wtf_unittests\": \"8ec3ac2a048ebf09567858ed6e49937f7b66095f\", \"zlib_unittests\": \"250acf22eb47488fe8ae06fac3fd7c033f0eb9cf\", \"zucchini_unittests\": \"63cc33e934c76453b1076370374b2a4f39a0aef8\"}}, \"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-0-4yp8\"], \"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\": [\"5626-39642e9\"], \"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- PDFExtensionTestWithParam.ExtensionlessPDFLocalFileLoads/1\\n\\n- PDFExtensionTestWithParam.ExtensionlessPDFLocalFileLoads/0\\n\\n- All/PDFExtensionAccessibilityTreeDumpTest.TextFields/win_updateEnabled\\n\\n- All/PDFExtensionAccessibilityTreeDumpTest.DirectionalTextRuns/win_updateDisabled\\n\\n- ...242 more failure(s) (246 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605246942693545",
"status": "COMPLETED",
"status_changed_ts": "1605246943658427",
"tags": [
"build_address:luci.chromium.ci/win-asan/15615",
"builder:win-asan",
"buildset:commit/git/ba706a33d708bbcf13a6150a0748ce347b488279",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ba706a33d708bbcf13a6150a0748ce347b488279",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029200641746435280",
"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/8863770579728394544/+/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:4fd8f9efc2f1b210",
"user_agent:luci-scheduler"
],
"updated_ts": "1605252783224241",
"url": "https://ci.chromium.org/b/8863770579728394544",
"utcnow_ts": "1605252784029329"
}
}
[07:33:04.042] Invocation finished in 1h41m51.546912393s with status FAILED