[01:11:05.591] New invocation is queued and will start shortly
[01:11:06.723] Starting the invocation (attempt 1)
[01:11:06.791] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:11:06.791] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:11:06.791] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018618420011034400",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e0fada832e51c3e29dbc7ac110009e62dfde5b6b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018618420011034400",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/e0fada832e51c3e29dbc7ac110009e62dfde5b6b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e0fada832e51c3e29dbc7ac110009e62dfde5b6b",
"gitiles_ref:refs/heads/master"
]
}
[01:11:07.630] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615338667025057",
"id": "8853188357844034976",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e0fada832e51c3e29dbc7ac110009e62dfde5b6b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615338667520304",
"tags": [
"build_address:luci.chromium.ci/win-asan/17729",
"builder:win-asan",
"buildset:commit/git/e0fada832e51c3e29dbc7ac110009e62dfde5b6b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e0fada832e51c3e29dbc7ac110009e62dfde5b6b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018618420011034400",
"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/8853188357844034976/+/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": "1615338667520412",
"url": "https://ci.chromium.org/b/8853188357844034976",
"utcnow_ts": "1615338667620131"
}
}
[01:11:07.630] Task URL: https://ci.chromium.org/b/8853188357844034976
[01:11:07.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:2:0) after 1m0s
[01:11:10.484] Received PubSub notification, asking Buildbucket for the build status
[01:11:10.561] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:07.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:2:0)
[01:12:07.813] Timer tick, asking Buildbucket for the build status
[01:12:08.055] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:08.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:4:0) after 1m0s
[01:13:08.047] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:4:0)
[01:13:08.047] Timer tick, asking Buildbucket for the build status
[01:13:08.128] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:08.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:5:0) after 1m0s
[01:14:08.206] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:5:0)
[01:14:08.206] Timer tick, asking Buildbucket for the build status
[01:14:08.361] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:08.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:6:0) after 1m0s
[01:15:08.409] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:6:0)
[01:15:08.409] Timer tick, asking Buildbucket for the build status
[01:15:08.525] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:08.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:7:0) after 1m0s
[01:16:08.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:7:0)
[01:16:08.571] Timer tick, asking Buildbucket for the build status
[01:16:08.645] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:08.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:8:0) after 1m0s
[01:17:08.754] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:8:0)
[01:17:08.754] Timer tick, asking Buildbucket for the build status
[01:17:08.825] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:08.826] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:9:0) after 1m0s
[01:18:09.054] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:9:0)
[01:18:09.054] Timer tick, asking Buildbucket for the build status
[01:18:09.136] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:09.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:10:0) after 1m0s
[01:19:09.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:10:0)
[01:19:09.325] Timer tick, asking Buildbucket for the build status
[01:19:09.476] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:09.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:11:0) after 1m0s
[01:20:09.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:11:0)
[01:20:09.567] Timer tick, asking Buildbucket for the build status
[01:20:09.635] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:09.635] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:12:0) after 1m0s
[01:21:09.671] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:12:0)
[01:21:09.671] Timer tick, asking Buildbucket for the build status
[01:21:09.945] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:09.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:13:0) after 1m0s
[01:22:10.039] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:13:0)
[01:22:10.039] Timer tick, asking Buildbucket for the build status
[01:22:10.258] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:10.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:14:0) after 1m0s
[01:23:10.424] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:14:0)
[01:23:10.424] Timer tick, asking Buildbucket for the build status
[01:23:10.528] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:10.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:15:0) after 1m0s
[01:24:10.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:15:0)
[01:24:10.558] Timer tick, asking Buildbucket for the build status
[01:24:10.833] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:10.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:16:0) after 1m0s
[01:25:10.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:16:0)
[01:25:10.849] Timer tick, asking Buildbucket for the build status
[01:25:11.030] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:11.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:17:0) after 1m0s
[01:26:11.090] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:17:0)
[01:26:11.090] Timer tick, asking Buildbucket for the build status
[01:26:11.320] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:11.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:18:0) after 1m0s
[01:27:11.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:18:0)
[01:27:11.362] Timer tick, asking Buildbucket for the build status
[01:27:11.603] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:11.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:19:0) after 1m0s
[01:28:11.660] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:19:0)
[01:28:11.661] Timer tick, asking Buildbucket for the build status
[01:28:11.804] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:11.804] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:20:0) after 1m0s
[01:29:11.846] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:20:0)
[01:29:11.846] Timer tick, asking Buildbucket for the build status
[01:29:12.173] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:12.173] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:21:0) after 1m0s
[01:30:12.179] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:21:0)
[01:30:12.179] Timer tick, asking Buildbucket for the build status
[01:30:12.307] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:12.307] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:22:0) after 1m0s
[01:31:12.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:22:0)
[01:31:12.327] Timer tick, asking Buildbucket for the build status
[01:31:12.775] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:12.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:23:0) after 1m0s
[01:32:12.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:23:0)
[01:32:12.791] Timer tick, asking Buildbucket for the build status
[01:32:12.869] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:12.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:24:0) after 1m0s
[01:33:12.903] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:24:0)
[01:33:12.903] Timer tick, asking Buildbucket for the build status
[01:33:12.990] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:12.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:25:0) after 1m0s
[01:34:13.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:25:0)
[01:34:13.056] Timer tick, asking Buildbucket for the build status
[01:34:13.160] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:13.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:26:0) after 1m0s
[01:35:13.156] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:26:0)
[01:35:13.156] Timer tick, asking Buildbucket for the build status
[01:35:13.313] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:13.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:27:0) after 1m0s
[01:36:13.343] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:27:0)
[01:36:13.343] Timer tick, asking Buildbucket for the build status
[01:36:13.911] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:13.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:28:0) after 1m0s
[01:37:13.933] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:28:0)
[01:37:13.933] Timer tick, asking Buildbucket for the build status
[01:37:14.325] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:14.325] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:29:0) after 1m0s
[01:38:14.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:29:0)
[01:38:14.367] Timer tick, asking Buildbucket for the build status
[01:38:14.538] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:14.538] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:30:0) after 1m0s
[01:39:14.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:30:0)
[01:39:14.556] Timer tick, asking Buildbucket for the build status
[01:39:14.632] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:14.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:31:0) after 1m0s
[01:40:14.688] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:31:0)
[01:40:14.688] Timer tick, asking Buildbucket for the build status
[01:40:14.773] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:14.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:32:0) after 1m0s
[01:41:14.868] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:32:0)
[01:41:14.868] Timer tick, asking Buildbucket for the build status
[01:41:14.980] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:14.980] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:33:0) after 1m0s
[01:42:15.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:33:0)
[01:42:15.053] Timer tick, asking Buildbucket for the build status
[01:42:15.132] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:15.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:34:0) after 1m0s
[01:43:15.132] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:34:0)
[01:43:15.132] Timer tick, asking Buildbucket for the build status
[01:43:15.404] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:15.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:35:0) after 1m0s
[01:44:15.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:35:0)
[01:44:15.441] Timer tick, asking Buildbucket for the build status
[01:44:15.542] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:15.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:36:0) after 1m0s
[01:45:15.576] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:36:0)
[01:45:15.576] Timer tick, asking Buildbucket for the build status
[01:45:15.851] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:15.851] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:37:0) after 1m0s
[01:46:15.823] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:37:0)
[01:46:15.823] Timer tick, asking Buildbucket for the build status
[01:46:16.010] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:16.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:38:0) after 1m0s
[01:47:16.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:38:0)
[01:47:16.056] Timer tick, asking Buildbucket for the build status
[01:47:16.151] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:16.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:39:0) after 1m0s
[01:48:16.181] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:39:0)
[01:48:16.181] Timer tick, asking Buildbucket for the build status
[01:48:16.252] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:16.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:40:0) after 1m0s
[01:49:16.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:40:0)
[01:49:16.305] Timer tick, asking Buildbucket for the build status
[01:49:16.516] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:16.516] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:41:0) after 1m0s
[01:50:16.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:41:0)
[01:50:16.536] Timer tick, asking Buildbucket for the build status
[01:50:16.751] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:16.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:42:0) after 1m0s
[01:51:16.761] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:42:0)
[01:51:16.761] Timer tick, asking Buildbucket for the build status
[01:51:17.433] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:17.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:43:0) after 1m0s
[01:52:17.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:43:0)
[01:52:17.585] Timer tick, asking Buildbucket for the build status
[01:52:17.657] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:17.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:44:0) after 1m0s
[01:53:17.687] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:44:0)
[01:53:17.687] Timer tick, asking Buildbucket for the build status
[01:53:18.331] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:18.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:45:0) after 1m0s
[01:54:18.330] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:45:0)
[01:54:18.330] Timer tick, asking Buildbucket for the build status
[01:54:18.558] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:18.558] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:46:0) after 1m0s
[01:55:18.583] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:46:0)
[01:55:18.583] Timer tick, asking Buildbucket for the build status
[01:55:18.664] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:18.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:47:0) after 1m0s
[01:56:18.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:47:0)
[01:56:18.715] Timer tick, asking Buildbucket for the build status
[01:56:18.807] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:18.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:48:0) after 1m0s
[01:57:18.851] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:48:0)
[01:57:18.851] Timer tick, asking Buildbucket for the build status
[01:57:18.933] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:18.933] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:49:0) after 1m0s
[01:58:18.920] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:49:0)
[01:58:18.920] Timer tick, asking Buildbucket for the build status
[01:58:19.109] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:19.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:50:0) after 1m0s
[01:59:19.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:50:0)
[01:59:19.116] Timer tick, asking Buildbucket for the build status
[01:59:19.396] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:19.396] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:51:0) after 1m0s
[02:00:19.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:51:0)
[02:00:19.392] Timer tick, asking Buildbucket for the build status
[02:00:19.605] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:19.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:52:0) after 1m0s
[02:01:19.751] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:52:0)
[02:01:19.751] Timer tick, asking Buildbucket for the build status
[02:01:19.845] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:19.845] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:53:0) after 1m0s
[02:02:19.915] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:53:0)
[02:02:19.915] Timer tick, asking Buildbucket for the build status
[02:02:20.158] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:20.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:54:0) after 1m0s
[02:03:20.787] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:54:0)
[02:03:20.787] Timer tick, asking Buildbucket for the build status
[02:03:20.876] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:20.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:55:0) after 1m0s
[02:04:20.962] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:55:0)
[02:04:20.962] Timer tick, asking Buildbucket for the build status
[02:04:21.235] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:21.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:56:0) after 1m0s
[02:05:21.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:56:0)
[02:05:21.353] Timer tick, asking Buildbucket for the build status
[02:05:21.435] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:21.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:57:0) after 1m0s
[02:06:21.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:57:0)
[02:06:21.514] Timer tick, asking Buildbucket for the build status
[02:06:21.608] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:21.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:58:0) after 1m0s
[02:07:21.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:58:0)
[02:07:21.655] Timer tick, asking Buildbucket for the build status
[02:07:21.725] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:21.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:59:0) after 1m0s
[02:08:21.790] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:59:0)
[02:08:21.790] Timer tick, asking Buildbucket for the build status
[02:08:22.064] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:22.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:60:0) after 1m0s
[02:09:22.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:60:0)
[02:09:22.133] Timer tick, asking Buildbucket for the build status
[02:09:22.736] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:22.736] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:61:0) after 1m0s
[02:10:22.864] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:61:0)
[02:10:22.864] Timer tick, asking Buildbucket for the build status
[02:10:22.942] Build 8853188357844034976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:22.942] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018618420011034400:62:0) after 1m0s
[02:10:56.933] Received PubSub notification, asking Buildbucket for the build status
[02:10:57.006] Build 8853188357844034976: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:10:57.007] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615342254938005",
"created_by": "project:chromium",
"created_ts": "1615338667025057",
"id": "8853188357844034976",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e0fada832e51c3e29dbc7ac110009e62dfde5b6b\"}}",
"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\": \"e0fada832e51c3e29dbc7ac110009e62dfde5b6b\", \"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-2xaw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17729, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"2b7fdb62837eb5de4fede39f62c2d554b16cdbd5\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"e0fada832e51c3e29dbc7ac110009e62dfde5b6b\", \"got_revision_cp\": \"refs/heads/master@{#861373}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"b3b47599bf78d3b7869f92c17edc5cd0ec216acf\", \"got_v8_revision_cp\": \"refs/heads/9.1.84@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"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\": \"e0fada832e51c3e29dbc7ac110009e62dfde5b6b\", \"swarm_hashes_refs/heads/master(at){#861373}_without_patch\": {\"absl_hardening_tests\": \"6f4d0bdd775207b19b7dd4c2432e9887a21606f6\", \"accessibility_unittests\": \"e6efebd5ab0e8b7f74baaa363281e6e894003450\", \"angle_unittests\": \"dc81bb5f7818e6c881a9533ea7f88e0d2395ea2f\", \"app_shell_unittests\": \"2695055433717488b2a0235a38337a9130aa5a01\", \"aura_unittests\": \"5f029a44620795108dbcc94a2169edc424e24ab1\", \"base_unittests\": \"761ede99ac5bfce9f8c3ae58947bf488e90debb6\", \"base_util_unittests\": \"6f32bdcd8fe1644cb258bc157a08b263084edbd3\", \"blink_common_unittests\": \"9078b0f28393f1b2252fdbbceb9c7f0d9cddf533\", \"blink_fuzzer_unittests\": \"974ac1c84595f13c89e4eff89f7356ac3c16a961\", \"blink_heap_unittests\": \"4b80835ace3125496416ab4db9f910a58fc83765\", \"blink_platform_unittests\": \"9e7e5d334999f7153fad0a6ecb259fc2fe903dc0\", \"blink_unittests\": \"fe5d21b2e1edaf14dc52ff94644e5022d1311325\", \"boringssl_crypto_tests\": \"e8c0ea9a988ddf63719daa11a12bf1b2d9ac780b\", \"boringssl_ssl_tests\": \"1ff63b184847919ca295c24e2abf9560034c6852\", \"browser_switcher_bho_unittests\": \"1f76ba355e191a522069eba153bd992997efa9be\", \"browser_tests\": \"2f57cf8988afc9c97d0ce81674552db7a564abd2\", \"capture_unittests\": \"f5382c0b3ab135fe15ba2e3ace9d9c1f674d49aa\", \"cast_unittests\": \"0ab020c2332047f8a290b7e43e719e297804b124\", \"cc_unittests\": \"c767d099db966d0dc79923fb33db257f0b27593b\", \"chrome_app_unittests\": \"b3976cdeb6e01df1170553f7d0d2d0149444d5d1\", \"chrome_cleaner_unittests\": \"ec52001dc378d3dc9ed973b5e1492f3317abb4a8\", \"chrome_elf_unittests\": \"772ae7d097aced8c4a005bd092ded60b088a36ba\", \"chromedriver_unittests\": \"c4150c091b390488ff663576e4d3c56b1233297f\", \"color_unittests\": \"403c6112f958c115c2f693e8477345f28a64b24e\", \"components_browsertests\": \"a3b17d3570cc1551dbe64e7933171a9f5b75dbd6\", \"components_unittests\": \"2dde7b0045ebf2d6c140898ac523b5988a049bd3\", \"compositor_unittests\": \"3217e807915461629abc6f8caae7e1a293941751\", \"content_browsertests\": \"5e2af7d43609f2646806a4c82a371c1fb8347c67\", \"content_unittests\": \"82c5dd60eb1bbcf1c1757850ee860882339211f0\", \"courgette_unittests\": \"80a6afd1290471b5146cb9ae45113781c2902570\", \"crashpad_tests\": \"ecbf80a7d6a7a90f0c9fc7dda926a21432902ec2\", \"cronet_tests\": \"fad30352b255931a9e498e7d5a989efc6aa320b8\", \"cronet_unittests\": \"ca8f3f5d8c74b2e757f1bbd89ee677564d89c780\", \"crypto_unittests\": \"4e5aa5d373c0dfea1fb1f3ba9b021be7e148a675\", \"delayloads_unittests\": \"783728b5610ad0a0dffce32a50ab5a2af094dd71\", \"device_unittests\": \"ea5286d202b79fe95f5425c6811bd987a3ba7abc\", \"display_unittests\": \"4b945bf31c354c9b6afc4e5e97f7da35c823ed0c\", \"elevation_service_unittests\": \"c418319d8cd457bc0297e88c91147710e2ef4333\", \"events_unittests\": \"be1b285b72893fc5f7643b61580d610636c7c351\", \"extensions_browsertests\": \"0fa8f6e3c8381e652bc24a06b28360b9ebacf975\", \"extensions_unittests\": \"fcd3b3143d23e511a77b4630e011433bcf754922\", \"filesystem_service_unittests\": \"6851e0ed46e0368d0da183453e174220771fd5e9\", \"gcm_unit_tests\": \"5f4985c92dc4db7e5499ed79f4b32530eeae65c5\", \"gcp_unittests\": \"e8e605fc69c595b74ee4c7156e12ef327cddbeed\", \"gfx_unittests\": \"86da39ccae89079aa8562fa3ff4ee34fbba03b2e\", \"gin_unittests\": \"f231070254df2f4e910b0294271824c69aa1ad40\", \"google_apis_unittests\": \"df0a92179a5da788bb4d47326016b9cd55a1a62f\", \"gpu_unittests\": \"161fbd43e41dd0b66821dde9c8c02d0a4fbae242\", \"gwp_asan_unittests\": \"0eb89cc792e7bde8f2737e930a208bcc8cf8c8e9\", \"headless_browsertests\": \"265877fc282c490119291b653b3d7c1924d9defb\", \"headless_unittests\": \"d95b22f673fc5ec3f8d9e8ecbb8f350f6992e4ec\", \"install_static_unittests\": \"8a83250c9ae5605134bb79726927c31655546ea9\", \"installer_util_unittests\": \"8edfd47edf5df2539201b110a185dfbc16bb88f7\", \"interactive_ui_tests\": \"8030fb2d00a3bab494101487585c082f0d75485c\", \"ipc_tests\": \"076aa4f5ad7ee99dccd5446a4da093540616c179\", \"jingle_unittests\": \"382d1ced3e9f684033898037599d5f86df92e95e\", \"latency_unittests\": \"b8eb940eb700c7cc5c38712ed49e1738d3a6a396\", \"libjingle_xmpp_unittests\": \"5e711cfe3c7da62cae38cd1748157415d86315f9\", \"liburlpattern_unittests\": \"90cdb7e3757032b88fb8f0daac63cf25a1a3cdb5\", \"media_blink_unittests\": \"6131c32b24a3b8611d0021ec3cd61cb1de9ae02d\", \"media_unittests\": \"d76f59e1fa641757ef0485f81a9fa098f5b19796\", \"message_center_unittests\": \"f957e3655d8b3d2ccdd1645b3ae291a38cd0bd09\", \"midi_unittests\": \"99434b4294f11eb9f06089b4a8bb8a5e4b45682f\", \"mojo_core_unittests\": \"f0aa52af6d2f6f2ea26e7bcbb802d55fc8f23e68\", \"mojo_unittests\": \"5677a1d5810a3a0b821908929839d91a43379c40\", \"nacl_loader_unittests\": \"2b1266ee11451d5196deb5ddcd31bcdf9aab8ba2\", \"native_theme_unittests\": \"316bab4a04f03213ae1a38e286f5aa0edd861057\", \"net_unittests\": \"62055a9e3d1cadb50b6451e11545e2ba7ae574e2\", \"notification_helper_unittests\": \"01fdf38f5bf878fc954c7605016d1b63442729be\", \"pdf_unittests\": \"a496aab3ab28234c3c0e5fd7bc3d24f3d0e21101\", \"perfetto_unittests\": \"6d6e23ecfe7e995a16427bab74200f994b2cdb3b\", \"ppapi_unittests\": \"15aa85b32d6d61477c3d067b0f0728648d2e25ae\", \"printing_unittests\": \"eb0a3707cfdf850cce28f3c3fe207ca72b7a2374\", \"remoting_unittests\": \"4d24ffda7c62da79e511e8a4e0463a7e2ff757d1\", \"sbox_integration_tests\": \"8dfc39c8bde50801a2ea9d8014175f30e07043e8\", \"sbox_unittests\": \"3226834ff9ef3b16b3528a49376e926314f71592\", \"sbox_validation_tests\": \"a1b3461d142ddf3aeb88312c251b7ea059640c17\", \"service_manager_unittests\": \"fec109f1675a912eb38547a885b9a4c05c31d6dc\", \"services_unittests\": \"cc7d8c9711195eef7bb973a3ccf7da8b3ef6ea8e\", \"setup_unittests\": \"d9ea133b14a4af7996be8fe92c049cb1b9779139\", \"shell_dialogs_unittests\": \"f2a56ed4a0f5e48db594e45f788a67edb47b081d\", \"skia_unittests\": \"38f65a46ffe22468dd683d97a945a393b8900919\", \"snapshot_unittests\": \"0ee6e08c2eefdba305f49a6e4908c673946fb750\", \"sql_unittests\": \"59cc410635fea87c400ce87068f708b6a0962441\", \"storage_unittests\": \"5839146ab46752dd6fd9fe5bac73c84d6533b2eb\", \"sync_integration_tests\": \"9a68b4a81aa22faa472314ceee099dc23b2ec39f\", \"traffic_annotation_auditor_unittests\": \"0da050484428222dd0857dfd71bcb4f9fde90a45\", \"ui_base_unittests\": \"66af1d90abbd58e535952aaa8a4eb3e1a76e0b6f\", \"ui_touch_selection_unittests\": \"0ba50398956280295b32c1878cb29e426da89d5b\", \"unit_tests\": \"5c2d6866d9b7788366ac23d8a62c3ae32f5257c2\", \"updater_tests\": \"0db2868e3e9f1287a50d777c9dbbc40be943d88d\", \"url_unittests\": \"9d04da7ea6aad9da0a3794a5906cb6c32ff86d62\", \"views_unittests\": \"335b5863b0030f8037c2857c11088342160e1ef5\", \"viz_unittests\": \"940712c246dcfc37a878737323b483293f2cb8a8\", \"vr_common_unittests\": \"f5fd838115f44e470bcc6e3c0ec6298c57e0c895\", \"vr_pixeltests\": \"073f5756c050630a434063fcbe8a1273065a62f7\", \"weblayer_browsertests\": \"ddba4639c93f0169e634c8ffef4ee4c819405827\", \"weblayer_unittests\": \"0a6c0ed21e61cb1b84d4e435c6638c1c01a5d6ad\", \"wm_unittests\": \"66c66e289eda01fc512eb8996670e8b92903da4e\", \"wtf_unittests\": \"25571107e1e9c39dd7be64906dcd5ba0b0e39402\", \"zlib_unittests\": \"6e2f0117b7a8e01b9a51a2a07cc52a285141a945\", \"zucchini_unittests\": \"e71d0445775b6073471bfcbdad1fadb4960fd67f\"}}, \"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-2xaw\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5746-91ff3bd\"], \"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": "1615338668814625",
"status": "COMPLETED",
"status_changed_ts": "1615342255234306",
"tags": [
"build_address:luci.chromium.ci/win-asan/17729",
"builder:win-asan",
"buildset:commit/git/e0fada832e51c3e29dbc7ac110009e62dfde5b6b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e0fada832e51c3e29dbc7ac110009e62dfde5b6b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018618420011034400",
"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/8853188357844034976/+/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:523281869e324b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615342255256786",
"url": "https://ci.chromium.org/b/8853188357844034976",
"utcnow_ts": "1615342256999632"
}
}
[02:10:57.007] Invocation finished in 59m51.43146857s with status SUCCEEDED