[19:09:52.959] New invocation is queued and will start shortly
[19:09:54.057] Starting the invocation (attempt 1)
[19:09:54.106] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:09:54.109] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:09:54.109] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027610245095518896",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"13a7e9c432a98d3b893825a90280ed02a8c046d0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9027610245095518896",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/13a7e9c432a98d3b893825a90280ed02a8c046d0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/13a7e9c432a98d3b893825a90280ed02a8c046d0",
"gitiles_ref:refs/heads/master"
]
}
[19:09:55.074] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606763394253697",
"id": "8862180183065580112",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"13a7e9c432a98d3b893825a90280ed02a8c046d0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606763394817723",
"tags": [
"build_address:luci.chromium.ci/win-asan/15952",
"builder:win-asan",
"buildset:commit/git/13a7e9c432a98d3b893825a90280ed02a8c046d0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/13a7e9c432a98d3b893825a90280ed02a8c046d0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027610245095518896",
"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/8862180183065580112/+/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": "1606763394817872",
"url": "https://ci.chromium.org/b/8862180183065580112",
"utcnow_ts": "1606763395059914"
}
}
[19:09:55.074] Task URL: https://ci.chromium.org/b/8862180183065580112
[19:09:55.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:2:0) after 1m0s
[19:09:58.773] Received PubSub notification, asking Buildbucket for the build status
[19:09:59.011] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:55.125] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:2:0)
[19:10:55.125] Timer tick, asking Buildbucket for the build status
[19:10:55.641] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:55.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:4:0) after 1m0s
[19:11:55.697] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:4:0)
[19:11:55.698] Timer tick, asking Buildbucket for the build status
[19:11:55.814] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:55.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:5:0) after 1m0s
[19:12:55.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:5:0)
[19:12:55.820] Timer tick, asking Buildbucket for the build status
[19:12:56.281] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:56.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:6:0) after 1m0s
[19:13:56.307] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:6:0)
[19:13:56.307] Timer tick, asking Buildbucket for the build status
[19:13:56.588] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:56.589] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:7:0) after 1m0s
[19:14:56.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:7:0)
[19:14:56.614] Timer tick, asking Buildbucket for the build status
[19:14:56.985] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:56.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:8:0) after 1m0s
[19:15:57.030] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:8:0)
[19:15:57.030] Timer tick, asking Buildbucket for the build status
[19:15:57.285] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:57.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:9:0) after 1m0s
[19:16:57.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:9:0)
[19:16:57.343] Timer tick, asking Buildbucket for the build status
[19:16:57.424] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:57.424] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:10:0) after 1m0s
[19:17:57.505] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:10:0)
[19:17:57.505] Timer tick, asking Buildbucket for the build status
[19:17:57.951] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:57.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:11:0) after 1m0s
[19:18:57.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:11:0)
[19:18:57.957] Timer tick, asking Buildbucket for the build status
[19:18:58.155] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:58.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:12:0) after 1m0s
[19:19:58.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:12:0)
[19:19:58.298] Timer tick, asking Buildbucket for the build status
[19:19:58.746] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:58.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:13:0) after 1m0s
[19:20:58.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:13:0)
[19:20:58.819] Timer tick, asking Buildbucket for the build status
[19:20:59.941] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:59.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:14:0) after 1m0s
[19:21:59.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:14:0)
[19:21:59.992] Timer tick, asking Buildbucket for the build status
[19:22:00.265] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:00.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:15:0) after 1m0s
[19:23:00.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:15:0)
[19:23:00.402] Timer tick, asking Buildbucket for the build status
[19:23:00.491] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:00.491] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:16:0) after 1m0s
[19:24:00.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:16:0)
[19:24:00.592] Timer tick, asking Buildbucket for the build status
[19:24:00.707] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:00.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:17:0) after 1m0s
[19:25:00.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:17:0)
[19:25:00.753] Timer tick, asking Buildbucket for the build status
[19:25:00.940] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:00.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:18:0) after 1m0s
[19:26:01.235] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:18:0)
[19:26:01.235] Timer tick, asking Buildbucket for the build status
[19:26:01.489] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:01.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:19:0) after 1m0s
[19:27:01.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:19:0)
[19:27:01.668] Timer tick, asking Buildbucket for the build status
[19:27:02.693] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:02.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:20:0) after 1m0s
[19:28:02.725] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:20:0)
[19:28:02.725] Timer tick, asking Buildbucket for the build status
[19:28:04.363] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:04.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:21:0) after 1m0s
[19:29:04.412] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:21:0)
[19:29:04.412] Timer tick, asking Buildbucket for the build status
[19:29:04.626] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:04.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:22:0) after 1m0s
[19:30:04.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:22:0)
[19:30:04.751] Timer tick, asking Buildbucket for the build status
[19:30:04.948] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:04.948] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:23:0) after 1m0s
[19:31:04.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:23:0)
[19:31:04.981] Timer tick, asking Buildbucket for the build status
[19:31:05.076] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:05.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:24:0) after 1m0s
[19:32:05.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:24:0)
[19:32:05.089] Timer tick, asking Buildbucket for the build status
[19:32:06.493] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:06.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:25:0) after 1m0s
[19:33:06.738] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:25:0)
[19:33:06.738] Timer tick, asking Buildbucket for the build status
[19:33:07.203] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:07.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:26:0) after 1m0s
[19:34:07.245] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:26:0)
[19:34:07.245] Timer tick, asking Buildbucket for the build status
[19:34:07.442] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:07.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:27:0) after 1m0s
[19:35:07.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:27:0)
[19:35:07.512] Timer tick, asking Buildbucket for the build status
[19:35:07.786] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:07.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:28:0) after 1m0s
[19:36:07.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:28:0)
[19:36:07.902] Timer tick, asking Buildbucket for the build status
[19:36:08.478] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:08.478] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:29:0) after 1m0s
[19:37:08.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:29:0)
[19:37:08.655] Timer tick, asking Buildbucket for the build status
[19:37:09.251] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:09.251] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:30:0) after 1m0s
[19:38:09.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:30:0)
[19:38:09.286] Timer tick, asking Buildbucket for the build status
[19:38:09.529] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:09.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:31:0) after 1m0s
[19:39:09.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:31:0)
[19:39:09.666] Timer tick, asking Buildbucket for the build status
[19:39:10.262] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:10.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:32:0) after 1m0s
[19:40:10.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:32:0)
[19:40:10.334] Timer tick, asking Buildbucket for the build status
[19:40:11.081] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:11.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:33:0) after 1m0s
[19:41:11.110] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:33:0)
[19:41:11.110] Timer tick, asking Buildbucket for the build status
[19:41:11.322] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:11.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:34:0) after 1m0s
[19:42:11.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:34:0)
[19:42:11.355] Timer tick, asking Buildbucket for the build status
[19:42:14.129] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:14.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:35:0) after 1m0s
[19:43:14.136] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:35:0)
[19:43:14.136] Timer tick, asking Buildbucket for the build status
[19:43:14.276] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:14.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:36:0) after 1m0s
[19:44:14.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:36:0)
[19:44:14.366] Timer tick, asking Buildbucket for the build status
[19:44:16.321] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:16.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:37:0) after 1m0s
[19:45:16.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:37:0)
[19:45:16.621] Timer tick, asking Buildbucket for the build status
[19:45:19.174] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:19.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:38:0) after 1m0s
[19:46:19.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:38:0)
[19:46:19.194] Timer tick, asking Buildbucket for the build status
[19:46:19.332] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:19.333] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:39:0) after 1m0s
[19:47:19.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:39:0)
[19:47:19.464] Timer tick, asking Buildbucket for the build status
[19:47:19.707] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:19.708] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:40:0) after 1m0s
[19:48:19.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:40:0)
[19:48:19.739] Timer tick, asking Buildbucket for the build status
[19:48:19.882] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:19.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:41:0) after 1m0s
[19:49:19.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:41:0)
[19:49:19.968] Timer tick, asking Buildbucket for the build status
[19:49:20.059] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:20.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:42:0) after 1m0s
[19:50:20.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:42:0)
[19:50:20.189] Timer tick, asking Buildbucket for the build status
[19:50:21.806] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:21.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:43:0) after 1m0s
[19:51:21.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:43:0)
[19:51:21.873] Timer tick, asking Buildbucket for the build status
[19:51:22.192] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:22.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:44:0) after 1m0s
[19:52:22.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:44:0)
[19:52:22.284] Timer tick, asking Buildbucket for the build status
[19:52:22.441] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:22.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:45:0) after 1m0s
[19:53:22.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:45:0)
[19:53:22.489] Timer tick, asking Buildbucket for the build status
[19:53:23.549] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:23.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:46:0) after 1m0s
[19:54:23.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:46:0)
[19:54:23.606] Timer tick, asking Buildbucket for the build status
[19:54:23.755] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:23.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:47:0) after 1m0s
[19:55:23.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:47:0)
[19:55:23.814] Timer tick, asking Buildbucket for the build status
[19:55:24.740] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:24.740] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:48:0) after 1m0s
[19:56:24.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:48:0)
[19:56:24.771] Timer tick, asking Buildbucket for the build status
[19:56:25.239] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:25.239] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:49:0) after 1m0s
[19:57:25.265] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:49:0)
[19:57:25.265] Timer tick, asking Buildbucket for the build status
[19:57:26.825] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:26.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:50:0) after 1m0s
[19:58:26.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:50:0)
[19:58:26.869] Timer tick, asking Buildbucket for the build status
[19:58:27.039] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:27.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:51:0) after 1m0s
[19:59:27.093] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:51:0)
[19:59:27.093] Timer tick, asking Buildbucket for the build status
[19:59:27.268] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:27.268] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:52:0) after 1m0s
[20:00:27.320] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:52:0)
[20:00:27.320] Timer tick, asking Buildbucket for the build status
[20:00:27.545] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:27.545] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:53:0) after 1m0s
[20:01:27.608] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:53:0)
[20:01:27.608] Timer tick, asking Buildbucket for the build status
[20:01:28.490] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:28.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:54:0) after 1m0s
[20:02:28.566] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:54:0)
[20:02:28.566] Timer tick, asking Buildbucket for the build status
[20:02:28.702] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:28.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:55:0) after 1m0s
[20:03:28.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:55:0)
[20:03:28.820] Timer tick, asking Buildbucket for the build status
[20:03:30.063] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:30.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:56:0) after 1m0s
[20:04:30.076] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:56:0)
[20:04:30.076] Timer tick, asking Buildbucket for the build status
[20:04:30.647] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:30.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:57:0) after 1m0s
[20:05:30.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:57:0)
[20:05:30.694] Timer tick, asking Buildbucket for the build status
[20:05:33.137] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:33.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:58:0) after 1m0s
[20:06:33.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:58:0)
[20:06:33.167] Timer tick, asking Buildbucket for the build status
[20:06:35.040] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:35.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:59:0) after 1m0s
[20:07:35.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:59:0)
[20:07:35.146] Timer tick, asking Buildbucket for the build status
[20:07:35.538] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:35.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:60:0) after 1m0s
[20:08:35.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:60:0)
[20:08:35.606] Timer tick, asking Buildbucket for the build status
[20:08:36.106] Build 8862180183065580112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:36.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9027610245095518896:61:0) after 1m0s
[20:08:43.946] Received PubSub notification, asking Buildbucket for the build status
[20:08:45.118] Build 8862180183065580112: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:08:45.118] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606766922741957",
"created_by": "project:chromium",
"created_ts": "1606763394253697",
"id": "8862180183065580112",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"13a7e9c432a98d3b893825a90280ed02a8c046d0\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"13a7e9c432a98d3b893825a90280ed02a8c046d0\", \"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-10-eupo\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15952, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"5968da649c175c15854f83c1186cc52ecd4bf1bc\", \"got_dawn_revision\": \"2fe7335d34bc59edefd90a9d3f8683eb8ef83817\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"13a7e9c432a98d3b893825a90280ed02a8c046d0\", \"got_revision_cp\": \"refs/heads/master@{#831932}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"7cbb98085a26a2fd514bb7d2445c761095fac6f8\", \"got_v8_revision\": \"779fa622348c3fab46d3337764c3eaf19e684a42\", \"got_v8_revision_cp\": \"refs/heads/8.9.70@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"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\": \"13a7e9c432a98d3b893825a90280ed02a8c046d0\", \"swarm_hashes_refs/heads/master(at){#831932}_without_patch\": {\"absl_hardening_tests\": \"7528f3e41652268f51a584de7967537c7298ddb9\", \"accessibility_unittests\": \"463a1dac39461fd5caacab894cc556e7327e4896\", \"angle_unittests\": \"b103d7b4f58749513620467a2538f9afd83f74b7\", \"app_shell_unittests\": \"add6b3a9eab4bf504c1f76641484c51388bfe7e6\", \"aura_unittests\": \"cd5d325a497125c460b1ad34389023f04df1fefd\", \"base_unittests\": \"0d39042b443f901ffa56b6c3c8b1bbf0b5419ead\", \"base_util_unittests\": \"94c85d7a8ffcf531b5da1abcfa05bb14b9bccb64\", \"blink_common_unittests\": \"adf953653776acd49496f360ca1c5d49a75eff56\", \"blink_fuzzer_unittests\": \"e8f2875e365908ee31b90c8255d09252d7894d3e\", \"blink_heap_unittests\": \"e20463d217693800f87c8446e640322002243574\", \"blink_platform_unittests\": \"a04feea6cdb1a88f4d9c99bf444c93550b486ae0\", \"blink_unittests\": \"17462467ef9681773f0c8218a6ce8032b8e07fa4\", \"boringssl_crypto_tests\": \"ffba749f1401098a2f04f86bbdc863436be772bd\", \"boringssl_ssl_tests\": \"4aeac5a54a5bc932991efd04f48bbf69dadd96ff\", \"browser_switcher_bho_unittests\": \"c5b364efa73dbcb9935435427609af04d8873761\", \"browser_tests\": \"d484efbf729fac9432ebc4cc178fa82929e766e3\", \"capture_unittests\": \"af0a6f31a5cad0df367356a35e8eaaf9d1969b5f\", \"cast_unittests\": \"a9cbc449ba5852d51a465c1daaa5305c49facc6f\", \"cc_unittests\": \"59212ce2d8cda668d9d306b62ab8b1d695bf0d36\", \"chrome_app_unittests\": \"99e8424db04482c92ed1211cf96cd9420c422229\", \"chrome_cleaner_unittests\": \"84c8280309b595a8c331a06f97532d85d8e05226\", \"chrome_elf_unittests\": \"9b52a99b034d7f3cda2ffaa63d207b7dbab1f948\", \"chromedriver_unittests\": \"78dfb1603c0e54e8b484f7aaa1d11885387fdc94\", \"components_browsertests\": \"858d08cd561fdfe037fe66bf59f41324d33597b7\", \"components_unittests\": \"616b421fe3c436d8ee8d1211b6a21a47fa1e59f6\", \"compositor_unittests\": \"7e2c05ad1f34c84e712b47fe4a123777b34f028a\", \"content_browsertests\": \"9647b89a06d1b046e2928e1bd89df9d72d896c6e\", \"content_unittests\": \"79de359389e697414a92fca517d96c29da0e32ad\", \"courgette_unittests\": \"d58eafd6990874427722282ea9f0e571b961cae4\", \"crashpad_tests\": \"028b3001babc59f1d34542b8db63ebc49cad3c21\", \"cronet_tests\": \"b113d86dcf473f1f0c50f769a670057d22386278\", \"cronet_unittests\": \"8810611113e7b7795d9ddf56b2630f179824daef\", \"crypto_unittests\": \"92484c963be226c21442cf9b97f1a1f6aff79e84\", \"delayloads_unittests\": \"c5b19a343ad1c8e0e75d21f9f6a48dc68b87a0af\", \"device_unittests\": \"14be94eb4f24ded6b33842a6e666c042785f967d\", \"display_unittests\": \"12aeb370405d453235297e9569596b9a3644fe10\", \"elevation_service_unittests\": \"fb6517b4d19c2abd03daee105c85cddde43ab6a6\", \"events_unittests\": \"450471fe0e2b53baf2d8f74efdd637ec874a0f48\", \"extensions_browsertests\": \"b854d2480af8364fb561eaafeb0297eab40ed246\", \"extensions_unittests\": \"42b3fc162f8a1d2b9528a5a90aee74c00e58a281\", \"filesystem_service_unittests\": \"33716d7e598629ac853f7afb118944a6827ec41e\", \"gcm_unit_tests\": \"6d81d873f7a5f618302b1d94bf64ea3045686df9\", \"gcp_unittests\": \"eaa05c717eec2d8be1a012da11cea3eca80b6058\", \"gfx_unittests\": \"1f2be836f3c1a4483332a94eff7bfd0e1b8445bc\", \"gin_unittests\": \"0a0121a7bc4068631ae5dc0432f8dad6c5250cbc\", \"google_apis_unittests\": \"498535adfd24e88506156f2d15e26f2825d84d4e\", \"gpu_unittests\": \"9fd97f6c03289fb0837f030041571f9e7a945c9e\", \"gwp_asan_unittests\": \"2d5cc97d619d63126f0b2fd976f3105b8c1a24e9\", \"headless_browsertests\": \"8060eccc4c23c9defecc6f4e8286f640c51efa0e\", \"headless_unittests\": \"3f140e5f50b4d34564874e347fce4c12493dc885\", \"install_static_unittests\": \"150e8496d35f9704094ba23915685809f7a30de4\", \"installer_util_unittests\": \"160ffd5e7423a6a861f7305e3aac3d98e20e18b1\", \"interactive_ui_tests\": \"ac553f44e0285ec06125398c5c4df3bdedcf3fe4\", \"ipc_tests\": \"bf4a633668b6a7fb272835944e67fafd6199ea8b\", \"jingle_unittests\": \"50eab244d00ce137dc13c7aa772ffea68b1ab4f5\", \"latency_unittests\": \"d21bc2dc34c07f09811c8671d1d9df29f7e5fe8a\", \"libjingle_xmpp_unittests\": \"c8d625dbc3a541a80efdcd11fc325adb8206937d\", \"liburlpattern_unittests\": \"8ce89e1b2bb178fdf113cdff80b1a17d8bb0c1c6\", \"media_blink_unittests\": \"cd4a3af4d277bf83829f437ef08b9c4fef32a5ee\", \"media_unittests\": \"3e9c45cfb55e162e053d277c8ddecd161b06a104\", \"message_center_unittests\": \"17ccb0a33f5935eb8a2391f12796415bbbdf3408\", \"midi_unittests\": \"ae6c8eb4f90b8f63b550cff4bbcb9e4e4c6bfdfa\", \"mojo_core_unittests\": \"6350c88db6f9fcb24ff7e94fda977ca78832c8ab\", \"mojo_unittests\": \"725d6b486cb2fab4e1fa3d633eb07db96ed95988\", \"nacl_loader_unittests\": \"f8108b04d29749ae3efb778d1771d70033b5aa11\", \"native_theme_unittests\": \"7bb304834f55cfdcb9b116cf69e2b0544d461740\", \"net_unittests\": \"af9a13372020d882b472b1e5abbff4e5943bae49\", \"notification_helper_unittests\": \"516ca95e98018c3c606bebcc402d08f77dc9784f\", \"pdf_unittests\": \"a027d467b2e8baa1122df015ef5b798765496b23\", \"perfetto_unittests\": \"e032b7013f9b793d4f79a9a5caf7beeccb821c96\", \"ppapi_unittests\": \"52a71224c2e6052e3f4c087936ed2b87b8d8289b\", \"printing_unittests\": \"a368ccaff627d054812a134aed1861b4dac8f529\", \"remoting_unittests\": \"ae7429463f07d32edbc03277cc3232c94e61b9ec\", \"sbox_integration_tests\": \"f28ac38835387609468f03a0cf4b1606f95aead5\", \"sbox_unittests\": \"9eaee5f56ecd06312d6f3f12130ed096c8764b93\", \"sbox_validation_tests\": \"3f04a40ba46f63c7505a6f06ddc809b938dade2b\", \"service_manager_unittests\": \"6cf6f6fb1fbc0bfc7a3cb0bdac33668cc25dc933\", \"services_unittests\": \"fcd1f63308de3464fde89ee64c16fe868809fccf\", \"setup_unittests\": \"c7643a99e6095e86c4da57acf705f5c78b29a61d\", \"shell_dialogs_unittests\": \"a2436b0646b33988e74ae563d287cdb7b39c0480\", \"skia_unittests\": \"c4432485d9e39c6221d43ed242f93f7f629eac6d\", \"snapshot_unittests\": \"2edaedeab94e98369f45888a1cd0edce13de3e54\", \"sql_unittests\": \"18f81f355e528564ec48bb93cd2629e2328b288b\", \"storage_unittests\": \"e38ab1fa306a0539a846de407b8e6e83f8112eac\", \"sync_integration_tests\": \"5483622b12fdf3945923d589c7f65ea495e6d045\", \"traffic_annotation_auditor_unittests\": \"5d39d77fe1c5809080372c2cdb79a9a3bc77e460\", \"ui_base_unittests\": \"b8b0e6995e9c361eafafad82efa5a8edc4498537\", \"ui_touch_selection_unittests\": \"92bb89d39f031696d91e626e4b09d89101bb8c6b\", \"unit_tests\": \"157700f6b490986f5859340a1a3639363ade3ca8\", \"updater_tests\": \"dcd1edbaaf0c788a7a29c3dd3743950566c6f2c4\", \"url_unittests\": \"f8061a27e11d7b83af1e52ad5f98b4ade6dfb25b\", \"views_unittests\": \"348ea9e5014991dfcfea65c8cb028f7d5767600b\", \"viz_unittests\": \"5cf9acfc8f167fd18d3ab6abb988da92a6aaea57\", \"vr_common_unittests\": \"99d61aa58444b93348a3e9a04c6e25e19b8aef7e\", \"vr_pixeltests\": \"d42ed35d3c029515cb76477f4eb4fbd094640dc7\", \"weblayer_browsertests\": \"296d4068e39dd88d0991179f6e1e9da3f074904e\", \"weblayer_unittests\": \"de551a74f0448fe82a63ec66ebeb1748b21b7110\", \"wm_unittests\": \"11a22b09a0778daa2da26b8d8262a18b2476267b\", \"wtf_unittests\": \"8bdb36ed27e20be461d1dcbef91e71b8295370d2\", \"zlib_unittests\": \"b422caf06e7ff80f20f13327107774d032d763f8\", \"zucchini_unittests\": \"b1c18bbcfd020bcfb0793f8c2bceb152c24244f7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_91b2ef8341586e76bd64fa3093e74ce43aef344c2e2134fb3b046b47c3d4bcdb_v2\", \"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-10-eupo\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606763397689453",
"status": "COMPLETED",
"status_changed_ts": "1606766923220089",
"tags": [
"build_address:luci.chromium.ci/win-asan/15952",
"builder:win-asan",
"buildset:commit/git/13a7e9c432a98d3b893825a90280ed02a8c046d0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/13a7e9c432a98d3b893825a90280ed02a8c046d0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027610245095518896",
"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/8862180183065580112/+/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:50336140cd5b7d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1606766923242696",
"url": "https://ci.chromium.org/b/8862180183065580112",
"utcnow_ts": "1606766925030589"
}
}
[20:08:45.118] Invocation finished in 58m52.184261437s with status SUCCEEDED