[10:22:12.188] New invocation is queued and will start shortly
[10:22:13.255] Starting the invocation (attempt 1)
[10:22:13.314] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:22:13.314] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:22:13.314] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028187025610428384",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b956187f9954d8d7f17984d7a470ecf094572264\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028187025610428384",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/b956187f9954d8d7f17984d7a470ecf094572264",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b956187f9954d8d7f17984d7a470ecf094572264",
"gitiles_ref:refs/heads/master"
]
}
[10:22:13.919] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606213333444447",
"id": "8862756963628592352",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b956187f9954d8d7f17984d7a470ecf094572264\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606213333802363",
"tags": [
"build_address:luci.chromium.ci/win-asan/15819",
"builder:win-asan",
"buildset:commit/git/b956187f9954d8d7f17984d7a470ecf094572264",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b956187f9954d8d7f17984d7a470ecf094572264",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028187025610428384",
"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/8862756963628592352/+/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": "1606213333802501",
"url": "https://ci.chromium.org/b/8862756963628592352",
"utcnow_ts": "1606213333909626"
}
}
[10:22:13.919] Task URL: https://ci.chromium.org/b/8862756963628592352
[10:22:13.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:2:0) after 1m0s
[10:22:15.344] Received PubSub notification, asking Buildbucket for the build status
[10:22:15.647] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:13.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:2:0)
[10:23:13.987] Timer tick, asking Buildbucket for the build status
[10:23:14.085] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:14.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:4:0) after 1m0s
[10:24:14.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:4:0)
[10:24:14.260] Timer tick, asking Buildbucket for the build status
[10:24:14.386] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:14.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:5:0) after 1m0s
[10:25:14.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:5:0)
[10:25:14.415] Timer tick, asking Buildbucket for the build status
[10:25:15.480] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:15.480] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:6:0) after 1m0s
[10:26:15.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:6:0)
[10:26:15.481] Timer tick, asking Buildbucket for the build status
[10:26:15.579] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:15.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:7:0) after 1m0s
[10:27:15.602] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:7:0)
[10:27:15.602] Timer tick, asking Buildbucket for the build status
[10:27:15.831] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:15.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:8:0) after 1m0s
[10:28:15.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:8:0)
[10:28:15.877] Timer tick, asking Buildbucket for the build status
[10:28:15.961] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:15.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:9:0) after 1m0s
[10:29:16.006] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:9:0)
[10:29:16.007] Timer tick, asking Buildbucket for the build status
[10:29:16.079] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:16.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:10:0) after 1m0s
[10:30:16.110] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:10:0)
[10:30:16.110] Timer tick, asking Buildbucket for the build status
[10:30:16.185] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:16.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:11:0) after 1m0s
[10:31:16.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:11:0)
[10:31:16.270] Timer tick, asking Buildbucket for the build status
[10:31:16.339] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:16.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:12:0) after 1m0s
[10:32:16.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:12:0)
[10:32:16.395] Timer tick, asking Buildbucket for the build status
[10:32:16.532] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:16.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:13:0) after 1m0s
[10:33:16.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:13:0)
[10:33:16.557] Timer tick, asking Buildbucket for the build status
[10:33:16.649] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:16.649] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:14:0) after 1m0s
[10:34:16.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:14:0)
[10:34:16.654] Timer tick, asking Buildbucket for the build status
[10:34:16.728] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:16.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:15:0) after 1m0s
[10:35:16.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:15:0)
[10:35:16.803] Timer tick, asking Buildbucket for the build status
[10:35:16.900] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:16.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:16:0) after 1m0s
[10:36:16.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:16:0)
[10:36:16.981] Timer tick, asking Buildbucket for the build status
[10:36:17.579] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:17.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:17:0) after 1m0s
[10:37:17.644] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:17:0)
[10:37:17.644] Timer tick, asking Buildbucket for the build status
[10:37:17.738] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:17.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:18:0) after 1m0s
[10:38:17.801] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:18:0)
[10:38:17.801] Timer tick, asking Buildbucket for the build status
[10:38:17.902] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:17.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:19:0) after 1m0s
[10:39:17.969] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:19:0)
[10:39:17.969] Timer tick, asking Buildbucket for the build status
[10:39:18.423] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:18.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:20:0) after 1m0s
[10:40:18.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:20:0)
[10:40:18.615] Timer tick, asking Buildbucket for the build status
[10:40:18.685] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:18.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:21:0) after 1m0s
[10:41:18.750] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:21:0)
[10:41:18.750] Timer tick, asking Buildbucket for the build status
[10:41:18.863] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:18.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:22:0) after 1m0s
[10:42:19.080] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:22:0)
[10:42:19.080] Timer tick, asking Buildbucket for the build status
[10:42:19.195] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:19.195] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:23:0) after 1m0s
[10:43:19.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:23:0)
[10:43:19.330] Timer tick, asking Buildbucket for the build status
[10:43:19.416] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:19.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:24:0) after 1m0s
[10:44:19.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:24:0)
[10:44:19.515] Timer tick, asking Buildbucket for the build status
[10:44:19.573] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:19.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:25:0) after 1m0s
[10:45:19.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:25:0)
[10:45:19.568] Timer tick, asking Buildbucket for the build status
[10:45:19.691] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:19.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:26:0) after 1m0s
[10:46:19.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:26:0)
[10:46:19.715] Timer tick, asking Buildbucket for the build status
[10:46:19.841] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:19.841] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:27:0) after 1m0s
[10:47:19.958] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:27:0)
[10:47:19.959] Timer tick, asking Buildbucket for the build status
[10:47:20.392] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:20.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:28:0) after 1m0s
[10:48:20.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:28:0)
[10:48:20.493] Timer tick, asking Buildbucket for the build status
[10:48:20.641] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:20.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:29:0) after 1m0s
[10:49:20.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:29:0)
[10:49:20.696] Timer tick, asking Buildbucket for the build status
[10:49:20.806] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:20.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:30:0) after 1m0s
[10:50:20.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:30:0)
[10:50:20.900] Timer tick, asking Buildbucket for the build status
[10:50:21.026] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:21.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:31:0) after 1m0s
[10:51:21.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:31:0)
[10:51:21.107] Timer tick, asking Buildbucket for the build status
[10:51:21.223] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:21.223] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:32:0) after 1m0s
[10:52:21.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:32:0)
[10:52:21.281] Timer tick, asking Buildbucket for the build status
[10:52:21.405] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:21.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:33:0) after 1m0s
[10:53:21.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:33:0)
[10:53:21.490] Timer tick, asking Buildbucket for the build status
[10:53:21.941] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:21.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:34:0) after 1m0s
[10:54:22.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:34:0)
[10:54:22.028] Timer tick, asking Buildbucket for the build status
[10:54:22.141] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:22.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:35:0) after 1m0s
[10:55:22.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:35:0)
[10:55:22.192] Timer tick, asking Buildbucket for the build status
[10:55:22.391] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:22.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:36:0) after 1m0s
[10:56:22.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:36:0)
[10:56:22.511] Timer tick, asking Buildbucket for the build status
[10:56:22.706] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:22.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:37:0) after 1m0s
[10:57:22.730] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:37:0)
[10:57:22.730] Timer tick, asking Buildbucket for the build status
[10:57:22.844] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:22.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:38:0) after 1m0s
[10:58:22.882] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:38:0)
[10:58:22.882] Timer tick, asking Buildbucket for the build status
[10:58:23.020] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:23.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:39:0) after 1m0s
[10:59:23.050] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:39:0)
[10:59:23.050] Timer tick, asking Buildbucket for the build status
[10:59:23.212] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:23.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:40:0) after 1m0s
[11:00:23.274] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:40:0)
[11:00:23.274] Timer tick, asking Buildbucket for the build status
[11:00:23.395] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:23.395] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:41:0) after 1m0s
[11:01:23.431] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:41:0)
[11:01:23.431] Timer tick, asking Buildbucket for the build status
[11:01:23.725] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:23.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:42:0) after 1m0s
[11:02:23.779] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:42:0)
[11:02:23.779] Timer tick, asking Buildbucket for the build status
[11:02:23.912] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:23.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:43:0) after 1m0s
[11:03:23.979] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:43:0)
[11:03:23.980] Timer tick, asking Buildbucket for the build status
[11:03:24.228] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:24.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:44:0) after 1m0s
[11:04:24.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:44:0)
[11:04:24.262] Timer tick, asking Buildbucket for the build status
[11:04:24.426] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:24.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:45:0) after 1m0s
[11:05:24.467] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:45:0)
[11:05:24.467] Timer tick, asking Buildbucket for the build status
[11:05:24.548] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:24.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:46:0) after 1m0s
[11:06:24.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:46:0)
[11:06:24.591] Timer tick, asking Buildbucket for the build status
[11:06:24.684] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:24.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:47:0) after 1m0s
[11:07:24.664] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:47:0)
[11:07:24.664] Timer tick, asking Buildbucket for the build status
[11:07:24.769] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:24.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:48:0) after 1m0s
[11:08:24.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:48:0)
[11:08:24.826] Timer tick, asking Buildbucket for the build status
[11:08:24.910] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:24.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:49:0) after 1m0s
[11:09:24.943] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:49:0)
[11:09:24.944] Timer tick, asking Buildbucket for the build status
[11:09:25.074] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:25.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:50:0) after 1m0s
[11:10:25.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:50:0)
[11:10:25.098] Timer tick, asking Buildbucket for the build status
[11:10:25.520] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:25.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:51:0) after 1m0s
[11:11:25.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:51:0)
[11:11:25.569] Timer tick, asking Buildbucket for the build status
[11:11:25.691] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:25.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:52:0) after 1m0s
[11:12:25.723] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:52:0)
[11:12:25.723] Timer tick, asking Buildbucket for the build status
[11:12:25.898] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:25.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:53:0) after 1m0s
[11:13:25.968] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:53:0)
[11:13:25.968] Timer tick, asking Buildbucket for the build status
[11:13:26.825] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:26.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:54:0) after 1m0s
[11:14:26.863] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:54:0)
[11:14:26.863] Timer tick, asking Buildbucket for the build status
[11:14:27.415] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:27.415] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:55:0) after 1m0s
[11:15:27.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:55:0)
[11:15:27.455] Timer tick, asking Buildbucket for the build status
[11:15:27.539] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:27.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:56:0) after 1m0s
[11:16:27.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:56:0)
[11:16:27.596] Timer tick, asking Buildbucket for the build status
[11:16:27.911] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:27.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:57:0) after 1m0s
[11:17:28.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:57:0)
[11:17:28.008] Timer tick, asking Buildbucket for the build status
[11:17:28.161] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:28.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:58:0) after 1m0s
[11:18:28.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:58:0)
[11:18:28.229] Timer tick, asking Buildbucket for the build status
[11:18:28.404] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:28.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:59:0) after 1m0s
[11:19:28.516] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:59:0)
[11:19:28.516] Timer tick, asking Buildbucket for the build status
[11:19:28.601] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:28.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:60:0) after 1m0s
[11:20:28.627] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:60:0)
[11:20:28.627] Timer tick, asking Buildbucket for the build status
[11:20:29.109] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:29.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:61:0) after 1m0s
[11:21:29.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:61:0)
[11:21:29.135] Timer tick, asking Buildbucket for the build status
[11:21:29.250] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:29.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:62:0) after 1m0s
[11:22:29.320] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:62:0)
[11:22:29.320] Timer tick, asking Buildbucket for the build status
[11:22:29.482] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:29.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:63:0) after 1m0s
[11:23:29.542] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:63:0)
[11:23:29.542] Timer tick, asking Buildbucket for the build status
[11:23:29.619] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:29.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:64:0) after 1m0s
[11:24:29.644] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:64:0)
[11:24:29.644] Timer tick, asking Buildbucket for the build status
[11:24:29.715] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:29.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:65:0) after 1m0s
[11:25:29.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:65:0)
[11:25:29.803] Timer tick, asking Buildbucket for the build status
[11:25:29.971] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:29.971] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:66:0) after 1m0s
[11:26:29.992] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:66:0)
[11:26:29.992] Timer tick, asking Buildbucket for the build status
[11:26:30.626] Build 8862756963628592352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:30.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028187025610428384:67:0) after 1m0s
[11:26:31.043] Received PubSub notification, asking Buildbucket for the build status
[11:26:31.131] Build 8862756963628592352: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:26:31.131] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606217189859541",
"created_by": "project:chromium",
"created_ts": "1606213333444447",
"id": "8862756963628592352",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b956187f9954d8d7f17984d7a470ecf094572264\"}}",
"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\": \"b956187f9954d8d7f17984d7a470ecf094572264\", \"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-6-2gr3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15819, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"35df41dad8851431846a2ba565dc7aad2e295002\", \"got_dawn_revision\": \"03badec5d73ab4138f798b94221546c496177a09\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"b956187f9954d8d7f17984d7a470ecf094572264\", \"got_revision_cp\": \"refs/heads/master@{#830526}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"4ff956a829fefd66af0deeb9bb091fda4389fa21\", \"got_v8_revision_cp\": \"refs/heads/8.9.39@{#1}\", \"got_webrtc_revision\": \"d840c8fb5dc4aca585e48dc92c7f6afb0408f258\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32680}\", \"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\": \"b956187f9954d8d7f17984d7a470ecf094572264\", \"swarm_hashes_refs/heads/master(at){#830526}_without_patch\": {\"absl_hardening_tests\": \"e2ccc92626475bfabb4fa473f2ae0376eeb94cc9\", \"accessibility_unittests\": \"1d1fe8c30b5984211778c1f1067722280e7f966a\", \"angle_unittests\": \"19eed31f6fe8e42df6edc14462bd51361f939d94\", \"app_shell_unittests\": \"3f75732f441662ef2e6445135af6a738195f2bc4\", \"aura_unittests\": \"51cf013f9f61f75dba9e7827f307ad04a253e4ef\", \"base_unittests\": \"2a451422e50a44c85685bd989caf18c3eb6780ca\", \"base_util_unittests\": \"3e8356d9f6b70f5ee0add0c16e2690cc4dde036a\", \"blink_common_unittests\": \"f76b7c7880e0f1a182f1a3fd9d5c207bd7f0ca5b\", \"blink_fuzzer_unittests\": \"cbd71cd6485aed5a45fd524d3c8fb75fcbd03ddf\", \"blink_heap_unittests\": \"bce877395c0d3a8d757a37dfaa2450b5e822f90d\", \"blink_platform_unittests\": \"f7579d31fcd49efc888f8120cd3293ec39a70bdc\", \"blink_unittests\": \"1de749827821b19a2df855a2ec5dce2c884c0452\", \"boringssl_crypto_tests\": \"aae324d9c343b7b8ed84f629aa5aadbdb7addf25\", \"boringssl_ssl_tests\": \"6b79f81a137eda9ff76bbb85eb60cbf88c88a170\", \"browser_switcher_bho_unittests\": \"50332590f5228c0962661540660aa618c06a2fcd\", \"browser_tests\": \"18b7ed69284573a5b015527b48ce14a6c49298f7\", \"capture_unittests\": \"4e776bcbe6adb3bc70624bbdfad98523733880f2\", \"cast_unittests\": \"15e4d7084a3589eeb7ea4c4f9de1e32e9425ab14\", \"cc_unittests\": \"3563d673bc49a1362f074067b3388202c8e02fc5\", \"chrome_app_unittests\": \"3bda3244f84225fa78ddebb15b9dd286d4f3f5bb\", \"chrome_cleaner_unittests\": \"0e6139d3dd50132a05e39f36142871ccb19225d5\", \"chrome_elf_unittests\": \"f92abce2a9c468fcdd0c66f1ace091766946a8ad\", \"chromedriver_unittests\": \"95f0319682af804e2f775349c82da8001fb508e2\", \"components_browsertests\": \"0c13a8029aa25cc3b5b6b0e1a57ea28873e3d346\", \"components_unittests\": \"810fdef74b835ccd7f78eaea05e26ca779ea6f08\", \"compositor_unittests\": \"68f38418cc64e16481388a4b80a1273885c567e8\", \"content_browsertests\": \"d14e94c08fd6137e38404edb2b13d35baf28e843\", \"content_unittests\": \"5952cedbdffe1f2ec531781dcdd8836219cdb510\", \"courgette_unittests\": \"5b18a3d7cea54302494c60084e7b41300d045cb2\", \"crashpad_tests\": \"995be11c680d33e5596e19e53b8a69e52f1e2122\", \"cronet_tests\": \"70d4ca5cb9adc9ffe391183129416babf9070c9c\", \"cronet_unittests\": \"c351c6594deb7b3aa8cc4f1879f6139114e2826c\", \"crypto_unittests\": \"156c885c1cb72cf1ada29e06314eb9f418e4b851\", \"delayloads_unittests\": \"b1f05615d9a0d37b4548bc9e7be45eedb9c2053e\", \"device_unittests\": \"42963a1ef3ff108b5e95360a1d9ed520bfe3d04f\", \"display_unittests\": \"725050572bbd4871fe1d93cfe054c60e094abf0f\", \"elevation_service_unittests\": \"0025241607982fed8f36e5207569ac372a9dff9d\", \"events_unittests\": \"a8835fe56e63589c937edafa4cc178cfef6ed783\", \"extensions_browsertests\": \"b318ff72d65a961f3e688fc47e93a0b3dd8ee8a2\", \"extensions_unittests\": \"c348b07e0cfbc7c23f984a515dfa3059ac7d36b1\", \"filesystem_service_unittests\": \"9752da960caf5a82beba972ece94b40d2fe426ec\", \"gcm_unit_tests\": \"740e2a8dff23b08a20a0582811153e9f361e2b68\", \"gcp_unittests\": \"2c71bb52280bb2370a2472ddd5d1c17a0aa00515\", \"gfx_unittests\": \"316249345494763a6a1846856e117dd527162262\", \"gin_unittests\": \"cb00c52faa51596f928556883986fc6c35fa0297\", \"google_apis_unittests\": \"e976b119eef1016d55ab0a6932ee0f8a1b9e84ab\", \"gpu_unittests\": \"95a917e583d49f1460577410f6fc4c59eaac9768\", \"gwp_asan_unittests\": \"135c78c7f7aafe67c4ca003de7f8996a24318d07\", \"headless_browsertests\": \"c862292005bbc020702fe9721b8919f8ecd4737a\", \"headless_unittests\": \"8135332411f96f4f5de02ba7a65083e26a5b7184\", \"install_static_unittests\": \"062bce20b5e08e6d9974c2f62d69018c5df468a4\", \"installer_util_unittests\": \"1836a9f26e096dd0e6e27ecb8045ed39ca0e861d\", \"interactive_ui_tests\": \"8bee6d9ea62428d2c94a9a6034ced1bef1cfa802\", \"ipc_tests\": \"b3301e28ec290e0f7ec6c44eaa2b3dab1b842727\", \"jingle_unittests\": \"f61903feb0187e4234212f24bde74c095d5700cf\", \"latency_unittests\": \"e1a0270131d09ca7c7975676eb61b4216774749b\", \"libjingle_xmpp_unittests\": \"0cfeec47af3485a2abdbc5b12dce11934f5de1bf\", \"liburlpattern_unittests\": \"24ed6822a04941f24fbf731ef1c15fe7010892d8\", \"media_blink_unittests\": \"22b88fee02b5fd118acb2f4faf87073bb114b69d\", \"media_unittests\": \"f2a20139c01c3f5c1641f385652711602ff4fe6d\", \"message_center_unittests\": \"98f7d0bf0a376fb477200f01d9a2f02c074970b8\", \"midi_unittests\": \"e4a745798888b1206984a065d12e5ebadd21cccb\", \"mojo_core_unittests\": \"e8f3121180cfc60115a711c1014f33e7fe5993b3\", \"mojo_unittests\": \"f84ec2d0471144aa0d7a846859a266371cbde51d\", \"nacl_loader_unittests\": \"099679a721c52678f7a06cf91a54f7873d47e316\", \"native_theme_unittests\": \"5b58211e19cb2eb0f8af8744da875bd20cda28c5\", \"net_unittests\": \"f9f78d43be29bddb6e1bea703fd1dec5379cbf82\", \"notification_helper_unittests\": \"6ac959807de4414409f13c0fcdebee36824ec090\", \"pdf_unittests\": \"7838467ec166557c2ae6e1618f86c348b19da79b\", \"perfetto_unittests\": \"219a3808d6f7f31a437379f86ff28b393fad5d05\", \"ppapi_unittests\": \"11faaedb5a887ef841ff5a0e4e5f1654bd99a4af\", \"printing_unittests\": \"bf8bc2d3608e9d2bd9ad801d1769ebe251a63fd9\", \"remoting_unittests\": \"c375fd5e1dbb6c1e761d4995762cf49235739450\", \"sbox_integration_tests\": \"851c37a799f6ed729a9bb2b17c40925d81c4bf40\", \"sbox_unittests\": \"d130de668f071aa7f16ee5d970d0685360f6efee\", \"sbox_validation_tests\": \"26312cf3b7319bd037ae0263f4894e435663a419\", \"service_manager_unittests\": \"8cd35c64a8466810628f63e0b7c8b2e93f3c33a6\", \"services_unittests\": \"418bfd99975a901957e5a5651e9bb9a3ea873799\", \"setup_unittests\": \"e7172335109189b0e16ee0497aec43b119080487\", \"shell_dialogs_unittests\": \"aa13e0c0245625f8ee7ccf05ba1c35d919f18ed7\", \"skia_unittests\": \"382394b189eba6bed894a72082a75e3d3724d867\", \"snapshot_unittests\": \"af7b6a7719cf43bdc8f802577cbbd54774559512\", \"sql_unittests\": \"ebaee487a10b190d4b17a95a6000b6355fa86b69\", \"storage_unittests\": \"32d3064206197f6d0870d41c3e17987ad0428935\", \"sync_integration_tests\": \"29988a3a546cddc7c5a63c81d0179b344e218a4c\", \"traffic_annotation_auditor_unittests\": \"144101002d1a765369b1c584c9faf07117aa8651\", \"ui_base_unittests\": \"670f7bae0a1cfc8024c0fc8d031e67fcbcfd7ba7\", \"ui_touch_selection_unittests\": \"146b13a71ed829395c1eadf2f7a1a7f65b1e9dda\", \"unit_tests\": \"a88e77e0b49cd430fc2ccafaaaaea3147e6a72a4\", \"updater_tests\": \"7035071f92ebe72899fbbccfbb38811ec25a6341\", \"url_unittests\": \"cc1d972536714bb74a6eed5c2692c118255793f0\", \"views_unittests\": \"ba561a4978d35a6678291f1985006e22d68e018a\", \"viz_unittests\": \"2abfdce7cdb09c47969cc1c59ba9affbab29b1ec\", \"vr_common_unittests\": \"fa6ac286e1e52e782a61035bc89e4e4dd5016d80\", \"vr_pixeltests\": \"06a2cb0879319edb74c86f93c912720ba247e32a\", \"weblayer_browsertests\": \"a0776708075148401f62e8b277020407cc24bee2\", \"weblayer_unittests\": \"628c8a7bf90e64d5de776ef2f6e93b8af75e803e\", \"wm_unittests\": \"27204b633981b16921d9536bdd1265708a669954\", \"wtf_unittests\": \"7d0062203b5c4e8cc8b9948c1feb1efae980401a\", \"zlib_unittests\": \"fd8982b26089a5f3602b61ed98f530d05596ccef\", \"zucchini_unittests\": \"260b008fac59186f9953816b15da905d7fc59279\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_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-6-2gr3\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606213334587688",
"status": "COMPLETED",
"status_changed_ts": "1606217190184705",
"tags": [
"build_address:luci.chromium.ci/win-asan/15819",
"builder:win-asan",
"buildset:commit/git/b956187f9954d8d7f17984d7a470ecf094572264",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b956187f9954d8d7f17984d7a470ecf094572264",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028187025610428384",
"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/8862756963628592352/+/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:501297fbf4fe6510",
"user_agent:luci-scheduler"
],
"updated_ts": "1606217190188835",
"url": "https://ci.chromium.org/b/8862756963628592352",
"utcnow_ts": "1606217191117783"
}
}
[11:26:31.131] Invocation finished in 1h4m18.959910769s with status SUCCEEDED