[08:05:43.405] New invocation is queued and will start shortly
[08:05:44.625] Starting the invocation (attempt 1)
[08:05:44.661] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:05:44.662] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:05:44.662] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023665763852366560",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8e0677971e2f893ba07381b363fb1928c25b3060\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023665763852366560",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/8e0677971e2f893ba07381b363fb1928c25b3060",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e0677971e2f893ba07381b363fb1928c25b3060",
"gitiles_ref:refs/heads/master"
]
}
[08:05:45.684] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610525144813721",
"id": "8858235701711095808",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e0677971e2f893ba07381b363fb1928c25b3060\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610525145466076",
"tags": [
"build_address:luci.chromium.ci/win-asan/16793",
"builder:win-asan",
"buildset:commit/git/8e0677971e2f893ba07381b363fb1928c25b3060",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e0677971e2f893ba07381b363fb1928c25b3060",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023665763852366560",
"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/8858235701711095808/+/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": "1610525145466258",
"url": "https://ci.chromium.org/b/8858235701711095808",
"utcnow_ts": "1610525145673663"
}
}
[08:05:45.684] Task URL: https://ci.chromium.org/b/8858235701711095808
[08:05:45.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:2:0) after 1m0s
[08:05:49.306] Received PubSub notification, asking Buildbucket for the build status
[08:05:49.386] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:45.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:2:0)
[08:06:45.695] Timer tick, asking Buildbucket for the build status
[08:06:45.784] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:45.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:4:0) after 1m0s
[08:07:45.837] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:4:0)
[08:07:45.837] Timer tick, asking Buildbucket for the build status
[08:07:46.017] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:46.017] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:5:0) after 1m0s
[08:08:46.035] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:5:0)
[08:08:46.035] Timer tick, asking Buildbucket for the build status
[08:08:46.168] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:46.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:6:0) after 1m0s
[08:09:46.176] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:6:0)
[08:09:46.176] Timer tick, asking Buildbucket for the build status
[08:09:46.270] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:46.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:7:0) after 1m0s
[08:10:46.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:7:0)
[08:10:46.288] Timer tick, asking Buildbucket for the build status
[08:10:46.402] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:46.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:8:0) after 1m0s
[08:11:46.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:8:0)
[08:11:46.423] Timer tick, asking Buildbucket for the build status
[08:11:46.531] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:46.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:9:0) after 1m0s
[08:12:46.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:9:0)
[08:12:46.551] Timer tick, asking Buildbucket for the build status
[08:12:46.656] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:46.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:10:0) after 1m0s
[08:13:46.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:10:0)
[08:13:46.685] Timer tick, asking Buildbucket for the build status
[08:13:47.009] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:47.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:11:0) after 1m0s
[08:14:47.028] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:11:0)
[08:14:47.028] Timer tick, asking Buildbucket for the build status
[08:14:47.300] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:47.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:12:0) after 1m0s
[08:15:47.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:12:0)
[08:15:47.319] Timer tick, asking Buildbucket for the build status
[08:15:47.707] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:47.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:13:0) after 1m0s
[08:16:47.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:13:0)
[08:16:47.745] Timer tick, asking Buildbucket for the build status
[08:16:47.809] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:47.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:14:0) after 1m0s
[08:17:47.811] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:14:0)
[08:17:47.811] Timer tick, asking Buildbucket for the build status
[08:17:47.917] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:47.917] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:15:0) after 1m0s
[08:18:47.967] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:15:0)
[08:18:47.967] Timer tick, asking Buildbucket for the build status
[08:18:48.074] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:48.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:16:0) after 1m0s
[08:19:48.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:16:0)
[08:19:48.102] Timer tick, asking Buildbucket for the build status
[08:19:48.288] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:48.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:17:0) after 1m0s
[08:20:48.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:17:0)
[08:20:48.361] Timer tick, asking Buildbucket for the build status
[08:20:48.500] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:48.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:18:0) after 1m0s
[08:21:48.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:18:0)
[08:21:48.576] Timer tick, asking Buildbucket for the build status
[08:21:48.716] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:48.716] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:19:0) after 1m0s
[08:22:48.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:19:0)
[08:22:48.748] Timer tick, asking Buildbucket for the build status
[08:22:48.905] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:48.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:20:0) after 1m0s
[08:23:48.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:20:0)
[08:23:48.966] Timer tick, asking Buildbucket for the build status
[08:23:49.123] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:49.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:21:0) after 1m0s
[08:24:49.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:21:0)
[08:24:49.170] Timer tick, asking Buildbucket for the build status
[08:24:49.329] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:49.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:22:0) after 1m0s
[08:25:49.381] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:22:0)
[08:25:49.381] Timer tick, asking Buildbucket for the build status
[08:25:49.519] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:49.519] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:23:0) after 1m0s
[08:26:49.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:23:0)
[08:26:49.670] Timer tick, asking Buildbucket for the build status
[08:26:50.323] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:50.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:24:0) after 1m0s
[08:27:50.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:24:0)
[08:27:50.395] Timer tick, asking Buildbucket for the build status
[08:27:50.895] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:50.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:25:0) after 1m0s
[08:28:51.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:25:0)
[08:28:51.015] Timer tick, asking Buildbucket for the build status
[08:28:51.200] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:51.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:26:0) after 1m0s
[08:29:51.270] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:26:0)
[08:29:51.270] Timer tick, asking Buildbucket for the build status
[08:29:51.728] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:51.728] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:27:0) after 1m0s
[08:30:51.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:27:0)
[08:30:51.763] Timer tick, asking Buildbucket for the build status
[08:30:51.936] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:51.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:28:0) after 1m0s
[08:31:51.980] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:28:0)
[08:31:51.980] Timer tick, asking Buildbucket for the build status
[08:31:52.124] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:52.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:29:0) after 1m0s
[08:32:52.249] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:29:0)
[08:32:52.249] Timer tick, asking Buildbucket for the build status
[08:32:53.020] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:53.020] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:30:0) after 1m0s
[08:33:53.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:30:0)
[08:33:53.114] Timer tick, asking Buildbucket for the build status
[08:33:54.116] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:54.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:31:0) after 1m0s
[08:34:54.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:31:0)
[08:34:54.139] Timer tick, asking Buildbucket for the build status
[08:34:54.402] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:54.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:32:0) after 1m0s
[08:35:54.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:32:0)
[08:35:54.415] Timer tick, asking Buildbucket for the build status
[08:35:54.578] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:54.578] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:33:0) after 1m0s
[08:36:54.598] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:33:0)
[08:36:54.598] Timer tick, asking Buildbucket for the build status
[08:36:54.682] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:54.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:34:0) after 1m0s
[08:37:54.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:34:0)
[08:37:54.767] Timer tick, asking Buildbucket for the build status
[08:37:54.949] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:54.949] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:35:0) after 1m0s
[08:38:54.975] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:35:0)
[08:38:54.975] Timer tick, asking Buildbucket for the build status
[08:38:55.073] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:55.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:36:0) after 1m0s
[08:39:55.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:36:0)
[08:39:55.171] Timer tick, asking Buildbucket for the build status
[08:39:55.349] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:55.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:37:0) after 1m0s
[08:40:55.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:37:0)
[08:40:55.415] Timer tick, asking Buildbucket for the build status
[08:40:55.571] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:55.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:38:0) after 1m0s
[08:41:55.669] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:38:0)
[08:41:55.669] Timer tick, asking Buildbucket for the build status
[08:41:55.834] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:55.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:39:0) after 1m0s
[08:42:55.926] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:39:0)
[08:42:55.926] Timer tick, asking Buildbucket for the build status
[08:42:56.749] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:56.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:40:0) after 1m0s
[08:43:56.847] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:40:0)
[08:43:56.847] Timer tick, asking Buildbucket for the build status
[08:43:57.006] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:57.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:41:0) after 1m0s
[08:44:57.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:41:0)
[08:44:57.029] Timer tick, asking Buildbucket for the build status
[08:44:57.269] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:57.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:42:0) after 1m0s
[08:45:57.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:42:0)
[08:45:57.282] Timer tick, asking Buildbucket for the build status
[08:45:57.414] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:57.414] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:43:0) after 1m0s
[08:46:57.503] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:43:0)
[08:46:57.503] Timer tick, asking Buildbucket for the build status
[08:46:57.659] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:57.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:44:0) after 1m0s
[08:47:57.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:44:0)
[08:47:57.770] Timer tick, asking Buildbucket for the build status
[08:47:57.883] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:57.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:45:0) after 1m0s
[08:48:57.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:45:0)
[08:48:57.906] Timer tick, asking Buildbucket for the build status
[08:48:58.026] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:58.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:46:0) after 1m0s
[08:49:58.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:46:0)
[08:49:58.077] Timer tick, asking Buildbucket for the build status
[08:49:58.204] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:58.204] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:47:0) after 1m0s
[08:50:58.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:47:0)
[08:50:58.278] Timer tick, asking Buildbucket for the build status
[08:50:58.401] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:58.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:48:0) after 1m0s
[08:51:58.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:48:0)
[08:51:58.457] Timer tick, asking Buildbucket for the build status
[08:51:58.534] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:58.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:49:0) after 1m0s
[08:52:58.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:49:0)
[08:52:58.696] Timer tick, asking Buildbucket for the build status
[08:52:58.760] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:58.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:50:0) after 1m0s
[08:53:58.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:50:0)
[08:53:58.889] Timer tick, asking Buildbucket for the build status
[08:53:58.970] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:58.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:51:0) after 1m0s
[08:54:59.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:51:0)
[08:54:59.144] Timer tick, asking Buildbucket for the build status
[08:54:59.272] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:59.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:52:0) after 1m0s
[08:55:59.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:52:0)
[08:55:59.357] Timer tick, asking Buildbucket for the build status
[08:55:59.534] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:59.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:53:0) after 1m0s
[08:56:59.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:53:0)
[08:56:59.625] Timer tick, asking Buildbucket for the build status
[08:56:59.702] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:59.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:54:0) after 1m0s
[08:57:59.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:54:0)
[08:57:59.814] Timer tick, asking Buildbucket for the build status
[08:57:59.894] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:59.894] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:55:0) after 1m0s
[08:58:59.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:55:0)
[08:58:59.916] Timer tick, asking Buildbucket for the build status
[08:58:59.974] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:59.974] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:56:0) after 1m0s
[08:59:59.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:56:0)
[08:59:59.996] Timer tick, asking Buildbucket for the build status
[09:00:00.202] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:00.202] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:57:0) after 1m0s
[09:01:00.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:57:0)
[09:01:00.266] Timer tick, asking Buildbucket for the build status
[09:01:00.366] Build 8858235701711095808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:00.366] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023665763852366560:58:0) after 1m0s
[09:01:27.591] Received PubSub notification, asking Buildbucket for the build status
[09:01:27.711] Build 8858235701711095808: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:01:27.711] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610528485233909",
"created_by": "project:chromium",
"created_ts": "1610525144813721",
"id": "8858235701711095808",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e0677971e2f893ba07381b363fb1928c25b3060\"}}",
"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\": \"8e0677971e2f893ba07381b363fb1928c25b3060\", \"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-8-wwgq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16793, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"2ed9671a0dddaab9c2582b62d3e479895ee0d333\", \"got_dawn_revision\": \"7faa362ea9c2bffbb8e9cc2e2d9f4f4af2fe4dde\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"8e0677971e2f893ba07381b363fb1928c25b3060\", \"got_revision_cp\": \"refs/heads/master@{#842924}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"1e60bce4522aa7c92b1010988f8815f96c8243b7\", \"got_v8_revision_cp\": \"refs/heads/8.9.257@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"8e0677971e2f893ba07381b363fb1928c25b3060\", \"swarm_hashes_refs/heads/master(at){#842924}_without_patch\": {\"absl_hardening_tests\": \"1ef04d65afd764da8e896aeba26aada62e6909f3\", \"accessibility_unittests\": \"7b293b4bdc40ab529fc9b94693ed82192319fa15\", \"angle_unittests\": \"55360ef4f7ede6186ee037170e24cdec374213f5\", \"app_shell_unittests\": \"2f16766d896d532cb4461174d716c1bc60bc9f86\", \"aura_unittests\": \"6cb350b164ecc9ca3b2ce04c3d201b931114506c\", \"base_unittests\": \"59683a84ce2848d2ffcec8d9342c48c940455c9f\", \"base_util_unittests\": \"3737961d0c8907433d49c3c79757dfa42e8e044e\", \"blink_common_unittests\": \"d1b4bf7f4f0c32af0bd9292aedd8a363ae46e0cf\", \"blink_fuzzer_unittests\": \"4aee234a4cf65905d067961fc26e3bd8e4c5453d\", \"blink_heap_unittests\": \"0b7ddb805bb8792f00b09af9f7fb1df2cb3e05b8\", \"blink_platform_unittests\": \"8c4cbf66a7cd4035b6c25ffb36b43932160cb6eb\", \"blink_unittests\": \"ac7aeb5a1332cee63ee3b8f5ead561edf163be04\", \"boringssl_crypto_tests\": \"5ee30f498c0f5848954b33a14a1e19c67cec788d\", \"boringssl_ssl_tests\": \"ee8da5a346cba968462f7108f0783dfd697f9e1a\", \"browser_switcher_bho_unittests\": \"7b8bc711ffb6bead9b12b397a47bae67cb5f6cb3\", \"browser_tests\": \"16ac4980cb4faf913f0864cb27de19450352b2e5\", \"capture_unittests\": \"24dbb5f0952082e32a22e56e08d43c16d9e6e043\", \"cast_unittests\": \"4ea453b608723b14d94235ee04989d05eb9e73d6\", \"cc_unittests\": \"0f907fc722e228b720b035c3bc361c57ace334bd\", \"chrome_app_unittests\": \"c0ebe64b3b1c4daef2d794a8dd8f42b210f6b847\", \"chrome_cleaner_unittests\": \"b8c44e9a53bb99c2ce40ff5984e6b52d770b882a\", \"chrome_elf_unittests\": \"f96575625c0754ec7f9c3f8abd1b6db8d89f9cfa\", \"chromedriver_unittests\": \"e05bb5a95f28bfc5d4c6cf851d28b788883ec48f\", \"components_browsertests\": \"257fbc5d6e8d522530f7489263ffde7f4efbf831\", \"components_unittests\": \"42febdbda071a184fb196628b2b69f9131d1d5c1\", \"compositor_unittests\": \"19f720e4365615aff5491f4e0fa2a8327cc1e80b\", \"content_browsertests\": \"422d8bc8982a62fe7d5f39c1d668c1de406e4ff5\", \"content_unittests\": \"21efef5089853b2f9745b9aa00e161a1f3727524\", \"courgette_unittests\": \"098be4bf12255bab4f09da15b9478f91f5aa7040\", \"crashpad_tests\": \"361cc0081fa38be3532c6c97962a28b6e246ccea\", \"cronet_tests\": \"ea55d73aa0410d382b0be9c06df23cfa33e7def5\", \"cronet_unittests\": \"4132a5d142d76905ce9f4a42e0bc4692052c9871\", \"crypto_unittests\": \"adb7ab3f67626e0925d8d0be0410ea6582422342\", \"delayloads_unittests\": \"59b4c9561bbe3320177d396e970357a45b572c26\", \"device_unittests\": \"fee5759aba2b823e6252f965f467e06b1eaf463b\", \"display_unittests\": \"b1b5695fb0ce96f04319ea96f3036ff573ab8fb4\", \"elevation_service_unittests\": \"9f40e1065f9123c78f77deacae8272eac4ede739\", \"events_unittests\": \"c9588a7896b9543ef811169508094931545a3dea\", \"extensions_browsertests\": \"a1e9157113f1491e127a42e9733be88661f61503\", \"extensions_unittests\": \"dad9a09068fa10fbe31f31bf509357639224128c\", \"filesystem_service_unittests\": \"e520f364def20584f971b93ea66a5b33ec923c37\", \"gcm_unit_tests\": \"f480005d4b4ebf3be6ca1a255ec32540c5751600\", \"gcp_unittests\": \"7e8add18a59b3fc9ea1ffca421e39d03d6b1a867\", \"gfx_unittests\": \"eb05b5c26403b820de617102b1aed3829634e20c\", \"gin_unittests\": \"3915b6d9fbce402fdb0381493218e45b19210b06\", \"google_apis_unittests\": \"76f16064b04856017abf64bc5c859e3083ba5f0e\", \"gpu_unittests\": \"666bccfc0bb351b39c63ea81788f82ab84c2ecd4\", \"gwp_asan_unittests\": \"15a1f0574f29e720be5b43fa47ee06d9e0434f18\", \"headless_browsertests\": \"fc239800022a2f7156ce23971b727ae2f47ac581\", \"headless_unittests\": \"e1ef9f6df7d0001ad356403b4f4d39cc9c79cc90\", \"install_static_unittests\": \"665d747ee0c6b437221113486535f95d2f306097\", \"installer_util_unittests\": \"daabe8ff0efdc13f709af7b8e6352a1cad975b85\", \"interactive_ui_tests\": \"1067f0e78dba412ebcef24596df01596224a2d46\", \"ipc_tests\": \"e623ee383a4e525ebf2d8d9c6f6225f71841bfa1\", \"jingle_unittests\": \"02ea5b780522a99d2f4b19889a86c169a27bba71\", \"latency_unittests\": \"4a545a948e5847582ce7f1583826b232969db3c1\", \"libjingle_xmpp_unittests\": \"93b6af5404d60342d6fafa3f75628cd13d783970\", \"liburlpattern_unittests\": \"62e961b1330c1644b0d3affbb61d654378d011af\", \"media_blink_unittests\": \"7beb2e502758dd751bcc55a6f80a507b231d444b\", \"media_unittests\": \"0ad88163ec1ee736988e842b00fa546cd61f1980\", \"message_center_unittests\": \"5df5216e534c7ebf934983dc6fe83ea4473db78d\", \"midi_unittests\": \"5b17e444f83f7d2aadeacf9f3f870e20c7cf736c\", \"mojo_core_unittests\": \"a00b4b89d31be2ef0e6e41c059f16e5c5d3bc3ac\", \"mojo_unittests\": \"468411093fab3e0ab71ccc334ee2534d4bc3b6a8\", \"nacl_loader_unittests\": \"b8a45baed18173aa9766a86576441df00b95d067\", \"native_theme_unittests\": \"399cec9421f8bbe18a63b7d09abaf086a9c55dfd\", \"net_unittests\": \"bbfd42d9d551678c58cf2b497f0ea92856be398a\", \"notification_helper_unittests\": \"4b33c8c96812c3f3574db3badc80a7374a008280\", \"pdf_unittests\": \"d10950420967033b6665eb66c005bc28e6e6d532\", \"perfetto_unittests\": \"390f48362389f5bdccdb0cfb1480c57c5f2cab07\", \"ppapi_unittests\": \"401c1c58c040cbc3e7933566c5126f6264fcd6f3\", \"printing_unittests\": \"f458c2aaf86aadf973962983982b47575744ed8d\", \"remoting_unittests\": \"5dab7f9299abdd7c115c7b31bb53a19ac2289c26\", \"sbox_integration_tests\": \"63f3f07972685db3e67474c11c9144490ba3d089\", \"sbox_unittests\": \"013a8f0f93a07a08be956ee47c608e8d190523b1\", \"sbox_validation_tests\": \"80bb28f3ae967686eab469f9cfb08f4c0a6ac8dc\", \"service_manager_unittests\": \"30f196599f990dee7da8ce2569dfb9821b4728e3\", \"services_unittests\": \"062aa844eeea35d50d16fdb276640832893edfe9\", \"setup_unittests\": \"1e41e24dc536eea73640249f4058b16899626ebf\", \"shell_dialogs_unittests\": \"3d99ba838e5c2ff9489b8e83bb7117f332cd1250\", \"skia_unittests\": \"302679d75f48a4d8ca61f7268fb15d512005a766\", \"snapshot_unittests\": \"8c294a31940f011792967c4f6fd811d756a6f9bf\", \"sql_unittests\": \"6385b5245ef97c28b769d16b2019b293e544e5ff\", \"storage_unittests\": \"3c4c11d0f4f0d34adc8cf41efe758f606fd715af\", \"sync_integration_tests\": \"901bde2dc59c434734de324dde5ac287abd7dcfe\", \"traffic_annotation_auditor_unittests\": \"627fa665b562c32cd1eb45d7cb6ce2dd50852826\", \"ui_base_unittests\": \"b5ea8b5897a956cea4c3f15e505654fba391aa45\", \"ui_touch_selection_unittests\": \"b549fc0e4a211e68f7db05163db4e4ad2abc2fe5\", \"unit_tests\": \"9d85830a878cf4c30f444130b2f472bb8bb1a305\", \"updater_tests\": \"c2cf226f863acd6d24e8b3c36c48309ffe809404\", \"url_unittests\": \"9d1001babf56d179435c7af8624eb9a15bf9a6e1\", \"views_unittests\": \"810586e5efe0f337c7e152e54e5d22e81c422412\", \"viz_unittests\": \"53eff4b5283596f5bdc0279b7fd22a70631e628f\", \"vr_common_unittests\": \"b67cb33cff1d3ef13966dd2c87796ced8ad68349\", \"vr_pixeltests\": \"4a71f9f7a2508872d400785739cb8416f4b65dfd\", \"weblayer_browsertests\": \"f15245f844c12c3a18b4a9c6314ba5182e58cc44\", \"weblayer_unittests\": \"ff2030e2d7363131cfa2585d1520bcb37863fa92\", \"wm_unittests\": \"9fc0ea5ef538a45b4a3ac0b2a701ccb12e5ee32d\", \"wtf_unittests\": \"17db666c4cb3998f81ada084a12c7df7e4a86d61\", \"zlib_unittests\": \"eac41890e5ef08112a0c18acda29c480652e0f6d\", \"zucchini_unittests\": \"feb6cc47956e67508e476dd2ec0bd9e27a1b3704\"}}, \"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-8-wwgq\"], \"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\": [\"5661-c6f6250\"], \"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": "1610525148199122",
"status": "COMPLETED",
"status_changed_ts": "1610528485926725",
"tags": [
"build_address:luci.chromium.ci/win-asan/16793",
"builder:win-asan",
"buildset:commit/git/8e0677971e2f893ba07381b363fb1928c25b3060",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e0677971e2f893ba07381b363fb1928c25b3060",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023665763852366560",
"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/8858235701711095808/+/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:51139903773ca610",
"user_agent:luci-scheduler"
],
"updated_ts": "1610528486016437",
"url": "https://ci.chromium.org/b/8858235701711095808",
"utcnow_ts": "1610528487699933"
}
}
[09:01:27.711] Invocation finished in 55m44.323858838s with status SUCCEEDED