[08:34:06.819] New invocation is queued and will start shortly
[08:34:08.484] Starting the invocation (attempt 1)
[08:34:08.524] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:34:08.524] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:34:08.524] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028193826013442704",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"52526660a2682125c7e5b4565b34f25ab0c13443\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028193826013442704",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/52526660a2682125c7e5b4565b34f25ab0c13443",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52526660a2682125c7e5b4565b34f25ab0c13443",
"gitiles_ref:refs/heads/master"
]
}
[08:34:09.993] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606206848624564",
"id": "8862763763455348704",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52526660a2682125c7e5b4565b34f25ab0c13443\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606206849643630",
"tags": [
"build_address:luci.chromium.ci/win-asan/15818",
"builder:win-asan",
"buildset:commit/git/52526660a2682125c7e5b4565b34f25ab0c13443",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52526660a2682125c7e5b4565b34f25ab0c13443",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028193826013442704",
"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/8862763763455348704/+/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": "1606206849645626",
"url": "https://ci.chromium.org/b/8862763763455348704",
"utcnow_ts": "1606206849966386"
}
}
[08:34:09.993] Task URL: https://ci.chromium.org/b/8862763763455348704
[08:34:09.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:2:0) after 1m0s
[08:35:10.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:2:0)
[08:35:10.023] Timer tick, asking Buildbucket for the build status
[08:35:10.152] Build 8862763763455348704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:10.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:3:0) after 1m0s
[08:36:10.188] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:3:0)
[08:36:10.188] Timer tick, asking Buildbucket for the build status
[08:36:10.264] Build 8862763763455348704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:10.265] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:4:0) after 1m0s
[08:37:10.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:4:0)
[08:37:10.295] Timer tick, asking Buildbucket for the build status
[08:37:10.402] Build 8862763763455348704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:37:10.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:5:0) after 1m0s
[08:38:10.525] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:5:0)
[08:38:10.525] Timer tick, asking Buildbucket for the build status
[08:38:10.630] Build 8862763763455348704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:38:10.630] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:6:0) after 1m0s
[08:39:10.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:6:0)
[08:39:10.666] Timer tick, asking Buildbucket for the build status
[08:39:10.842] Build 8862763763455348704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:39:10.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:7:0) after 1m0s
[08:39:53.788] Received PubSub notification, asking Buildbucket for the build status
[08:39:53.867] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:10.964] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:7:0)
[08:40:10.964] Timer tick, asking Buildbucket for the build status
[08:40:11.064] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:11.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:9:0) after 1m0s
[08:41:11.116] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:9:0)
[08:41:11.116] Timer tick, asking Buildbucket for the build status
[08:41:11.219] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:11.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:10:0) after 1m0s
[08:42:11.292] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:10:0)
[08:42:11.292] Timer tick, asking Buildbucket for the build status
[08:42:11.735] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:11.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:11:0) after 1m0s
[08:43:11.779] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:11:0)
[08:43:11.779] Timer tick, asking Buildbucket for the build status
[08:43:11.846] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:11.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:12:0) after 1m0s
[08:44:11.894] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:12:0)
[08:44:11.894] Timer tick, asking Buildbucket for the build status
[08:44:12.023] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:12.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:13:0) after 1m0s
[08:45:12.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:13:0)
[08:45:12.089] Timer tick, asking Buildbucket for the build status
[08:45:12.159] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:12.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:14:0) after 1m0s
[08:46:12.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:14:0)
[08:46:12.189] Timer tick, asking Buildbucket for the build status
[08:46:12.263] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:12.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:15:0) after 1m0s
[08:47:12.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:15:0)
[08:47:12.303] Timer tick, asking Buildbucket for the build status
[08:47:12.365] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:12.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:16:0) after 1m0s
[08:48:12.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:16:0)
[08:48:12.398] Timer tick, asking Buildbucket for the build status
[08:48:12.525] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:12.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:17:0) after 1m0s
[08:49:12.593] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:17:0)
[08:49:12.593] Timer tick, asking Buildbucket for the build status
[08:49:13.305] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:13.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:18:0) after 1m0s
[08:50:13.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:18:0)
[08:50:13.459] Timer tick, asking Buildbucket for the build status
[08:50:13.588] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:13.588] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:19:0) after 1m0s
[08:51:13.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:19:0)
[08:51:13.703] Timer tick, asking Buildbucket for the build status
[08:51:13.754] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:13.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:20:0) after 1m0s
[08:52:13.864] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:20:0)
[08:52:13.864] Timer tick, asking Buildbucket for the build status
[08:52:13.997] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:13.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:21:0) after 1m0s
[08:53:14.068] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:21:0)
[08:53:14.068] Timer tick, asking Buildbucket for the build status
[08:53:14.133] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:14.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:22:0) after 1m0s
[08:54:14.137] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:22:0)
[08:54:14.137] Timer tick, asking Buildbucket for the build status
[08:54:14.247] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:14.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:23:0) after 1m0s
[08:55:14.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:23:0)
[08:55:14.360] Timer tick, asking Buildbucket for the build status
[08:55:14.494] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:14.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:24:0) after 1m0s
[08:56:14.585] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:24:0)
[08:56:14.585] Timer tick, asking Buildbucket for the build status
[08:56:14.810] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:14.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:25:0) after 1m0s
[08:57:14.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:25:0)
[08:57:14.818] Timer tick, asking Buildbucket for the build status
[08:57:14.924] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:14.924] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:26:0) after 1m0s
[08:58:15.015] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:26:0)
[08:58:15.015] Timer tick, asking Buildbucket for the build status
[08:58:15.129] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:15.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:27:0) after 1m0s
[08:59:15.185] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:27:0)
[08:59:15.185] Timer tick, asking Buildbucket for the build status
[08:59:15.291] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:15.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:28:0) after 1m0s
[09:00:15.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:28:0)
[09:00:15.402] Timer tick, asking Buildbucket for the build status
[09:00:15.618] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:15.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:29:0) after 1m0s
[09:01:15.654] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:29:0)
[09:01:15.654] Timer tick, asking Buildbucket for the build status
[09:01:15.790] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:15.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:30:0) after 1m0s
[09:02:15.849] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:30:0)
[09:02:15.849] Timer tick, asking Buildbucket for the build status
[09:02:15.911] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:15.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:31:0) after 1m0s
[09:03:16.018] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:31:0)
[09:03:16.018] Timer tick, asking Buildbucket for the build status
[09:03:16.209] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:16.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:32:0) after 1m0s
[09:04:16.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:32:0)
[09:04:16.229] Timer tick, asking Buildbucket for the build status
[09:04:16.421] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:16.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:33:0) after 1m0s
[09:05:16.536] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:33:0)
[09:05:16.536] Timer tick, asking Buildbucket for the build status
[09:05:16.624] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:16.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:34:0) after 1m0s
[09:06:16.687] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:34:0)
[09:06:16.688] Timer tick, asking Buildbucket for the build status
[09:06:16.850] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:16.850] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:35:0) after 1m0s
[09:07:16.913] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:35:0)
[09:07:16.913] Timer tick, asking Buildbucket for the build status
[09:07:16.982] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:16.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:36:0) after 1m0s
[09:08:17.077] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:36:0)
[09:08:17.077] Timer tick, asking Buildbucket for the build status
[09:08:17.152] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:17.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:37:0) after 1m0s
[09:09:17.213] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:37:0)
[09:09:17.213] Timer tick, asking Buildbucket for the build status
[09:09:17.318] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:17.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:38:0) after 1m0s
[09:10:17.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:38:0)
[09:10:17.325] Timer tick, asking Buildbucket for the build status
[09:10:17.387] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:17.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:39:0) after 1m0s
[09:11:17.443] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:39:0)
[09:11:17.443] Timer tick, asking Buildbucket for the build status
[09:11:17.520] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:17.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:40:0) after 1m0s
[09:12:17.604] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:40:0)
[09:12:17.604] Timer tick, asking Buildbucket for the build status
[09:12:17.678] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:17.678] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:41:0) after 1m0s
[09:13:17.812] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:41:0)
[09:13:17.812] Timer tick, asking Buildbucket for the build status
[09:13:18.254] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:18.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:42:0) after 1m0s
[09:14:18.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:42:0)
[09:14:18.353] Timer tick, asking Buildbucket for the build status
[09:14:18.455] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:18.455] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:43:0) after 1m0s
[09:15:18.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:43:0)
[09:15:18.568] Timer tick, asking Buildbucket for the build status
[09:15:18.650] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:18.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:44:0) after 1m0s
[09:16:18.712] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:44:0)
[09:16:18.712] Timer tick, asking Buildbucket for the build status
[09:16:18.809] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:18.809] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:45:0) after 1m0s
[09:17:18.890] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:45:0)
[09:17:18.890] Timer tick, asking Buildbucket for the build status
[09:17:19.063] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:19.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:46:0) after 1m0s
[09:18:19.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:46:0)
[09:18:19.167] Timer tick, asking Buildbucket for the build status
[09:18:19.300] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:19.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:47:0) after 1m0s
[09:19:19.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:47:0)
[09:19:19.323] Timer tick, asking Buildbucket for the build status
[09:19:19.428] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:19.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:48:0) after 1m0s
[09:20:19.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:48:0)
[09:20:19.459] Timer tick, asking Buildbucket for the build status
[09:20:19.550] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:19.550] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:49:0) after 1m0s
[09:21:20.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:49:0)
[09:21:20.025] Timer tick, asking Buildbucket for the build status
[09:21:20.224] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:20.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:50:0) after 1m0s
[09:22:20.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:50:0)
[09:22:20.408] Timer tick, asking Buildbucket for the build status
[09:22:20.502] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:20.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:51:0) after 1m0s
[09:23:20.625] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:51:0)
[09:23:20.625] Timer tick, asking Buildbucket for the build status
[09:23:20.703] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:20.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:52:0) after 1m0s
[09:24:20.971] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:52:0)
[09:24:20.971] Timer tick, asking Buildbucket for the build status
[09:24:21.119] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:21.119] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:53:0) after 1m0s
[09:25:21.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:53:0)
[09:25:21.317] Timer tick, asking Buildbucket for the build status
[09:25:21.387] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:21.387] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:54:0) after 1m0s
[09:26:21.425] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:54:0)
[09:26:21.425] Timer tick, asking Buildbucket for the build status
[09:26:21.665] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:21.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:55:0) after 1m0s
[09:27:21.811] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:55:0)
[09:27:21.811] Timer tick, asking Buildbucket for the build status
[09:27:21.881] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:21.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:56:0) after 1m0s
[09:28:22.081] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:56:0)
[09:28:22.081] Timer tick, asking Buildbucket for the build status
[09:28:22.247] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:22.247] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:57:0) after 1m0s
[09:29:22.312] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:57:0)
[09:29:22.312] Timer tick, asking Buildbucket for the build status
[09:29:22.439] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:22.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:58:0) after 1m0s
[09:30:22.558] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:58:0)
[09:30:22.558] Timer tick, asking Buildbucket for the build status
[09:30:22.618] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:22.618] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:59:0) after 1m0s
[09:31:22.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:59:0)
[09:31:22.791] Timer tick, asking Buildbucket for the build status
[09:31:22.912] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:22.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:60:0) after 1m0s
[09:32:23.129] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:60:0)
[09:32:23.129] Timer tick, asking Buildbucket for the build status
[09:32:23.210] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:23.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:61:0) after 1m0s
[09:33:23.413] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:61:0)
[09:33:23.413] Timer tick, asking Buildbucket for the build status
[09:33:23.500] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:23.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:62:0) after 1m0s
[09:34:23.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:62:0)
[09:34:23.550] Timer tick, asking Buildbucket for the build status
[09:34:23.646] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:23.646] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:63:0) after 1m0s
[09:35:23.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:63:0)
[09:35:23.753] Timer tick, asking Buildbucket for the build status
[09:35:23.855] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:23.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:64:0) after 1m0s
[09:36:23.886] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:64:0)
[09:36:23.886] Timer tick, asking Buildbucket for the build status
[09:36:24.013] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:24.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:65:0) after 1m0s
[09:37:24.073] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:65:0)
[09:37:24.073] Timer tick, asking Buildbucket for the build status
[09:37:24.596] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:24.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:66:0) after 1m0s
[09:38:24.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:66:0)
[09:38:24.646] Timer tick, asking Buildbucket for the build status
[09:38:24.761] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:24.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:67:0) after 1m0s
[09:39:24.881] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:67:0)
[09:39:24.881] Timer tick, asking Buildbucket for the build status
[09:39:25.118] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:25.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:68:0) after 1m0s
[09:40:25.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:68:0)
[09:40:25.210] Timer tick, asking Buildbucket for the build status
[09:40:25.419] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:25.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:69:0) after 1m0s
[09:41:25.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:69:0)
[09:41:25.479] Timer tick, asking Buildbucket for the build status
[09:41:25.604] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:25.604] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:70:0) after 1m0s
[09:42:25.770] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:70:0)
[09:42:25.770] Timer tick, asking Buildbucket for the build status
[09:42:25.858] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:25.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:71:0) after 1m0s
[09:43:25.937] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:71:0)
[09:43:25.937] Timer tick, asking Buildbucket for the build status
[09:43:26.052] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:26.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:72:0) after 1m0s
[09:44:26.188] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:72:0)
[09:44:26.188] Timer tick, asking Buildbucket for the build status
[09:44:26.385] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:26.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:73:0) after 1m0s
[09:45:26.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:73:0)
[09:45:26.481] Timer tick, asking Buildbucket for the build status
[09:45:26.603] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:26.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:74:0) after 1m0s
[09:46:26.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:74:0)
[09:46:26.626] Timer tick, asking Buildbucket for the build status
[09:46:26.746] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:26.746] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:75:0) after 1m0s
[09:47:26.772] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:75:0)
[09:47:26.772] Timer tick, asking Buildbucket for the build status
[09:47:26.869] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:26.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:76:0) after 1m0s
[09:48:26.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:76:0)
[09:48:26.991] Timer tick, asking Buildbucket for the build status
[09:48:27.269] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:27.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:77:0) after 1m0s
[09:49:27.474] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:77:0)
[09:49:27.474] Timer tick, asking Buildbucket for the build status
[09:49:27.945] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:27.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:78:0) after 1m0s
[09:50:28.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:78:0)
[09:50:28.005] Timer tick, asking Buildbucket for the build status
[09:50:28.196] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:28.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:79:0) after 1m0s
[09:51:28.255] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:79:0)
[09:51:28.255] Timer tick, asking Buildbucket for the build status
[09:51:28.329] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:28.329] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:80:0) after 1m0s
[09:52:28.319] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:80:0)
[09:52:28.319] Timer tick, asking Buildbucket for the build status
[09:52:28.425] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:28.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:81:0) after 1m0s
[09:53:28.459] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:81:0)
[09:53:28.459] Timer tick, asking Buildbucket for the build status
[09:53:28.583] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:28.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:82:0) after 1m0s
[09:54:28.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:82:0)
[09:54:28.614] Timer tick, asking Buildbucket for the build status
[09:54:28.766] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:28.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:83:0) after 1m0s
[09:55:28.790] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:83:0)
[09:55:28.790] Timer tick, asking Buildbucket for the build status
[09:55:28.938] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:28.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:84:0) after 1m0s
[09:56:28.996] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:84:0)
[09:56:28.996] Timer tick, asking Buildbucket for the build status
[09:56:29.079] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:29.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:85:0) after 1m0s
[09:57:29.109] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:85:0)
[09:57:29.109] Timer tick, asking Buildbucket for the build status
[09:57:29.179] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:29.179] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:86:0) after 1m0s
[09:58:29.212] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:86:0)
[09:58:29.212] Timer tick, asking Buildbucket for the build status
[09:58:29.349] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:29.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:87:0) after 1m0s
[09:59:29.383] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:87:0)
[09:59:29.383] Timer tick, asking Buildbucket for the build status
[09:59:29.487] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:29.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:88:0) after 1m0s
[10:00:29.522] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:88:0)
[10:00:29.522] Timer tick, asking Buildbucket for the build status
[10:00:29.583] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:29.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:89:0) after 1m0s
[10:01:29.623] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:89:0)
[10:01:29.623] Timer tick, asking Buildbucket for the build status
[10:01:29.695] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:29.695] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:90:0) after 1m0s
[10:02:29.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:90:0)
[10:02:29.909] Timer tick, asking Buildbucket for the build status
[10:02:29.999] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:29.999] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:91:0) after 1m0s
[10:03:30.075] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:91:0)
[10:03:30.075] Timer tick, asking Buildbucket for the build status
[10:03:30.228] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:30.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:92:0) after 1m0s
[10:04:30.293] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:92:0)
[10:04:30.293] Timer tick, asking Buildbucket for the build status
[10:04:30.437] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:30.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:93:0) after 1m0s
[10:05:30.467] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:93:0)
[10:05:30.467] Timer tick, asking Buildbucket for the build status
[10:05:30.905] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:30.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:94:0) after 1m0s
[10:06:30.987] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:94:0)
[10:06:30.987] Timer tick, asking Buildbucket for the build status
[10:06:31.111] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:31.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:95:0) after 1m0s
[10:07:31.591] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:95:0)
[10:07:31.591] Timer tick, asking Buildbucket for the build status
[10:07:32.264] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:32.264] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:96:0) after 1m0s
[10:08:32.350] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:96:0)
[10:08:32.350] Timer tick, asking Buildbucket for the build status
[10:08:32.479] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:32.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:97:0) after 1m0s
[10:09:32.679] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:97:0)
[10:09:32.680] Timer tick, asking Buildbucket for the build status
[10:09:32.814] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:32.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:98:0) after 1m0s
[10:10:32.932] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:98:0)
[10:10:32.932] Timer tick, asking Buildbucket for the build status
[10:10:33.005] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:33.005] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:99:0) after 1m0s
[10:11:35.401] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:99:0)
[10:11:35.401] Timer tick, asking Buildbucket for the build status
[10:11:35.489] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:35.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:100:0) after 1m0s
[10:12:35.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:100:0)
[10:12:35.805] Timer tick, asking Buildbucket for the build status
[10:12:35.876] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:35.877] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:101:0) after 1m0s
[10:13:36.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:101:0)
[10:13:36.067] Timer tick, asking Buildbucket for the build status
[10:13:36.159] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:36.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:102:0) after 1m0s
[10:14:36.148] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:102:0)
[10:14:36.148] Timer tick, asking Buildbucket for the build status
[10:14:36.489] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:36.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:103:0) after 1m0s
[10:15:36.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:103:0)
[10:15:36.481] Timer tick, asking Buildbucket for the build status
[10:15:36.565] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:36.565] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:104:0) after 1m0s
[10:16:36.601] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:104:0)
[10:16:36.601] Timer tick, asking Buildbucket for the build status
[10:16:37.428] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:37.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:105:0) after 1m0s
[10:17:37.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:105:0)
[10:17:37.512] Timer tick, asking Buildbucket for the build status
[10:17:37.580] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:37.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:106:0) after 1m0s
[10:18:37.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:106:0)
[10:18:37.663] Timer tick, asking Buildbucket for the build status
[10:18:37.840] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:37.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:107:0) after 1m0s
[10:19:37.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:107:0)
[10:19:37.888] Timer tick, asking Buildbucket for the build status
[10:19:38.808] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:38.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:108:0) after 1m0s
[10:20:38.913] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:108:0)
[10:20:38.913] Timer tick, asking Buildbucket for the build status
[10:20:38.985] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:38.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:109:0) after 1m0s
[10:21:39.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:109:0)
[10:21:39.005] Timer tick, asking Buildbucket for the build status
[10:21:39.109] Build 8862763763455348704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:39.109] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028193826013442704:110:0) after 1m0s
[10:22:10.400] Received PubSub notification, asking Buildbucket for the build status
[10:22:10.713] Build 8862763763455348704: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:22:10.713] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606213329428258",
"created_by": "project:chromium",
"created_ts": "1606206848624564",
"id": "8862763763455348704",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52526660a2682125c7e5b4565b34f25ab0c13443\"}}",
"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\": \"52526660a2682125c7e5b4565b34f25ab0c13443\", \"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-2gr3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15818, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"1b413197a6d7eefe786ee57b380ac4d5b7334ee3\", \"got_dawn_revision\": \"03badec5d73ab4138f798b94221546c496177a09\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"52526660a2682125c7e5b4565b34f25ab0c13443\", \"got_revision_cp\": \"refs/heads/master@{#830508}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"43bb60e1fa119d80b449c6550dd2b72328b101b9\", \"got_v8_revision\": \"4ff956a829fefd66af0deeb9bb091fda4389fa21\", \"got_v8_revision_cp\": \"refs/heads/8.9.39@{#1}\", \"got_webrtc_revision\": \"19526a69c763d26f4699f14dd33681db8976a1b1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32676}\", \"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\": \"52526660a2682125c7e5b4565b34f25ab0c13443\", \"swarm_hashes_refs/heads/master(at){#830508}_without_patch\": {\"absl_hardening_tests\": \"e2ccc92626475bfabb4fa473f2ae0376eeb94cc9\", \"accessibility_unittests\": \"366b0ef7478cc8e64bc71b16b781de5ce5aaad45\", \"angle_unittests\": \"94d4b16818bcce0ceafe423289a4591982628c67\", \"app_shell_unittests\": \"9248af666459aaf156dd86e1aaeafa6270041c0c\", \"aura_unittests\": \"a61d8be29d1b956207c8929d923ccb86b857eeaa\", \"base_unittests\": \"ca45002274196d76a29699459d6b4010f5bbf21f\", \"base_util_unittests\": \"3e8356d9f6b70f5ee0add0c16e2690cc4dde036a\", \"blink_common_unittests\": \"0b08ddcb2faff4f14ccc37b9150150c7be255631\", \"blink_fuzzer_unittests\": \"925ef324a845006022db5c8ffef989ac58ce00a9\", \"blink_heap_unittests\": \"81fd03dc7416b9afa33258d96cca4b6be453ed5e\", \"blink_platform_unittests\": \"c37671675dd71dc86d9bde0c2a2c002e9702e712\", \"blink_unittests\": \"43655ec9db2b4f5d8e82e2b2296fe8f8d6cee31d\", \"boringssl_crypto_tests\": \"aae324d9c343b7b8ed84f629aa5aadbdb7addf25\", \"boringssl_ssl_tests\": \"6b79f81a137eda9ff76bbb85eb60cbf88c88a170\", \"browser_switcher_bho_unittests\": \"50332590f5228c0962661540660aa618c06a2fcd\", \"browser_tests\": \"fca97b578588d5e338562b1bd03d6a3ea420206c\", \"capture_unittests\": \"04c18371a9592fe2feb2d644598fb0aa6ba1b458\", \"cast_unittests\": \"8e6c802f97b205cd21b81528202d5d209f375d17\", \"cc_unittests\": \"e5b3255e98fec8034785b85020aa0a0d053b74a0\", \"chrome_app_unittests\": \"b9dae5a837d013aa2a76f71e4145d9efc075abe2\", \"chrome_cleaner_unittests\": \"0e6139d3dd50132a05e39f36142871ccb19225d5\", \"chrome_elf_unittests\": \"ef02cff661c072c9dd6cbcdd11907516ac393c28\", \"chromedriver_unittests\": \"05a339efa67a8452e73b01fef0d3ca24801bf558\", \"components_browsertests\": \"c6f84e050cc8f402b81818b3bd06e3909677c86b\", \"components_unittests\": \"3df9d28813ae11933b7693b809b3d0630de3a757\", \"compositor_unittests\": \"fe0090c2e690bf54d1ed4ecd2fb1f421249f07b0\", \"content_browsertests\": \"8dac0ebcecf1a252751c108dc6f7bba082791620\", \"content_unittests\": \"c3457b0c8812e4f5fec92784e32a80f0668db085\", \"courgette_unittests\": \"5b18a3d7cea54302494c60084e7b41300d045cb2\", \"crashpad_tests\": \"995be11c680d33e5596e19e53b8a69e52f1e2122\", \"cronet_tests\": \"70d4ca5cb9adc9ffe391183129416babf9070c9c\", \"cronet_unittests\": \"c351c6594deb7b3aa8cc4f1879f6139114e2826c\", \"crypto_unittests\": \"156c885c1cb72cf1ada29e06314eb9f418e4b851\", \"delayloads_unittests\": \"5e253cb1a7e0efd3e54e27b613664d5191fdab36\", \"device_unittests\": \"b74d6ac7e9e4953f20981cc8e437daa13e3afd99\", \"display_unittests\": \"725050572bbd4871fe1d93cfe054c60e094abf0f\", \"elevation_service_unittests\": \"3926b9bb944f4fcc92ab9321e8896e149a78fe52\", \"events_unittests\": \"a58f572c505ea585f6d22f42d5641ea99c832a77\", \"extensions_browsertests\": \"39e3ade89a96bbbfa5c85f4701f8db79f89ef0f5\", \"extensions_unittests\": \"309214558f5cfa66019c894404a0b61044490b44\", \"filesystem_service_unittests\": \"9752da960caf5a82beba972ece94b40d2fe426ec\", \"gcm_unit_tests\": \"740e2a8dff23b08a20a0582811153e9f361e2b68\", \"gcp_unittests\": \"d1398a3352a44f7bc098c277a677a21b93cb1698\", \"gfx_unittests\": \"316249345494763a6a1846856e117dd527162262\", \"gin_unittests\": \"cb00c52faa51596f928556883986fc6c35fa0297\", \"google_apis_unittests\": \"e976b119eef1016d55ab0a6932ee0f8a1b9e84ab\", \"gpu_unittests\": \"86ee78c340a0e42308799f86ea52c07016a7effe\", \"gwp_asan_unittests\": \"135c78c7f7aafe67c4ca003de7f8996a24318d07\", \"headless_browsertests\": \"a548562649d41a1a5f753668ecdb2cca2039ebce\", \"headless_unittests\": \"1b3495e68395bb4507d9b18eb23320aa3753b871\", \"install_static_unittests\": \"062bce20b5e08e6d9974c2f62d69018c5df468a4\", \"installer_util_unittests\": \"fa7b491fe4883f2d12bf10ed999f53b9e5901a2a\", \"interactive_ui_tests\": \"5ccac62f277af9dc7849af3da471476b43f92c98\", \"ipc_tests\": \"b3301e28ec290e0f7ec6c44eaa2b3dab1b842727\", \"jingle_unittests\": \"f61903feb0187e4234212f24bde74c095d5700cf\", \"latency_unittests\": \"e1a0270131d09ca7c7975676eb61b4216774749b\", \"libjingle_xmpp_unittests\": \"0cfeec47af3485a2abdbc5b12dce11934f5de1bf\", \"liburlpattern_unittests\": \"24ed6822a04941f24fbf731ef1c15fe7010892d8\", \"media_blink_unittests\": \"efb4910c2ecacaef5c36e2fe58fe1960d3e7fee4\", \"media_unittests\": \"2c1b6786d054eb19afe0fdc73f2ea53a889db26f\", \"message_center_unittests\": \"997df14492f5b934426a6bf52115c5367b92fe71\", \"midi_unittests\": \"e4a745798888b1206984a065d12e5ebadd21cccb\", \"mojo_core_unittests\": \"e8f3121180cfc60115a711c1014f33e7fe5993b3\", \"mojo_unittests\": \"61a63d782f1c83f775c9558ae4c8bace55c24e24\", \"nacl_loader_unittests\": \"aa0d0aea2445a0a39b6636b2e9e1083668f85cd1\", \"native_theme_unittests\": \"5b58211e19cb2eb0f8af8744da875bd20cda28c5\", \"net_unittests\": \"f9f78d43be29bddb6e1bea703fd1dec5379cbf82\", \"notification_helper_unittests\": \"2164e4048d42148c873b2cae861819f4406dd388\", \"pdf_unittests\": \"0f0709a74d231a0ee9c94fff99fb426019a1dace\", \"perfetto_unittests\": \"219a3808d6f7f31a437379f86ff28b393fad5d05\", \"ppapi_unittests\": \"cea482537e0b934684a4aeb243e395f78ef7eebe\", \"printing_unittests\": \"202cc7f734906c9e2e0cdc1d72e866bf99d3d32c\", \"remoting_unittests\": \"d637a6e8dd82e1945713c593b0ab596919a17bb4\", \"sbox_integration_tests\": \"851c37a799f6ed729a9bb2b17c40925d81c4bf40\", \"sbox_unittests\": \"d130de668f071aa7f16ee5d970d0685360f6efee\", \"sbox_validation_tests\": \"26312cf3b7319bd037ae0263f4894e435663a419\", \"service_manager_unittests\": \"8cd35c64a8466810628f63e0b7c8b2e93f3c33a6\", \"services_unittests\": \"97a1c2fba7681631fa661ba1cc194bfe9a2515d5\", \"setup_unittests\": \"e7172335109189b0e16ee0497aec43b119080487\", \"shell_dialogs_unittests\": \"a5c70f86fa99225e84b16e17306f5f5a583cd439\", \"skia_unittests\": \"382394b189eba6bed894a72082a75e3d3724d867\", \"snapshot_unittests\": \"d21a23c31e51ec33d08e269724edab96ef55d450\", \"sql_unittests\": \"ebaee487a10b190d4b17a95a6000b6355fa86b69\", \"storage_unittests\": \"f22c6fb4cf6e3d65c51be8a41e6960c35f77e0e0\", \"sync_integration_tests\": \"6f8418f6bab6221f070b5fee404e68a75fc84989\", \"traffic_annotation_auditor_unittests\": \"144101002d1a765369b1c584c9faf07117aa8651\", \"ui_base_unittests\": \"facf4ee6b58dbb2190824f2eabc20d1a9364ec4d\", \"ui_touch_selection_unittests\": \"eb857e2ac5c92b6d3b9b9a94079f2e43129b3cba\", \"unit_tests\": \"a65ac8b98b7300784cfa31094da3873b1ecf5db2\", \"updater_tests\": \"87f083706edcd3f194cb897e6c5ea10d0e03da39\", \"url_unittests\": \"cc1d972536714bb74a6eed5c2692c118255793f0\", \"views_unittests\": \"1a93504e1262b97cd49a6e0891b2bdb5478341e8\", \"viz_unittests\": \"ba7dc05aaea95973607d0bfacee70e0a4147e7d5\", \"vr_common_unittests\": \"adfd61459deff202631ad2f6126608b072f3e1d8\", \"vr_pixeltests\": \"995ab35cc861a45e54bb9f42160395fdf6eefc93\", \"weblayer_browsertests\": \"c22f554bbb75f21ccd9f5035dff10f8b64369f20\", \"weblayer_unittests\": \"d151092e0b53e8e7bc066f64fdbb5e301e61c7f5\", \"wm_unittests\": \"5b8c01d2d3c3fcb46092f360574afe408dcc45b8\", \"wtf_unittests\": \"645afedd67694fc47e6d38c959e1015811fda0e8\", \"zlib_unittests\": \"fd8982b26089a5f3602b61ed98f530d05596ccef\", \"zucchini_unittests\": \"260b008fac59186f9953816b15da905d7fc59279\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_ba2591630e3c492a7f8bed019e3d41c3ae1f8879793a1bf71c3be1367a2696d6_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-2gr3\"], \"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\": [\"5637-4d8b832\"], \"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": "1606207192914234",
"status": "COMPLETED",
"status_changed_ts": "1606213329773063",
"tags": [
"build_address:luci.chromium.ci/win-asan/15818",
"builder:win-asan",
"buildset:commit/git/52526660a2682125c7e5b4565b34f25ab0c13443",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52526660a2682125c7e5b4565b34f25ab0c13443",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028193826013442704",
"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/8862763763455348704/+/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:5012350bd3b51810",
"user_agent:luci-scheduler"
],
"updated_ts": "1606213329777433",
"url": "https://ci.chromium.org/b/8862763763455348704",
"utcnow_ts": "1606213330696664"
}
}
[10:22:10.713] Invocation finished in 1h48m3.912239996s with status SUCCEEDED