[05:57:58.210] New invocation is queued and will start shortly
[05:57:59.286] Starting the invocation (attempt 1)
[05:57:59.318] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:57:59.318] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:57:59.319] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023492607459949984",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"95acd4f022b508d443420f3f3f90855c12ceb01c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9023492607459949984",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/95acd4f022b508d443420f3f3f90855c12ceb01c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95acd4f022b508d443420f3f3f90855c12ceb01c",
"gitiles_ref:refs/heads/master"
]
}
[05:58:00.157] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1610690279414962",
"id": "8858062545531917696",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95acd4f022b508d443420f3f3f90855c12ceb01c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610690279911726",
"tags": [
"build_address:luci.chromium.ci/win-asan/16831",
"builder:win-asan",
"buildset:commit/git/95acd4f022b508d443420f3f3f90855c12ceb01c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95acd4f022b508d443420f3f3f90855c12ceb01c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023492607459949984",
"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/8858062545531917696/+/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": "1610690279911871",
"url": "https://ci.chromium.org/b/8858062545531917696",
"utcnow_ts": "1610690280029465"
}
}
[05:58:00.157] Task URL: https://ci.chromium.org/b/8858062545531917696
[05:58:00.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:2:0) after 1m0s
[05:58:01.414] Received PubSub notification, asking Buildbucket for the build status
[05:58:01.516] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:00.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:2:0)
[05:59:00.153] Timer tick, asking Buildbucket for the build status
[05:59:01.220] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:01.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:4:0) after 1m0s
[06:00:01.238] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:4:0)
[06:00:01.238] Timer tick, asking Buildbucket for the build status
[06:00:01.340] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:01.340] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:5:0) after 1m0s
[06:01:01.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:5:0)
[06:01:01.475] Timer tick, asking Buildbucket for the build status
[06:01:01.837] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:01.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:6:0) after 1m0s
[06:02:01.887] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:6:0)
[06:02:01.887] Timer tick, asking Buildbucket for the build status
[06:02:02.311] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:02.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:7:0) after 1m0s
[06:03:02.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:7:0)
[06:03:02.326] Timer tick, asking Buildbucket for the build status
[06:03:02.842] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:02.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:8:0) after 1m0s
[06:04:02.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:8:0)
[06:04:02.858] Timer tick, asking Buildbucket for the build status
[06:04:03.174] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:03.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:9:0) after 1m0s
[06:05:03.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:9:0)
[06:05:03.221] Timer tick, asking Buildbucket for the build status
[06:05:03.466] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:03.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:10:0) after 1m0s
[06:06:03.511] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:10:0)
[06:06:03.511] Timer tick, asking Buildbucket for the build status
[06:06:03.575] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:03.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:11:0) after 1m0s
[06:07:03.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:11:0)
[06:07:03.649] Timer tick, asking Buildbucket for the build status
[06:07:04.039] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:04.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:12:0) after 1m0s
[06:08:04.076] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:12:0)
[06:08:04.076] Timer tick, asking Buildbucket for the build status
[06:08:04.516] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:04.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:13:0) after 1m0s
[06:09:04.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:13:0)
[06:09:04.527] Timer tick, asking Buildbucket for the build status
[06:09:04.593] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:04.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:14:0) after 1m0s
[06:10:04.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:14:0)
[06:10:04.612] Timer tick, asking Buildbucket for the build status
[06:10:05.489] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:05.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:15:0) after 1m0s
[06:11:05.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:15:0)
[06:11:05.521] Timer tick, asking Buildbucket for the build status
[06:11:05.636] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:05.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:16:0) after 1m0s
[06:12:05.651] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:16:0)
[06:12:05.651] Timer tick, asking Buildbucket for the build status
[06:12:06.230] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:06.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:17:0) after 1m0s
[06:13:06.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:17:0)
[06:13:06.224] Timer tick, asking Buildbucket for the build status
[06:13:06.345] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:06.345] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:18:0) after 1m0s
[06:14:06.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:18:0)
[06:14:06.368] Timer tick, asking Buildbucket for the build status
[06:14:06.531] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:06.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:19:0) after 1m0s
[06:15:06.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:19:0)
[06:15:06.573] Timer tick, asking Buildbucket for the build status
[06:15:06.696] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:06.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:20:0) after 1m0s
[06:16:06.709] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:20:0)
[06:16:06.709] Timer tick, asking Buildbucket for the build status
[06:16:07.148] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:07.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:21:0) after 1m0s
[06:17:07.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:21:0)
[06:17:07.217] Timer tick, asking Buildbucket for the build status
[06:17:07.856] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:07.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:22:0) after 1m0s
[06:18:07.871] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:22:0)
[06:18:07.871] Timer tick, asking Buildbucket for the build status
[06:18:08.101] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:08.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:23:0) after 1m0s
[06:19:08.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:23:0)
[06:19:08.151] Timer tick, asking Buildbucket for the build status
[06:19:08.269] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:08.269] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:24:0) after 1m0s
[06:20:08.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:24:0)
[06:20:08.321] Timer tick, asking Buildbucket for the build status
[06:20:08.641] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:08.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:25:0) after 1m0s
[06:21:08.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:25:0)
[06:21:08.715] Timer tick, asking Buildbucket for the build status
[06:21:08.799] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:08.799] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:26:0) after 1m0s
[06:22:08.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:26:0)
[06:22:08.844] Timer tick, asking Buildbucket for the build status
[06:22:08.951] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:08.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:27:0) after 1m0s
[06:23:09.020] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:27:0)
[06:23:09.020] Timer tick, asking Buildbucket for the build status
[06:23:09.309] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:09.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:28:0) after 1m0s
[06:24:09.382] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:28:0)
[06:24:09.382] Timer tick, asking Buildbucket for the build status
[06:24:09.532] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:09.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:29:0) after 1m0s
[06:25:09.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:29:0)
[06:25:09.557] Timer tick, asking Buildbucket for the build status
[06:25:10.820] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:10.820] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:30:0) after 1m0s
[06:26:10.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:30:0)
[06:26:10.873] Timer tick, asking Buildbucket for the build status
[06:26:11.026] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:11.026] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:31:0) after 1m0s
[06:27:11.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:31:0)
[06:27:11.112] Timer tick, asking Buildbucket for the build status
[06:27:11.281] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:11.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:32:0) after 1m0s
[06:28:11.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:32:0)
[06:28:11.362] Timer tick, asking Buildbucket for the build status
[06:28:12.201] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:12.201] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:33:0) after 1m0s
[06:29:12.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:33:0)
[06:29:12.248] Timer tick, asking Buildbucket for the build status
[06:29:12.614] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:12.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:34:0) after 1m0s
[06:30:12.692] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:34:0)
[06:30:12.692] Timer tick, asking Buildbucket for the build status
[06:30:13.102] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:13.102] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:35:0) after 1m0s
[06:31:13.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:35:0)
[06:31:13.292] Timer tick, asking Buildbucket for the build status
[06:31:13.377] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:13.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:36:0) after 1m0s
[06:32:13.508] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:36:0)
[06:32:13.508] Timer tick, asking Buildbucket for the build status
[06:32:13.571] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:13.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:37:0) after 1m0s
[06:33:13.773] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:37:0)
[06:33:13.773] Timer tick, asking Buildbucket for the build status
[06:33:13.887] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:13.888] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:38:0) after 1m0s
[06:34:14.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:38:0)
[06:34:14.116] Timer tick, asking Buildbucket for the build status
[06:34:14.233] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:14.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:39:0) after 1m0s
[06:35:14.354] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:39:0)
[06:35:14.354] Timer tick, asking Buildbucket for the build status
[06:35:14.641] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:14.641] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:40:0) after 1m0s
[06:36:14.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:40:0)
[06:36:14.639] Timer tick, asking Buildbucket for the build status
[06:36:15.241] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:15.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:41:0) after 1m0s
[06:37:15.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:41:0)
[06:37:15.287] Timer tick, asking Buildbucket for the build status
[06:37:15.833] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:15.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:42:0) after 1m0s
[06:38:15.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:42:0)
[06:38:15.857] Timer tick, asking Buildbucket for the build status
[06:38:16.001] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:16.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:43:0) after 1m0s
[06:39:16.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:43:0)
[06:39:16.873] Timer tick, asking Buildbucket for the build status
[06:39:17.016] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:17.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:44:0) after 1m0s
[06:40:17.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:44:0)
[06:40:17.044] Timer tick, asking Buildbucket for the build status
[06:40:17.230] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:17.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:45:0) after 1m0s
[06:41:17.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:45:0)
[06:41:17.386] Timer tick, asking Buildbucket for the build status
[06:41:17.535] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:17.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:46:0) after 1m0s
[06:42:17.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:46:0)
[06:42:17.545] Timer tick, asking Buildbucket for the build status
[06:42:17.910] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:17.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:47:0) after 1m0s
[06:43:18.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:47:0)
[06:43:18.099] Timer tick, asking Buildbucket for the build status
[06:43:18.270] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:18.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:48:0) after 1m0s
[06:44:18.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:48:0)
[06:44:18.367] Timer tick, asking Buildbucket for the build status
[06:44:18.448] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:18.448] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:49:0) after 1m0s
[06:45:18.430] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:49:0)
[06:45:18.430] Timer tick, asking Buildbucket for the build status
[06:45:18.505] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:18.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:50:0) after 1m0s
[06:46:18.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:50:0)
[06:46:18.576] Timer tick, asking Buildbucket for the build status
[06:46:18.712] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:18.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:51:0) after 1m0s
[06:47:18.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:51:0)
[06:47:18.731] Timer tick, asking Buildbucket for the build status
[06:47:18.915] Build 8858062545531917696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:18.915] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9023492607459949984:52:0) after 1m0s
[06:48:14.950] Received PubSub notification, asking Buildbucket for the build status
[06:48:15.302] Build 8858062545531917696: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:48:15.302] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1610693291303370",
"created_by": "project:chromium",
"created_ts": "1610690279414962",
"id": "8858062545531917696",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95acd4f022b508d443420f3f3f90855c12ceb01c\"}}",
"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\": \"95acd4f022b508d443420f3f3f90855c12ceb01c\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-3-nb2x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16831, \"clang_revision\": \"llvmorg-12-init-16296-g5e476061-1\", \"got_angle_revision\": \"50c82f42e33fe7b58b7fd8ad343d0c7c8245eedb\", \"got_dawn_revision\": \"5a6fda1a6fcc99553bab1411e2159cf962b6a36d\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"95acd4f022b508d443420f3f3f90855c12ceb01c\", \"got_revision_cp\": \"refs/heads/master@{#843965}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"aedd133cd85f40f92c304776d240a8a3503d1d71\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"7acc2d9fe3a6e3c4d8881d2bdfc9b8968a724cd5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32986}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"95acd4f022b508d443420f3f3f90855c12ceb01c\", \"swarm_hashes_refs/heads/master(at){#843965}_without_patch\": {\"absl_hardening_tests\": \"e80e92a86c11a52a4cf3f675de43aec506c9e3ea\", \"accessibility_unittests\": \"e97b53b91529f3d6cd63c5d60a13a8a4b5936e5d\", \"angle_unittests\": \"817566b5f3228621d1638dcb81fa3d6915556fd8\", \"app_shell_unittests\": \"76fc6de69ac270fa6b252a782d41b344f2c54519\", \"aura_unittests\": \"81dbc8a35a13ca4d1cd8013124388dd80ec0f140\", \"base_unittests\": \"d5ec61e37be17907ec096826bd30ab6eee527cd2\", \"base_util_unittests\": \"531aa59189cf3c84d9310590aa31901cf8fab6be\", \"blink_common_unittests\": \"9af69a9a9f66ac54deba6b2fa722da373d15d293\", \"blink_fuzzer_unittests\": \"fd8864f5a515997740ff847a6d1600735b6c17b7\", \"blink_heap_unittests\": \"92f5846f12f64e64a63da5faa14b96e718aef474\", \"blink_platform_unittests\": \"28c105b289bc83dbd4dfb22b688bcc15823f76d0\", \"blink_unittests\": \"60c5b92d36fd8591bb01427dacd2aba120dc1340\", \"boringssl_crypto_tests\": \"b995521b6f19b3b11577bfa9e47f07c1b5caaf53\", \"boringssl_ssl_tests\": \"cdd021a97166d08e7f1c5650219ec2c0451fd25b\", \"browser_switcher_bho_unittests\": \"d59b8f24bd6d2d6214b7eb96648da77ae91641d1\", \"browser_tests\": \"d80c91e9567b727bd3c1cdab3029edff16b0e923\", \"capture_unittests\": \"2d4050e66d32aaefe3a64e7961c830c88803dde2\", \"cast_unittests\": \"17423f07370fcb506f8252703c9adf43105f6c26\", \"cc_unittests\": \"4f64094c67be62ee77dd3af1367a7bc409c382cc\", \"chrome_app_unittests\": \"2533c76a3baf2f22c88eb42d767a6b3eda802df7\", \"chrome_cleaner_unittests\": \"2f87823d5c2d6f6bf52871858b23b19b0591062f\", \"chrome_elf_unittests\": \"73001bd02fe30c32ca879ed62ccbe9e4f465355b\", \"chromedriver_unittests\": \"b07e020fc11403b850d4c33b4e33c1fdf7a7e4a4\", \"components_browsertests\": \"03cae74473442b6c9286ee90390103db71d09a53\", \"components_unittests\": \"47692a6832fa0f785e07b588c47ae9b8da1242ee\", \"compositor_unittests\": \"5b51ab5dee44d7aefeebe7bade5b5a252293fb4c\", \"content_browsertests\": \"5f1438f2b72e8deb85061ecff1aac91d6974833a\", \"content_unittests\": \"190807c9aa01f34e3eccc41d91d304865e2fb0c9\", \"courgette_unittests\": \"b8b6c92c7b06b4d764c063717d0a5955a98de60b\", \"crashpad_tests\": \"06220aa4edecc39e23a185493813b2c21b5b94fd\", \"cronet_tests\": \"6edd595ed3da1563ff92708a4bc09aef633f85d5\", \"cronet_unittests\": \"0979f8c20e217f4154498e353dfdffb746d4676d\", \"crypto_unittests\": \"e2b0d161341807935eac59ec866a6fcea383d0ed\", \"delayloads_unittests\": \"17c7d2f6406b6c151e1c7d6485b4e66dd9442f3b\", \"device_unittests\": \"ad8c27e02f2319594978f1d1030924ab2837be74\", \"display_unittests\": \"9c722805aed7d61e93a26f68502fbdbe8199b455\", \"elevation_service_unittests\": \"44fd8c55a851f3d311f2ed3e7e6804846a1a04e2\", \"events_unittests\": \"afd23e66f5d9ffd45dd1656eba4d271ec906b221\", \"extensions_browsertests\": \"c1be2fe01219a1114e392e3290f91db9cc23268c\", \"extensions_unittests\": \"f84c1dbf870070c27ddc91f89517c35af6bd382a\", \"filesystem_service_unittests\": \"1a0a90ec0e5e56ae3e1106d44d642ed86eb571b7\", \"gcm_unit_tests\": \"285c89def9ea88b9f6ee07233f31a93ba9f2f372\", \"gcp_unittests\": \"c00695c269aefdaffd2f9ba2703ee1fac7db1522\", \"gfx_unittests\": \"2d083b85f07a2d71de649de42aa8784ea23ebd21\", \"gin_unittests\": \"a36ae523b97dbe94b0fdea36d7b2f8f8f921d8c6\", \"google_apis_unittests\": \"64c08dfd14d303371f34692d2e24838649f3ecfe\", \"gpu_unittests\": \"2f5f9540a2c8e512444b0d4fb3c53035ffe278a7\", \"gwp_asan_unittests\": \"6d1b502b740bf4628309e3c928dcff3d0295e956\", \"headless_browsertests\": \"7b98151ed9a6d9b2c233577298604da164fa23fe\", \"headless_unittests\": \"3d19edb7f803eaa0ecbb554f64e11ad656340063\", \"install_static_unittests\": \"d49b57e36d9f580b2207b3a09bab7dc64c1c508a\", \"installer_util_unittests\": \"e55b9677da32982925ac69facb80950a4cf424e9\", \"interactive_ui_tests\": \"433137866a0093da8f3cc18f24bed56044a983df\", \"ipc_tests\": \"04b29ea2dcac58398dc589b81059bb615997fce1\", \"jingle_unittests\": \"65a1cc02c214c4e42ce76694360b7d7dfe587142\", \"latency_unittests\": \"a52d62052f352647292a56f64c43126e68a233f8\", \"libjingle_xmpp_unittests\": \"195c09bcc503e019af953742f15d87e622df0ee4\", \"liburlpattern_unittests\": \"495c955f01e6fdcdefb5d15c755815bb921457ca\", \"media_blink_unittests\": \"97104c26008b4c37eb4af5e7cc2681c92cda49d2\", \"media_unittests\": \"e03a55385acecf88615dd6057240b5f4d5daffce\", \"message_center_unittests\": \"f153e247234bd29113d562d31e740b246bf2fee7\", \"midi_unittests\": \"63ef9c56554fdcd74f5124fb04fc6dcc32676df1\", \"mojo_core_unittests\": \"f6710360f13b359ca507b66bfd8b784e8620216d\", \"mojo_unittests\": \"e96619bc9f8b7157cf897e2f515794b59fe3936f\", \"nacl_loader_unittests\": \"fd8d519c4d979cfea7f88a479c011cde6d0f085f\", \"native_theme_unittests\": \"8fa744daed3b6d49bbfc8be6e5464283535de457\", \"net_unittests\": \"a399dd2d37a063a87dc1fb0ed51cdc7c8914d67b\", \"notification_helper_unittests\": \"4a357c04c64889b14f893836f792fae39c0210a5\", \"pdf_unittests\": \"a2121972532311dde1904cbef944fcca610dd50e\", \"perfetto_unittests\": \"624ce3abbe2f373f9756a323bfb69ca848cc380c\", \"ppapi_unittests\": \"4568f0463abc8a59ff24b0a44a931625dd93c923\", \"printing_unittests\": \"99b068ee9cce2233445338e6de12a77de56e8e97\", \"remoting_unittests\": \"bfb716d024bb00f587e58cd923bf816679438781\", \"sbox_integration_tests\": \"b97a238235ba2e9b70ff904ee1cfcd5b6dca02dc\", \"sbox_unittests\": \"e6384c634732dc697d9968a7896a260ce5f4ba80\", \"sbox_validation_tests\": \"a445ad3b3d19612cdc2cf663ec2fb4c9a5646b8d\", \"service_manager_unittests\": \"fb503dfe95a0cc5d042f7a5a3bb4a2045e990460\", \"services_unittests\": \"46b24df1267f736c43fdac980a5dfa8c9044ae03\", \"setup_unittests\": \"b538b35b98c37a26337f606ee3458d36ae5aec7b\", \"shell_dialogs_unittests\": \"cb2d01d211d020d6d7b48968fee4461ce1a3d294\", \"skia_unittests\": \"819b1ea362c95a27279001f2bee92b9bd1eb2aee\", \"snapshot_unittests\": \"d1923eb87b6baea5f4dd56629fed46078fb2a79b\", \"sql_unittests\": \"e5adab62a9ed29fb63800cf9acc67796c9ed1425\", \"storage_unittests\": \"084814b55c451e428ffc2dde62c3bd856e3df93c\", \"sync_integration_tests\": \"67c487a4560d17cc6173bebaee70b0254053b62a\", \"traffic_annotation_auditor_unittests\": \"5ca5b0dfb6e577335278e6a58d35ac57539b9360\", \"ui_base_unittests\": \"1c7354c1a236904ed64f8a0d53a155fcd8dd7d6b\", \"ui_touch_selection_unittests\": \"b6b145b23a57795be36b7e3dc32a59d7cbf367c3\", \"unit_tests\": \"65509bf9b2fd1371441fb9ab9494c27993b8bd1e\", \"updater_tests\": \"709856ed84993da87b0c2d3e38608a48be65c13a\", \"url_unittests\": \"ca5c3c0079d3547037355463520ce302894f4548\", \"views_unittests\": \"454e0dc235711ca7c633b4e2fa37605ae3d0b04b\", \"viz_unittests\": \"fc18be5ef0b03acee2ccdc67838f4a7c1ea9ecd1\", \"vr_common_unittests\": \"6dc684faa6dea9dc51183160b48121edee6b6c10\", \"vr_pixeltests\": \"c66fc9132f0611893b673d51f7e2de69d25e9dc0\", \"weblayer_browsertests\": \"4082fe7d73f3da9f5f282ec1ce67912e502112f7\", \"weblayer_unittests\": \"b7517fe69587d695fbe1d25a167fac41723c1008\", \"wm_unittests\": \"746894649b5a430ddc29adb20b325e7ae0079a54\", \"wtf_unittests\": \"7148c4bd5d2c4ff25d6a82e0e95b116d61b2b788\", \"zlib_unittests\": \"2bac7ff559dcb01788a3ee11922da5c6ce43ca1e\", \"zucchini_unittests\": \"e4aae04e68d3e116a1918ef7332ae6230c43894f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-nb2x\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610690280478864",
"status": "COMPLETED",
"status_changed_ts": "1610693291802984",
"tags": [
"build_address:luci.chromium.ci/win-asan/16831",
"builder:win-asan",
"buildset:commit/git/95acd4f022b508d443420f3f3f90855c12ceb01c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/95acd4f022b508d443420f3f3f90855c12ceb01c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023492607459949984",
"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/8858062545531917696/+/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:511d70c2ebc4f610",
"user_agent:luci-scheduler"
],
"updated_ts": "1610693291816883",
"url": "https://ci.chromium.org/b/8858062545531917696",
"utcnow_ts": "1610693295235050"
}
}
[06:48:15.302] Invocation finished in 50m17.111012071s with status SUCCEEDED