[03:47:44.091] New invocation is queued and will start shortly
[03:47:45.209] Starting the invocation (attempt 1)
[03:47:45.245] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:47:45.245] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:47:45.245] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023863189020138896",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b1e2c1865172f26a708aa94231548748dd3d8c96\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023863189020138896",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/b1e2c1865172f26a708aa94231548748dd3d8c96",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1e2c1865172f26a708aa94231548748dd3d8c96",
"gitiles_ref:refs/heads/master"
]
}
[03:47:46.042] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610336865449086",
"id": "8858433126933325504",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1e2c1865172f26a708aa94231548748dd3d8c96\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610336865843766",
"tags": [
"build_address:luci.chromium.ci/win-asan/16749",
"builder:win-asan",
"buildset:commit/git/b1e2c1865172f26a708aa94231548748dd3d8c96",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1e2c1865172f26a708aa94231548748dd3d8c96",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023863189020138896",
"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/8858433126933325504/+/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": "1610336865843997",
"url": "https://ci.chromium.org/b/8858433126933325504",
"utcnow_ts": "1610336866034148"
}
}
[03:47:46.042] Task URL: https://ci.chromium.org/b/8858433126933325504
[03:47:46.042] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:2:0) after 1m0s
[03:47:47.769] Received PubSub notification, asking Buildbucket for the build status
[03:47:47.859] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:46.063] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:2:0)
[03:48:46.063] Timer tick, asking Buildbucket for the build status
[03:48:46.422] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:46.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:4:0) after 1m0s
[03:49:46.445] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:4:0)
[03:49:46.445] Timer tick, asking Buildbucket for the build status
[03:49:46.687] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:46.687] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:5:0) after 1m0s
[03:50:46.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:5:0)
[03:50:46.757] Timer tick, asking Buildbucket for the build status
[03:50:46.879] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:46.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:6:0) after 1m0s
[03:51:46.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:6:0)
[03:51:46.900] Timer tick, asking Buildbucket for the build status
[03:51:47.001] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:47.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:7:0) after 1m0s
[03:52:47.030] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:7:0)
[03:52:47.030] Timer tick, asking Buildbucket for the build status
[03:52:47.140] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:47.140] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:8:0) after 1m0s
[03:53:47.289] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:8:0)
[03:53:47.289] Timer tick, asking Buildbucket for the build status
[03:53:47.601] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:47.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:9:0) after 1m0s
[03:54:47.621] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:9:0)
[03:54:47.621] Timer tick, asking Buildbucket for the build status
[03:54:47.807] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:47.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:10:0) after 1m0s
[03:55:47.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:10:0)
[03:55:47.826] Timer tick, asking Buildbucket for the build status
[03:55:48.167] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:48.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:11:0) after 1m0s
[03:56:48.276] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:11:0)
[03:56:48.276] Timer tick, asking Buildbucket for the build status
[03:56:48.420] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:48.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:12:0) after 1m0s
[03:57:48.496] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:12:0)
[03:57:48.496] Timer tick, asking Buildbucket for the build status
[03:57:48.612] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:48.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:13:0) after 1m0s
[03:58:48.771] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:13:0)
[03:58:48.771] Timer tick, asking Buildbucket for the build status
[03:58:49.092] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:49.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:14:0) after 1m0s
[03:59:49.125] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:14:0)
[03:59:49.125] Timer tick, asking Buildbucket for the build status
[03:59:49.344] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:49.344] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:15:0) after 1m0s
[04:00:49.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:15:0)
[04:00:49.395] Timer tick, asking Buildbucket for the build status
[04:00:49.534] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:49.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:16:0) after 1m0s
[04:01:49.616] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:16:0)
[04:01:49.616] Timer tick, asking Buildbucket for the build status
[04:01:50.122] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:50.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:17:0) after 1m0s
[04:02:50.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:17:0)
[04:02:50.154] Timer tick, asking Buildbucket for the build status
[04:02:50.280] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:50.280] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:18:0) after 1m0s
[04:03:50.366] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:18:0)
[04:03:50.366] Timer tick, asking Buildbucket for the build status
[04:03:50.492] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:50.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:19:0) after 1m0s
[04:04:50.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:19:0)
[04:04:50.513] Timer tick, asking Buildbucket for the build status
[04:04:50.691] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:50.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:20:0) after 1m0s
[04:05:50.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:20:0)
[04:05:50.711] Timer tick, asking Buildbucket for the build status
[04:05:50.841] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:50.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:21:0) after 1m0s
[04:06:50.862] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:21:0)
[04:06:50.862] Timer tick, asking Buildbucket for the build status
[04:06:51.059] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:51.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:22:0) after 1m0s
[04:07:51.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:22:0)
[04:07:51.104] Timer tick, asking Buildbucket for the build status
[04:07:51.261] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:51.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:23:0) after 1m0s
[04:08:51.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:23:0)
[04:08:51.295] Timer tick, asking Buildbucket for the build status
[04:08:51.508] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:51.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:24:0) after 1m0s
[04:09:51.590] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:24:0)
[04:09:51.590] Timer tick, asking Buildbucket for the build status
[04:09:51.728] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:51.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:25:0) after 1m0s
[04:10:51.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:25:0)
[04:10:51.745] Timer tick, asking Buildbucket for the build status
[04:10:51.814] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:51.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:26:0) after 1m0s
[04:11:51.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:26:0)
[04:11:51.837] Timer tick, asking Buildbucket for the build status
[04:11:51.953] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:51.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:27:0) after 1m0s
[04:12:51.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:27:0)
[04:12:51.979] Timer tick, asking Buildbucket for the build status
[04:12:52.090] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:52.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:28:0) after 1m0s
[04:13:52.185] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:28:0)
[04:13:52.185] Timer tick, asking Buildbucket for the build status
[04:13:52.256] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:52.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:29:0) after 1m0s
[04:14:52.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:29:0)
[04:14:52.336] Timer tick, asking Buildbucket for the build status
[04:14:52.429] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:52.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:30:0) after 1m0s
[04:15:52.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:30:0)
[04:15:52.515] Timer tick, asking Buildbucket for the build status
[04:15:52.595] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:52.595] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:31:0) after 1m0s
[04:16:52.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:31:0)
[04:16:52.658] Timer tick, asking Buildbucket for the build status
[04:16:52.780] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:52.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:32:0) after 1m0s
[04:17:52.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:32:0)
[04:17:52.853] Timer tick, asking Buildbucket for the build status
[04:17:52.952] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:52.952] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:33:0) after 1m0s
[04:18:53.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:33:0)
[04:18:53.079] Timer tick, asking Buildbucket for the build status
[04:18:53.144] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:53.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:34:0) after 1m0s
[04:19:53.276] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:34:0)
[04:19:53.276] Timer tick, asking Buildbucket for the build status
[04:19:53.413] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:53.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:35:0) after 1m0s
[04:20:53.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:35:0)
[04:20:53.534] Timer tick, asking Buildbucket for the build status
[04:20:53.656] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:53.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:36:0) after 1m0s
[04:21:53.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:36:0)
[04:21:53.678] Timer tick, asking Buildbucket for the build status
[04:21:53.750] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:53.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:37:0) after 1m0s
[04:22:53.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:37:0)
[04:22:53.820] Timer tick, asking Buildbucket for the build status
[04:22:53.965] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:53.965] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:38:0) after 1m0s
[04:23:54.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:38:0)
[04:23:54.051] Timer tick, asking Buildbucket for the build status
[04:23:54.555] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:54.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:39:0) after 1m0s
[04:24:54.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:39:0)
[04:24:54.611] Timer tick, asking Buildbucket for the build status
[04:24:54.703] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:54.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:40:0) after 1m0s
[04:25:54.765] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:40:0)
[04:25:54.765] Timer tick, asking Buildbucket for the build status
[04:25:54.881] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:54.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:41:0) after 1m0s
[04:26:54.948] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:41:0)
[04:26:54.948] Timer tick, asking Buildbucket for the build status
[04:26:55.027] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:55.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:42:0) after 1m0s
[04:27:55.143] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:42:0)
[04:27:55.143] Timer tick, asking Buildbucket for the build status
[04:27:55.260] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:55.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:43:0) after 1m0s
[04:28:55.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:43:0)
[04:28:55.306] Timer tick, asking Buildbucket for the build status
[04:28:55.385] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:55.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:44:0) after 1m0s
[04:29:55.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:44:0)
[04:29:55.432] Timer tick, asking Buildbucket for the build status
[04:29:55.766] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:55.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:45:0) after 1m0s
[04:30:55.854] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:45:0)
[04:30:55.854] Timer tick, asking Buildbucket for the build status
[04:30:56.038] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:56.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:46:0) after 1m0s
[04:31:56.073] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:46:0)
[04:31:56.073] Timer tick, asking Buildbucket for the build status
[04:31:56.151] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:56.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:47:0) after 1m0s
[04:32:56.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:47:0)
[04:32:56.210] Timer tick, asking Buildbucket for the build status
[04:32:56.315] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:56.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:48:0) after 1m0s
[04:33:56.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:48:0)
[04:33:56.479] Timer tick, asking Buildbucket for the build status
[04:33:56.569] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:56.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:49:0) after 1m0s
[04:34:56.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:49:0)
[04:34:56.693] Timer tick, asking Buildbucket for the build status
[04:34:57.357] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:57.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:50:0) after 1m0s
[04:35:57.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:50:0)
[04:35:57.444] Timer tick, asking Buildbucket for the build status
[04:35:57.513] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:57.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:51:0) after 1m0s
[04:36:57.586] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:51:0)
[04:36:57.586] Timer tick, asking Buildbucket for the build status
[04:36:57.909] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:57.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:52:0) after 1m0s
[04:37:57.967] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:52:0)
[04:37:57.967] Timer tick, asking Buildbucket for the build status
[04:37:58.110] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:58.110] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:53:0) after 1m0s
[04:38:58.152] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:53:0)
[04:38:58.152] Timer tick, asking Buildbucket for the build status
[04:38:58.244] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:58.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:54:0) after 1m0s
[04:39:58.265] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:54:0)
[04:39:58.265] Timer tick, asking Buildbucket for the build status
[04:39:58.459] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:58.459] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:55:0) after 1m0s
[04:40:58.581] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:55:0)
[04:40:58.581] Timer tick, asking Buildbucket for the build status
[04:40:58.760] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:58.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:56:0) after 1m0s
[04:41:58.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:56:0)
[04:41:58.844] Timer tick, asking Buildbucket for the build status
[04:41:58.911] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:58.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:57:0) after 1m0s
[04:42:58.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:57:0)
[04:42:58.979] Timer tick, asking Buildbucket for the build status
[04:42:59.102] Build 8858433126933325504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:59.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023863189020138896:58:0) after 1m0s
[04:43:37.963] Received PubSub notification, asking Buildbucket for the build status
[04:43:38.056] Build 8858433126933325504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:43:38.056] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610340215853639",
"created_by": "project:chromium",
"created_ts": "1610336865449086",
"id": "8858433126933325504",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1e2c1865172f26a708aa94231548748dd3d8c96\"}}",
"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\": \"b1e2c1865172f26a708aa94231548748dd3d8c96\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-us-central1-b-32-1-ervs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16749, \"clang_revision\": \"llvmorg-12-init-15676-g5c951623-1\", \"got_angle_revision\": \"0b90eef09f607336330f318bc8e65fa981634160\", \"got_dawn_revision\": \"3a0405597374c9ae12fb93e33aac35826455a958\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"b1e2c1865172f26a708aa94231548748dd3d8c96\", \"got_revision_cp\": \"refs/heads/master@{#841922}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"348ba200aa29d5b3a36d696d48d8f619e055219f\", \"got_v8_revision\": \"5d60a181de0863d8d00ae42ec0ee3521f51b501a\", \"got_v8_revision_cp\": \"refs/heads/8.9.229@{#1}\", \"got_webrtc_revision\": \"952be209246ab9ba702159cb246eac0e232b15ae\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32931}\", \"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\": \"b1e2c1865172f26a708aa94231548748dd3d8c96\", \"swarm_hashes_refs/heads/master(at){#841922}_without_patch\": {\"absl_hardening_tests\": \"263a2bb1f83e7e3466c0b288cc1d2659da464fa3\", \"accessibility_unittests\": \"22e63dbc06b80829b08339357908a88b47d8b2bc\", \"angle_unittests\": \"915f84af2f71a9f12f648dfed609c440ebc1b97d\", \"app_shell_unittests\": \"2b9f44d1e1bca5bf03eceac3dd11610b0b798e18\", \"aura_unittests\": \"e7c657ed2f822c94759f3f3220989f08a37e7b14\", \"base_unittests\": \"918d47eab7f5258d7f810806a622148e4af87a6f\", \"base_util_unittests\": \"cf51485a34fa795fc8724b63d7ab7d89d13eb817\", \"blink_common_unittests\": \"9f5af52a4332fe8c5ae4aaaf50b260f503ef2c34\", \"blink_fuzzer_unittests\": \"4d8e38bce18eff602181e555343cb275798fab78\", \"blink_heap_unittests\": \"8b1c6479e24c9f637651e5fd20bddbaa93d41ec7\", \"blink_platform_unittests\": \"21680ec78474624a52c55f3e3f49a93eb7363d7b\", \"blink_unittests\": \"452b7290feec1329f57bde43d6339ef6ca237f01\", \"boringssl_crypto_tests\": \"7ce3b570ffdbdf77e800d94b7e4eb4f2fc2e6dce\", \"boringssl_ssl_tests\": \"b7fa7f4d2c184bb8778f54111768d535187d006b\", \"browser_switcher_bho_unittests\": \"13203f7ff96092eaa32a638298cc9cc849de9e64\", \"browser_tests\": \"fdb959e4e0def12593409b008ee6836185137dad\", \"capture_unittests\": \"78f645a379f0a02b20573485c2a686724e46905d\", \"cast_unittests\": \"a30e8f3633bd6d5445285429447dfaa3aea8013a\", \"cc_unittests\": \"b31b94bae5c62bb629793f6080d79d6974b5f5f2\", \"chrome_app_unittests\": \"da139e0fb224a8fcb8a752bad471209209190074\", \"chrome_cleaner_unittests\": \"832091c5fcc578f40cb1a2540b843107d410e264\", \"chrome_elf_unittests\": \"8a2b112a3c574e13bf63ec6e98ef4c94da7f56ea\", \"chromedriver_unittests\": \"6faedb6594ff4b11f21c281ba387686ed29e88b7\", \"components_browsertests\": \"f17575697c08d6e61520f0a120538d259c7aee49\", \"components_unittests\": \"ed4efb2d49e2796604e7b320d10b7a21a7a17a53\", \"compositor_unittests\": \"a1e3a5a6f886d42471ea08751d5d18bf65b2197f\", \"content_browsertests\": \"c34f7b6b06fea90ee1f313d463ef258e0691f114\", \"content_unittests\": \"bbb00b6ffd06d1ef854e64a822df0aef61a53c12\", \"courgette_unittests\": \"4187f2d13b5f861ae1d1b51514badda04ade0ed8\", \"crashpad_tests\": \"d502bcec8b6a598327c5385e6bf6e118c8f779ef\", \"cronet_tests\": \"7123ae3277f1a37c864790af33dbf24eb59c08ff\", \"cronet_unittests\": \"ab57de9555d3e19d003406e7ebd8f41135b19331\", \"crypto_unittests\": \"57026856aad1fbb82ab97a70a6fb43468277bc09\", \"delayloads_unittests\": \"c5083a2a6e9fbe6014dac70dccf67de82d68021d\", \"device_unittests\": \"08f9bfb4c48c1c4f5db24a0da5ae6b240fb30792\", \"display_unittests\": \"dd7e5dd916b3ef27809f0746165e0592f55716c4\", \"elevation_service_unittests\": \"a24ac2887c1e0b1b9bc8be0515482e2d0606ed1d\", \"events_unittests\": \"b78b3a7d3588cf785bde3f545e923b3f1364725b\", \"extensions_browsertests\": \"6c8adb762fd59b805ad87aeaeed712c48ee8434c\", \"extensions_unittests\": \"79acd96f35562bed7e495d8f4784b7fe93e6ca04\", \"filesystem_service_unittests\": \"1ca0ea8d55c20beb3ae6b4e48ab09f3ec1e2a651\", \"gcm_unit_tests\": \"ec31712a1150833dc85a33b1b421f0f1dcce43bb\", \"gcp_unittests\": \"a7efedc9a31593492824c856095a2b60c1d2c13b\", \"gfx_unittests\": \"c06da246fde7da2022dd44d204724b7946bbc048\", \"gin_unittests\": \"3b7aebbd9e419f002a6b10290f3aa8332baf4c19\", \"google_apis_unittests\": \"495b26c9f7e69e5dbb4206f198e2615ac6c04e20\", \"gpu_unittests\": \"90349a780ca4fad596a8539a90be6fb289f4f1d3\", \"gwp_asan_unittests\": \"c532943201f95285ffff105b15098c14aba5a9a0\", \"headless_browsertests\": \"bf1b636985dda6f2b2d99758422aeacc3c82f7e8\", \"headless_unittests\": \"06c79e0134179d1f61691f982439d8df527a8a5a\", \"install_static_unittests\": \"665d59413c0859a7b535b75b6a70438b5a201644\", \"installer_util_unittests\": \"ce5c3a3f542f1f3702d290cff99e52daf08fd6c6\", \"interactive_ui_tests\": \"4f1b0de378842f96fa236af58074cb1e0741abf5\", \"ipc_tests\": \"23db75503de726520d1edf35673649aacf8bda5d\", \"jingle_unittests\": \"9b67b87b48b80c270f59397b0c0ed48920c5d4e8\", \"latency_unittests\": \"9e3c872a9769cab94a1285954e55c1b5cd3715f7\", \"libjingle_xmpp_unittests\": \"951a8696c0ce92c1a9bfffb15adccd6391095199\", \"liburlpattern_unittests\": \"c873b6028142a0327d2a6b995de111159dbf54df\", \"media_blink_unittests\": \"de01f7b2490b5c2445682bf79a4ea0bdf7e1179a\", \"media_unittests\": \"e87b4bf19578bbb70ce45dba081b7b5d898c107f\", \"message_center_unittests\": \"0c9e033e8077e7a89778f3383d075d68704744cb\", \"midi_unittests\": \"f63929d9edcc17808621281e80048a4248ec1008\", \"mojo_core_unittests\": \"61fdd7110655a1bd4e8e3a7b4d4a9238db7eb6bc\", \"mojo_unittests\": \"8744c043471ab521b3f923714e4dbc1db231f7d3\", \"nacl_loader_unittests\": \"b156848f81d989e7b22fae51705045e55b05eb34\", \"native_theme_unittests\": \"2fc380bcfc887940a07369c0a0c73b93d909b739\", \"net_unittests\": \"22d1bfd47a1b93d0fb3a120a133c4485f1380572\", \"notification_helper_unittests\": \"3445cc9755af9eade09e928f12cc9200de60c3f1\", \"pdf_unittests\": \"8beebbc03de566701163d0c948cb21a0a336df0d\", \"perfetto_unittests\": \"d956693d0cab28655fdd0ccff1cd2d952921a9bb\", \"ppapi_unittests\": \"c38c67b9caed5536fc22f751aa029afe80b1a8bc\", \"printing_unittests\": \"56500350115fbfde2decb89bb9b7ad90d6ea0b73\", \"remoting_unittests\": \"d8aa8c34d12d96785a9f0dae0110050e6333b88d\", \"sbox_integration_tests\": \"1638ef3ea4e52bbafba3ba62b0e5fc8c708a9cfa\", \"sbox_unittests\": \"327163edbf124562c39110e07862fa88299ac951\", \"sbox_validation_tests\": \"7af29d15a8af9a0045e2da0349b0d275ba013016\", \"service_manager_unittests\": \"aaa77c679c7c70aee9d8de2aad75fa7302a1ad72\", \"services_unittests\": \"1496499a6bd056dcafa7f149cd6039b2e7d01265\", \"setup_unittests\": \"70410d503fd5341ca3adb137b1ca847fe8807ca0\", \"shell_dialogs_unittests\": \"3827543ad809aa901c2b18b7317260e3e9c7c289\", \"skia_unittests\": \"49c8b39eb161cd8d97e6a6093f4ad8bfb7f1da36\", \"snapshot_unittests\": \"64307f82b740f93dcde314f6f2c273b0643b6390\", \"sql_unittests\": \"b5c57c6691b922b73882152601541fcd9b1a411d\", \"storage_unittests\": \"401152b0bc791f131ee94f984ebdd9ded1ed80fd\", \"sync_integration_tests\": \"67bbf67c1582087d534e9dba6a5f6aa2db557b0e\", \"traffic_annotation_auditor_unittests\": \"e5fe4906589f5ffed060838cb5fdca5f283d8abc\", \"ui_base_unittests\": \"d95d2242c117b7a33f8bc3574138d0156b8a7dd1\", \"ui_touch_selection_unittests\": \"edb2f367eb0a8b630d74fe0b5d1dba6ef036a43d\", \"unit_tests\": \"0f5ed1be0a821929d7add5d89bd44ebd3a5fba68\", \"updater_tests\": \"040a1f0156b19051ab376b625d9989c6f2d93fc6\", \"url_unittests\": \"7b7cadd7054df84738e2d3945782ccccdb27787f\", \"views_unittests\": \"db5a536e938b7dec01a048d5ca29e09c5aa813da\", \"viz_unittests\": \"2b0ad241aac4443ec5fcaf82decc0b2e34f432c6\", \"vr_common_unittests\": \"5dc033a6f290f7b65ca177cc721fc018a424d1bd\", \"vr_pixeltests\": \"c89ac4c0eb3699c508c46d7163ac51f942fa6c06\", \"weblayer_browsertests\": \"7e5b4e4fb262c871f07c363a8f04a2db7744d4f0\", \"weblayer_unittests\": \"81fe488cc2b9450a488da810aae9fb5f2709f379\", \"wm_unittests\": \"d25eb458a82f2652ec6ab3dc7235787cd4b5e122\", \"wtf_unittests\": \"8c570e4471cf120905789ab40b1f50fc8172e0a1\", \"zlib_unittests\": \"830d0834bbb812f50e90c5b7c59d5ad437289cf9\", \"zucchini_unittests\": \"00ebe21a752a5d428de2a77cdb979ead2f61ca14\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-1-ervs\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610336866974090",
"status": "COMPLETED",
"status_changed_ts": "1610340216288042",
"tags": [
"build_address:luci.chromium.ci/win-asan/16749",
"builder:win-asan",
"buildset:commit/git/b1e2c1865172f26a708aa94231548748dd3d8c96",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1e2c1865172f26a708aa94231548748dd3d8c96",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023863189020138896",
"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/8858433126933325504/+/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:510860179099ba10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610340216292313",
"url": "https://ci.chromium.org/b/8858433126933325504",
"utcnow_ts": "1610340218044160"
}
}
[04:43:38.056] Invocation finished in 55m53.98055148s with status SUCCEEDED