[21:49:37.212] New invocation is queued and will start shortly
[21:49:38.975] Starting the invocation (attempt 1)
[21:49:39.015] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:49:39.015] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:49:39.015] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024701092343417984",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dfbe34f3268650f7b38d06aabf9cdd698285f254\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9024701092343417984",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/dfbe34f3268650f7b38d06aabf9cdd698285f254",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dfbe34f3268650f7b38d06aabf9cdd698285f254",
"gitiles_ref:refs/heads/master"
]
}
[21:49:39.634] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609537779146392",
"id": "8859271029652492064",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dfbe34f3268650f7b38d06aabf9cdd698285f254\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609537779530987",
"tags": [
"build_address:luci.chromium.ci/win-asan/16582",
"builder:win-asan",
"buildset:commit/git/dfbe34f3268650f7b38d06aabf9cdd698285f254",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dfbe34f3268650f7b38d06aabf9cdd698285f254",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024701092343417984",
"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/8859271029652492064/+/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": "1609537779531091",
"url": "https://ci.chromium.org/b/8859271029652492064",
"utcnow_ts": "1609537779627664"
}
}
[21:49:39.634] Task URL: https://ci.chromium.org/b/8859271029652492064
[21:49:39.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:2:0) after 1m0s
[21:49:44.227] Received PubSub notification, asking Buildbucket for the build status
[21:49:44.304] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:39.683] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:2:0)
[21:50:39.683] Timer tick, asking Buildbucket for the build status
[21:50:39.745] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:39.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:4:0) after 1m0s
[21:51:39.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:4:0)
[21:51:39.826] Timer tick, asking Buildbucket for the build status
[21:51:39.925] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:39.925] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:5:0) after 1m0s
[21:52:40.059] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:5:0)
[21:52:40.059] Timer tick, asking Buildbucket for the build status
[21:52:40.175] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:40.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:6:0) after 1m0s
[21:53:40.252] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:6:0)
[21:53:40.252] Timer tick, asking Buildbucket for the build status
[21:53:40.342] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:40.342] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:7:0) after 1m0s
[21:54:40.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:7:0)
[21:54:40.589] Timer tick, asking Buildbucket for the build status
[21:54:40.707] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:40.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:8:0) after 1m0s
[21:55:40.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:8:0)
[21:55:40.964] Timer tick, asking Buildbucket for the build status
[21:55:41.019] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:41.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:9:0) after 1m0s
[21:56:41.123] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:9:0)
[21:56:41.123] Timer tick, asking Buildbucket for the build status
[21:56:41.347] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:41.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:10:0) after 1m0s
[21:57:41.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:10:0)
[21:57:41.401] Timer tick, asking Buildbucket for the build status
[21:57:41.577] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:41.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:11:0) after 1m0s
[21:58:41.653] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:11:0)
[21:58:41.653] Timer tick, asking Buildbucket for the build status
[21:58:41.746] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:41.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:12:0) after 1m0s
[21:59:41.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:12:0)
[21:59:41.876] Timer tick, asking Buildbucket for the build status
[21:59:41.958] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:41.958] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:13:0) after 1m0s
[22:00:42.058] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:13:0)
[22:00:42.058] Timer tick, asking Buildbucket for the build status
[22:00:42.125] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:42.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:14:0) after 1m0s
[22:01:42.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:14:0)
[22:01:42.163] Timer tick, asking Buildbucket for the build status
[22:01:42.219] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:42.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:15:0) after 1m0s
[22:02:42.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:15:0)
[22:02:42.317] Timer tick, asking Buildbucket for the build status
[22:02:42.384] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:42.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:16:0) after 1m0s
[22:03:42.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:16:0)
[22:03:42.432] Timer tick, asking Buildbucket for the build status
[22:03:42.827] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:42.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:17:0) after 1m0s
[22:04:42.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:17:0)
[22:04:42.836] Timer tick, asking Buildbucket for the build status
[22:04:43.625] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:43.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:18:0) after 1m0s
[22:05:43.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:18:0)
[22:05:43.600] Timer tick, asking Buildbucket for the build status
[22:05:44.038] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:44.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:19:0) after 1m0s
[22:06:44.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:19:0)
[22:06:44.104] Timer tick, asking Buildbucket for the build status
[22:06:44.289] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:44.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:20:0) after 1m0s
[22:07:44.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:20:0)
[22:07:44.304] Timer tick, asking Buildbucket for the build status
[22:07:44.432] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:44.432] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:21:0) after 1m0s
[22:08:44.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:21:0)
[22:08:44.466] Timer tick, asking Buildbucket for the build status
[22:08:44.539] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:44.539] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:22:0) after 1m0s
[22:09:44.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:22:0)
[22:09:44.615] Timer tick, asking Buildbucket for the build status
[22:09:44.713] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:44.713] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:23:0) after 1m0s
[22:10:44.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:23:0)
[22:10:44.731] Timer tick, asking Buildbucket for the build status
[22:10:44.884] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:44.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:24:0) after 1m0s
[22:11:44.951] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:24:0)
[22:11:44.951] Timer tick, asking Buildbucket for the build status
[22:11:45.693] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:45.693] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:25:0) after 1m0s
[22:12:45.783] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:25:0)
[22:12:45.783] Timer tick, asking Buildbucket for the build status
[22:12:46.457] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:46.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:26:0) after 1m0s
[22:13:46.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:26:0)
[22:13:46.469] Timer tick, asking Buildbucket for the build status
[22:13:46.839] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:46.839] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:27:0) after 1m0s
[22:14:46.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:27:0)
[22:14:46.888] Timer tick, asking Buildbucket for the build status
[22:14:46.994] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:46.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:28:0) after 1m0s
[22:15:47.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:28:0)
[22:15:47.099] Timer tick, asking Buildbucket for the build status
[22:15:47.193] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:47.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:29:0) after 1m0s
[22:16:47.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:29:0)
[22:16:47.214] Timer tick, asking Buildbucket for the build status
[22:16:47.567] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:47.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:30:0) after 1m0s
[22:17:47.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:30:0)
[22:17:47.583] Timer tick, asking Buildbucket for the build status
[22:17:47.788] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:47.788] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:31:0) after 1m0s
[22:18:47.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:31:0)
[22:18:47.804] Timer tick, asking Buildbucket for the build status
[22:18:48.120] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:48.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:32:0) after 1m0s
[22:19:48.149] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:32:0)
[22:19:48.150] Timer tick, asking Buildbucket for the build status
[22:19:48.417] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:48.418] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:33:0) after 1m0s
[22:20:48.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:33:0)
[22:20:48.492] Timer tick, asking Buildbucket for the build status
[22:20:49.311] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:49.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:34:0) after 1m0s
[22:21:49.420] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:34:0)
[22:21:49.420] Timer tick, asking Buildbucket for the build status
[22:21:49.499] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:49.499] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:35:0) after 1m0s
[22:22:49.569] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:35:0)
[22:22:49.569] Timer tick, asking Buildbucket for the build status
[22:22:49.639] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:49.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:36:0) after 1m0s
[22:23:49.658] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:36:0)
[22:23:49.658] Timer tick, asking Buildbucket for the build status
[22:23:49.741] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:49.741] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:37:0) after 1m0s
[22:24:49.828] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:37:0)
[22:24:49.828] Timer tick, asking Buildbucket for the build status
[22:24:50.108] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:50.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:38:0) after 1m0s
[22:25:50.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:38:0)
[22:25:50.211] Timer tick, asking Buildbucket for the build status
[22:25:50.277] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:50.277] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:39:0) after 1m0s
[22:26:50.250] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:39:0)
[22:26:50.250] Timer tick, asking Buildbucket for the build status
[22:26:50.408] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:50.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:40:0) after 1m0s
[22:27:50.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:40:0)
[22:27:50.475] Timer tick, asking Buildbucket for the build status
[22:27:50.573] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:50.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:41:0) after 1m0s
[22:28:50.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:41:0)
[22:28:50.618] Timer tick, asking Buildbucket for the build status
[22:28:50.818] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:50.818] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:42:0) after 1m0s
[22:29:50.817] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:42:0)
[22:29:50.817] Timer tick, asking Buildbucket for the build status
[22:29:50.920] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:50.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:43:0) after 1m0s
[22:30:50.906] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:43:0)
[22:30:50.906] Timer tick, asking Buildbucket for the build status
[22:30:51.022] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:51.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:44:0) after 1m0s
[22:31:51.043] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:44:0)
[22:31:51.043] Timer tick, asking Buildbucket for the build status
[22:31:51.296] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:51.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:45:0) after 1m0s
[22:32:51.314] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:45:0)
[22:32:51.314] Timer tick, asking Buildbucket for the build status
[22:32:51.407] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:51.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:46:0) after 1m0s
[22:33:51.456] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:46:0)
[22:33:51.456] Timer tick, asking Buildbucket for the build status
[22:33:51.632] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:51.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:47:0) after 1m0s
[22:34:51.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:47:0)
[22:34:51.714] Timer tick, asking Buildbucket for the build status
[22:34:51.875] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:51.875] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:48:0) after 1m0s
[22:35:51.945] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:48:0)
[22:35:51.945] Timer tick, asking Buildbucket for the build status
[22:35:52.022] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:52.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:49:0) after 1m0s
[22:36:52.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:49:0)
[22:36:52.049] Timer tick, asking Buildbucket for the build status
[22:36:52.117] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:52.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:50:0) after 1m0s
[22:37:52.282] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:50:0)
[22:37:52.282] Timer tick, asking Buildbucket for the build status
[22:37:52.420] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:52.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:51:0) after 1m0s
[22:38:52.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:51:0)
[22:38:52.612] Timer tick, asking Buildbucket for the build status
[22:38:52.667] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:52.667] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:52:0) after 1m0s
[22:39:52.706] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:52:0)
[22:39:52.706] Timer tick, asking Buildbucket for the build status
[22:39:52.835] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:52.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:53:0) after 1m0s
[22:40:52.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:53:0)
[22:40:52.914] Timer tick, asking Buildbucket for the build status
[22:40:52.973] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:52.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:54:0) after 1m0s
[22:41:53.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:54:0)
[22:41:53.044] Timer tick, asking Buildbucket for the build status
[22:41:53.111] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:53.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:55:0) after 1m0s
[22:42:53.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:55:0)
[22:42:53.179] Timer tick, asking Buildbucket for the build status
[22:42:53.244] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:53.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:56:0) after 1m0s
[22:43:53.603] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:56:0)
[22:43:53.603] Timer tick, asking Buildbucket for the build status
[22:43:53.905] Build 8859271029652492064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:53.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9024701092343417984:57:0) after 1m0s
[22:44:37.871] Received PubSub notification, asking Buildbucket for the build status
[22:44:38.005] Build 8859271029652492064: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:44:38.005] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609541077204915",
"created_by": "project:chromium",
"created_ts": "1609537779146392",
"id": "8859271029652492064",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dfbe34f3268650f7b38d06aabf9cdd698285f254\"}}",
"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\": \"dfbe34f3268650f7b38d06aabf9cdd698285f254\", \"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-jgc6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16582, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"bf02c31bec07a549cc8eea26ad0e63143954643d\", \"got_dawn_revision\": \"86980018b3f2786aeb5ded1220ec94bc927fa6b2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"dfbe34f3268650f7b38d06aabf9cdd698285f254\", \"got_revision_cp\": \"refs/heads/master@{#839913}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"ff29e249d3179766a40c9486183559fe3e5c1456\", \"got_v8_revision\": \"a3f2933bb6d06bd7473ccbed77714874e6bf63b3\", \"got_v8_revision_cp\": \"refs/heads/8.9.201@{#1}\", \"got_webrtc_revision\": \"6215ba804eb500f3e28b39088c73af3c4f4cd10a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32897}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.win:win-asan\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dfbe34f3268650f7b38d06aabf9cdd698285f254\", \"swarm_hashes_refs/heads/master(at){#839913}_without_patch\": {\"absl_hardening_tests\": \"4b5c3ca1221575578a87a70377477b7181dac560\", \"accessibility_unittests\": \"e0d58119a3c4736334ff9bd0cedaadde3fc1e590\", \"angle_unittests\": \"e676041c0160606ed49d2b735983b7a2a718d5d3\", \"app_shell_unittests\": \"202edc910c3b3661ff39ef389655da105061123f\", \"aura_unittests\": \"8868a2ea6796fa12afc88e9d05dfc48f261a9fda\", \"base_unittests\": \"f389b31b4fa77b28bd2557986be1757977c1f6de\", \"base_util_unittests\": \"30cd4e78714aae2b8d42d7f2b477ad3f4bc4923b\", \"blink_common_unittests\": \"0af02e835442010584f4adbb88811d2d3dd7ff9e\", \"blink_fuzzer_unittests\": \"679046146261a09a289fc209403a0606e8f5838d\", \"blink_heap_unittests\": \"4aa44bbb65b6d41e2e714715cec2434304ba811e\", \"blink_platform_unittests\": \"762755464cfd22d6d8b23270a847047a3470e8ff\", \"blink_unittests\": \"801303a19035c4316a60de8e47cb1b8b4e105dcd\", \"boringssl_crypto_tests\": \"e8272ba7e9b69b4bf0a35039ee8b72950ca04c0e\", \"boringssl_ssl_tests\": \"bc8e5da089e5c401dd7e977ec3165a3abc98e124\", \"browser_switcher_bho_unittests\": \"3b0b8468d116f1ccb582cb9131e89d6fdb3b444c\", \"browser_tests\": \"568e0a415cb2ceae13361123b701e7736ef762bd\", \"capture_unittests\": \"ef3475c1a66e72615ffce0c7d8cd59f7f33f5f07\", \"cast_unittests\": \"745c79cadb0bd0de4da3d2bd28659e6e7c74487e\", \"cc_unittests\": \"9ce69b3ec87d587011a5b6d541d84e4ad9723801\", \"chrome_app_unittests\": \"2e16b19c262d444a1ebb3cdb8b80a44b749f0b41\", \"chrome_cleaner_unittests\": \"77c979ca4af511a1962730fa49bf8461c2182192\", \"chrome_elf_unittests\": \"83cc76e809207fded7ce4bf7fbddca74c7639fe2\", \"chromedriver_unittests\": \"22d289e2dc22e66e5487a047f3dfa047b2742d26\", \"components_browsertests\": \"aaa65d90ca0895ab4e7b0ed68a2a6301b4b3d0b2\", \"components_unittests\": \"f8c3fccdadfc0ca7d4735f984d350e2889bc0d45\", \"compositor_unittests\": \"46ee88074db93d7c874e3e6429db2cfb968fc687\", \"content_browsertests\": \"7116761ae6d8dff31470ed5e07313ebab2db31c0\", \"content_unittests\": \"50e5a786b921ec7396fc93ad6a83de1d303bdbef\", \"courgette_unittests\": \"8291c07967c4855e7d366ef0c4dab1329dc2c358\", \"crashpad_tests\": \"2fc96d89198874c1095261057fb2b07a456bdaf1\", \"cronet_tests\": \"869385412ebe58403fe419507b1dbb8833fbf267\", \"cronet_unittests\": \"a25cb3656bc859c9e57091ab86ca7ecbbd042d01\", \"crypto_unittests\": \"5f95f1c4e3d78558a42991b0bafdcab70c1d0a8e\", \"delayloads_unittests\": \"fe5ae8a7787dfdea68c8465188dec824a46b4ae6\", \"device_unittests\": \"0bde745a75a6d8e4418f8acb4496e6be1108a684\", \"display_unittests\": \"091f4afbac30904da8b4d8b1eab5a1501f15e1ef\", \"elevation_service_unittests\": \"2890cdb70bf873a36435756f2905284692c0172b\", \"events_unittests\": \"32e489bb3a616198b646485737d31851da615893\", \"extensions_browsertests\": \"dd83ab35e46b6cc043da9672b3c6848a18d73479\", \"extensions_unittests\": \"66ca337167ce872b34e02c761b9c0f9cebc53c8a\", \"filesystem_service_unittests\": \"526e7640405984d57e8e98483603a160f179f2fc\", \"gcm_unit_tests\": \"f16c8889965275e4c373d4954fb545a2a73c01d4\", \"gcp_unittests\": \"f299ee25ad28580757bdcfca04129a6296e9e615\", \"gfx_unittests\": \"646677c59b39b1211005bb509f56f0d567d2f7b1\", \"gin_unittests\": \"12e85f845677340c24dde2a5d325c2ca0a37845d\", \"google_apis_unittests\": \"c4a435be99535b7d96746b671fca5a767e11dc76\", \"gpu_unittests\": \"fe1a71805b255a3acbeb13034a0dbc08d734325a\", \"gwp_asan_unittests\": \"70494ee86946b11b5428dcae620c3ff511dc5cf7\", \"headless_browsertests\": \"9277d8b4df2ff78a11f6107fd9680d7602f74a30\", \"headless_unittests\": \"9b5b1981d856a9e6c4a95d9057d0618739ea012b\", \"install_static_unittests\": \"f00a5d5403820fe29fae32b1f6e985bbdff4a10f\", \"installer_util_unittests\": \"f3114c1086d6cd04d0c18fced6126c1503747cbf\", \"interactive_ui_tests\": \"17ef71357d2a1b2e3cb0371d50d07a503040b082\", \"ipc_tests\": \"d3d9b577d2992349455aa2ca0ef760b0116b7285\", \"jingle_unittests\": \"283214109d2c9e7350651044055feecf59b621b7\", \"latency_unittests\": \"57a0e63ec019c49bdabf3765520a5f3b55dd1c1f\", \"libjingle_xmpp_unittests\": \"764102ab86a5511a0ed7af932cd70633c9f1298d\", \"liburlpattern_unittests\": \"05e42b7bd00e8b3aedd47087663fcb4ddc35ad3b\", \"media_blink_unittests\": \"7f3f306a786f5875cf5ebc9de394dfef3b1df740\", \"media_unittests\": \"6f4bf7fa681cd17ccbcb6c82122247e1d6c29b16\", \"message_center_unittests\": \"ed3d20b63543525046b487207e4bc87d620401ae\", \"midi_unittests\": \"f8f3d17fe9d48366f503ffeee50063beb90eec9d\", \"mojo_core_unittests\": \"e1ac989b5f5bcc278b16a4c87c8292504311ceab\", \"mojo_unittests\": \"0e9fb757639b8574bd2311bfd621aecf6b4b01d0\", \"nacl_loader_unittests\": \"a9860992f4df600962076b4f0735aca45570516a\", \"native_theme_unittests\": \"3e0a2332e7ae899f7c684c1bfa52a8476a9ae49b\", \"net_unittests\": \"6175b2f79e34204658c42c9df23254fede5ba4cb\", \"notification_helper_unittests\": \"56f1d960b8e40b9aedcd26e0ca7f100d0473dae3\", \"pdf_unittests\": \"47cedd26a03550fdbd4ba8d2d14a052463f590c7\", \"perfetto_unittests\": \"b903917a353625c02407765030c826cffb2a72e2\", \"ppapi_unittests\": \"f5c467fa6aa97bc1a102ee0261a5c7e6184e4b8f\", \"printing_unittests\": \"e878082a88f7edb2cfbd31221f563245db10ecf1\", \"remoting_unittests\": \"0b4564c011d19cd2afbdb47c41c73d1db511ada2\", \"sbox_integration_tests\": \"27bc4514b56c6c16af16296ac5daa1ca08d8f63a\", \"sbox_unittests\": \"90b9fe4846a75eee70608081ef25bfba13c29416\", \"sbox_validation_tests\": \"3cc333cb24d22c229df887cb736e6aed6a23fbef\", \"service_manager_unittests\": \"bcada8b300d70719cd7728c1629e25d17ec3a69b\", \"services_unittests\": \"ab21012b63c1c0819eddeeb82ed81f1445f0044f\", \"setup_unittests\": \"4032569dd9db82b003e91edc39f17ee0760a4abc\", \"shell_dialogs_unittests\": \"f37e00a83faffe9cca72663e859caa87554ccd73\", \"skia_unittests\": \"08bf3ae6f928f4f8ba3f1cd3ffba58957676d49b\", \"snapshot_unittests\": \"162b784e8f1176712a04efbb83b76f2072c965a3\", \"sql_unittests\": \"e58c761f7c2e18a41887a089151f58e640a70ea0\", \"storage_unittests\": \"a6e96b9534e95fca4d49e268e6f97ee44d621b8c\", \"sync_integration_tests\": \"b37dff11143d55557ae332bb3fa42a7636d34e9d\", \"traffic_annotation_auditor_unittests\": \"d344eeaf1af69394405d10245ee47a34134916a8\", \"ui_base_unittests\": \"149c2526a434424bdbdad2c5dae436e93a2e7151\", \"ui_touch_selection_unittests\": \"34e85e9057d3cba6d8f768486c2b0d2741528f8c\", \"unit_tests\": \"7e0b825b8d52203a68bbda7f0615a1840bbb4dea\", \"updater_tests\": \"79e99c4ab3fb50605745ea59a2d6a908ca41240b\", \"url_unittests\": \"0b04704ac98c2bb2f9b738054da078b7501bcbdb\", \"views_unittests\": \"ea92d845a6162ee9f8d957c697baf26574003663\", \"viz_unittests\": \"ef75c7c34712c17a8e281b37fdb690c071e33a01\", \"vr_common_unittests\": \"cb912f8214192b07808142d11020a277b88056e2\", \"vr_pixeltests\": \"49ba6b3a74b130654617d4112e85bf26a71e55f7\", \"weblayer_browsertests\": \"703ce741e4a5c091792f6305caa2d312bdc48d6b\", \"weblayer_unittests\": \"574742b5e8eebcd4c362178f0f1fb95d71b292fd\", \"wm_unittests\": \"058fdf6d2d94ec843fc0ca7eb1ae48479af75a82\", \"wtf_unittests\": \"93b410f9c22ed148a6f957c6d6f5024d55cdef40\", \"zlib_unittests\": \"dbd6ebb7321f8e3b9fb5bed64bd1af9b79c91268\", \"zucchini_unittests\": \"8c5e18b623a78e7916c544bde56c95541d04fc2b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-8-jgc6\"], \"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": "1609537782854283",
"status": "COMPLETED",
"status_changed_ts": "1609541077431183",
"tags": [
"build_address:luci.chromium.ci/win-asan/16582",
"builder:win-asan",
"buildset:commit/git/dfbe34f3268650f7b38d06aabf9cdd698285f254",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dfbe34f3268650f7b38d06aabf9cdd698285f254",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024701092343417984",
"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/8859271029652492064/+/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:50d8bf003d0d8e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1609541077437090",
"url": "https://ci.chromium.org/b/8859271029652492064",
"utcnow_ts": "1609541077989823"
}
}
[22:44:38.005] Invocation finished in 55m0.808887863s with status SUCCEEDED