[07:19:34.722] New invocation is queued and will start shortly
[07:19:35.914] Starting the invocation (attempt 1)
[07:19:35.950] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:19:35.954] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:19:35.954] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028470306277707936",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"224723e7fbd13403da2a7162c30b2c015c04aeed\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028470306277707936",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/224723e7fbd13403da2a7162c30b2c015c04aeed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/224723e7fbd13403da2a7162c30b2c015c04aeed",
"gitiles_ref:refs/heads/master"
]
}
[07:19:36.657] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605943176070359",
"id": "8863040244167493280",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"224723e7fbd13403da2a7162c30b2c015c04aeed\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605943176513232",
"tags": [
"build_address:luci.chromium.ci/win-asan/15755",
"builder:win-asan",
"buildset:commit/git/224723e7fbd13403da2a7162c30b2c015c04aeed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/224723e7fbd13403da2a7162c30b2c015c04aeed",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028470306277707936",
"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/8863040244167493280/+/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": "1605943176513390",
"url": "https://ci.chromium.org/b/8863040244167493280",
"utcnow_ts": "1605943176646939"
}
}
[07:19:36.657] Task URL: https://ci.chromium.org/b/8863040244167493280
[07:19:36.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:2:0) after 1m0s
[07:20:36.669] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:2:0)
[07:20:36.669] Timer tick, asking Buildbucket for the build status
[07:20:37.115] Build 8863040244167493280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:20:37.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:3:0) after 1m0s
[07:21:37.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:3:0)
[07:21:37.134] Timer tick, asking Buildbucket for the build status
[07:21:37.303] Build 8863040244167493280: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:21:37.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:4:0) after 1m0s
[07:22:26.282] Received PubSub notification, asking Buildbucket for the build status
[07:22:26.356] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:37.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:4:0)
[07:22:37.327] Timer tick, asking Buildbucket for the build status
[07:22:37.392] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:37.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:6:0) after 1m0s
[07:23:37.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:6:0)
[07:23:37.434] Timer tick, asking Buildbucket for the build status
[07:23:37.534] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:37.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:7:0) after 1m0s
[07:24:37.571] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:7:0)
[07:24:37.571] Timer tick, asking Buildbucket for the build status
[07:24:37.682] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:37.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:8:0) after 1m0s
[07:25:37.701] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:8:0)
[07:25:37.701] Timer tick, asking Buildbucket for the build status
[07:25:37.860] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:37.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:9:0) after 1m0s
[07:26:37.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:9:0)
[07:26:37.883] Timer tick, asking Buildbucket for the build status
[07:26:37.955] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:37.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:10:0) after 1m0s
[07:27:37.970] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:10:0)
[07:27:37.970] Timer tick, asking Buildbucket for the build status
[07:27:38.032] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:38.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:11:0) after 1m0s
[07:28:38.048] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:11:0)
[07:28:38.048] Timer tick, asking Buildbucket for the build status
[07:28:38.200] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:38.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:12:0) after 1m0s
[07:29:38.246] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:12:0)
[07:29:38.246] Timer tick, asking Buildbucket for the build status
[07:29:38.656] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:38.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:13:0) after 1m0s
[07:30:38.676] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:13:0)
[07:30:38.676] Timer tick, asking Buildbucket for the build status
[07:30:38.754] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:38.754] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:14:0) after 1m0s
[07:31:38.813] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:14:0)
[07:31:38.813] Timer tick, asking Buildbucket for the build status
[07:31:38.873] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:38.873] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:15:0) after 1m0s
[07:32:38.932] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:15:0)
[07:32:38.932] Timer tick, asking Buildbucket for the build status
[07:32:39.234] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:39.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:16:0) after 1m0s
[07:33:39.314] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:16:0)
[07:33:39.314] Timer tick, asking Buildbucket for the build status
[07:33:39.607] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:39.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:17:0) after 1m0s
[07:34:39.687] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:17:0)
[07:34:39.687] Timer tick, asking Buildbucket for the build status
[07:34:39.796] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:39.796] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:18:0) after 1m0s
[07:35:39.838] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:18:0)
[07:35:39.838] Timer tick, asking Buildbucket for the build status
[07:35:39.945] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:39.945] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:19:0) after 1m0s
[07:36:39.974] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:19:0)
[07:36:39.974] Timer tick, asking Buildbucket for the build status
[07:36:40.084] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:40.084] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:20:0) after 1m0s
[07:37:40.172] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:20:0)
[07:37:40.172] Timer tick, asking Buildbucket for the build status
[07:37:40.731] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:40.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:21:0) after 1m0s
[07:38:40.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:21:0)
[07:38:40.756] Timer tick, asking Buildbucket for the build status
[07:38:40.872] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:40.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:22:0) after 1m0s
[07:39:40.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:22:0)
[07:39:40.896] Timer tick, asking Buildbucket for the build status
[07:39:41.068] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:41.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:23:0) after 1m0s
[07:40:41.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:23:0)
[07:40:41.086] Timer tick, asking Buildbucket for the build status
[07:40:41.219] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:41.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:24:0) after 1m0s
[07:41:41.287] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:24:0)
[07:41:41.287] Timer tick, asking Buildbucket for the build status
[07:41:43.245] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:43.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:25:0) after 1m0s
[07:42:43.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:25:0)
[07:42:43.298] Timer tick, asking Buildbucket for the build status
[07:42:43.367] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:43.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:26:0) after 1m0s
[07:43:43.389] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:26:0)
[07:43:43.389] Timer tick, asking Buildbucket for the build status
[07:43:43.544] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:43.544] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:27:0) after 1m0s
[07:44:43.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:27:0)
[07:44:43.545] Timer tick, asking Buildbucket for the build status
[07:44:43.661] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:43.661] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:28:0) after 1m0s
[07:45:43.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:28:0)
[07:45:43.694] Timer tick, asking Buildbucket for the build status
[07:45:43.760] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:43.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:29:0) after 1m0s
[07:46:43.798] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:29:0)
[07:46:43.798] Timer tick, asking Buildbucket for the build status
[07:46:43.880] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:43.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:30:0) after 1m0s
[07:47:43.873] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:30:0)
[07:47:43.873] Timer tick, asking Buildbucket for the build status
[07:47:44.071] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:44.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:31:0) after 1m0s
[07:48:44.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:31:0)
[07:48:44.214] Timer tick, asking Buildbucket for the build status
[07:48:44.285] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:44.285] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:32:0) after 1m0s
[07:49:44.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:32:0)
[07:49:44.339] Timer tick, asking Buildbucket for the build status
[07:49:44.814] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:44.814] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:33:0) after 1m0s
[07:50:44.875] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:33:0)
[07:50:44.875] Timer tick, asking Buildbucket for the build status
[07:50:44.957] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:44.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:34:0) after 1m0s
[07:51:45.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:34:0)
[07:51:45.014] Timer tick, asking Buildbucket for the build status
[07:51:45.075] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:45.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:35:0) after 1m0s
[07:52:45.100] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:35:0)
[07:52:45.100] Timer tick, asking Buildbucket for the build status
[07:52:45.299] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:45.299] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:36:0) after 1m0s
[07:53:45.373] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:36:0)
[07:53:45.373] Timer tick, asking Buildbucket for the build status
[07:53:45.435] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:45.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:37:0) after 1m0s
[07:54:45.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:37:0)
[07:54:45.504] Timer tick, asking Buildbucket for the build status
[07:54:45.612] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:45.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:38:0) after 1m0s
[07:55:45.633] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:38:0)
[07:55:45.633] Timer tick, asking Buildbucket for the build status
[07:55:45.706] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:45.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:39:0) after 1m0s
[07:56:45.742] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:39:0)
[07:56:45.742] Timer tick, asking Buildbucket for the build status
[07:56:45.807] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:45.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:40:0) after 1m0s
[07:57:45.882] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:40:0)
[07:57:45.882] Timer tick, asking Buildbucket for the build status
[07:57:46.032] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:46.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:41:0) after 1m0s
[07:58:46.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:41:0)
[07:58:46.127] Timer tick, asking Buildbucket for the build status
[07:58:46.196] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:46.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:42:0) after 1m0s
[07:59:46.202] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:42:0)
[07:59:46.202] Timer tick, asking Buildbucket for the build status
[07:59:46.309] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:46.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:43:0) after 1m0s
[08:00:46.305] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:43:0)
[08:00:46.305] Timer tick, asking Buildbucket for the build status
[08:00:49.323] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:49.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:44:0) after 1m0s
[08:01:49.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:44:0)
[08:01:49.392] Timer tick, asking Buildbucket for the build status
[08:01:49.463] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:49.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:45:0) after 1m0s
[08:02:49.483] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:45:0)
[08:02:49.483] Timer tick, asking Buildbucket for the build status
[08:02:49.551] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:49.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:46:0) after 1m0s
[08:03:49.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:46:0)
[08:03:49.599] Timer tick, asking Buildbucket for the build status
[08:03:49.823] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:49.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:47:0) after 1m0s
[08:04:49.807] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:47:0)
[08:04:49.807] Timer tick, asking Buildbucket for the build status
[08:04:49.918] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:49.918] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:48:0) after 1m0s
[08:05:49.977] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:48:0)
[08:05:49.977] Timer tick, asking Buildbucket for the build status
[08:05:50.165] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:50.165] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:49:0) after 1m0s
[08:06:50.186] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:49:0)
[08:06:50.186] Timer tick, asking Buildbucket for the build status
[08:06:51.323] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:51.323] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:50:0) after 1m0s
[08:07:51.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:50:0)
[08:07:51.311] Timer tick, asking Buildbucket for the build status
[08:07:51.528] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:51.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:51:0) after 1m0s
[08:08:51.553] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:51:0)
[08:08:51.553] Timer tick, asking Buildbucket for the build status
[08:08:51.922] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:51.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:52:0) after 1m0s
[08:09:51.976] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:52:0)
[08:09:51.976] Timer tick, asking Buildbucket for the build status
[08:09:52.081] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:52.081] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:53:0) after 1m0s
[08:10:52.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:53:0)
[08:10:52.099] Timer tick, asking Buildbucket for the build status
[08:10:52.170] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:52.170] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:54:0) after 1m0s
[08:11:52.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:54:0)
[08:11:52.229] Timer tick, asking Buildbucket for the build status
[08:11:52.319] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:52.319] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:55:0) after 1m0s
[08:12:52.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:55:0)
[08:12:52.353] Timer tick, asking Buildbucket for the build status
[08:12:52.551] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:52.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:56:0) after 1m0s
[08:13:52.575] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:56:0)
[08:13:52.575] Timer tick, asking Buildbucket for the build status
[08:13:53.178] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:53.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:57:0) after 1m0s
[08:14:53.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:57:0)
[08:14:53.170] Timer tick, asking Buildbucket for the build status
[08:14:53.288] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:53.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:58:0) after 1m0s
[08:15:53.315] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:58:0)
[08:15:53.315] Timer tick, asking Buildbucket for the build status
[08:15:53.425] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:53.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:59:0) after 1m0s
[08:16:53.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:59:0)
[08:16:53.488] Timer tick, asking Buildbucket for the build status
[08:16:53.665] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:53.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:60:0) after 1m0s
[08:17:53.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:60:0)
[08:17:53.675] Timer tick, asking Buildbucket for the build status
[08:17:53.798] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:53.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:61:0) after 1m0s
[08:18:53.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:61:0)
[08:18:53.869] Timer tick, asking Buildbucket for the build status
[08:18:53.959] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:53.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:62:0) after 1m0s
[08:19:54.041] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:62:0)
[08:19:54.041] Timer tick, asking Buildbucket for the build status
[08:19:54.166] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:54.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:63:0) after 1m0s
[08:20:54.357] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:63:0)
[08:20:54.357] Timer tick, asking Buildbucket for the build status
[08:20:54.474] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:54.474] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:64:0) after 1m0s
[08:21:54.711] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:64:0)
[08:21:54.711] Timer tick, asking Buildbucket for the build status
[08:21:54.832] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:54.832] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:65:0) after 1m0s
[08:22:54.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:65:0)
[08:22:54.985] Timer tick, asking Buildbucket for the build status
[08:22:55.107] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:55.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:66:0) after 1m0s
[08:23:55.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:66:0)
[08:23:55.147] Timer tick, asking Buildbucket for the build status
[08:23:55.273] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:55.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:67:0) after 1m0s
[08:24:55.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:67:0)
[08:24:55.328] Timer tick, asking Buildbucket for the build status
[08:24:55.619] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:55.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:68:0) after 1m0s
[08:25:55.702] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:68:0)
[08:25:55.702] Timer tick, asking Buildbucket for the build status
[08:25:55.819] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:55.819] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:69:0) after 1m0s
[08:26:55.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:69:0)
[08:26:55.955] Timer tick, asking Buildbucket for the build status
[08:26:56.292] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:56.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:70:0) after 1m0s
[08:27:56.368] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:70:0)
[08:27:56.368] Timer tick, asking Buildbucket for the build status
[08:27:56.566] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:56.566] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:71:0) after 1m0s
[08:28:56.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:71:0)
[08:28:56.544] Timer tick, asking Buildbucket for the build status
[08:28:56.654] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:56.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:72:0) after 1m0s
[08:29:56.673] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:72:0)
[08:29:56.673] Timer tick, asking Buildbucket for the build status
[08:29:56.801] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:56.801] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:73:0) after 1m0s
[08:30:56.795] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:73:0)
[08:30:56.795] Timer tick, asking Buildbucket for the build status
[08:30:56.923] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:56.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:74:0) after 1m0s
[08:31:56.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:74:0)
[08:31:56.947] Timer tick, asking Buildbucket for the build status
[08:31:57.073] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:57.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:75:0) after 1m0s
[08:32:57.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:75:0)
[08:32:57.144] Timer tick, asking Buildbucket for the build status
[08:32:57.580] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:57.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:76:0) after 1m0s
[08:33:57.609] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:76:0)
[08:33:57.609] Timer tick, asking Buildbucket for the build status
[08:33:58.013] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:58.014] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:77:0) after 1m0s
[08:34:58.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:77:0)
[08:34:58.087] Timer tick, asking Buildbucket for the build status
[08:34:58.300] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:58.300] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:78:0) after 1m0s
[08:35:58.326] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:78:0)
[08:35:58.326] Timer tick, asking Buildbucket for the build status
[08:35:58.407] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:58.407] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:79:0) after 1m0s
[08:36:58.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:79:0)
[08:36:58.464] Timer tick, asking Buildbucket for the build status
[08:36:58.564] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:58.564] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:80:0) after 1m0s
[08:37:58.660] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:80:0)
[08:37:58.660] Timer tick, asking Buildbucket for the build status
[08:37:58.878] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:58.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:81:0) after 1m0s
[08:38:58.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:81:0)
[08:38:58.934] Timer tick, asking Buildbucket for the build status
[08:38:59.221] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:59.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:82:0) after 1m0s
[08:39:59.277] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:82:0)
[08:39:59.278] Timer tick, asking Buildbucket for the build status
[08:39:59.421] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:59.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:83:0) after 1m0s
[08:40:59.440] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:83:0)
[08:40:59.440] Timer tick, asking Buildbucket for the build status
[08:41:04.816] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:04.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:84:0) after 1m0s
[08:42:04.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:84:0)
[08:42:04.818] Timer tick, asking Buildbucket for the build status
[08:42:04.990] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:04.990] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:85:0) after 1m0s
[08:43:04.977] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:85:0)
[08:43:04.977] Timer tick, asking Buildbucket for the build status
[08:43:05.099] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:05.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:86:0) after 1m0s
[08:44:05.169] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:86:0)
[08:44:05.169] Timer tick, asking Buildbucket for the build status
[08:44:05.257] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:05.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:87:0) after 1m0s
[08:45:05.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:87:0)
[08:45:05.311] Timer tick, asking Buildbucket for the build status
[08:45:05.621] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:05.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:88:0) after 1m0s
[08:46:05.652] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:88:0)
[08:46:05.652] Timer tick, asking Buildbucket for the build status
[08:46:05.757] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:05.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:89:0) after 1m0s
[08:47:05.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:89:0)
[08:47:05.794] Timer tick, asking Buildbucket for the build status
[08:47:05.900] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:05.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:90:0) after 1m0s
[08:48:05.919] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:90:0)
[08:48:05.919] Timer tick, asking Buildbucket for the build status
[08:48:06.040] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:06.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:91:0) after 1m0s
[08:49:06.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:91:0)
[08:49:06.089] Timer tick, asking Buildbucket for the build status
[08:49:06.232] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:06.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:92:0) after 1m0s
[08:50:06.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:92:0)
[08:50:06.310] Timer tick, asking Buildbucket for the build status
[08:50:06.441] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:06.441] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:93:0) after 1m0s
[08:51:06.460] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:93:0)
[08:51:06.460] Timer tick, asking Buildbucket for the build status
[08:51:06.523] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:06.523] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:94:0) after 1m0s
[08:52:06.586] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:94:0)
[08:52:06.586] Timer tick, asking Buildbucket for the build status
[08:52:06.650] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:06.650] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:95:0) after 1m0s
[08:53:06.676] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:95:0)
[08:53:06.676] Timer tick, asking Buildbucket for the build status
[08:53:07.008] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:07.009] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:96:0) after 1m0s
[08:54:07.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:96:0)
[08:54:07.032] Timer tick, asking Buildbucket for the build status
[08:54:07.185] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:07.185] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:97:0) after 1m0s
[08:55:07.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:97:0)
[08:55:07.309] Timer tick, asking Buildbucket for the build status
[08:55:07.987] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:07.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:98:0) after 1m0s
[08:56:08.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:98:0)
[08:56:08.045] Timer tick, asking Buildbucket for the build status
[08:56:08.162] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:08.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:99:0) after 1m0s
[08:57:08.180] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:99:0)
[08:57:08.181] Timer tick, asking Buildbucket for the build status
[08:57:08.259] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:08.259] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:100:0) after 1m0s
[08:58:08.301] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:100:0)
[08:58:08.301] Timer tick, asking Buildbucket for the build status
[08:58:09.055] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:09.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:101:0) after 1m0s
[08:59:09.088] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:101:0)
[08:59:09.088] Timer tick, asking Buildbucket for the build status
[08:59:09.162] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:09.162] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:102:0) after 1m0s
[09:00:09.228] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:102:0)
[09:00:09.228] Timer tick, asking Buildbucket for the build status
[09:00:09.386] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:09.386] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:103:0) after 1m0s
[09:01:09.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:103:0)
[09:01:09.372] Timer tick, asking Buildbucket for the build status
[09:01:09.456] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:09.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:104:0) after 1m0s
[09:02:09.574] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:104:0)
[09:02:09.575] Timer tick, asking Buildbucket for the build status
[09:02:09.835] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:09.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:105:0) after 1m0s
[09:03:09.853] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:105:0)
[09:03:09.853] Timer tick, asking Buildbucket for the build status
[09:03:09.931] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:09.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:106:0) after 1m0s
[09:04:10.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:106:0)
[09:04:10.005] Timer tick, asking Buildbucket for the build status
[09:04:10.189] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:10.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:107:0) after 1m0s
[09:05:10.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:107:0)
[09:05:10.182] Timer tick, asking Buildbucket for the build status
[09:05:10.363] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:10.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:108:0) after 1m0s
[09:06:10.447] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:108:0)
[09:06:10.447] Timer tick, asking Buildbucket for the build status
[09:06:10.567] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:10.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:109:0) after 1m0s
[09:07:10.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:109:0)
[09:07:10.639] Timer tick, asking Buildbucket for the build status
[09:07:10.724] Build 8863040244167493280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:10.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028470306277707936:110:0) after 1m0s
[09:07:26.508] Received PubSub notification, asking Buildbucket for the build status
[09:07:26.591] Build 8863040244167493280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:07:26.591] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605949644179600",
"created_by": "project:chromium",
"created_ts": "1605943176070359",
"id": "8863040244167493280",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"224723e7fbd13403da2a7162c30b2c015c04aeed\"}}",
"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\": \"224723e7fbd13403da2a7162c30b2c015c04aeed\", \"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-3-xoby\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15755, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"e51c9068a84f14e42157c097eb764ec3009e0e54\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"224723e7fbd13403da2a7162c30b2c015c04aeed\", \"got_revision_cp\": \"refs/heads/master@{#829967}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"fa2966f12624e498083c1f4cacd3f82d14f4eacb\", \"got_v8_revision_cp\": \"refs/heads/8.9.30@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\", \"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\": \"224723e7fbd13403da2a7162c30b2c015c04aeed\", \"swarm_hashes_refs/heads/master(at){#829967}_without_patch\": {\"absl_hardening_tests\": \"03f8cf3a2f4169627e0ed28ba69c5c84c44e9bca\", \"accessibility_unittests\": \"97c0704b4494051c1e6c227a3caa910daf19593d\", \"angle_unittests\": \"61d00a2ca7432bf2f24d1cfe2e38adfe0b5dada6\", \"app_shell_unittests\": \"b92eda41ece1692e6035d84e2dc5cda533f7475d\", \"aura_unittests\": \"968500870ab7f3f930dc3bbce8a4d944aaaa9253\", \"base_unittests\": \"b17ffdd03697a33f343c1c2a67807ddb161c7985\", \"base_util_unittests\": \"812836bc6dd6835f64320125857ead7b6fcb58da\", \"blink_common_unittests\": \"a5ab8ea704addb090b88d2a3dd55b5be58beb87e\", \"blink_fuzzer_unittests\": \"38e31451117102316e03d75c4d27fc28805d3681\", \"blink_heap_unittests\": \"ee78cbf2ab23b20cc50220b059669472957bef4e\", \"blink_platform_unittests\": \"d1e964dfc52127fb9dedc77a5b987d8014270666\", \"blink_unittests\": \"89871eea22c8e0cba8f280c5b6dc911a7620f945\", \"boringssl_crypto_tests\": \"437c75175903f17674a9426a491631b4128312e4\", \"boringssl_ssl_tests\": \"f4ff432e1af43e5acb487de694833bb9c814729b\", \"browser_switcher_bho_unittests\": \"919516cdd26c2924eef5e801aba557510c19e98d\", \"browser_tests\": \"06bb72be7cd46423bb0ef84ef3efb2777290eb42\", \"capture_unittests\": \"63992950517e3d3ddba196f40c48b6b7ed4eb61f\", \"cast_unittests\": \"73e8102ba34907fa6253124a1d41cefc774abb06\", \"cc_unittests\": \"4147b08ef10087d32c3fe3266bbb42a3b80be256\", \"chrome_app_unittests\": \"c0c6c03447524099dfa80d98b1ac6226886d2f16\", \"chrome_cleaner_unittests\": \"bf8274db752e05f8502d3d27f11d3c5c361f2f60\", \"chrome_elf_unittests\": \"c53b6a143690b55f210a557b037ef8d07130dc29\", \"chromedriver_unittests\": \"7532f570c85fce3c390fee7c5c6ebc5a4e55b454\", \"components_browsertests\": \"5cf7b78f47d8cba5686bf8013f71a4e62a519a97\", \"components_unittests\": \"d3074dfd3a5b30e88db84ff47a62c25097bf653f\", \"compositor_unittests\": \"0c9372c18d1c26b1d4c39cd4abbc9a98f1504f80\", \"content_browsertests\": \"18e91789570b78e1db876b6c06d6a7154d92c21d\", \"content_unittests\": \"61c34f3a11285d8c2fe8b5e5d2b5656b51720dbe\", \"courgette_unittests\": \"a17f5074c9c443370901ebbd313a73fad4f2232d\", \"crashpad_tests\": \"2fa8caccdc442fd1d58e8af08fc7595ed23482c8\", \"cronet_tests\": \"64a1a87b84d94ba28aa36b43e4349cb99bb90ceb\", \"cronet_unittests\": \"77db119592d5c1ef68e9c029cfddd9430a31f9f6\", \"crypto_unittests\": \"3da2dbc00740440fb318d4c7ff7565d884f2c7d4\", \"delayloads_unittests\": \"470cdd728202ad93b0bc614bed44cd88ad2d28ec\", \"device_unittests\": \"7f0649fad37fbe3261acc2bd42195ff856b4c5c9\", \"display_unittests\": \"f130d4305b32a01ba2d3a86969b6b9a32ebd5fcd\", \"elevation_service_unittests\": \"78bb91533b1e7e9f20097e549eac6ea1b4fcc4ae\", \"events_unittests\": \"0bda69f104ba75a5b5e7c8d5b3e777aaacc10b09\", \"extensions_browsertests\": \"bf392430157b20031291c34a36a4b39ea7048b62\", \"extensions_unittests\": \"003a0f1219b5a94115938afb3e8e5448ba3dccba\", \"filesystem_service_unittests\": \"fdac573d1382394d2f151c6d3bfbeb63e15a0cc3\", \"gcm_unit_tests\": \"65594e4978db1eb2d0be82cac1245a8ee3bca796\", \"gcp_unittests\": \"ae6499f98d2289e71f764ce47c7ce58c34c8fd6d\", \"gfx_unittests\": \"d79f7e7395568dca43d47ac9c378debc187ef075\", \"gin_unittests\": \"cd9ad8a446872971e75981f9b76c3a868d1faff5\", \"google_apis_unittests\": \"41113b35b4049c25ff1c639b2ea66e21e5e7b05f\", \"gpu_unittests\": \"d5238e004586f9f85fceb8a6c66bbd6fd98319bc\", \"gwp_asan_unittests\": \"d089adbe34f9eb3581284df92e7c9b9cae7bf80e\", \"headless_browsertests\": \"a81501c681e7b1019f6f0d82532549fb9116e483\", \"headless_unittests\": \"ff980b7d11f3b1fabc1680a5aa7cb3ee3a2c8ba2\", \"install_static_unittests\": \"2edf1b7d23afcb4022d3824355ed553468a3e500\", \"installer_util_unittests\": \"deeb25d1d3a57cdbebf3cbb0ea1531e93b3f7cc3\", \"interactive_ui_tests\": \"262759a112b84e680e9f931db7db70d0987f662b\", \"ipc_tests\": \"8a91f2ffb2683809f4c32af4109fa87e6e4cee65\", \"jingle_unittests\": \"cfb21d9ebb28597793be794117dba0989b85a9ae\", \"latency_unittests\": \"4ce69b73e3a901d5d888b50430d6b8d41ad16157\", \"libjingle_xmpp_unittests\": \"572ece09f722d4c605e3b5329e22992e71ddf109\", \"liburlpattern_unittests\": \"4d9b160b32a730f6228271723d31ba3533ea8a90\", \"media_blink_unittests\": \"4007a971510b4f480d904d715b3188c5d9387cb2\", \"media_unittests\": \"060096f9b032318520999c23e0ef5ac11e4c1088\", \"message_center_unittests\": \"edab0fefc4afa8c2d0e2afd704b2ce35965f2748\", \"midi_unittests\": \"d1c87dca65125232d5addd6c538d49aa18b2b6dc\", \"mojo_core_unittests\": \"475f21aeb586ace23eee0c18ba22b4aafbea0bc3\", \"mojo_unittests\": \"9e153544bcc0932d8eb2a0a99ae20eee12087872\", \"nacl_loader_unittests\": \"82391c67196310f01422aafd6ace01e848ddae08\", \"native_theme_unittests\": \"117b637313f6fe55db3b0c398acae23f6701fd4d\", \"net_unittests\": \"3cd506f18c18a86a4994dbfe009d8c251640b384\", \"notification_helper_unittests\": \"b6055968e0d1429dfa2151297596d081cb14d337\", \"pdf_unittests\": \"88b1f842699619814db29496f32656b3c200984b\", \"perfetto_unittests\": \"82bd99ddee7719e34966774e38dc3b74958506d3\", \"ppapi_unittests\": \"eaf49d62140eb3f5964a88853f350e4568d846e4\", \"printing_unittests\": \"a57700a607b93b52093387cd7be85d88add16b2b\", \"remoting_unittests\": \"b6501e4f1e6e979fe30982f842dadc4aa3066db4\", \"sbox_integration_tests\": \"e6bd515c87268308824a2c219974ac6df2d152d1\", \"sbox_unittests\": \"fb25190ce879ae23856e8fa9ec2df388ea4a81f0\", \"sbox_validation_tests\": \"73711daf6e4bee6a49876d8236a80596d9026575\", \"service_manager_unittests\": \"481a7bfd90022efb76b7238b2baa2edf3bdf9204\", \"services_unittests\": \"830f8bf04951987371ab229c841da4ade1eddb77\", \"setup_unittests\": \"0c2a9d8e1807fd404b8a1c59659f1e62375e3b8d\", \"shell_dialogs_unittests\": \"d6376afd5fed0f5be684571639d72faad89f0f0b\", \"skia_unittests\": \"9c0dc336f73eb58b14b966dc7ddcdca215b85d0b\", \"snapshot_unittests\": \"cff283663998ae01a39ff6f9c56710b036b54496\", \"sql_unittests\": \"b758c138cfee371b392954b82b108423636c39bc\", \"storage_unittests\": \"ecfc70231b1a93e989f099ac5899cf8df719856b\", \"sync_integration_tests\": \"0c0eb1727e2cf0fd214f096b317fbe2c69f0483a\", \"traffic_annotation_auditor_unittests\": \"f47a08f7c985d97872e41dcc546da1e45a12b3a7\", \"ui_base_unittests\": \"abc4e68a816b5927a05cd034a6258d57ad95c53e\", \"ui_touch_selection_unittests\": \"df8b5b97986608b9b2bd31572b99147ae8ebd650\", \"unit_tests\": \"d72987b3cd2b3b2ab6ebad2c2105766c6bb49300\", \"updater_tests\": \"ca7194eff7ce7dbb0e832573f31764fb60db7e1a\", \"url_unittests\": \"6ad24ee46ed673531cf4d3fba2020f90e7f10499\", \"views_unittests\": \"edb032a9d7de3b120e81e30a7a013b4cd13c4b4c\", \"viz_unittests\": \"1b5e7647412cecfa076296b04e5e50da06759baf\", \"vr_common_unittests\": \"9f8ad281dadefc98c492e24918b94e6cddfe3271\", \"vr_pixeltests\": \"92f9a7402f457aff9da2599a2a479c726cef9ecb\", \"weblayer_browsertests\": \"23583dae63943224502f0dabda068db0281ba70a\", \"weblayer_unittests\": \"c2f370724397c77b76297d0efbdfe751c573932c\", \"wm_unittests\": \"81dbd6bf121baf87f582413eede6618e4599c130\", \"wtf_unittests\": \"d3fe8f56d8096b6e7722872bc66b3fa7761ad12b\", \"zlib_unittests\": \"ba6da342d7ae880f9c35d222d5c5daa0c2a982a3\", \"zucchini_unittests\": \"75335a4920051e8a5388fc68fa6c32da0ae47dce\"}}, \"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-3-xoby\"], \"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": "1605943345448131",
"status": "COMPLETED",
"status_changed_ts": "1605949644783728",
"tags": [
"build_address:luci.chromium.ci/win-asan/15755",
"builder:win-asan",
"buildset:commit/git/224723e7fbd13403da2a7162c30b2c015c04aeed",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/224723e7fbd13403da2a7162c30b2c015c04aeed",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028470306277707936",
"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/8863040244167493280/+/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:50027db6298e5910",
"user_agent:luci-scheduler"
],
"updated_ts": "1605949644945317",
"url": "https://ci.chromium.org/b/8863040244167493280",
"utcnow_ts": "1605949646581582"
}
}
[09:07:26.591] Invocation finished in 1h47m51.917838297s with status SUCCEEDED