[11:34:00.502] New invocation is queued and will start shortly
[11:34:02.508] Starting the invocation (attempt 1)
[11:34:02.544] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:34:02.544] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:34:02.544] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026008180820833616",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9912c91aaef47eb7d177f24790f14eb4d5d87973\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9026008180820833616",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/9912c91aaef47eb7d177f24790f14eb4d5d87973",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9912c91aaef47eb7d177f24790f14eb4d5d87973",
"gitiles_ref:refs/heads/master"
]
}
[11:34:03.276] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608291242658982",
"id": "8860578117896395520",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9912c91aaef47eb7d177f24790f14eb4d5d87973\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608291243022187",
"tags": [
"build_address:luci.chromium.ci/win-asan/16299",
"builder:win-asan",
"buildset:commit/git/9912c91aaef47eb7d177f24790f14eb4d5d87973",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9912c91aaef47eb7d177f24790f14eb4d5d87973",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026008180820833616",
"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/8860578117896395520/+/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": "1608291243022447",
"url": "https://ci.chromium.org/b/8860578117896395520",
"utcnow_ts": "1608291243262735"
}
}
[11:34:03.276] Task URL: https://ci.chromium.org/b/8860578117896395520
[11:34:03.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:2:0) after 1m0s
[11:34:14.216] Received PubSub notification, asking Buildbucket for the build status
[11:34:14.284] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:03.301] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:2:0)
[11:35:03.301] Timer tick, asking Buildbucket for the build status
[11:35:03.486] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:03.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:4:0) after 1m0s
[11:36:03.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:4:0)
[11:36:03.504] Timer tick, asking Buildbucket for the build status
[11:36:03.594] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:03.594] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:5:0) after 1m0s
[11:37:03.617] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:5:0)
[11:37:03.617] Timer tick, asking Buildbucket for the build status
[11:37:03.904] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:03.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:6:0) after 1m0s
[11:38:03.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:6:0)
[11:38:03.930] Timer tick, asking Buildbucket for the build status
[11:38:04.056] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:04.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:7:0) after 1m0s
[11:39:04.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:7:0)
[11:39:04.086] Timer tick, asking Buildbucket for the build status
[11:39:04.215] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:04.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:8:0) after 1m0s
[11:40:04.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:8:0)
[11:40:04.248] Timer tick, asking Buildbucket for the build status
[11:40:04.458] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:04.458] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:9:0) after 1m0s
[11:41:04.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:9:0)
[11:41:04.532] Timer tick, asking Buildbucket for the build status
[11:41:04.609] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:04.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:10:0) after 1m0s
[11:42:04.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:10:0)
[11:42:04.625] Timer tick, asking Buildbucket for the build status
[11:42:04.713] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:04.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:11:0) after 1m0s
[11:43:04.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:11:0)
[11:43:04.803] Timer tick, asking Buildbucket for the build status
[11:43:04.904] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:04.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:12:0) after 1m0s
[11:44:04.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:12:0)
[11:44:04.972] Timer tick, asking Buildbucket for the build status
[11:44:05.452] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:05.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:13:0) after 1m0s
[11:45:05.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:13:0)
[11:45:05.545] Timer tick, asking Buildbucket for the build status
[11:45:05.832] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:05.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:14:0) after 1m0s
[11:46:05.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:14:0)
[11:46:05.875] Timer tick, asking Buildbucket for the build status
[11:46:06.551] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:06.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:15:0) after 1m0s
[11:47:06.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:15:0)
[11:47:06.600] Timer tick, asking Buildbucket for the build status
[11:47:06.749] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:06.749] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:16:0) after 1m0s
[11:48:06.769] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:16:0)
[11:48:06.769] Timer tick, asking Buildbucket for the build status
[11:48:06.950] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:06.950] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:17:0) after 1m0s
[11:49:06.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:17:0)
[11:49:06.971] Timer tick, asking Buildbucket for the build status
[11:49:07.232] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:07.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:18:0) after 1m0s
[11:50:07.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:18:0)
[11:50:07.255] Timer tick, asking Buildbucket for the build status
[11:50:07.390] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:07.390] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:19:0) after 1m0s
[11:51:07.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:19:0)
[11:51:07.408] Timer tick, asking Buildbucket for the build status
[11:51:07.526] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:07.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:20:0) after 1m0s
[11:52:07.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:20:0)
[11:52:07.547] Timer tick, asking Buildbucket for the build status
[11:52:07.675] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:07.675] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:21:0) after 1m0s
[11:53:08.407] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:21:0)
[11:53:08.407] Timer tick, asking Buildbucket for the build status
[11:53:08.512] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:08.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:22:0) after 1m0s
[11:54:08.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:22:0)
[11:54:08.657] Timer tick, asking Buildbucket for the build status
[11:54:08.776] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:08.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:23:0) after 1m0s
[11:55:08.901] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:23:0)
[11:55:08.901] Timer tick, asking Buildbucket for the build status
[11:55:09.085] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:09.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:24:0) after 1m0s
[11:56:09.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:24:0)
[11:56:09.130] Timer tick, asking Buildbucket for the build status
[11:56:09.254] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:09.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:25:0) after 1m0s
[11:57:09.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:25:0)
[11:57:09.333] Timer tick, asking Buildbucket for the build status
[11:57:09.516] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:09.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:26:0) after 1m0s
[11:58:09.687] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:26:0)
[11:58:09.687] Timer tick, asking Buildbucket for the build status
[11:58:09.760] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:09.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:27:0) after 1m0s
[11:59:09.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:27:0)
[11:59:09.857] Timer tick, asking Buildbucket for the build status
[11:59:09.961] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:09.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:28:0) after 1m0s
[12:00:10.276] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:28:0)
[12:00:10.276] Timer tick, asking Buildbucket for the build status
[12:00:10.417] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:10.417] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:29:0) after 1m0s
[12:01:13.391] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:29:0)
[12:01:13.391] Timer tick, asking Buildbucket for the build status
[12:01:13.476] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:13.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:30:0) after 1m0s
[12:02:13.495] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:30:0)
[12:02:13.495] Timer tick, asking Buildbucket for the build status
[12:02:13.574] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:13.574] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:31:0) after 1m0s
[12:03:13.642] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:31:0)
[12:03:13.642] Timer tick, asking Buildbucket for the build status
[12:03:13.723] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:13.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:32:0) after 1m0s
[12:04:13.749] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:32:0)
[12:04:13.749] Timer tick, asking Buildbucket for the build status
[12:04:13.856] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:13.856] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:33:0) after 1m0s
[12:05:13.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:33:0)
[12:05:13.874] Timer tick, asking Buildbucket for the build status
[12:05:13.959] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:13.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:34:0) after 1m0s
[12:06:14.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:34:0)
[12:06:14.014] Timer tick, asking Buildbucket for the build status
[12:06:14.082] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:14.082] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:35:0) after 1m0s
[12:07:14.161] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:35:0)
[12:07:14.161] Timer tick, asking Buildbucket for the build status
[12:07:14.230] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:14.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:36:0) after 1m0s
[12:08:14.286] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:36:0)
[12:08:14.286] Timer tick, asking Buildbucket for the build status
[12:08:14.378] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:14.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:37:0) after 1m0s
[12:09:14.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:37:0)
[12:09:14.612] Timer tick, asking Buildbucket for the build status
[12:09:14.755] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:14.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:38:0) after 1m0s
[12:10:14.797] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:38:0)
[12:10:14.797] Timer tick, asking Buildbucket for the build status
[12:10:14.907] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:14.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:39:0) after 1m0s
[12:11:14.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:39:0)
[12:11:14.921] Timer tick, asking Buildbucket for the build status
[12:11:15.059] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:15.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:40:0) after 1m0s
[12:12:15.102] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:40:0)
[12:12:15.102] Timer tick, asking Buildbucket for the build status
[12:12:15.426] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:15.426] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:41:0) after 1m0s
[12:13:15.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:41:0)
[12:13:15.402] Timer tick, asking Buildbucket for the build status
[12:13:15.816] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:15.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:42:0) after 1m0s
[12:14:15.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:42:0)
[12:14:15.906] Timer tick, asking Buildbucket for the build status
[12:14:16.253] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:16.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:43:0) after 1m0s
[12:15:16.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:43:0)
[12:15:16.293] Timer tick, asking Buildbucket for the build status
[12:15:16.447] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:16.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:44:0) after 1m0s
[12:16:16.515] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:44:0)
[12:16:16.516] Timer tick, asking Buildbucket for the build status
[12:16:16.656] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:16.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:45:0) after 1m0s
[12:17:16.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:45:0)
[12:17:16.678] Timer tick, asking Buildbucket for the build status
[12:17:17.175] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:17.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:46:0) after 1m0s
[12:18:17.238] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:46:0)
[12:18:17.238] Timer tick, asking Buildbucket for the build status
[12:18:17.628] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:17.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:47:0) after 1m0s
[12:19:17.617] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:47:0)
[12:19:17.617] Timer tick, asking Buildbucket for the build status
[12:19:17.715] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:17.715] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:48:0) after 1m0s
[12:20:17.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:48:0)
[12:20:17.804] Timer tick, asking Buildbucket for the build status
[12:20:17.882] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:17.882] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:49:0) after 1m0s
[12:21:19.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:49:0)
[12:21:19.880] Timer tick, asking Buildbucket for the build status
[12:21:19.966] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:19.966] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:50:0) after 1m0s
[12:22:20.232] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:50:0)
[12:22:20.232] Timer tick, asking Buildbucket for the build status
[12:22:20.312] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:20.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:51:0) after 1m0s
[12:23:20.597] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:51:0)
[12:23:20.597] Timer tick, asking Buildbucket for the build status
[12:23:20.664] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:20.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:52:0) after 1m0s
[12:24:21.016] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:52:0)
[12:24:21.016] Timer tick, asking Buildbucket for the build status
[12:24:21.377] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:21.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:53:0) after 1m0s
[12:25:21.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:53:0)
[12:25:21.512] Timer tick, asking Buildbucket for the build status
[12:25:21.593] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:21.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:54:0) after 1m0s
[12:26:21.631] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:54:0)
[12:26:21.631] Timer tick, asking Buildbucket for the build status
[12:26:21.706] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:21.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:55:0) after 1m0s
[12:27:21.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:55:0)
[12:27:21.856] Timer tick, asking Buildbucket for the build status
[12:27:21.939] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:21.939] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:56:0) after 1m0s
[12:28:22.060] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:56:0)
[12:28:22.060] Timer tick, asking Buildbucket for the build status
[12:28:22.167] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:22.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:57:0) after 1m0s
[12:29:22.335] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:57:0)
[12:29:22.335] Timer tick, asking Buildbucket for the build status
[12:29:22.625] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:22.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:58:0) after 1m0s
[12:30:22.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:58:0)
[12:30:22.747] Timer tick, asking Buildbucket for the build status
[12:30:23.052] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:23.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:59:0) after 1m0s
[12:31:23.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:59:0)
[12:31:23.107] Timer tick, asking Buildbucket for the build status
[12:31:23.226] Build 8860578117896395520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:23.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026008180820833616:60:0) after 1m0s
[12:31:30.674] Received PubSub notification, asking Buildbucket for the build status
[12:31:31.628] Build 8860578117896395520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:31:31.628] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608294689674218",
"created_by": "project:chromium",
"created_ts": "1608291242658982",
"id": "8860578117896395520",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9912c91aaef47eb7d177f24790f14eb4d5d87973\"}}",
"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\": \"9912c91aaef47eb7d177f24790f14eb4d5d87973\", \"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-5-miap\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16299, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"c47b951ecbcbbba653db801bc7eb5f4fa5d72042\", \"got_dawn_revision\": \"64c5d601f89b7733091222796ff3631668fb2c25\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"9912c91aaef47eb7d177f24790f14eb4d5d87973\", \"got_revision_cp\": \"refs/heads/master@{#838443}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"68e7e8e44e2565c394ee558210d6d9fa5a4d80ff\", \"got_v8_revision_cp\": \"refs/heads/8.9.174@{#1}\", \"got_webrtc_revision\": \"2157c5d256c2c32995def0a67a448dd1928edef5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32861}\", \"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\": \"9912c91aaef47eb7d177f24790f14eb4d5d87973\", \"swarm_hashes_refs/heads/master(at){#838443}_without_patch\": {\"absl_hardening_tests\": \"854ae10a0a73d897d3c2837f3eddbe08f41ff582\", \"accessibility_unittests\": \"3ef5d663898ffaf41f5c14fb2c3fe4af1105379f\", \"angle_unittests\": \"06da09767846f92d7f0180281d5dbf80d5ee0528\", \"app_shell_unittests\": \"3215956618c4760c415b6116b5a292c44042ccbf\", \"aura_unittests\": \"4c6922ab4309f2b66fb03615302dc4658b2196e6\", \"base_unittests\": \"ec3434c27ca793aae7fc4b315e6b345b783ed66a\", \"base_util_unittests\": \"101c6e5050da3b144164486f2739e9c52c2c9204\", \"blink_common_unittests\": \"6e7fb9794f36d711af977ceaf086844246bf00dc\", \"blink_fuzzer_unittests\": \"24ead1aea8cbd045d0148a1edb22d8b256f8af3a\", \"blink_heap_unittests\": \"dd2f8c10dc2e526ca65de135a3e761239c4fdb28\", \"blink_platform_unittests\": \"d8f636c305a708de53090693c487a57e662a7877\", \"blink_unittests\": \"9e356a1b83aa7496d1ced26e488ba2886c388a1c\", \"boringssl_crypto_tests\": \"372e6cde463d62c392736f0ba5d5abfcd3c80d88\", \"boringssl_ssl_tests\": \"33c1075fb46c39a1956d347baa28669f25140c19\", \"browser_switcher_bho_unittests\": \"f99c21ce9eee4c5454bb25c7765689aef14cb69e\", \"browser_tests\": \"43296b295807e1413502c98d1658def768d8d00d\", \"capture_unittests\": \"2007d6cbea06808158948e1b76d42dcaf4d9ff52\", \"cast_unittests\": \"161fd16ba3dbeacf9a2c92c6c396e0d181597051\", \"cc_unittests\": \"95fd9c8fe1b946da5f0da2ee6f6807fe1fe8bb0e\", \"chrome_app_unittests\": \"10bd3b266e99cfa39f75b3503ad249dd1eb93d13\", \"chrome_cleaner_unittests\": \"c1839e20b28916824941f54e3551483f10ef4b70\", \"chrome_elf_unittests\": \"f7953e642909d94aa37cc7ab023f7363694e100e\", \"chromedriver_unittests\": \"5165e2365763dd3b95b3f0f281f6fb9d7884a2eb\", \"components_browsertests\": \"b217f56a6c94c61b8b8345cfd98322f3776ff13c\", \"components_unittests\": \"8ebdde40127f8091d48bfd8aed2f64ab04e5ae2b\", \"compositor_unittests\": \"3622a93c019a4e0c036fd25d7a4f3a46d81b703d\", \"content_browsertests\": \"af44c5e77f08de44f3456fafc23fa65ea5282163\", \"content_unittests\": \"015cb4391b3031457d21e9b535028f14ae8b9a1d\", \"courgette_unittests\": \"54173dd9ac2b518820737edecf3c331024c55e0c\", \"crashpad_tests\": \"1567afdcad6824e421bd3c5adb319e9b23bec6bb\", \"cronet_tests\": \"d84d4a0e6adad1e42369e425a516b22e67a409fc\", \"cronet_unittests\": \"7f4f604c96328a7adc1b301d520cae657d289638\", \"crypto_unittests\": \"55ed4ad48334db96be96e25102a4f6756c795c41\", \"delayloads_unittests\": \"4a8848b1b2ff9c6a918bf380aedb6caadb53b657\", \"device_unittests\": \"b5f75ed24d158140c14220c88153fd4e88e74e1e\", \"display_unittests\": \"49cd68f96e0dd79081cc45dea2fe5bd03457a5f3\", \"elevation_service_unittests\": \"fd22f985a2fc5d51cb2f10ae44994792c44b1d43\", \"events_unittests\": \"9206e93cf70bf33057c3605eacd29e79492036f3\", \"extensions_browsertests\": \"a814b343b20b17663f60a845a883f5d297d9e076\", \"extensions_unittests\": \"5c8aec6de82ab78ee54491a7e788d6471c3ddd4d\", \"filesystem_service_unittests\": \"43ee6a3f8699d36ed0378420881958d94e2b845b\", \"gcm_unit_tests\": \"5f81f5116943df94a4ed59c4667ba72f7fc57d85\", \"gcp_unittests\": \"9f8370eb956ab9956cde8990d602a201c43669ff\", \"gfx_unittests\": \"0230341e908597f03b15abcc96d216a080fa562b\", \"gin_unittests\": \"27c73ff14a48b16276590174e31776e8a4f23348\", \"google_apis_unittests\": \"5afba569f9c802d0464ed8ba978aa298ebf417aa\", \"gpu_unittests\": \"2c784c4f1fa3ad2c00dda47f03ea098be585c2cd\", \"gwp_asan_unittests\": \"e7885c46373f66908885f494084d3f5c0e545883\", \"headless_browsertests\": \"4c3f71d010e1fef3bd64ef44c9f640e5b56e75c1\", \"headless_unittests\": \"bdd26d4039ad7f30bf7f417628ade98fb1824dd1\", \"install_static_unittests\": \"9582d3cd591ad1d55bb248ec041700679d9e7cd3\", \"installer_util_unittests\": \"78c0baff17fa9d4cb137f5b94c1e359c9ec0db03\", \"interactive_ui_tests\": \"70dfb6e7ade91ad0291f60b487b9f1f6123a5832\", \"ipc_tests\": \"7b0cd9d808bf3c55e80c74a2d991c6a556926ddb\", \"jingle_unittests\": \"dc084b1d70f25e038629819e2296ebb71fd2b79b\", \"latency_unittests\": \"9f6fed2c0020be8f04a630b44c9381875b361184\", \"libjingle_xmpp_unittests\": \"2cb9a8afaf60cf5ce604249408e98bdbc875cdad\", \"liburlpattern_unittests\": \"f52e3080a1824a3db529011129b206de9b3104bb\", \"media_blink_unittests\": \"f716adb7025337ae595c65a736a77aad78e14d84\", \"media_unittests\": \"5b944731f2a2b67e46750de73447dafd93e6ee45\", \"message_center_unittests\": \"8ae0c89a7ae517ad8120c3b82cc40e1a74b6c0d6\", \"midi_unittests\": \"000eaa48403572258ecb4801db5fc59122e0771b\", \"mojo_core_unittests\": \"349e41d4189feb5a515bcaa042b209349a1e65e0\", \"mojo_unittests\": \"05c8b772646e8e8cf280ecd37463e33eef3fc715\", \"nacl_loader_unittests\": \"8cc7d6cc00650797d3f0cbed4d65fada38c510bf\", \"native_theme_unittests\": \"2bcc21638482e6551a0c96419ce94ce4baaf9b63\", \"net_unittests\": \"36b59b0f4a2e053a8bba7f2bfe8e19a92721e99b\", \"notification_helper_unittests\": \"4447b1b5efe4cebafda4969907be7d3251c80cb1\", \"pdf_unittests\": \"212ddf7ac2d01c3cc130c9cbec4c56d072999dc3\", \"perfetto_unittests\": \"03edb9d0c5ed34a4116a4250ff4972d6346862bf\", \"ppapi_unittests\": \"0babe4730ea39d2d0bb33f31111e5bb81b330440\", \"printing_unittests\": \"2d5b9b07d135cd5d237a26f1b9d5a33f10286026\", \"remoting_unittests\": \"b176a6628e74819c9b0d9b9ab44274fb55738266\", \"sbox_integration_tests\": \"5fb7fb962356bb582550be67ca0cf0faf179e299\", \"sbox_unittests\": \"473d26a44c2ac2b5ad74ec604574ac2a8326cbe1\", \"sbox_validation_tests\": \"567b1ec7a2244dec92047d7112705143c4e41503\", \"service_manager_unittests\": \"6b2adaa6c9e46a8ec103a025f6eb81213e2168ed\", \"services_unittests\": \"3ae473f47eb0ce257ca5b0d14347abda7893ffff\", \"setup_unittests\": \"6edc1b4e4761adc5caeef68fbec40296a72c5e11\", \"shell_dialogs_unittests\": \"2aa434f6a40f286e7c0cd34758ab2038b5109e29\", \"skia_unittests\": \"695b63921aabc1c28669d9c98fedd4e4c814b90d\", \"snapshot_unittests\": \"1a4060183739b373691dc26bb4736c50e01a0530\", \"sql_unittests\": \"2591be94a978a420159fdc01a51f518da88d0a66\", \"storage_unittests\": \"9dff6a1abfea51fd0fdb02579ca68c3e63089db7\", \"sync_integration_tests\": \"a891999b5de806af84b29101ffcd24efb7bb87c4\", \"traffic_annotation_auditor_unittests\": \"080d0602248272bd37d258f17850eacba7902fa9\", \"ui_base_unittests\": \"08b41c74d776b1a51704a30b6b3d6031add5ff67\", \"ui_touch_selection_unittests\": \"c5eb551029d2997d3d04368724d18673e5be4dd6\", \"unit_tests\": \"ef65c76ad8d4c22583fe8ca84f446639c312163e\", \"updater_tests\": \"eb661170a52483a33fac35a2f0ec6ca85d5452fe\", \"url_unittests\": \"fa2b0775d83e32365d3877efd42623f688bab357\", \"views_unittests\": \"38c5a2e686cb6caa1def0fc217b4489ade4afe01\", \"viz_unittests\": \"538aa8cce55656f957f9e43c3f4e1db6c8b28512\", \"vr_common_unittests\": \"b2fd14274005ca7aba87459c289dfad65e7605ca\", \"vr_pixeltests\": \"f50d7836cd5f0efb43a19dfda0b630b70690d198\", \"weblayer_browsertests\": \"3badf113cf9e0ec3ee17b20f075f813a9bf2d089\", \"weblayer_unittests\": \"ee8f5e35837a5d7c63a645cdabeaf552b859f6fa\", \"wm_unittests\": \"4ced5fe5b41c33025b101e5b847ebb13bfdd9399\", \"wtf_unittests\": \"1431973356ee8d5d6aafcae540c574fc6a5297b3\", \"zlib_unittests\": \"c86f6c133db126bb6616278cf82c8647d9222861\", \"zucchini_unittests\": \"161974ffbacb3eafbf4d17c07db5dd49b035c955\"}}, \"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-5-miap\"], \"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": "1608291253428620",
"status": "COMPLETED",
"status_changed_ts": "1608294690126069",
"tags": [
"build_address:luci.chromium.ci/win-asan/16299",
"builder:win-asan",
"buildset:commit/git/9912c91aaef47eb7d177f24790f14eb4d5d87973",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9912c91aaef47eb7d177f24790f14eb4d5d87973",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026008180820833616",
"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/8860578117896395520/+/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:508e7267b89efa10",
"user_agent:luci-scheduler"
],
"updated_ts": "1608294690130441",
"url": "https://ci.chromium.org/b/8860578117896395520",
"utcnow_ts": "1608294691617726"
}
}
[12:31:31.628] Invocation finished in 57m31.141709535s with status SUCCEEDED