[04:39:58.108] New invocation is queued and will start shortly
[04:39:59.264] Starting the invocation (attempt 1)
[04:39:59.304] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:39:59.304] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:39:59.304] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029114526816358112",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a946c30f1ace4159f9d308643334b3755bcf85fe\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9029114526816358112",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/a946c30f1ace4159f9d308643334b3755bcf85fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a946c30f1ace4159f9d308643334b3755bcf85fe",
"gitiles_ref:refs/heads/master"
]
}
[04:39:59.932] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605328799375698",
"id": "8863684464824764400",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a946c30f1ace4159f9d308643334b3755bcf85fe\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605328799820956",
"tags": [
"build_address:luci.chromium.ci/win-asan/15632",
"builder:win-asan",
"buildset:commit/git/a946c30f1ace4159f9d308643334b3755bcf85fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a946c30f1ace4159f9d308643334b3755bcf85fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029114526816358112",
"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/8863684464824764400/+/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": "1605328799821064",
"url": "https://ci.chromium.org/b/8863684464824764400",
"utcnow_ts": "1605328799925011"
}
}
[04:39:59.932] Task URL: https://ci.chromium.org/b/8863684464824764400
[04:39:59.932] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:2:0) after 1m0s
[04:40:59.950] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:2:0)
[04:40:59.950] Timer tick, asking Buildbucket for the build status
[04:41:00.605] Build 8863684464824764400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:00.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:3:0) after 1m0s
[04:42:01.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:3:0)
[04:42:01.849] Timer tick, asking Buildbucket for the build status
[04:42:01.963] Build 8863684464824764400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:01.964] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:4:0) after 1m0s
[04:43:02.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:4:0)
[04:43:02.224] Timer tick, asking Buildbucket for the build status
[04:43:02.391] Build 8863684464824764400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:02.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:5:0) after 1m0s
[04:43:42.379] Received PubSub notification, asking Buildbucket for the build status
[04:43:42.459] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:02.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:5:0)
[04:44:02.747] Timer tick, asking Buildbucket for the build status
[04:44:02.829] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:02.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:7:0) after 1m0s
[04:45:02.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:7:0)
[04:45:02.855] Timer tick, asking Buildbucket for the build status
[04:45:03.043] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:03.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:8:0) after 1m0s
[04:46:03.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:8:0)
[04:46:03.066] Timer tick, asking Buildbucket for the build status
[04:46:04.243] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:04.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:9:0) after 1m0s
[04:47:04.310] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:9:0)
[04:47:04.310] Timer tick, asking Buildbucket for the build status
[04:47:04.416] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:04.416] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:10:0) after 1m0s
[04:48:04.436] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:10:0)
[04:48:04.436] Timer tick, asking Buildbucket for the build status
[04:48:04.492] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:04.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:11:0) after 1m0s
[04:49:04.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:11:0)
[04:49:04.649] Timer tick, asking Buildbucket for the build status
[04:49:04.946] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:04.946] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:12:0) after 1m0s
[04:50:05.019] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:12:0)
[04:50:05.019] Timer tick, asking Buildbucket for the build status
[04:50:05.322] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:05.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:13:0) after 1m0s
[04:51:05.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:13:0)
[04:51:05.698] Timer tick, asking Buildbucket for the build status
[04:51:05.755] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:05.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:14:0) after 1m0s
[04:52:05.880] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:14:0)
[04:52:05.880] Timer tick, asking Buildbucket for the build status
[04:52:06.703] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:06.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:15:0) after 1m0s
[04:53:06.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:15:0)
[04:53:06.889] Timer tick, asking Buildbucket for the build status
[04:53:07.198] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:07.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:16:0) after 1m0s
[04:54:07.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:16:0)
[04:54:07.295] Timer tick, asking Buildbucket for the build status
[04:54:07.540] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:07.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:17:0) after 1m0s
[04:55:07.559] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:17:0)
[04:55:07.559] Timer tick, asking Buildbucket for the build status
[04:55:07.672] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:07.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:18:0) after 1m0s
[04:56:07.801] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:18:0)
[04:56:07.801] Timer tick, asking Buildbucket for the build status
[04:56:07.909] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:07.909] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:19:0) after 1m0s
[04:57:07.932] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:19:0)
[04:57:07.932] Timer tick, asking Buildbucket for the build status
[04:57:08.237] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:08.237] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:20:0) after 1m0s
[04:58:08.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:20:0)
[04:58:08.605] Timer tick, asking Buildbucket for the build status
[04:58:08.700] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:08.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:21:0) after 1m0s
[04:59:09.296] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:21:0)
[04:59:09.296] Timer tick, asking Buildbucket for the build status
[04:59:09.504] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:09.504] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:22:0) after 1m0s
[05:00:09.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:22:0)
[05:00:09.685] Timer tick, asking Buildbucket for the build status
[05:00:10.222] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:10.222] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:23:0) after 1m0s
[05:01:11.320] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:23:0)
[05:01:11.320] Timer tick, asking Buildbucket for the build status
[05:01:11.379] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:11.379] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:24:0) after 1m0s
[05:02:11.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:24:0)
[05:02:11.570] Timer tick, asking Buildbucket for the build status
[05:02:11.632] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:11.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:25:0) after 1m0s
[05:03:11.827] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:25:0)
[05:03:11.827] Timer tick, asking Buildbucket for the build status
[05:03:12.257] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:12.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:26:0) after 1m0s
[05:04:12.351] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:26:0)
[05:04:12.351] Timer tick, asking Buildbucket for the build status
[05:04:12.466] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:12.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:27:0) after 1m0s
[05:05:12.532] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:27:0)
[05:05:12.532] Timer tick, asking Buildbucket for the build status
[05:05:12.642] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:12.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:28:0) after 1m0s
[05:06:12.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:28:0)
[05:06:12.732] Timer tick, asking Buildbucket for the build status
[05:06:12.789] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:12.789] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:29:0) after 1m0s
[05:07:12.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:29:0)
[05:07:12.804] Timer tick, asking Buildbucket for the build status
[05:07:12.898] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:12.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:30:0) after 1m0s
[05:08:12.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:30:0)
[05:08:12.899] Timer tick, asking Buildbucket for the build status
[05:08:13.302] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:13.302] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:31:0) after 1m0s
[05:09:13.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:31:0)
[05:09:13.333] Timer tick, asking Buildbucket for the build status
[05:09:15.142] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:15.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:32:0) after 1m0s
[05:10:15.187] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:32:0)
[05:10:15.187] Timer tick, asking Buildbucket for the build status
[05:10:15.485] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:15.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:33:0) after 1m0s
[05:11:15.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:33:0)
[05:11:15.550] Timer tick, asking Buildbucket for the build status
[05:11:15.615] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:15.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:34:0) after 1m0s
[05:12:16.072] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:34:0)
[05:12:16.072] Timer tick, asking Buildbucket for the build status
[05:12:16.180] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:16.180] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:35:0) after 1m0s
[05:13:16.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:35:0)
[05:13:16.327] Timer tick, asking Buildbucket for the build status
[05:13:16.389] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:16.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:36:0) after 1m0s
[05:14:16.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:36:0)
[05:14:16.510] Timer tick, asking Buildbucket for the build status
[05:14:16.580] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:16.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:37:0) after 1m0s
[05:15:16.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:37:0)
[05:15:16.748] Timer tick, asking Buildbucket for the build status
[05:15:16.859] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:16.859] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:38:0) after 1m0s
[05:16:17.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:38:0)
[05:16:17.010] Timer tick, asking Buildbucket for the build status
[05:16:18.076] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:18.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:39:0) after 1m0s
[05:17:18.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:39:0)
[05:17:18.224] Timer tick, asking Buildbucket for the build status
[05:17:18.464] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:18.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:40:0) after 1m0s
[05:18:18.567] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:40:0)
[05:18:18.567] Timer tick, asking Buildbucket for the build status
[05:18:18.654] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:18.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:41:0) after 1m0s
[05:19:18.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:41:0)
[05:19:18.714] Timer tick, asking Buildbucket for the build status
[05:19:18.972] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:18.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:42:0) after 1m0s
[05:20:19.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:42:0)
[05:20:19.025] Timer tick, asking Buildbucket for the build status
[05:20:19.174] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:19.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:43:0) after 1m0s
[05:21:19.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:43:0)
[05:21:19.327] Timer tick, asking Buildbucket for the build status
[05:21:19.583] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:19.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:44:0) after 1m0s
[05:22:19.630] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:44:0)
[05:22:19.630] Timer tick, asking Buildbucket for the build status
[05:22:19.795] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:19.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:45:0) after 1m0s
[05:23:19.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:45:0)
[05:23:19.843] Timer tick, asking Buildbucket for the build status
[05:23:20.032] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:20.032] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:46:0) after 1m0s
[05:24:20.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:46:0)
[05:24:20.042] Timer tick, asking Buildbucket for the build status
[05:24:20.124] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:20.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:47:0) after 1m0s
[05:25:20.108] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:47:0)
[05:25:20.108] Timer tick, asking Buildbucket for the build status
[05:25:20.336] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:20.336] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:48:0) after 1m0s
[05:26:20.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:48:0)
[05:26:20.365] Timer tick, asking Buildbucket for the build status
[05:26:20.449] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:20.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:49:0) after 1m0s
[05:27:20.430] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:49:0)
[05:27:20.430] Timer tick, asking Buildbucket for the build status
[05:27:20.608] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:20.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:50:0) after 1m0s
[05:28:20.626] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:50:0)
[05:28:20.626] Timer tick, asking Buildbucket for the build status
[05:28:20.686] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:20.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:51:0) after 1m0s
[05:29:20.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:51:0)
[05:29:20.714] Timer tick, asking Buildbucket for the build status
[05:29:20.827] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:20.827] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:52:0) after 1m0s
[05:30:20.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:52:0)
[05:30:20.857] Timer tick, asking Buildbucket for the build status
[05:30:20.989] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:20.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:53:0) after 1m0s
[05:31:21.048] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:53:0)
[05:31:21.048] Timer tick, asking Buildbucket for the build status
[05:31:21.121] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:21.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:54:0) after 1m0s
[05:32:21.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:54:0)
[05:32:21.182] Timer tick, asking Buildbucket for the build status
[05:32:21.256] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:21.256] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:55:0) after 1m0s
[05:33:21.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:55:0)
[05:33:21.342] Timer tick, asking Buildbucket for the build status
[05:33:21.420] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:21.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:56:0) after 1m0s
[05:34:21.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:56:0)
[05:34:21.454] Timer tick, asking Buildbucket for the build status
[05:34:21.528] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:21.528] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:57:0) after 1m0s
[05:35:21.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:57:0)
[05:35:21.587] Timer tick, asking Buildbucket for the build status
[05:35:21.707] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:21.707] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:58:0) after 1m0s
[05:36:21.754] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:58:0)
[05:36:21.754] Timer tick, asking Buildbucket for the build status
[05:36:22.228] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:22.228] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:59:0) after 1m0s
[05:37:22.280] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:59:0)
[05:37:22.280] Timer tick, asking Buildbucket for the build status
[05:37:22.420] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:22.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:60:0) after 1m0s
[05:38:22.466] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:60:0)
[05:38:22.466] Timer tick, asking Buildbucket for the build status
[05:38:22.536] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:22.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:61:0) after 1m0s
[05:39:22.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:61:0)
[05:39:22.550] Timer tick, asking Buildbucket for the build status
[05:39:22.652] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:22.652] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:62:0) after 1m0s
[05:40:22.661] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:62:0)
[05:40:22.661] Timer tick, asking Buildbucket for the build status
[05:40:22.758] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:22.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:63:0) after 1m0s
[05:41:22.821] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:63:0)
[05:41:22.821] Timer tick, asking Buildbucket for the build status
[05:41:22.991] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:22.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:64:0) after 1m0s
[05:42:23.048] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:64:0)
[05:42:23.048] Timer tick, asking Buildbucket for the build status
[05:42:23.186] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:23.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:65:0) after 1m0s
[05:43:23.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:65:0)
[05:43:23.211] Timer tick, asking Buildbucket for the build status
[05:43:23.330] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:23.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:66:0) after 1m0s
[05:44:23.426] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:66:0)
[05:44:23.426] Timer tick, asking Buildbucket for the build status
[05:44:23.573] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:23.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:67:0) after 1m0s
[05:45:23.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:67:0)
[05:45:23.600] Timer tick, asking Buildbucket for the build status
[05:45:23.706] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:23.706] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:68:0) after 1m0s
[05:46:23.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:68:0)
[05:46:23.763] Timer tick, asking Buildbucket for the build status
[05:46:23.991] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:23.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:69:0) after 1m0s
[05:47:23.989] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:69:0)
[05:47:23.989] Timer tick, asking Buildbucket for the build status
[05:47:24.413] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:24.413] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:70:0) after 1m0s
[05:48:24.446] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:70:0)
[05:48:24.446] Timer tick, asking Buildbucket for the build status
[05:48:24.585] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:24.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:71:0) after 1m0s
[05:49:24.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:71:0)
[05:49:24.606] Timer tick, asking Buildbucket for the build status
[05:49:24.734] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:24.734] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:72:0) after 1m0s
[05:50:24.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:72:0)
[05:50:24.748] Timer tick, asking Buildbucket for the build status
[05:50:24.858] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:24.858] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:73:0) after 1m0s
[05:51:24.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:73:0)
[05:51:24.923] Timer tick, asking Buildbucket for the build status
[05:51:25.064] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:25.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:74:0) after 1m0s
[05:52:25.093] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:74:0)
[05:52:25.093] Timer tick, asking Buildbucket for the build status
[05:52:25.226] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:25.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:75:0) after 1m0s
[05:53:25.283] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:75:0)
[05:53:25.283] Timer tick, asking Buildbucket for the build status
[05:53:25.825] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:25.825] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:76:0) after 1m0s
[05:54:25.838] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:76:0)
[05:54:25.838] Timer tick, asking Buildbucket for the build status
[05:54:33.919] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:33.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:77:0) after 1m0s
[05:55:33.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:77:0)
[05:55:33.983] Timer tick, asking Buildbucket for the build status
[05:55:34.155] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:34.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:78:0) after 1m0s
[05:56:34.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:78:0)
[05:56:34.214] Timer tick, asking Buildbucket for the build status
[05:56:34.392] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:34.392] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:79:0) after 1m0s
[05:57:34.490] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:79:0)
[05:57:34.490] Timer tick, asking Buildbucket for the build status
[05:57:34.631] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:34.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:80:0) after 1m0s
[05:58:34.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:80:0)
[05:58:34.796] Timer tick, asking Buildbucket for the build status
[05:58:35.276] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:35.276] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:81:0) after 1m0s
[05:59:35.408] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:81:0)
[05:59:35.408] Timer tick, asking Buildbucket for the build status
[05:59:35.531] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:35.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:82:0) after 1m0s
[06:00:35.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:82:0)
[06:00:35.775] Timer tick, asking Buildbucket for the build status
[06:00:35.919] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:35.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:83:0) after 1m0s
[06:01:36.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:83:0)
[06:01:36.138] Timer tick, asking Buildbucket for the build status
[06:01:36.286] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:36.286] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:84:0) after 1m0s
[06:02:36.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:84:0)
[06:02:36.423] Timer tick, asking Buildbucket for the build status
[06:02:36.591] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:36.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:85:0) after 1m0s
[06:03:36.620] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:85:0)
[06:03:36.620] Timer tick, asking Buildbucket for the build status
[06:03:36.709] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:36.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:86:0) after 1m0s
[06:04:36.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:86:0)
[06:04:36.718] Timer tick, asking Buildbucket for the build status
[06:04:36.847] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:36.847] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:87:0) after 1m0s
[06:05:36.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:87:0)
[06:05:36.883] Timer tick, asking Buildbucket for the build status
[06:05:37.079] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:37.079] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:88:0) after 1m0s
[06:06:37.118] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:88:0)
[06:06:37.118] Timer tick, asking Buildbucket for the build status
[06:06:37.263] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:37.263] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:89:0) after 1m0s
[06:07:37.288] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:89:0)
[06:07:37.288] Timer tick, asking Buildbucket for the build status
[06:07:37.483] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:37.483] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:90:0) after 1m0s
[06:08:37.529] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:90:0)
[06:08:37.529] Timer tick, asking Buildbucket for the build status
[06:08:37.640] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:37.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:91:0) after 1m0s
[06:09:37.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:91:0)
[06:09:37.767] Timer tick, asking Buildbucket for the build status
[06:09:37.907] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:37.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:92:0) after 1m0s
[06:10:37.932] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:92:0)
[06:10:37.932] Timer tick, asking Buildbucket for the build status
[06:10:38.074] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:38.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:93:0) after 1m0s
[06:11:38.125] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:93:0)
[06:11:38.125] Timer tick, asking Buildbucket for the build status
[06:11:38.242] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:38.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:94:0) after 1m0s
[06:12:38.279] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:94:0)
[06:12:38.279] Timer tick, asking Buildbucket for the build status
[06:12:38.400] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:38.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:95:0) after 1m0s
[06:13:38.468] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:95:0)
[06:13:38.468] Timer tick, asking Buildbucket for the build status
[06:13:38.798] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:38.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:96:0) after 1m0s
[06:14:38.912] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:96:0)
[06:14:38.912] Timer tick, asking Buildbucket for the build status
[06:14:39.098] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:39.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:97:0) after 1m0s
[06:15:39.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:97:0)
[06:15:39.127] Timer tick, asking Buildbucket for the build status
[06:15:39.640] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:39.640] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:98:0) after 1m0s
[06:16:39.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:98:0)
[06:16:39.732] Timer tick, asking Buildbucket for the build status
[06:16:39.808] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:39.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:99:0) after 1m0s
[06:17:39.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:99:0)
[06:17:39.896] Timer tick, asking Buildbucket for the build status
[06:17:40.002] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:40.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:100:0) after 1m0s
[06:18:40.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:100:0)
[06:18:40.046] Timer tick, asking Buildbucket for the build status
[06:18:40.128] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:40.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:101:0) after 1m0s
[06:19:40.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:101:0)
[06:19:40.218] Timer tick, asking Buildbucket for the build status
[06:19:40.327] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:40.327] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:102:0) after 1m0s
[06:20:40.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:102:0)
[06:20:40.362] Timer tick, asking Buildbucket for the build status
[06:20:41.018] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:41.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:103:0) after 1m0s
[06:21:41.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:103:0)
[06:21:41.281] Timer tick, asking Buildbucket for the build status
[06:21:41.833] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:41.833] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:104:0) after 1m0s
[06:22:41.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:104:0)
[06:22:41.876] Timer tick, asking Buildbucket for the build status
[06:22:42.030] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:42.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:105:0) after 1m0s
[06:23:42.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:105:0)
[06:23:42.049] Timer tick, asking Buildbucket for the build status
[06:23:42.121] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:42.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:106:0) after 1m0s
[06:24:42.182] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:106:0)
[06:24:42.182] Timer tick, asking Buildbucket for the build status
[06:24:42.246] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:42.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:107:0) after 1m0s
[06:25:42.261] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:107:0)
[06:25:42.261] Timer tick, asking Buildbucket for the build status
[06:25:42.702] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:42.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:108:0) after 1m0s
[06:26:42.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:108:0)
[06:26:42.731] Timer tick, asking Buildbucket for the build status
[06:26:42.840] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:42.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:109:0) after 1m0s
[06:27:42.858] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:109:0)
[06:27:42.858] Timer tick, asking Buildbucket for the build status
[06:27:42.923] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:42.923] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:110:0) after 1m0s
[06:28:42.977] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:110:0)
[06:28:42.977] Timer tick, asking Buildbucket for the build status
[06:28:43.075] Build 8863684464824764400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:43.075] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9029114526816358112:111:0) after 1m0s
[06:28:51.459] Received PubSub notification, asking Buildbucket for the build status
[06:28:51.545] Build 8863684464824764400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:28:51.545] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605335325116581",
"created_by": "project:chromium",
"created_ts": "1605328799375698",
"id": "8863684464824764400",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a946c30f1ace4159f9d308643334b3755bcf85fe\"}}",
"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\": \"a946c30f1ace4159f9d308643334b3755bcf85fe\", \"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-5-d467\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15632, \"clang_revision\": \"llvmorg-12-init-11462-g418f18c6-1\", \"got_angle_revision\": \"f46e6201b40bdee3e0b79d5d97660fc302fd76f5\", \"got_dawn_revision\": \"da1f66c8cee18677bf921181613732a9378e9864\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"a946c30f1ace4159f9d308643334b3755bcf85fe\", \"got_revision_cp\": \"refs/heads/master@{#827566}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e4c1a25cc6797a47043fc415c53b8edcd7b3e37e\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"ed95a75961bfbb4497d367b24f2d5d4f31affa40\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32608}\", \"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\": \"a946c30f1ace4159f9d308643334b3755bcf85fe\", \"swarm_hashes_refs/heads/master(at){#827566}_without_patch\": {\"absl_hardening_tests\": \"b6365e47f86737717baaadf78ceed65b7ae79a89\", \"accessibility_unittests\": \"452e2d6ed62c27e4ee3b93cf9e46d23875932853\", \"angle_unittests\": \"46fce55f4924a637b7b42d6dc19ceb85f118b55d\", \"app_shell_unittests\": \"29de0bd26e0a4619ce577a660744be963bff64f8\", \"aura_unittests\": \"1e084081dc11d0bfafc77011d9e995cf8d1a2af0\", \"base_unittests\": \"4f8489dacb633cab098f890a5a5237b5c8656b69\", \"base_util_unittests\": \"18d3cbad5022ab69abe4d84137944955dd773f72\", \"blink_common_unittests\": \"ea534d0a9004bbd06daa0adcf877b618d7cdc44c\", \"blink_fuzzer_unittests\": \"98266437d4b5d80b0bc314ee7ebbdba10fb0ac72\", \"blink_heap_unittests\": \"21e3e43dae006c31262a961a6b4a042dd86adf4f\", \"blink_platform_unittests\": \"8bddc96ce004d52d9192c55c4dd9f5d2d6265f4c\", \"blink_unittests\": \"837b74c85b90e5f2797bcd64b7798a1608980725\", \"boringssl_crypto_tests\": \"3ada1a4df8bd21930fe9482bfefe560d99006aa5\", \"boringssl_ssl_tests\": \"8c8a04469ba0f6560f5bb3a7346cfa1e9a50732e\", \"browser_switcher_bho_unittests\": \"410502981841e7fc832d4a50b555f33f97f7bc18\", \"browser_tests\": \"aabb100aa9b85c08101cc9fe43f7ef84127ca596\", \"capture_unittests\": \"ed9a8991c4859362c50bd5be9aed7980ac30767f\", \"cast_unittests\": \"aa742536e18301e87f050be9cf80b19739a4d2fd\", \"cc_unittests\": \"b8eb86a3241ec99d1528eadf87125144427f0590\", \"chrome_app_unittests\": \"667bf17763399e926a74bdf5ca3aeecf81e4ea15\", \"chrome_cleaner_unittests\": \"b2ab5a13f74de9e286f1565ccdf14ba26cbbfb4e\", \"chrome_elf_unittests\": \"e0d41f5c30cee17c5fbc0d575a760897b057fca1\", \"chromedriver_unittests\": \"ac54c2e8bb17dadaa1019c7969d507ee15dfbc6a\", \"components_browsertests\": \"25fc10b192cc7e4ca3fec0786a365241c8f07bac\", \"components_unittests\": \"1d4cf12a7dcc51d228101fad73f816dd3ec31244\", \"compositor_unittests\": \"d1ce85afe961c880fc7b3593ac26e1b0aa522584\", \"content_browsertests\": \"8541b9f52db59e6da038a276cea840c1e7e5b113\", \"content_unittests\": \"6f70971ed0a86f51f018299e4edb786cf2ab802e\", \"courgette_unittests\": \"dfb2fcaad187f2a65b4fb8266624b59f15ee2433\", \"crashpad_tests\": \"fa72afc24e80e9f30c8ca90bc0e114fccab4dcb9\", \"cronet_tests\": \"a167698cd7fc14e8789de8ce1a1e7bb21e658ed9\", \"cronet_unittests\": \"7cbe8d5cb0f03c73636b0aa7da7d72aa89a02d8b\", \"crypto_unittests\": \"7aff9d3bbcca7bc3237d5a478747347406d6de9c\", \"delayloads_unittests\": \"d7e7959e18618983055e82f4deb066625f2fafd5\", \"device_unittests\": \"a8fb5efc1fe9e25326d032067306388a8ec2917c\", \"display_unittests\": \"18ada29b42c5b8946ae3b2fcfc2929cfa8984592\", \"elevation_service_unittests\": \"5d5fdc677bb729c96be740d262eb445fce0230a0\", \"events_unittests\": \"4c7484b900ec8d26443868e832623188e016e4b2\", \"extensions_browsertests\": \"87a35b936a429d0d76438f116f0d265c8b025227\", \"extensions_unittests\": \"9145db83050c3cd1c772721232bf2c673890e9c1\", \"filesystem_service_unittests\": \"733655364a40d937b51916ca843842aaeaa07384\", \"gcm_unit_tests\": \"bf01be6ffe052113a48584432c1ff82954260e93\", \"gcp_unittests\": \"516a85eade6a708537637c2b36879149a4b9cc6a\", \"gfx_unittests\": \"790d82ab9f9167d479d4b84182bcff14b231de4c\", \"gin_unittests\": \"0e9d670cc6860555f4e003c17aa8eb87b68925da\", \"google_apis_unittests\": \"b6ad4732218c848b152fb2b7df3849bcba8eaa51\", \"gpu_unittests\": \"4d3b2f3e1cf935f1999dc03bad39abcf51b9ac9a\", \"gwp_asan_unittests\": \"495e4f3b7cd37e072cce18c599930314b20be321\", \"headless_browsertests\": \"5658fcfd17925fd0fab6ada32619ed4edbec7d2c\", \"headless_unittests\": \"2c1d2a4d98725eb5b7f0d33b9d2fdd787cce2113\", \"install_static_unittests\": \"86b3f3a53fcef3cc4cc635cecbc83a43439e1b30\", \"installer_util_unittests\": \"cd6a8f3174aa54660036d28af6898929c74fa77a\", \"interactive_ui_tests\": \"7afcc266e4e3761df21221e412348b9091c613af\", \"ipc_tests\": \"a4387df798a5d28b808abec76a2d0a79eaca3da9\", \"jingle_unittests\": \"270a57fc5705f5fed6485617569fdef4855429a6\", \"latency_unittests\": \"776f4e82f860d7c9a4a457015c7669ce6e8d21e7\", \"libjingle_xmpp_unittests\": \"384a8847d790c98a5750180ae7c4bf0827493c06\", \"liburlpattern_unittests\": \"ce638f93e9708a90ea599873798a4ed2dfc5cc05\", \"media_blink_unittests\": \"5e44e82c4cf24e1ea0d8fb84cab0aa527831733b\", \"media_unittests\": \"9958b5bd240a052b26e61ddf98471561a9207010\", \"message_center_unittests\": \"2edf53f562703b744b685987e843fcde7749bc0b\", \"midi_unittests\": \"a79ebe0bca774e6962b96929ceef659fc94f5b26\", \"mojo_core_unittests\": \"44cea81f20319847376f48e3d5f7f41c01a7d461\", \"mojo_unittests\": \"fd7e1c1819c84f2417c8a20e1d606c04ae7b9214\", \"nacl_loader_unittests\": \"9bda1a9793232c065a0f686d5f170373ba6a0a62\", \"native_theme_unittests\": \"9645ba4cf8cf3f982228425af9bf1e8c892a3991\", \"net_unittests\": \"3358412f3561374675f96d408c83eebfd64ba09a\", \"notification_helper_unittests\": \"f9dd4a6d00044aa2cf0959dff202139e6f27f79e\", \"pdf_unittests\": \"c9abdb6bf61bf8a73e7146d391b5a20dce964f3e\", \"perfetto_unittests\": \"c81b63a77b2acdab974e6db1cd3b340b6fcefc6b\", \"ppapi_unittests\": \"419d1b7e0d9a1283a5f00bbb45e64434e3a5e242\", \"printing_unittests\": \"bddb7a53dd751ed88bef9db9142bc28bcb871011\", \"remoting_unittests\": \"a540e50d55ae7b235455ecd554efc4271b153451\", \"sbox_integration_tests\": \"5c55f52dcfcaaf12a20b11cdb4a1e6bf3d135a47\", \"sbox_unittests\": \"d4a96109f90b33c49639e63cf070853944d0dc3a\", \"sbox_validation_tests\": \"5e2ee316830aa29bb96a915ef888f9ba8ecfc9a6\", \"service_manager_unittests\": \"01129974bf2dcb18072063a1aee4192c937400ec\", \"services_unittests\": \"88aab870df5f16c089505aed06952f4ca074b8a9\", \"setup_unittests\": \"dd5e65baf913c9239b04e7fddf6a06e2d94be465\", \"shell_dialogs_unittests\": \"f0081eacfe1b8e1f2a19fa158aff2fb898c39e8e\", \"skia_unittests\": \"22f9d4ce96b479b23261b451bfcf0a0e0b5b4c82\", \"snapshot_unittests\": \"9bc3c0616b99dcf5caf963837759972711e52413\", \"sql_unittests\": \"ba26d85ef3eaa401f1fa9076e499b069846a6044\", \"storage_unittests\": \"85d6bfc79cf015b05183227f5c706bd5e82419f8\", \"sync_integration_tests\": \"8514f0eddf3cef83630c9e36e1ad9071de6f9879\", \"traffic_annotation_auditor_unittests\": \"693ae040b6bb6367890cb5859dba4e8f428f9bb3\", \"ui_base_unittests\": \"6a3d777ed39e7353fa4c54336e2ca5c22d86f6b7\", \"ui_touch_selection_unittests\": \"1eeaeaea5a1ac2742e97d077989fa7f0a29fefa0\", \"unit_tests\": \"1ae170ac6e789898dc22625d181f43df505d0bdd\", \"updater_tests\": \"188d6d0aee22d08439cbd113c592d0f8159542f7\", \"url_unittests\": \"d66891c2c82b0c69f8384798d391e578bf404ea4\", \"views_unittests\": \"f3b3dd7648ccbcc6a00e7704430311064e2639ed\", \"viz_unittests\": \"77e494a166d96169ce61b7cd9cfbe59f583fbe6e\", \"vr_common_unittests\": \"257fc80201164927c14a03d241040d879a93de22\", \"vr_pixeltests\": \"68b0c7bb594111ab207005f0ffb07fbaefc346c9\", \"weblayer_browsertests\": \"5ed63ad3d1db686fc06771edd10bc69f3ed80fe6\", \"weblayer_unittests\": \"48063785e24d91e87fdd56ae8ccad59826396f54\", \"wm_unittests\": \"31726099c1e3d186eadfffbf4951ce22580e51fb\", \"wtf_unittests\": \"cde8e1fed7e10d40018d484200742f6aa83f67ab\", \"zlib_unittests\": \"bb2c922d136da147a84d44b7efb5580be8a7bcbf\", \"zucchini_unittests\": \"4f1e98e90d58b3af45fb66c2902174190ac45bae\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"builder_f77c1c08af9d0a4522ad60c9181aa925a8ae87fd7ec8443f284fb40f3b6bc27b_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-5-d467\"], \"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\": [\"5626-39642e9\"], \"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": "1605329020648921",
"status": "COMPLETED",
"status_changed_ts": "1605335325674593",
"tags": [
"build_address:luci.chromium.ci/win-asan/15632",
"builder:win-asan",
"buildset:commit/git/a946c30f1ace4159f9d308643334b3755bcf85fe",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a946c30f1ace4159f9d308643334b3755bcf85fe",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029114526816358112",
"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/8863684464824764400/+/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:4fdddf121503bd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605335325776193",
"url": "https://ci.chromium.org/b/8863684464824764400",
"utcnow_ts": "1605335331535373"
}
}
[06:28:51.545] Invocation finished in 1h48m53.453408422s with status SUCCEEDED