[08:32:21.324] New invocation is queued and will start shortly
[08:32:22.449] Starting the invocation (attempt 1)
[08:32:22.489] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:32:22.489] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:32:22.489] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026744385194014496",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"832fa81068bfaab6b5006dcca99c5f8926a17e56\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9026744385194014496",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/832fa81068bfaab6b5006dcca99c5f8926a17e56",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/832fa81068bfaab6b5006dcca99c5f8926a17e56",
"gitiles_ref:refs/heads/master"
]
}
[08:32:24.632] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607589143613275",
"id": "8861314322105449280",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"832fa81068bfaab6b5006dcca99c5f8926a17e56\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607589144401263",
"tags": [
"build_address:luci.chromium.ci/win-asan/16135",
"builder:win-asan",
"buildset:commit/git/832fa81068bfaab6b5006dcca99c5f8926a17e56",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/832fa81068bfaab6b5006dcca99c5f8926a17e56",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026744385194014496",
"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/8861314322105449280/+/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": "1607589144401391",
"url": "https://ci.chromium.org/b/8861314322105449280",
"utcnow_ts": "1607589144621750"
}
}
[08:32:24.632] Task URL: https://ci.chromium.org/b/8861314322105449280
[08:32:24.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:2:0) after 1m0s
[08:32:29.853] Received PubSub notification, asking Buildbucket for the build status
[08:32:29.920] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:24.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:2:0)
[08:33:24.685] Timer tick, asking Buildbucket for the build status
[08:33:24.764] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:24.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:4:0) after 1m0s
[08:34:24.782] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:4:0)
[08:34:24.782] Timer tick, asking Buildbucket for the build status
[08:34:24.936] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:24.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:5:0) after 1m0s
[08:35:24.956] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:5:0)
[08:35:24.956] Timer tick, asking Buildbucket for the build status
[08:35:25.407] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:25.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:6:0) after 1m0s
[08:36:25.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:6:0)
[08:36:25.432] Timer tick, asking Buildbucket for the build status
[08:36:25.753] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:25.753] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:7:0) after 1m0s
[08:37:25.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:7:0)
[08:37:25.803] Timer tick, asking Buildbucket for the build status
[08:37:25.900] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:25.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:8:0) after 1m0s
[08:38:25.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:8:0)
[08:38:25.971] Timer tick, asking Buildbucket for the build status
[08:38:26.046] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:26.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:9:0) after 1m0s
[08:39:26.125] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:9:0)
[08:39:26.125] Timer tick, asking Buildbucket for the build status
[08:39:26.212] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:26.212] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:10:0) after 1m0s
[08:40:26.238] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:10:0)
[08:40:26.238] Timer tick, asking Buildbucket for the build status
[08:40:26.339] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:26.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:11:0) after 1m0s
[08:41:26.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:11:0)
[08:41:26.367] Timer tick, asking Buildbucket for the build status
[08:41:26.435] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:26.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:12:0) after 1m0s
[08:42:26.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:12:0)
[08:42:26.454] Timer tick, asking Buildbucket for the build status
[08:42:26.572] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:26.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:13:0) after 1m0s
[08:43:26.629] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:13:0)
[08:43:26.629] Timer tick, asking Buildbucket for the build status
[08:43:26.730] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:26.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:14:0) after 1m0s
[08:44:26.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:14:0)
[08:44:26.767] Timer tick, asking Buildbucket for the build status
[08:44:26.996] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:26.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:15:0) after 1m0s
[08:45:27.100] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:15:0)
[08:45:27.100] Timer tick, asking Buildbucket for the build status
[08:45:27.159] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:27.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:16:0) after 1m0s
[08:46:27.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:16:0)
[08:46:27.170] Timer tick, asking Buildbucket for the build status
[08:46:27.226] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:27.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:17:0) after 1m0s
[08:47:27.291] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:17:0)
[08:47:27.291] Timer tick, asking Buildbucket for the build status
[08:47:27.401] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:27.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:18:0) after 1m0s
[08:48:27.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:18:0)
[08:48:27.615] Timer tick, asking Buildbucket for the build status
[08:48:27.722] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:27.722] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:19:0) after 1m0s
[08:49:27.758] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:19:0)
[08:49:27.758] Timer tick, asking Buildbucket for the build status
[08:49:27.874] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:27.874] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:20:0) after 1m0s
[08:50:27.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:20:0)
[08:50:27.939] Timer tick, asking Buildbucket for the build status
[08:50:27.997] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:27.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:21:0) after 1m0s
[08:51:28.100] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:21:0)
[08:51:28.100] Timer tick, asking Buildbucket for the build status
[08:51:28.315] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:28.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:22:0) after 1m0s
[08:52:28.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:22:0)
[08:52:28.336] Timer tick, asking Buildbucket for the build status
[08:52:28.592] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:28.592] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:23:0) after 1m0s
[08:53:28.619] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:23:0)
[08:53:28.619] Timer tick, asking Buildbucket for the build status
[08:53:28.777] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:28.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:24:0) after 1m0s
[08:54:28.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:24:0)
[08:54:28.802] Timer tick, asking Buildbucket for the build status
[08:54:29.148] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:29.148] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:25:0) after 1m0s
[08:55:29.240] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:25:0)
[08:55:29.240] Timer tick, asking Buildbucket for the build status
[08:55:29.348] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:29.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:26:0) after 1m0s
[08:56:29.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:26:0)
[08:56:29.376] Timer tick, asking Buildbucket for the build status
[08:56:29.501] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:29.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:27:0) after 1m0s
[08:57:29.590] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:27:0)
[08:57:29.590] Timer tick, asking Buildbucket for the build status
[08:57:29.731] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:29.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:28:0) after 1m0s
[08:58:29.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:28:0)
[08:58:29.870] Timer tick, asking Buildbucket for the build status
[08:58:29.984] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:29.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:29:0) after 1m0s
[08:59:30.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:29:0)
[08:59:30.002] Timer tick, asking Buildbucket for the build status
[08:59:30.113] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:30.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:30:0) after 1m0s
[09:00:30.125] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:30:0)
[09:00:30.125] Timer tick, asking Buildbucket for the build status
[09:00:30.247] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:30.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:31:0) after 1m0s
[09:01:30.271] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:31:0)
[09:01:30.271] Timer tick, asking Buildbucket for the build status
[09:01:30.378] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:30.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:32:0) after 1m0s
[09:02:30.403] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:32:0)
[09:02:30.403] Timer tick, asking Buildbucket for the build status
[09:02:30.532] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:30.532] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:33:0) after 1m0s
[09:03:30.573] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:33:0)
[09:03:30.573] Timer tick, asking Buildbucket for the build status
[09:03:30.969] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:30.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:34:0) after 1m0s
[09:04:31.007] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:34:0)
[09:04:31.007] Timer tick, asking Buildbucket for the build status
[09:04:31.143] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:31.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:35:0) after 1m0s
[09:05:31.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:35:0)
[09:05:31.172] Timer tick, asking Buildbucket for the build status
[09:05:31.329] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:31.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:36:0) after 1m0s
[09:06:31.379] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:36:0)
[09:06:31.379] Timer tick, asking Buildbucket for the build status
[09:06:31.502] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:31.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:37:0) after 1m0s
[09:07:31.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:37:0)
[09:07:31.576] Timer tick, asking Buildbucket for the build status
[09:07:31.743] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:31.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:38:0) after 1m0s
[09:08:31.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:38:0)
[09:08:31.874] Timer tick, asking Buildbucket for the build status
[09:08:31.960] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:31.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:39:0) after 1m0s
[09:09:31.984] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:39:0)
[09:09:31.984] Timer tick, asking Buildbucket for the build status
[09:09:32.056] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:32.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:40:0) after 1m0s
[09:10:32.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:40:0)
[09:10:32.126] Timer tick, asking Buildbucket for the build status
[09:10:32.190] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:32.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:41:0) after 1m0s
[09:11:32.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:41:0)
[09:11:32.229] Timer tick, asking Buildbucket for the build status
[09:11:32.304] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:32.304] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:42:0) after 1m0s
[09:12:32.351] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:42:0)
[09:12:32.351] Timer tick, asking Buildbucket for the build status
[09:12:32.477] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:32.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:43:0) after 1m0s
[09:13:32.538] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:43:0)
[09:13:32.538] Timer tick, asking Buildbucket for the build status
[09:13:32.614] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:32.614] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:44:0) after 1m0s
[09:14:32.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:44:0)
[09:14:32.694] Timer tick, asking Buildbucket for the build status
[09:14:32.784] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:32.784] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:45:0) after 1m0s
[09:15:32.936] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:45:0)
[09:15:32.936] Timer tick, asking Buildbucket for the build status
[09:15:33.041] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:33.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:46:0) after 1m0s
[09:16:33.252] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:46:0)
[09:16:33.252] Timer tick, asking Buildbucket for the build status
[09:16:33.312] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:33.312] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:47:0) after 1m0s
[09:17:33.439] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:47:0)
[09:17:33.439] Timer tick, asking Buildbucket for the build status
[09:17:33.549] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:33.549] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:48:0) after 1m0s
[09:18:33.669] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:48:0)
[09:18:33.669] Timer tick, asking Buildbucket for the build status
[09:18:33.785] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:33.785] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:49:0) after 1m0s
[09:19:33.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:49:0)
[09:19:33.930] Timer tick, asking Buildbucket for the build status
[09:19:34.000] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:34.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:50:0) after 1m0s
[09:20:34.097] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:50:0)
[09:20:34.097] Timer tick, asking Buildbucket for the build status
[09:20:34.207] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:34.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:51:0) after 1m0s
[09:21:34.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:51:0)
[09:21:34.339] Timer tick, asking Buildbucket for the build status
[09:21:34.465] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:34.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:52:0) after 1m0s
[09:22:34.496] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:52:0)
[09:22:34.496] Timer tick, asking Buildbucket for the build status
[09:22:34.625] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:34.625] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:53:0) after 1m0s
[09:23:34.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:53:0)
[09:23:34.652] Timer tick, asking Buildbucket for the build status
[09:23:34.806] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:34.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:54:0) after 1m0s
[09:24:34.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:54:0)
[09:24:34.868] Timer tick, asking Buildbucket for the build status
[09:24:34.991] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:34.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:55:0) after 1m0s
[09:25:35.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:55:0)
[09:25:35.122] Timer tick, asking Buildbucket for the build status
[09:25:35.213] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:35.213] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:56:0) after 1m0s
[09:26:35.202] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:56:0)
[09:26:35.202] Timer tick, asking Buildbucket for the build status
[09:26:35.271] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:35.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:57:0) after 1m0s
[09:27:35.387] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:57:0)
[09:27:35.387] Timer tick, asking Buildbucket for the build status
[09:27:35.828] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:35.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:58:0) after 1m0s
[09:28:35.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:58:0)
[09:28:35.850] Timer tick, asking Buildbucket for the build status
[09:28:36.526] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:36.526] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:59:0) after 1m0s
[09:29:36.621] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:59:0)
[09:29:36.621] Timer tick, asking Buildbucket for the build status
[09:29:36.709] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:36.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:60:0) after 1m0s
[09:30:36.850] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:60:0)
[09:30:36.850] Timer tick, asking Buildbucket for the build status
[09:30:36.990] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:36.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:61:0) after 1m0s
[09:31:37.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:61:0)
[09:31:37.001] Timer tick, asking Buildbucket for the build status
[09:31:37.067] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:37.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:62:0) after 1m0s
[09:32:37.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:62:0)
[09:32:37.124] Timer tick, asking Buildbucket for the build status
[09:32:37.226] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:37.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:63:0) after 1m0s
[09:33:37.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:63:0)
[09:33:37.294] Timer tick, asking Buildbucket for the build status
[09:33:37.530] Build 8861314322105449280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:37.530] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9026744385194014496:64:0) after 1m0s
[09:34:29.933] Received PubSub notification, asking Buildbucket for the build status
[09:34:29.999] Build 8861314322105449280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:34:29.999] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607592868261938",
"created_by": "project:chromium",
"created_ts": "1607589143613275",
"id": "8861314322105449280",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"832fa81068bfaab6b5006dcca99c5f8926a17e56\"}}",
"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}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$build/goma.jobs\", \"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"832fa81068bfaab6b5006dcca99c5f8926a17e56\", \"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-6-3vmi\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 16135, \"clang_revision\": \"llvmorg-12-init-12923-g6ee22ca6-1\", \"got_angle_revision\": \"067a12f059511ead6e91ab9e91af1d180ad9c144\", \"got_dawn_revision\": \"29fd62989338a0d5812bc654a3afee6dc684bfc4\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"832fa81068bfaab6b5006dcca99c5f8926a17e56\", \"got_revision_cp\": \"refs/heads/master@{#835587}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"d94a77b304f4fcb503ea037be3e5d7f2a371c4b6\", \"got_v8_revision\": \"7e546be6b2f61eb429d51abb78e973f7f623f62f\", \"got_v8_revision_cp\": \"refs/heads/8.9.126@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"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\": \"832fa81068bfaab6b5006dcca99c5f8926a17e56\", \"swarm_hashes_refs/heads/master(at){#835587}_without_patch\": {\"absl_hardening_tests\": \"10cb0d9cd3a969fb22162fa7a843d5a1b4368278\", \"accessibility_unittests\": \"88273fcaa0536074d8c843c807611acce14da0f9\", \"angle_unittests\": \"f4507280c758c28c0a86f3147030a800163d4328\", \"app_shell_unittests\": \"7485d221ccc736ea8c3da20e9408f463936d6712\", \"aura_unittests\": \"797f4806c242f282f5a122d8c16ad53af76139dd\", \"base_unittests\": \"f4c2dfa16f2f10aed0be99accac4a7207ba7b6ad\", \"base_util_unittests\": \"75939606105ac499ebc7ce29068385ef0acb21dc\", \"blink_common_unittests\": \"8bac030fd04fcf5332a15268076ed0c29b9a9172\", \"blink_fuzzer_unittests\": \"c3482925042765ad56947a9dfad2f17b211b32ad\", \"blink_heap_unittests\": \"2f3a2c3d177f605f4ddf3aff51bbeb5db624c5f8\", \"blink_platform_unittests\": \"4c1a8753426bd5b56c7bd67001c8538db522c1fd\", \"blink_unittests\": \"6a82eb5239d82708f76e8b77a510899febb1e0f3\", \"boringssl_crypto_tests\": \"ab1a1e3e7f334c5b1bfbde35e2067eecfc7a7bbd\", \"boringssl_ssl_tests\": \"764ba4dc3929ab9d7905c283024963e9ee0fc975\", \"browser_switcher_bho_unittests\": \"f7170bdb9a823c80b0d3025e816a41026a9ac21d\", \"browser_tests\": \"4b3e4c616bc88cc9ebd112e8ce6d8922299fb431\", \"capture_unittests\": \"0c2b6a30e94fd99a105c7c5d21396f8e098a0a8e\", \"cast_unittests\": \"0373b1e69a69f2738acba998d7ee2b289869fe66\", \"cc_unittests\": \"4d84c2f0a6a2a0777a221c2601553d05cafc2420\", \"chrome_app_unittests\": \"c1dca7f9e09ae8ec910d076af903ef38caedd397\", \"chrome_cleaner_unittests\": \"80f048e76c3379259f62f9296fd048a03d9b786e\", \"chrome_elf_unittests\": \"63c246de60418cf4eb46bf8354194b20b2b722eb\", \"chromedriver_unittests\": \"6479afa6636c69274875e4ec5b577a3225323aeb\", \"components_browsertests\": \"0480667f19b9521c1fcc1b8ec739f84f77757274\", \"components_unittests\": \"dfed60a4b769b31db9867ba217cb3c97ffeb91ee\", \"compositor_unittests\": \"5e80d069c49cdbbd81aaff9e3266f0207b596007\", \"content_browsertests\": \"c70b7d81e4a910db00908635c6811c714a22130a\", \"content_unittests\": \"425cfe1685268398c97fcb39c8ab9ab515a686d6\", \"courgette_unittests\": \"5ef7f8571d89f2749c8640d63c0748b0d03d1fbd\", \"crashpad_tests\": \"19f4fa8f74370bd938cf7620c86469faaeb59397\", \"cronet_tests\": \"71648583f45a364f471556e594b5c905931112bb\", \"cronet_unittests\": \"2fcdad64e6aa4fbb15dfcf2cda10f7f995568738\", \"crypto_unittests\": \"b3659c7f9329ae23b26e54a8a4d7ef9cd200b3d4\", \"delayloads_unittests\": \"0acccd60193911f66436d50a1810ee92afa03897\", \"device_unittests\": \"6dabe885a5003baf4104a54f86f3c86c622142e4\", \"display_unittests\": \"80bac625c47ec5aa06f3fbb630fa5517c142d34b\", \"elevation_service_unittests\": \"ffcc0cac6d4fd933a9f1c6cc809d61f361255f34\", \"events_unittests\": \"6f4c35cf9bd2457846564ccd5e0521784145011b\", \"extensions_browsertests\": \"244b7386202a7d83d52b0406a72e675549e24341\", \"extensions_unittests\": \"a0d9e118fa86a069b408b4cb1f147417ddc03817\", \"filesystem_service_unittests\": \"a60d082b2002d474dc9651469379c5672e640964\", \"gcm_unit_tests\": \"b1a322920e01f35a8f909b0d674b5d5631ed36b1\", \"gcp_unittests\": \"7a28b83714e207775de5f546a40cf0d56829c17e\", \"gfx_unittests\": \"3589926bed3c098b647b835608b5a7b54e40b183\", \"gin_unittests\": \"700e397f4826008a242dd5dbe5714e5fb9d03751\", \"google_apis_unittests\": \"34f62eaddb563f5ad8080ee81f22afad55d6774d\", \"gpu_unittests\": \"990ff1392ea0aaa53a26fed8ba5327d339a3e943\", \"gwp_asan_unittests\": \"04c44bf29df0cab4f8f68cee76cb0e556084ed7b\", \"headless_browsertests\": \"a33eca3e2c803d19da507ef1cd676aa64eb348a8\", \"headless_unittests\": \"8e5b17e7e6e2dc39bd8a9858737e8f9ecfc490b5\", \"install_static_unittests\": \"5bf5a03bffbc79652de4829959e003794d5c5261\", \"installer_util_unittests\": \"038c6377916c2ee1bf7adc422bffd99b8090be25\", \"interactive_ui_tests\": \"fc83a1bc8d744dc8fbe3c03d708ba3fb7fbb684a\", \"ipc_tests\": \"d4727f9bb22edaa6f1fa398a1f0c70fce7430490\", \"jingle_unittests\": \"e2d573618a8ffcd05413db8e8373390db4cfab79\", \"latency_unittests\": \"2c72777ac74803f26adfeaabe196a115d123f8ac\", \"libjingle_xmpp_unittests\": \"fa8c34da6d9fb37e803d160eccbd69d863be6e03\", \"liburlpattern_unittests\": \"64e12104afff5442e7b1593975b3de1e99cf70f6\", \"media_blink_unittests\": \"b466863d175121c7902953f879e1c148f7c3847a\", \"media_unittests\": \"2bd56755438809cdfb9b05b51ec4e72a87517da5\", \"message_center_unittests\": \"3e0f4e855939f3fcdb486f6a5d2bb4b5a3aa64bc\", \"midi_unittests\": \"9e5af0c6e76cb4ed3c60734fdb8766244e667b68\", \"mojo_core_unittests\": \"14c90b1ed1946cd34fa7d9a4be3b9e397dd51198\", \"mojo_unittests\": \"3fb8dcb9d19dcf78bd253f04b231d680736fbb8f\", \"nacl_loader_unittests\": \"ee1b7bfc4b31a90e2cce0419a9d2ad37c0d7e2a8\", \"native_theme_unittests\": \"5529efdab896babff90075bcc3cd2e300d9f7670\", \"net_unittests\": \"00023b95695cceefcfc777e7be9abc96e3888f97\", \"notification_helper_unittests\": \"c047679a93a575d1ba157b3250523d80a807cee2\", \"pdf_unittests\": \"01aef06c41f8132da3789d38cf49fdb6940b3793\", \"perfetto_unittests\": \"018f5d8142016c2e1183b3934859dc15177da4f3\", \"ppapi_unittests\": \"991d5d218e40a1a883c9574bf98260546ec0ca94\", \"printing_unittests\": \"287400ef39c5a136806c116b10f2513d10827a2f\", \"remoting_unittests\": \"5261f79fa390f9517ac1c6637f1146e25bd7864f\", \"sbox_integration_tests\": \"235677d6689da7eef708171065db541920e94221\", \"sbox_unittests\": \"b6ce798064d254f9c5d3cee5505ac214feaf4b0e\", \"sbox_validation_tests\": \"1b72e35e3c8d7d5252f424e896dbb1fc4f70b467\", \"service_manager_unittests\": \"4e4d5b1489e1f32e2017228bc0e4fdee83ba9422\", \"services_unittests\": \"10cca05b08124cfa7733548a61bac6a5490bab92\", \"setup_unittests\": \"44dd09d41dbf7b6331b68fefb7e07118afd264cc\", \"shell_dialogs_unittests\": \"2dbd45cddf4ef6244f807e6a04a97a5447161ea9\", \"skia_unittests\": \"2a000f1cc05031a97adcc37a8a6317cf029e05e3\", \"snapshot_unittests\": \"363a2e1af065e1979d6466f1bdbb938352459196\", \"sql_unittests\": \"aff24703dd5684be6b5838bba4f75e747b2741b8\", \"storage_unittests\": \"3d7c646542c9575cd7f3032d7f5c7c1a0822d85f\", \"sync_integration_tests\": \"5bd7f7e60bec618b4197e14133247f6923aae1a4\", \"traffic_annotation_auditor_unittests\": \"fe7e3566bc02a4d9cd56b8ee35e580e969876046\", \"ui_base_unittests\": \"922acb24e6ba776ba09b33aa5a2e3aae29ab0d4c\", \"ui_touch_selection_unittests\": \"d6deb035588f8e74169d2670fc23f818c97be649\", \"unit_tests\": \"7f5e48b3db2aad51ff9a87023ac76f89f3a2aff1\", \"updater_tests\": \"c6cdbe4a64ecba40f9b7c79eb2eed887841102e7\", \"url_unittests\": \"d56fdaab6c8b255bbbc700d234650e20a777158d\", \"views_unittests\": \"b62b4671296ee811fd7d2527a99398b8f9954ee2\", \"viz_unittests\": \"ef4a5ad330f72498bd5132f1c7f2106f8086543b\", \"vr_common_unittests\": \"70cdb2fe5932be2c7ac48cb903403af452075b18\", \"vr_pixeltests\": \"072d5334c6514f3dfb44ffe1b09782463ddf3a27\", \"weblayer_browsertests\": \"7076f3d7f6d859e108d038c6c1a3b145b96d93ce\", \"weblayer_unittests\": \"69ff3ea58030bb1ed91fae1e894f10d2e1e9d188\", \"wm_unittests\": \"74125058be9b2558e3e365cde2a9e78be30f744b\", \"wtf_unittests\": \"04caae5d32c57b1a749fcfc23b096b830af47a80\", \"zlib_unittests\": \"524e025f64c2d1fb6720bd29b409750157610dff\", \"zucchini_unittests\": \"c5c4bee6c7ddfad2cc0f3b54703abc7d326eaff9\"}}, \"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-6-3vmi\"], \"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": "1607589149295850",
"status": "COMPLETED",
"status_changed_ts": "1607592868802734",
"tags": [
"build_address:luci.chromium.ci/win-asan/16135",
"builder:win-asan",
"buildset:commit/git/832fa81068bfaab6b5006dcca99c5f8926a17e56",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/832fa81068bfaab6b5006dcca99c5f8926a17e56",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026744385194014496",
"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/8861314322105449280/+/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:50649931bc823510",
"user_agent:luci-scheduler"
],
"updated_ts": "1607592868832209",
"url": "https://ci.chromium.org/b/8861314322105449280",
"utcnow_ts": "1607592869991346"
}
}
[09:34:29.999] Invocation finished in 1h2m8.715594825s with status SUCCEEDED