[08:32:56.243] New invocation is queued and will start shortly
[08:32:57.333] Starting the invocation (attempt 1)
[08:32:57.370] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:32:57.370] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:32:57.370] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023482857762985536",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"818ff9c69438e4146308db0fc101eb27e02841aa\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023482857762985536",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/818ff9c69438e4146308db0fc101eb27e02841aa",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/818ff9c69438e4146308db0fc101eb27e02841aa",
"gitiles_ref:refs/heads/master"
]
}
[08:32:59.196] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610699577586370",
"id": "8858052795691891872",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"818ff9c69438e4146308db0fc101eb27e02841aa\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610699578804797",
"tags": [
"build_address:luci.chromium.ci/win-asan/16834",
"builder:win-asan",
"buildset:commit/git/818ff9c69438e4146308db0fc101eb27e02841aa",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/818ff9c69438e4146308db0fc101eb27e02841aa",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023482857762985536",
"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/8858052795691891872/+/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": "1610699578805066",
"url": "https://ci.chromium.org/b/8858052795691891872",
"utcnow_ts": "1610699579125181"
}
}
[08:32:59.196] Task URL: https://ci.chromium.org/b/8858052795691891872
[08:32:59.197] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:2:0) after 1m0s
[08:33:01.204] Received PubSub notification, asking Buildbucket for the build status
[08:33:01.333] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:59.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:2:0)
[08:33:59.249] Timer tick, asking Buildbucket for the build status
[08:33:59.401] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:59.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:4:0) after 1m0s
[08:34:59.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:4:0)
[08:34:59.444] Timer tick, asking Buildbucket for the build status
[08:34:59.680] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:59.680] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:5:0) after 1m0s
[08:35:59.740] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:5:0)
[08:35:59.740] Timer tick, asking Buildbucket for the build status
[08:36:03.385] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:03.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:6:0) after 1m0s
[08:37:03.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:6:0)
[08:37:03.495] Timer tick, asking Buildbucket for the build status
[08:37:03.686] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:03.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:7:0) after 1m0s
[08:38:03.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:7:0)
[08:38:03.804] Timer tick, asking Buildbucket for the build status
[08:38:04.070] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:04.070] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:8:0) after 1m0s
[08:39:04.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:8:0)
[08:39:04.211] Timer tick, asking Buildbucket for the build status
[08:39:04.357] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:04.357] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:9:0) after 1m0s
[08:40:04.382] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:9:0)
[08:40:04.382] Timer tick, asking Buildbucket for the build status
[08:40:04.517] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:04.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:10:0) after 1m0s
[08:41:04.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:10:0)
[08:41:04.526] Timer tick, asking Buildbucket for the build status
[08:41:04.635] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:04.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:11:0) after 1m0s
[08:42:04.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:11:0)
[08:42:04.677] Timer tick, asking Buildbucket for the build status
[08:42:04.777] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:04.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:12:0) after 1m0s
[08:43:04.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:12:0)
[08:43:04.911] Timer tick, asking Buildbucket for the build status
[08:43:05.011] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:05.011] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:13:0) after 1m0s
[08:44:05.225] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:13:0)
[08:44:05.225] Timer tick, asking Buildbucket for the build status
[08:44:05.694] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:05.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:14:0) after 1m0s
[08:45:05.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:14:0)
[08:45:05.808] Timer tick, asking Buildbucket for the build status
[08:45:06.278] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:06.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:15:0) after 1m0s
[08:46:06.414] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:15:0)
[08:46:06.414] Timer tick, asking Buildbucket for the build status
[08:46:06.537] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:06.537] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:16:0) after 1m0s
[08:47:06.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:16:0)
[08:47:06.659] Timer tick, asking Buildbucket for the build status
[08:47:06.791] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:06.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:17:0) after 1m0s
[08:48:06.917] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:17:0)
[08:48:06.917] Timer tick, asking Buildbucket for the build status
[08:48:07.037] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:07.037] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:18:0) after 1m0s
[08:49:07.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:18:0)
[08:49:07.087] Timer tick, asking Buildbucket for the build status
[08:49:07.583] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:07.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:19:0) after 1m0s
[08:50:07.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:19:0)
[08:50:07.846] Timer tick, asking Buildbucket for the build status
[08:50:08.405] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:08.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:20:0) after 1m0s
[08:51:08.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:20:0)
[08:51:08.601] Timer tick, asking Buildbucket for the build status
[08:51:09.020] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:09.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:21:0) after 1m0s
[08:52:09.160] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:21:0)
[08:52:09.160] Timer tick, asking Buildbucket for the build status
[08:52:09.311] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:09.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:22:0) after 1m0s
[08:53:09.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:22:0)
[08:53:09.368] Timer tick, asking Buildbucket for the build status
[08:53:09.465] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:09.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:23:0) after 1m0s
[08:54:09.572] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:23:0)
[08:54:09.572] Timer tick, asking Buildbucket for the build status
[08:54:09.704] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:09.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:24:0) after 1m0s
[08:55:09.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:24:0)
[08:55:09.747] Timer tick, asking Buildbucket for the build status
[08:55:09.859] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:09.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:25:0) after 1m0s
[08:56:10.021] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:25:0)
[08:56:10.021] Timer tick, asking Buildbucket for the build status
[08:56:10.118] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:10.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:26:0) after 1m0s
[08:57:10.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:26:0)
[08:57:10.246] Timer tick, asking Buildbucket for the build status
[08:57:10.509] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:10.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:27:0) after 1m0s
[08:58:10.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:27:0)
[08:58:10.579] Timer tick, asking Buildbucket for the build status
[08:58:10.725] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:10.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:28:0) after 1m0s
[08:59:10.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:28:0)
[08:59:10.791] Timer tick, asking Buildbucket for the build status
[08:59:10.857] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:10.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:29:0) after 1m0s
[09:00:10.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:29:0)
[09:00:10.921] Timer tick, asking Buildbucket for the build status
[09:00:12.406] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:12.406] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:30:0) after 1m0s
[09:01:12.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:30:0)
[09:01:12.674] Timer tick, asking Buildbucket for the build status
[09:01:12.853] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:12.853] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:31:0) after 1m0s
[09:02:12.982] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:31:0)
[09:02:12.982] Timer tick, asking Buildbucket for the build status
[09:02:13.177] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:13.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:32:0) after 1m0s
[09:03:13.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:32:0)
[09:03:13.247] Timer tick, asking Buildbucket for the build status
[09:03:13.655] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:13.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:33:0) after 1m0s
[09:04:13.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:33:0)
[09:04:13.756] Timer tick, asking Buildbucket for the build status
[09:04:13.852] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:13.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:34:0) after 1m0s
[09:05:13.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:34:0)
[09:05:13.927] Timer tick, asking Buildbucket for the build status
[09:05:14.247] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:14.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:35:0) after 1m0s
[09:06:14.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:35:0)
[09:06:14.279] Timer tick, asking Buildbucket for the build status
[09:06:14.521] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:14.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:36:0) after 1m0s
[09:07:14.640] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:36:0)
[09:07:14.640] Timer tick, asking Buildbucket for the build status
[09:07:15.103] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:15.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:37:0) after 1m0s
[09:08:15.115] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:37:0)
[09:08:15.115] Timer tick, asking Buildbucket for the build status
[09:08:16.688] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:16.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:38:0) after 1m0s
[09:09:16.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:38:0)
[09:09:16.739] Timer tick, asking Buildbucket for the build status
[09:09:16.891] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:16.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:39:0) after 1m0s
[09:10:16.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:39:0)
[09:10:16.870] Timer tick, asking Buildbucket for the build status
[09:10:16.985] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:16.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:40:0) after 1m0s
[09:11:17.012] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:40:0)
[09:11:17.012] Timer tick, asking Buildbucket for the build status
[09:11:17.592] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:17.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:41:0) after 1m0s
[09:12:17.592] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:41:0)
[09:12:17.592] Timer tick, asking Buildbucket for the build status
[09:12:17.755] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:17.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:42:0) after 1m0s
[09:13:17.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:42:0)
[09:13:17.850] Timer tick, asking Buildbucket for the build status
[09:13:18.512] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:18.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:43:0) after 1m0s
[09:14:18.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:43:0)
[09:14:18.523] Timer tick, asking Buildbucket for the build status
[09:14:18.692] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:18.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:44:0) after 1m0s
[09:15:18.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:44:0)
[09:15:18.703] Timer tick, asking Buildbucket for the build status
[09:15:19.118] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:19.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:45:0) after 1m0s
[09:16:19.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:45:0)
[09:16:19.155] Timer tick, asking Buildbucket for the build status
[09:16:19.283] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:19.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:46:0) after 1m0s
[09:17:19.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:46:0)
[09:17:19.308] Timer tick, asking Buildbucket for the build status
[09:17:19.375] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:19.375] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:47:0) after 1m0s
[09:18:19.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:47:0)
[09:18:19.444] Timer tick, asking Buildbucket for the build status
[09:18:19.661] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:19.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:48:0) after 1m0s
[09:19:19.713] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:48:0)
[09:19:19.713] Timer tick, asking Buildbucket for the build status
[09:19:19.898] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:19.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:49:0) after 1m0s
[09:20:19.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:49:0)
[09:20:19.937] Timer tick, asking Buildbucket for the build status
[09:20:20.027] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:20.027] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:50:0) after 1m0s
[09:21:20.052] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:50:0)
[09:21:20.052] Timer tick, asking Buildbucket for the build status
[09:21:20.152] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:20.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:51:0) after 1m0s
[09:22:20.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:51:0)
[09:22:20.223] Timer tick, asking Buildbucket for the build status
[09:22:20.570] Build 8858052795691891872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:20.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023482857762985536:52:0) after 1m0s
[09:23:19.481] Received PubSub notification, asking Buildbucket for the build status
[09:23:19.610] Build 8858052795691891872: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:23:19.610] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610702597388900",
"created_by": "project:chromium",
"created_ts": "1610699577586370",
"id": "8858052795691891872",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"818ff9c69438e4146308db0fc101eb27e02841aa\"}}",
"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\": \"818ff9c69438e4146308db0fc101eb27e02841aa\", \"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-3-nb2x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16834, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"29eeb610bd49e80a8109a6b42f2c95adcc619099\", \"got_dawn_revision\": \"5a6fda1a6fcc99553bab1411e2159cf962b6a36d\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"818ff9c69438e4146308db0fc101eb27e02841aa\", \"got_revision_cp\": \"refs/heads/master@{#843986}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"aedd133cd85f40f92c304776d240a8a3503d1d71\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"7acc2d9fe3a6e3c4d8881d2bdfc9b8968a724cd5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32986}\", \"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\": \"818ff9c69438e4146308db0fc101eb27e02841aa\", \"swarm_hashes_refs/heads/master(at){#843986}_without_patch\": {\"absl_hardening_tests\": \"e80e92a86c11a52a4cf3f675de43aec506c9e3ea\", \"accessibility_unittests\": \"9830dd5ca27799e4043342f6201150ce4478d029\", \"angle_unittests\": \"b915ae8c3e0e4357f1ac8e946c5dc3dcd81adeb1\", \"app_shell_unittests\": \"2cb6a3ab7958a6ee8b5d559e1b248c009139fa7a\", \"aura_unittests\": \"e0e648467e916eaa478cc985ea12133896a17e30\", \"base_unittests\": \"d5ec61e37be17907ec096826bd30ab6eee527cd2\", \"base_util_unittests\": \"531aa59189cf3c84d9310590aa31901cf8fab6be\", \"blink_common_unittests\": \"6b9cbc951225f761cd0a18541e9933a6142006ca\", \"blink_fuzzer_unittests\": \"c5e40c2fd9ba4e002d805616ff5db66b889bec80\", \"blink_heap_unittests\": \"6610e6bd9b13dd4d2c7de78fa0a1968d9a83d1a8\", \"blink_platform_unittests\": \"7384a3db944ebe08dfcef31e2e253b5fd717bc4f\", \"blink_unittests\": \"dd7989bc59c1e5dc57d50c630f5c5d0689052287\", \"boringssl_crypto_tests\": \"b995521b6f19b3b11577bfa9e47f07c1b5caaf53\", \"boringssl_ssl_tests\": \"cdd021a97166d08e7f1c5650219ec2c0451fd25b\", \"browser_switcher_bho_unittests\": \"d59b8f24bd6d2d6214b7eb96648da77ae91641d1\", \"browser_tests\": \"1d534cd43513c5749c609b51b3e494b68fc1918c\", \"capture_unittests\": \"eb84beef55f649b8f9f526717e5fc421e93f8ccb\", \"cast_unittests\": \"28edcd99c1a459b1094f62472063188062ab2e80\", \"cc_unittests\": \"3f521711ee3d29e3c1c33506bcb6114f079390e9\", \"chrome_app_unittests\": \"b460c79a369bcd7030444d86c796b9b519de010b\", \"chrome_cleaner_unittests\": \"60c80ee1fd45f9cb72722ea186978ff6a80d8514\", \"chrome_elf_unittests\": \"c64f7e5b43ab232c78b4fb6025a405a27b313871\", \"chromedriver_unittests\": \"999951710e2e44b2981ac85a9d95b7c02aa71d33\", \"components_browsertests\": \"6c74a6bc08deee716bd2477eeefa8670f743784c\", \"components_unittests\": \"0d250f59064da256eda6c2e0f7955eb679fd07b5\", \"compositor_unittests\": \"7ab13d5c99d891b9aa098494cf9627a839e36216\", \"content_browsertests\": \"5444fc3364b32109ab2a1e730a3cf443e89476be\", \"content_unittests\": \"196e0b52a86bd5d1bf0b756160d417cc9d24ba70\", \"courgette_unittests\": \"b8b6c92c7b06b4d764c063717d0a5955a98de60b\", \"crashpad_tests\": \"06220aa4edecc39e23a185493813b2c21b5b94fd\", \"cronet_tests\": \"002b430a417794ffae98e47832e4355ac354d4ce\", \"cronet_unittests\": \"043b0f0c7f37a21e12e99c73c280756808ad6079\", \"crypto_unittests\": \"e2b0d161341807935eac59ec866a6fcea383d0ed\", \"delayloads_unittests\": \"4012f10983acf5e454ae7cb96322ddf8c2d972c2\", \"device_unittests\": \"ceb3ae7582f7d2b332da2dec5101d92c5e76fa8b\", \"display_unittests\": \"6777e0b6a92d147801d90e61d37fd44b1096f88b\", \"elevation_service_unittests\": \"9d8580a1590628729e3a56892fefb636597ee15d\", \"events_unittests\": \"0465fcf0e2793f8f25ce5b3c759f34fd970ef4f0\", \"extensions_browsertests\": \"ee2f694f17c393767b17689f4c7a5580641a468b\", \"extensions_unittests\": \"8ccd82dfb583fc4609ceb62020266c1cf23e6ddd\", \"filesystem_service_unittests\": \"1a0a90ec0e5e56ae3e1106d44d642ed86eb571b7\", \"gcm_unit_tests\": \"a074ca76f8de2582d757343244ec1a6c6540711b\", \"gcp_unittests\": \"affab739a7112998b8f63c1febe714465a617d44\", \"gfx_unittests\": \"8d9fc8d1f1f70d9f89d102c73938e38c4af2cd1f\", \"gin_unittests\": \"a36ae523b97dbe94b0fdea36d7b2f8f8f921d8c6\", \"google_apis_unittests\": \"b1afb7a777d8160d8ebb48b437325ebe61d82c14\", \"gpu_unittests\": \"bb136f5bd5a587baecce498dc8c398d84bde8ade\", \"gwp_asan_unittests\": \"6d1b502b740bf4628309e3c928dcff3d0295e956\", \"headless_browsertests\": \"a4cf18f2d459dc66c16ce6a29b34d517f95d51cb\", \"headless_unittests\": \"e2ab5465c5ea2defa9f22897c05cdc859ba0b4c0\", \"install_static_unittests\": \"d49b57e36d9f580b2207b3a09bab7dc64c1c508a\", \"installer_util_unittests\": \"83cc7ddb56549f8866f24328719e6d403fe2d9e6\", \"interactive_ui_tests\": \"7e942e18e8ef19edffcf5b502fcde09f56ec5af8\", \"ipc_tests\": \"04b29ea2dcac58398dc589b81059bb615997fce1\", \"jingle_unittests\": \"36fd69b770404dcc6a40de0af27864991a14cb0e\", \"latency_unittests\": \"a52d62052f352647292a56f64c43126e68a233f8\", \"libjingle_xmpp_unittests\": \"24ec27fab270c2c07d1aae3a917d1d4592bd194f\", \"liburlpattern_unittests\": \"495c955f01e6fdcdefb5d15c755815bb921457ca\", \"media_blink_unittests\": \"954ad718d6cc285afdc7115c50239b5ac01bfb51\", \"media_unittests\": \"de465ea812d55d4632caf342f903c393c75fae19\", \"message_center_unittests\": \"6ceb0bea558799224fd791bb8e2c712514c56493\", \"midi_unittests\": \"63ef9c56554fdcd74f5124fb04fc6dcc32676df1\", \"mojo_core_unittests\": \"f6710360f13b359ca507b66bfd8b784e8620216d\", \"mojo_unittests\": \"63b20e5decdb86064aaff2e19c0fb7a41f471a06\", \"nacl_loader_unittests\": \"0f2f64f8fc3bb320bbffc5f48dc1bda5f665a8ab\", \"native_theme_unittests\": \"d027858932147252f7713e50b6dbac722a899b95\", \"net_unittests\": \"f0ba9bf80f7fdccd700c8b6a8a771bde30eac103\", \"notification_helper_unittests\": \"65d6995c72799c926c0b18418b3f6101620c01ec\", \"pdf_unittests\": \"de10f356b9fd5dd3e160a8e6aa641584a11b01be\", \"perfetto_unittests\": \"624ce3abbe2f373f9756a323bfb69ca848cc380c\", \"ppapi_unittests\": \"849bc529e848bde0e400e01bf6d21951481d1151\", \"printing_unittests\": \"f881a7c1bcd94589934426fbda06de200610cd56\", \"remoting_unittests\": \"6fc1aa7af52254d2e622a28bd319179bd0871739\", \"sbox_integration_tests\": \"b97a238235ba2e9b70ff904ee1cfcd5b6dca02dc\", \"sbox_unittests\": \"e6384c634732dc697d9968a7896a260ce5f4ba80\", \"sbox_validation_tests\": \"a445ad3b3d19612cdc2cf663ec2fb4c9a5646b8d\", \"service_manager_unittests\": \"de521c64743537dbee403d93eb92542657069db1\", \"services_unittests\": \"67b310d3802fb91cc71fc34b0e9c1015957fa36e\", \"setup_unittests\": \"d322123ec3a521892de2c330838d7b713c690566\", \"shell_dialogs_unittests\": \"eb0b2f08c0761f9487a0cca94edb3f24e279d390\", \"skia_unittests\": \"819b1ea362c95a27279001f2bee92b9bd1eb2aee\", \"snapshot_unittests\": \"242a0d01ed4ab5ea1a5f56a0ca1ccb0b917ee0f6\", \"sql_unittests\": \"e5adab62a9ed29fb63800cf9acc67796c9ed1425\", \"storage_unittests\": \"d97ff36244feeafbeed9b1b2981a33762a0795b7\", \"sync_integration_tests\": \"e023f1bd9dfebfb58c1f6a9fb1dce40021d1a633\", \"traffic_annotation_auditor_unittests\": \"5ca5b0dfb6e577335278e6a58d35ac57539b9360\", \"ui_base_unittests\": \"691f016edb61758d6cf50fba30aa3af3c905b74e\", \"ui_touch_selection_unittests\": \"aeab980e5ce307111993f2d9b01996949bac0868\", \"unit_tests\": \"2f48e51ed1de27e847f713a47bba652d208a0ab5\", \"updater_tests\": \"0b60b7e53a0404e11fa9853d0e5aa09a63d53628\", \"url_unittests\": \"ca5c3c0079d3547037355463520ce302894f4548\", \"views_unittests\": \"066d0075c82a8f1b92eb725be179efc53d2a83dd\", \"viz_unittests\": \"147d41d09480408bd1c21164cc29fc68d985109c\", \"vr_common_unittests\": \"27052508b3d54597a4c52a80a6133416fb1f3f69\", \"vr_pixeltests\": \"e53011b31abc8d6ac5e7f17d5a3ee5b9f39745c9\", \"weblayer_browsertests\": \"1253ec14784e0c617e9c4727b1ba5479418f036c\", \"weblayer_unittests\": \"c4acc607ec954773d0afdc447ee2e42dff3d68e3\", \"wm_unittests\": \"e84aaa91b142e28a34064a59c928423e68d6c55c\", \"wtf_unittests\": \"974232e10324a189a5f502dc3a97a39bf116c32e\", \"zlib_unittests\": \"2bac7ff559dcb01788a3ee11922da5c6ce43ca1e\", \"zucchini_unittests\": \"e4aae04e68d3e116a1918ef7332ae6230c43894f\"}}, \"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-3-nb2x\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5666-679c9bd\"], \"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": "1610699580369743",
"status": "COMPLETED",
"status_changed_ts": "1610702598151634",
"tags": [
"build_address:luci.chromium.ci/win-asan/16834",
"builder:win-asan",
"buildset:commit/git/818ff9c69438e4146308db0fc101eb27e02841aa",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/818ff9c69438e4146308db0fc101eb27e02841aa",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023482857762985536",
"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/8858052795691891872/+/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:511dfea7a7a21c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610702598204499",
"url": "https://ci.chromium.org/b/8858052795691891872",
"utcnow_ts": "1610702599595800"
}
}
[09:23:19.610] Invocation finished in 50m23.383017372s with status SUCCEEDED