[10:19:30.567] New invocation is queued and will start shortly
[10:19:31.797] Starting the invocation (attempt 1)
[10:19:31.837] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:19:31.837] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:19:31.837] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024744510360176576",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d4f96ac549b9e00f70f3de06854b537e94d27ff0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9024744510360176576",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/d4f96ac549b9e00f70f3de06854b537e94d27ff0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4f96ac549b9e00f70f3de06854b537e94d27ff0",
"gitiles_ref:refs/heads/master"
]
}
[10:19:33.311] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609496371942117",
"id": "8859314448253149104",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d4f96ac549b9e00f70f3de06854b537e94d27ff0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609496373091114",
"tags": [
"build_address:luci.chromium.ci/win-asan/16572",
"builder:win-asan",
"buildset:commit/git/d4f96ac549b9e00f70f3de06854b537e94d27ff0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4f96ac549b9e00f70f3de06854b537e94d27ff0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024744510360176576",
"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/8859314448253149104/+/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": "1609496373091423",
"url": "https://ci.chromium.org/b/8859314448253149104",
"utcnow_ts": "1609496373300487"
}
}
[10:19:33.311] Task URL: https://ci.chromium.org/b/8859314448253149104
[10:19:33.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:2:0) after 1m0s
[10:20:19.013] Received PubSub notification, asking Buildbucket for the build status
[10:20:19.171] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:33.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:2:0)
[10:20:33.370] Timer tick, asking Buildbucket for the build status
[10:20:33.440] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:33.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:4:0) after 1m0s
[10:21:33.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:4:0)
[10:21:33.408] Timer tick, asking Buildbucket for the build status
[10:21:33.509] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:33.509] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:5:0) after 1m0s
[10:22:33.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:5:0)
[10:22:33.532] Timer tick, asking Buildbucket for the build status
[10:22:33.629] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:33.629] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:6:0) after 1m0s
[10:23:33.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:6:0)
[10:23:33.649] Timer tick, asking Buildbucket for the build status
[10:23:33.758] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:33.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:7:0) after 1m0s
[10:24:33.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:7:0)
[10:24:33.775] Timer tick, asking Buildbucket for the build status
[10:24:34.057] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:34.058] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:8:0) after 1m0s
[10:25:34.075] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:8:0)
[10:25:34.075] Timer tick, asking Buildbucket for the build status
[10:25:34.141] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:34.141] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:9:0) after 1m0s
[10:26:34.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:9:0)
[10:26:34.186] Timer tick, asking Buildbucket for the build status
[10:26:34.235] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:34.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:10:0) after 1m0s
[10:27:34.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:10:0)
[10:27:34.295] Timer tick, asking Buildbucket for the build status
[10:27:34.418] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:34.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:11:0) after 1m0s
[10:28:34.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:11:0)
[10:28:34.453] Timer tick, asking Buildbucket for the build status
[10:28:34.696] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:34.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:12:0) after 1m0s
[10:29:34.823] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:12:0)
[10:29:34.823] Timer tick, asking Buildbucket for the build status
[10:29:34.968] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:34.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:13:0) after 1m0s
[10:30:35.070] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:13:0)
[10:30:35.070] Timer tick, asking Buildbucket for the build status
[10:30:35.165] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:35.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:14:0) after 1m0s
[10:31:35.184] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:14:0)
[10:31:35.184] Timer tick, asking Buildbucket for the build status
[10:31:35.278] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:35.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:15:0) after 1m0s
[10:32:35.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:15:0)
[10:32:35.250] Timer tick, asking Buildbucket for the build status
[10:32:35.792] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:35.792] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:16:0) after 1m0s
[10:33:35.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:16:0)
[10:33:35.808] Timer tick, asking Buildbucket for the build status
[10:33:35.895] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:35.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:17:0) after 1m0s
[10:34:36.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:17:0)
[10:34:36.065] Timer tick, asking Buildbucket for the build status
[10:34:36.204] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:36.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:18:0) after 1m0s
[10:35:36.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:18:0)
[10:35:36.212] Timer tick, asking Buildbucket for the build status
[10:35:36.306] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:36.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:19:0) after 1m0s
[10:36:36.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:19:0)
[10:36:36.323] Timer tick, asking Buildbucket for the build status
[10:36:36.430] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:36.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:20:0) after 1m0s
[10:37:36.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:20:0)
[10:37:36.464] Timer tick, asking Buildbucket for the build status
[10:37:36.644] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:36.644] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:21:0) after 1m0s
[10:38:36.674] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:21:0)
[10:38:36.674] Timer tick, asking Buildbucket for the build status
[10:38:37.001] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:37.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:22:0) after 1m0s
[10:39:37.031] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:22:0)
[10:39:37.031] Timer tick, asking Buildbucket for the build status
[10:39:37.323] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:37.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:23:0) after 1m0s
[10:40:37.360] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:23:0)
[10:40:37.360] Timer tick, asking Buildbucket for the build status
[10:40:37.600] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:37.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:24:0) after 1m0s
[10:41:37.623] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:24:0)
[10:41:37.623] Timer tick, asking Buildbucket for the build status
[10:41:37.730] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:37.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:25:0) after 1m0s
[10:42:37.754] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:25:0)
[10:42:37.754] Timer tick, asking Buildbucket for the build status
[10:42:37.840] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:37.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:26:0) after 1m0s
[10:43:37.819] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:26:0)
[10:43:37.819] Timer tick, asking Buildbucket for the build status
[10:43:37.883] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:37.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:27:0) after 1m0s
[10:44:37.893] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:27:0)
[10:44:37.893] Timer tick, asking Buildbucket for the build status
[10:44:38.503] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:38.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:28:0) after 1m0s
[10:45:40.322] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:28:0)
[10:45:40.322] Timer tick, asking Buildbucket for the build status
[10:45:40.397] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:40.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:29:0) after 1m0s
[10:46:41.016] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:29:0)
[10:46:41.016] Timer tick, asking Buildbucket for the build status
[10:46:41.259] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:41.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:30:0) after 1m0s
[10:47:41.363] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:30:0)
[10:47:41.363] Timer tick, asking Buildbucket for the build status
[10:47:41.437] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:41.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:31:0) after 1m0s
[10:48:41.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:31:0)
[10:48:41.457] Timer tick, asking Buildbucket for the build status
[10:48:41.574] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:41.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:32:0) after 1m0s
[10:49:43.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:32:0)
[10:49:43.007] Timer tick, asking Buildbucket for the build status
[10:49:43.106] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:43.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:33:0) after 1m0s
[10:50:43.195] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:33:0)
[10:50:43.195] Timer tick, asking Buildbucket for the build status
[10:50:43.697] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:43.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:34:0) after 1m0s
[10:51:43.824] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:34:0)
[10:51:43.824] Timer tick, asking Buildbucket for the build status
[10:51:44.029] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:44.029] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:35:0) after 1m0s
[10:52:44.051] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:35:0)
[10:52:44.051] Timer tick, asking Buildbucket for the build status
[10:52:44.123] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:44.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:36:0) after 1m0s
[10:53:44.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:36:0)
[10:53:44.196] Timer tick, asking Buildbucket for the build status
[10:53:44.301] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:44.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:37:0) after 1m0s
[10:54:44.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:37:0)
[10:54:44.479] Timer tick, asking Buildbucket for the build status
[10:54:44.608] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:44.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:38:0) after 1m0s
[10:55:44.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:38:0)
[10:55:44.658] Timer tick, asking Buildbucket for the build status
[10:55:44.761] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:44.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:39:0) after 1m0s
[10:56:44.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:39:0)
[10:56:44.873] Timer tick, asking Buildbucket for the build status
[10:56:44.990] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:44.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:40:0) after 1m0s
[10:57:45.012] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:40:0)
[10:57:45.012] Timer tick, asking Buildbucket for the build status
[10:57:45.206] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:45.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:41:0) after 1m0s
[10:58:45.230] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:41:0)
[10:58:45.230] Timer tick, asking Buildbucket for the build status
[10:58:45.322] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:45.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:42:0) after 1m0s
[10:59:45.370] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:42:0)
[10:59:45.370] Timer tick, asking Buildbucket for the build status
[10:59:45.707] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:45.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:43:0) after 1m0s
[11:00:45.806] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:43:0)
[11:00:45.806] Timer tick, asking Buildbucket for the build status
[11:00:45.968] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:45.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:44:0) after 1m0s
[11:01:46.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:44:0)
[11:01:46.059] Timer tick, asking Buildbucket for the build status
[11:01:46.305] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:46.305] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:45:0) after 1m0s
[11:02:46.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:45:0)
[11:02:46.380] Timer tick, asking Buildbucket for the build status
[11:02:46.487] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:46.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:46:0) after 1m0s
[11:03:46.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:46:0)
[11:03:46.568] Timer tick, asking Buildbucket for the build status
[11:03:46.725] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:46.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:47:0) after 1m0s
[11:04:50.738] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:47:0)
[11:04:50.738] Timer tick, asking Buildbucket for the build status
[11:04:50.863] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:50.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:48:0) after 1m0s
[11:05:51.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:48:0)
[11:05:51.146] Timer tick, asking Buildbucket for the build status
[11:05:51.631] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:51.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:49:0) after 1m0s
[11:06:51.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:49:0)
[11:06:51.851] Timer tick, asking Buildbucket for the build status
[11:06:52.238] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:52.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:50:0) after 1m0s
[11:07:52.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:50:0)
[11:07:52.367] Timer tick, asking Buildbucket for the build status
[11:07:52.429] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:52.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:51:0) after 1m0s
[11:08:52.760] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:51:0)
[11:08:52.761] Timer tick, asking Buildbucket for the build status
[11:08:52.897] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:52.897] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:52:0) after 1m0s
[11:09:53.019] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:52:0)
[11:09:53.019] Timer tick, asking Buildbucket for the build status
[11:09:53.617] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:53.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:53:0) after 1m0s
[11:10:53.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:53:0)
[11:10:53.650] Timer tick, asking Buildbucket for the build status
[11:10:53.770] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:53.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:54:0) after 1m0s
[11:11:53.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:54:0)
[11:11:53.814] Timer tick, asking Buildbucket for the build status
[11:11:53.876] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:53.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:55:0) after 1m0s
[11:12:54.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:55:0)
[11:12:54.001] Timer tick, asking Buildbucket for the build status
[11:12:54.103] Build 8859314448253149104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:54.103] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024744510360176576:56:0) after 1m0s
[11:13:29.443] Received PubSub notification, asking Buildbucket for the build status
[11:13:29.529] Build 8859314448253149104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:13:29.529] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609499608739630",
"created_by": "project:chromium",
"created_ts": "1609496371942117",
"id": "8859314448253149104",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d4f96ac549b9e00f70f3de06854b537e94d27ff0\"}}",
"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\": \"d4f96ac549b9e00f70f3de06854b537e94d27ff0\", \"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-1-9pgs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16572, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"2cbcb18e95e6820e1266fa17f421efe86f1bcc52\", \"got_dawn_revision\": \"86980018b3f2786aeb5ded1220ec94bc927fa6b2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"d4f96ac549b9e00f70f3de06854b537e94d27ff0\", \"got_revision_cp\": \"refs/heads/master@{#839891}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"ff29e249d3179766a40c9486183559fe3e5c1456\", \"got_v8_revision\": \"a3f2933bb6d06bd7473ccbed77714874e6bf63b3\", \"got_v8_revision_cp\": \"refs/heads/8.9.201@{#1}\", \"got_webrtc_revision\": \"6215ba804eb500f3e28b39088c73af3c4f4cd10a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32897}\", \"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\": \"d4f96ac549b9e00f70f3de06854b537e94d27ff0\", \"swarm_hashes_refs/heads/master(at){#839891}_without_patch\": {\"absl_hardening_tests\": \"4b5c3ca1221575578a87a70377477b7181dac560\", \"accessibility_unittests\": \"55b8eef447e4e1e1bfa97cdc6273104a66ea669e\", \"angle_unittests\": \"1650a0574320d3c94e4893279072710ff6c4406e\", \"app_shell_unittests\": \"73b0b8b2125079542205b5438b4f9a19a7fa4106\", \"aura_unittests\": \"8964da53aea069de4823aa6f83879d0a2a724b80\", \"base_unittests\": \"f389b31b4fa77b28bd2557986be1757977c1f6de\", \"base_util_unittests\": \"30cd4e78714aae2b8d42d7f2b477ad3f4bc4923b\", \"blink_common_unittests\": \"cbb43f41ff3517f9a02e03c82eacbb2a23b94b31\", \"blink_fuzzer_unittests\": \"d7a0e8c2128784dd8e81ad4aeff5a38de6a4bbb5\", \"blink_heap_unittests\": \"4e9e0579ebf1e7fca3390fbb85558959ae22e9c8\", \"blink_platform_unittests\": \"2fa3ac6c173bca1cb8b3756e62f63538c93e3ce4\", \"blink_unittests\": \"9d9b65bc69745aeee565b885b3f53ea7bd3f60e0\", \"boringssl_crypto_tests\": \"e8272ba7e9b69b4bf0a35039ee8b72950ca04c0e\", \"boringssl_ssl_tests\": \"bc8e5da089e5c401dd7e977ec3165a3abc98e124\", \"browser_switcher_bho_unittests\": \"3b0b8468d116f1ccb582cb9131e89d6fdb3b444c\", \"browser_tests\": \"5267ad1c63fbbdc618c5530167f929a980f52ae6\", \"capture_unittests\": \"bd4145d085f8ff09ba6b52b3ad04dd8685448b94\", \"cast_unittests\": \"3ecfa906ad64c58d516d3689ff21f0d3c3a0f680\", \"cc_unittests\": \"ddc594af52985e17d39c13082c0dbe8b2e14d10e\", \"chrome_app_unittests\": \"306aa0a01f33f5b035451f1c3e9f253e69faa5a0\", \"chrome_cleaner_unittests\": \"835107da6c2c935039925b54c294af64ffa196c7\", \"chrome_elf_unittests\": \"d9a9dff814707ad836bbb0a738858557bb059adb\", \"chromedriver_unittests\": \"b00d202f07cb1947c45faf0caa266758e1bfb18a\", \"components_browsertests\": \"718cadb3675bcc44ef7ee0e75651980430409e2e\", \"components_unittests\": \"196f1832c92c5bae3af3d6d79b77eaf3f7d972c7\", \"compositor_unittests\": \"a1f8e82ca3829f62f145ea694f799c639589a19e\", \"content_browsertests\": \"608ecb1d5ee82d913a612dd8273c5f490fb2523e\", \"content_unittests\": \"cb0f3dbb4492d6c593981659b321081ded465b3f\", \"courgette_unittests\": \"8291c07967c4855e7d366ef0c4dab1329dc2c358\", \"crashpad_tests\": \"2fc96d89198874c1095261057fb2b07a456bdaf1\", \"cronet_tests\": \"869385412ebe58403fe419507b1dbb8833fbf267\", \"cronet_unittests\": \"a25cb3656bc859c9e57091ab86ca7ecbbd042d01\", \"crypto_unittests\": \"5f95f1c4e3d78558a42991b0bafdcab70c1d0a8e\", \"delayloads_unittests\": \"309639aeb577670b9370031c85730675caf1dbca\", \"device_unittests\": \"9477cdb471490aeae3bca385c96ed7d2885947d9\", \"display_unittests\": \"068bf8b4f6231220f17e2a05551b99f830e4e084\", \"elevation_service_unittests\": \"08e9dfd7d07fe19778a0675f15c546e23fc108bc\", \"events_unittests\": \"dcb10c704801724ba7412d3738d349b78a61d8bc\", \"extensions_browsertests\": \"52e1cfcd51695b38ba585f01ec234d01bfd7a8e2\", \"extensions_unittests\": \"b424d8497d8c4bd0c5dde1e24b15df9f700d106e\", \"filesystem_service_unittests\": \"526e7640405984d57e8e98483603a160f179f2fc\", \"gcm_unit_tests\": \"3c28677560db55a6200a0c9456487a9188d79727\", \"gcp_unittests\": \"d4f95d1709a8c9e28fb8872aa1dcde1e7876b4fa\", \"gfx_unittests\": \"55d72e000cf6b2064f7044b430804d20c8e1d809\", \"gin_unittests\": \"12e85f845677340c24dde2a5d325c2ca0a37845d\", \"google_apis_unittests\": \"d40c88cf574cfd98a21ee6e604828d46469f7659\", \"gpu_unittests\": \"6c2747bc2bab9a0ba0637a88dbfb39a3dd4bcf7b\", \"gwp_asan_unittests\": \"70494ee86946b11b5428dcae620c3ff511dc5cf7\", \"headless_browsertests\": \"8ddea089f425857bef4b101ba7723e84a4e7a4f2\", \"headless_unittests\": \"824c587534670b97f3ec2f5eba54aee8600e8846\", \"install_static_unittests\": \"f00a5d5403820fe29fae32b1f6e985bbdff4a10f\", \"installer_util_unittests\": \"0e37cc7dcfed3c6911af75ccf38b15cbce53cd6c\", \"interactive_ui_tests\": \"a8422844912588a3d2982fc2459ce66713fd868a\", \"ipc_tests\": \"d3d9b577d2992349455aa2ca0ef760b0116b7285\", \"jingle_unittests\": \"70e70db8a79fafe1e22ddc26720697065b450e16\", \"latency_unittests\": \"5bee15533fe6ed948b4a43dc3802cee1a47be377\", \"libjingle_xmpp_unittests\": \"764102ab86a5511a0ed7af932cd70633c9f1298d\", \"liburlpattern_unittests\": \"05e42b7bd00e8b3aedd47087663fcb4ddc35ad3b\", \"media_blink_unittests\": \"89bd82bb949b8f0b1e9c1fda3b926c7a696bcb83\", \"media_unittests\": \"87eb5db9a37ed5e9ac1a5d300355da086da85d8a\", \"message_center_unittests\": \"8f0eafc795b8ed77083e6cc726f1ade3562594cb\", \"midi_unittests\": \"f8f3d17fe9d48366f503ffeee50063beb90eec9d\", \"mojo_core_unittests\": \"e1ac989b5f5bcc278b16a4c87c8292504311ceab\", \"mojo_unittests\": \"11853d1e40d79380396c0b1d7cd18ccd9f018cc5\", \"nacl_loader_unittests\": \"ac09002fecbdda0ca5001f6c0bb2c108a6d122b0\", \"native_theme_unittests\": \"6655c92506564afff0e8c4a867e1351dd17af7cf\", \"net_unittests\": \"6175b2f79e34204658c42c9df23254fede5ba4cb\", \"notification_helper_unittests\": \"ba8d62417772236ac0b7fb9bf144ae777f7b191e\", \"pdf_unittests\": \"70660c55a1a5419a092620890553c261c9aabf03\", \"perfetto_unittests\": \"b903917a353625c02407765030c826cffb2a72e2\", \"ppapi_unittests\": \"4f34d246c7acfad2b9fde28567f593a986bfa2de\", \"printing_unittests\": \"aa57c1057327b708909b11f14c3d79aaa7c76493\", \"remoting_unittests\": \"b66d2544b670440994e6fa457b3cc0bab9995b7a\", \"sbox_integration_tests\": \"27bc4514b56c6c16af16296ac5daa1ca08d8f63a\", \"sbox_unittests\": \"90b9fe4846a75eee70608081ef25bfba13c29416\", \"sbox_validation_tests\": \"3cc333cb24d22c229df887cb736e6aed6a23fbef\", \"service_manager_unittests\": \"e1a6e564c58e1edbc2ced5f4a6601bf1a884b002\", \"services_unittests\": \"4bcb0d15ddd1ad07d7091042f58be752090fec88\", \"setup_unittests\": \"d45dd19f9097b4f0324b17f7bbde01ac3384bc86\", \"shell_dialogs_unittests\": \"26cc47c32b6c7cee72139ec37104cdde02d85509\", \"skia_unittests\": \"25dbccb70ddf779068494596f7900ae216caa6fa\", \"snapshot_unittests\": \"3928b33c1c4f9136b9cce19fbcf368eab4066bf8\", \"sql_unittests\": \"e58c761f7c2e18a41887a089151f58e640a70ea0\", \"storage_unittests\": \"125904228057224141770d6ff63901c5b0469373\", \"sync_integration_tests\": \"eea9a2ef39d142d21fc8cca7e3d8aa3745b3f684\", \"traffic_annotation_auditor_unittests\": \"d344eeaf1af69394405d10245ee47a34134916a8\", \"ui_base_unittests\": \"8f82da303b702df676276f8abf732ba517a0ca13\", \"ui_touch_selection_unittests\": \"e8e7526a2c0b0a0c10668383987803c044ffd64f\", \"unit_tests\": \"bc0c9b586a524fc95a00f0fd57fe4f004e5ab822\", \"updater_tests\": \"f02216da47620fb2f4a137fa757003b180a6789f\", \"url_unittests\": \"0b04704ac98c2bb2f9b738054da078b7501bcbdb\", \"views_unittests\": \"80e9927a82a91df30c4421fc75eff977b3897a08\", \"viz_unittests\": \"e8f5012b9b1efc6b962f9c671d033163bd239970\", \"vr_common_unittests\": \"5910e5701674d0362c2ee0ab6493b87775036440\", \"vr_pixeltests\": \"b75800ad33a58e6d06a6cc469183f67e566ed237\", \"weblayer_browsertests\": \"68af151d76a596cdcd3c9f9839ce5e6f2b2dbf76\", \"weblayer_unittests\": \"8c23ed8f94dfc330b26fdeaeb382964273d159eb\", \"wm_unittests\": \"897b5b52b2d6b4104f465e909a45d23cbb36e452\", \"wtf_unittests\": \"700a9e4a80d9a027b0e4054ca84fb9151d0411ea\", \"zlib_unittests\": \"dbd6ebb7321f8e3b9fb5bed64bd1af9b79c91268\", \"zucchini_unittests\": \"8c5e18b623a78e7916c544bde56c95541d04fc2b\"}}, \"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-1-9pgs\"], \"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-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609496382164583",
"status": "COMPLETED",
"status_changed_ts": "1609499608946193",
"tags": [
"build_address:luci.chromium.ci/win-asan/16572",
"builder:win-asan",
"buildset:commit/git/d4f96ac549b9e00f70f3de06854b537e94d27ff0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4f96ac549b9e00f70f3de06854b537e94d27ff0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024744510360176576",
"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/8859314448253149104/+/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:50d64730b5a43b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609499608950452",
"url": "https://ci.chromium.org/b/8859314448253149104",
"utcnow_ts": "1609499609521535"
}
}
[11:13:29.529] Invocation finished in 53m58.979606744s with status SUCCEEDED