[14:52:36.381] New invocation is queued and will start shortly
[14:52:37.543] Starting the invocation (attempt 1)
[14:52:37.575] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:52:37.575] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:52:37.575] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021194046898315712",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"205edcdad46078c51a30ee931ac33b9273903624\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9021194046898315712",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/205edcdad46078c51a30ee931ac33b9273903624",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/205edcdad46078c51a30ee931ac33b9273903624",
"gitiles_ref:refs/heads/master"
]
}
[14:52:38.245] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612882357649640",
"id": "8855763984904537744",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"205edcdad46078c51a30ee931ac33b9273903624\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612882358135033",
"tags": [
"build_address:luci.chromium.ci/win-asan/17256",
"builder:win-asan",
"buildset:commit/git/205edcdad46078c51a30ee931ac33b9273903624",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/205edcdad46078c51a30ee931ac33b9273903624",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021194046898315712",
"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/8855763984904537744/+/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": "1612882358135731",
"url": "https://ci.chromium.org/b/8855763984904537744",
"utcnow_ts": "1612882358232723"
}
}
[14:52:38.245] Task URL: https://ci.chromium.org/b/8855763984904537744
[14:52:38.245] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:2:0) after 1m0s
[14:53:38.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:2:0)
[14:53:38.329] Timer tick, asking Buildbucket for the build status
[14:53:38.447] Build 8855763984904537744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:53:38.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:3:0) after 1m0s
[14:54:38.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:3:0)
[14:54:38.488] Timer tick, asking Buildbucket for the build status
[14:54:38.624] Build 8855763984904537744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:54:38.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:4:0) after 1m0s
[14:55:38.724] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:4:0)
[14:55:38.724] Timer tick, asking Buildbucket for the build status
[14:55:38.886] Build 8855763984904537744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:55:38.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:5:0) after 1m0s
[14:56:38.947] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:5:0)
[14:56:38.947] Timer tick, asking Buildbucket for the build status
[14:56:39.068] Build 8855763984904537744: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:56:39.068] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:6:0) after 1m0s
[14:57:27.376] Received PubSub notification, asking Buildbucket for the build status
[14:57:27.640] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:39.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:6:0)
[14:57:39.089] Timer tick, asking Buildbucket for the build status
[14:57:39.262] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:39.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:8:0) after 1m0s
[14:58:39.262] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:8:0)
[14:58:39.262] Timer tick, asking Buildbucket for the build status
[14:58:39.436] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:39.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:9:0) after 1m0s
[14:59:39.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:9:0)
[14:59:39.493] Timer tick, asking Buildbucket for the build status
[14:59:39.724] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:39.724] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:10:0) after 1m0s
[15:00:39.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:10:0)
[15:00:39.755] Timer tick, asking Buildbucket for the build status
[15:00:40.153] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:40.153] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:11:0) after 1m0s
[15:01:40.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:11:0)
[15:01:40.200] Timer tick, asking Buildbucket for the build status
[15:01:40.281] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:40.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:12:0) after 1m0s
[15:02:40.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:12:0)
[15:02:40.309] Timer tick, asking Buildbucket for the build status
[15:02:40.455] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:40.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:13:0) after 1m0s
[15:03:40.433] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:13:0)
[15:03:40.433] Timer tick, asking Buildbucket for the build status
[15:03:40.767] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:40.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:14:0) after 1m0s
[15:04:40.866] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:14:0)
[15:04:40.866] Timer tick, asking Buildbucket for the build status
[15:04:41.118] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:41.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:15:0) after 1m0s
[15:05:41.138] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:15:0)
[15:05:41.138] Timer tick, asking Buildbucket for the build status
[15:05:41.225] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:41.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:16:0) after 1m0s
[15:06:41.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:16:0)
[15:06:41.200] Timer tick, asking Buildbucket for the build status
[15:06:41.261] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:41.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:17:0) after 1m0s
[15:07:41.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:17:0)
[15:07:41.298] Timer tick, asking Buildbucket for the build status
[15:07:41.429] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:41.429] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:18:0) after 1m0s
[15:08:41.485] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:18:0)
[15:08:41.485] Timer tick, asking Buildbucket for the build status
[15:08:41.743] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:41.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:19:0) after 1m0s
[15:09:41.759] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:19:0)
[15:09:41.759] Timer tick, asking Buildbucket for the build status
[15:09:41.842] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:41.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:20:0) after 1m0s
[15:10:41.871] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:20:0)
[15:10:41.871] Timer tick, asking Buildbucket for the build status
[15:10:42.187] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:42.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:21:0) after 1m0s
[15:11:42.208] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:21:0)
[15:11:42.208] Timer tick, asking Buildbucket for the build status
[15:11:42.439] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:42.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:22:0) after 1m0s
[15:12:42.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:22:0)
[15:12:42.464] Timer tick, asking Buildbucket for the build status
[15:12:42.536] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:42.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:23:0) after 1m0s
[15:13:42.661] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:23:0)
[15:13:42.661] Timer tick, asking Buildbucket for the build status
[15:13:42.837] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:42.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:24:0) after 1m0s
[15:14:42.889] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:24:0)
[15:14:42.889] Timer tick, asking Buildbucket for the build status
[15:14:43.000] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:43.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:25:0) after 1m0s
[15:15:43.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:25:0)
[15:15:43.046] Timer tick, asking Buildbucket for the build status
[15:15:43.209] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:43.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:26:0) after 1m0s
[15:16:43.281] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:26:0)
[15:16:43.281] Timer tick, asking Buildbucket for the build status
[15:16:43.490] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:43.490] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:27:0) after 1m0s
[15:17:43.492] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:27:0)
[15:17:43.492] Timer tick, asking Buildbucket for the build status
[15:17:43.606] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:43.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:28:0) after 1m0s
[15:18:43.897] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:28:0)
[15:18:43.897] Timer tick, asking Buildbucket for the build status
[15:18:43.972] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:43.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:29:0) after 1m0s
[15:19:44.226] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:29:0)
[15:19:44.226] Timer tick, asking Buildbucket for the build status
[15:19:44.638] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:44.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:30:0) after 1m0s
[15:20:44.709] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:30:0)
[15:20:44.709] Timer tick, asking Buildbucket for the build status
[15:20:44.787] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:44.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:31:0) after 1m0s
[15:21:46.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:31:0)
[15:21:46.655] Timer tick, asking Buildbucket for the build status
[15:21:46.730] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:46.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:32:0) after 1m0s
[15:22:46.808] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:32:0)
[15:22:46.808] Timer tick, asking Buildbucket for the build status
[15:22:46.959] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:46.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:33:0) after 1m0s
[15:23:47.000] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:33:0)
[15:23:47.000] Timer tick, asking Buildbucket for the build status
[15:23:47.267] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:47.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:34:0) after 1m0s
[15:24:47.390] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:34:0)
[15:24:47.390] Timer tick, asking Buildbucket for the build status
[15:24:47.469] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:47.469] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:35:0) after 1m0s
[15:25:47.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:35:0)
[15:25:47.528] Timer tick, asking Buildbucket for the build status
[15:25:47.617] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:47.617] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:36:0) after 1m0s
[15:26:47.655] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:36:0)
[15:26:47.655] Timer tick, asking Buildbucket for the build status
[15:26:47.766] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:47.766] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:37:0) after 1m0s
[15:27:47.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:37:0)
[15:27:47.803] Timer tick, asking Buildbucket for the build status
[15:27:48.054] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:48.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:38:0) after 1m0s
[15:28:48.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:38:0)
[15:28:48.082] Timer tick, asking Buildbucket for the build status
[15:28:48.164] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:48.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:39:0) after 1m0s
[15:29:48.252] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:39:0)
[15:29:48.252] Timer tick, asking Buildbucket for the build status
[15:29:48.322] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:48.322] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:40:0) after 1m0s
[15:30:48.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:40:0)
[15:30:48.378] Timer tick, asking Buildbucket for the build status
[15:30:48.821] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:48.821] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:41:0) after 1m0s
[15:31:48.833] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:41:0)
[15:31:48.833] Timer tick, asking Buildbucket for the build status
[15:31:49.052] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:49.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:42:0) after 1m0s
[15:32:49.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:42:0)
[15:32:49.107] Timer tick, asking Buildbucket for the build status
[15:32:49.194] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:49.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:43:0) after 1m0s
[15:33:49.325] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:43:0)
[15:33:49.325] Timer tick, asking Buildbucket for the build status
[15:33:49.795] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:49.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:44:0) after 1m0s
[15:34:50.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:44:0)
[15:34:50.211] Timer tick, asking Buildbucket for the build status
[15:34:50.291] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:50.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:45:0) after 1m0s
[15:35:50.468] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:45:0)
[15:35:50.468] Timer tick, asking Buildbucket for the build status
[15:35:50.547] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:50.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:46:0) after 1m0s
[15:36:50.760] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:46:0)
[15:36:50.760] Timer tick, asking Buildbucket for the build status
[15:36:51.120] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:51.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:47:0) after 1m0s
[15:37:51.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:47:0)
[15:37:51.260] Timer tick, asking Buildbucket for the build status
[15:37:51.349] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:51.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:48:0) after 1m0s
[15:38:51.489] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:48:0)
[15:38:51.489] Timer tick, asking Buildbucket for the build status
[15:38:51.603] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:51.603] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:49:0) after 1m0s
[15:39:51.657] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:49:0)
[15:39:51.657] Timer tick, asking Buildbucket for the build status
[15:39:51.996] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:51.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:50:0) after 1m0s
[15:40:52.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:50:0)
[15:40:52.126] Timer tick, asking Buildbucket for the build status
[15:40:52.993] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:52.993] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:51:0) after 1m0s
[15:41:53.129] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:51:0)
[15:41:53.129] Timer tick, asking Buildbucket for the build status
[15:41:53.535] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:53.535] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:52:0) after 1m0s
[15:42:53.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:52:0)
[15:42:53.614] Timer tick, asking Buildbucket for the build status
[15:42:53.878] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:53.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:53:0) after 1m0s
[15:43:54.220] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:53:0)
[15:43:54.220] Timer tick, asking Buildbucket for the build status
[15:43:54.309] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:54.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:54:0) after 1m0s
[15:44:54.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:54:0)
[15:44:54.364] Timer tick, asking Buildbucket for the build status
[15:44:54.844] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:54.844] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:55:0) after 1m0s
[15:45:54.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:55:0)
[15:45:54.930] Timer tick, asking Buildbucket for the build status
[15:45:55.453] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:55.453] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:56:0) after 1m0s
[15:46:55.704] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:56:0)
[15:46:55.704] Timer tick, asking Buildbucket for the build status
[15:46:55.769] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:55.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:57:0) after 1m0s
[15:47:55.903] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:57:0)
[15:47:55.903] Timer tick, asking Buildbucket for the build status
[15:47:56.006] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:56.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:58:0) after 1m0s
[15:48:56.048] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:58:0)
[15:48:56.048] Timer tick, asking Buildbucket for the build status
[15:48:56.136] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:56.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:59:0) after 1m0s
[15:49:56.160] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:59:0)
[15:49:56.160] Timer tick, asking Buildbucket for the build status
[15:49:56.427] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:56.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:60:0) after 1m0s
[15:50:56.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:60:0)
[15:50:56.534] Timer tick, asking Buildbucket for the build status
[15:50:56.602] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:56.602] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:61:0) after 1m0s
[15:51:56.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:61:0)
[15:51:56.689] Timer tick, asking Buildbucket for the build status
[15:51:56.744] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:56.744] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:62:0) after 1m0s
[15:52:56.826] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:62:0)
[15:52:56.826] Timer tick, asking Buildbucket for the build status
[15:52:56.994] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:56.994] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:63:0) after 1m0s
[15:53:57.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:63:0)
[15:53:57.056] Timer tick, asking Buildbucket for the build status
[15:53:57.199] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:57.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:64:0) after 1m0s
[15:54:57.300] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:64:0)
[15:54:57.300] Timer tick, asking Buildbucket for the build status
[15:54:57.378] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:57.378] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:65:0) after 1m0s
[15:55:57.570] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:65:0)
[15:55:57.570] Timer tick, asking Buildbucket for the build status
[15:55:57.771] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:57.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:66:0) after 1m0s
[15:56:57.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:66:0)
[15:56:57.831] Timer tick, asking Buildbucket for the build status
[15:56:57.968] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:57.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:67:0) after 1m0s
[15:57:58.220] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:67:0)
[15:57:58.220] Timer tick, asking Buildbucket for the build status
[15:57:58.321] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:58.321] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:68:0) after 1m0s
[15:58:58.373] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:68:0)
[15:58:58.373] Timer tick, asking Buildbucket for the build status
[15:58:58.871] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:58.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:69:0) after 1m0s
[15:59:59.022] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:69:0)
[15:59:59.022] Timer tick, asking Buildbucket for the build status
[15:59:59.098] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:59.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:70:0) after 1m0s
[16:00:59.306] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:70:0)
[16:00:59.306] Timer tick, asking Buildbucket for the build status
[16:00:59.382] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:59.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:71:0) after 1m0s
[16:01:59.528] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:71:0)
[16:01:59.528] Timer tick, asking Buildbucket for the build status
[16:02:05.735] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:05.735] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:72:0) after 1m0s
[16:03:05.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:72:0)
[16:03:05.809] Timer tick, asking Buildbucket for the build status
[16:03:05.977] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:05.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:73:0) after 1m0s
[16:04:06.065] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:73:0)
[16:04:06.065] Timer tick, asking Buildbucket for the build status
[16:04:06.135] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:06.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:74:0) after 1m0s
[16:05:06.141] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:74:0)
[16:05:06.141] Timer tick, asking Buildbucket for the build status
[16:05:06.647] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:06.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:75:0) after 1m0s
[16:06:06.745] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:75:0)
[16:06:06.745] Timer tick, asking Buildbucket for the build status
[16:06:06.970] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:06.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:76:0) after 1m0s
[16:07:07.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:76:0)
[16:07:07.033] Timer tick, asking Buildbucket for the build status
[16:07:07.210] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:07.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:77:0) after 1m0s
[16:08:07.345] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:77:0)
[16:08:07.345] Timer tick, asking Buildbucket for the build status
[16:08:07.690] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:07.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:78:0) after 1m0s
[16:09:07.720] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:78:0)
[16:09:07.720] Timer tick, asking Buildbucket for the build status
[16:09:08.013] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:08.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:79:0) after 1m0s
[16:10:08.042] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:79:0)
[16:10:08.042] Timer tick, asking Buildbucket for the build status
[16:10:08.107] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:08.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:80:0) after 1m0s
[16:11:08.153] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:80:0)
[16:11:08.153] Timer tick, asking Buildbucket for the build status
[16:11:08.258] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:08.258] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:81:0) after 1m0s
[16:12:08.334] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:81:0)
[16:12:08.334] Timer tick, asking Buildbucket for the build status
[16:12:08.465] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:08.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:82:0) after 1m0s
[16:13:08.488] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:82:0)
[16:13:08.488] Timer tick, asking Buildbucket for the build status
[16:13:08.569] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:08.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:83:0) after 1m0s
[16:14:08.590] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:83:0)
[16:14:08.590] Timer tick, asking Buildbucket for the build status
[16:14:08.899] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:08.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:84:0) after 1m0s
[16:15:08.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:84:0)
[16:15:08.905] Timer tick, asking Buildbucket for the build status
[16:15:08.984] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:08.984] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:85:0) after 1m0s
[16:16:09.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:85:0)
[16:16:09.008] Timer tick, asking Buildbucket for the build status
[16:16:09.198] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:09.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:86:0) after 1m0s
[16:17:09.224] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:86:0)
[16:17:09.224] Timer tick, asking Buildbucket for the build status
[16:17:09.290] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:09.290] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:87:0) after 1m0s
[16:18:09.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:87:0)
[16:18:09.342] Timer tick, asking Buildbucket for the build status
[16:18:09.471] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:09.471] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:88:0) after 1m0s
[16:19:09.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:88:0)
[16:19:09.493] Timer tick, asking Buildbucket for the build status
[16:19:09.562] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:09.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:89:0) after 1m0s
[16:20:09.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:89:0)
[16:20:09.594] Timer tick, asking Buildbucket for the build status
[16:20:09.665] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:09.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:90:0) after 1m0s
[16:21:09.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:90:0)
[16:21:09.718] Timer tick, asking Buildbucket for the build status
[16:21:09.919] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:09.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:91:0) after 1m0s
[16:22:09.921] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:91:0)
[16:22:09.921] Timer tick, asking Buildbucket for the build status
[16:22:10.112] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:10.112] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:92:0) after 1m0s
[16:23:10.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:92:0)
[16:23:10.168] Timer tick, asking Buildbucket for the build status
[16:23:10.747] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:10.747] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:93:0) after 1m0s
[16:24:10.823] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:93:0)
[16:24:10.823] Timer tick, asking Buildbucket for the build status
[16:24:10.920] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:10.920] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:94:0) after 1m0s
[16:25:10.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:94:0)
[16:25:10.954] Timer tick, asking Buildbucket for the build status
[16:25:11.317] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:11.317] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:95:0) after 1m0s
[16:26:11.550] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:95:0)
[16:26:11.550] Timer tick, asking Buildbucket for the build status
[16:26:11.628] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:11.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:96:0) after 1m0s
[16:27:11.665] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:96:0)
[16:27:11.665] Timer tick, asking Buildbucket for the build status
[16:27:11.751] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:11.751] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:97:0) after 1m0s
[16:28:11.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:97:0)
[16:28:11.855] Timer tick, asking Buildbucket for the build status
[16:28:11.973] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:11.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:98:0) after 1m0s
[16:29:12.113] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:98:0)
[16:29:12.113] Timer tick, asking Buildbucket for the build status
[16:29:12.176] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:12.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:99:0) after 1m0s
[16:30:12.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:99:0)
[16:30:12.339] Timer tick, asking Buildbucket for the build status
[16:30:12.399] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:12.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:100:0) after 1m0s
[16:31:12.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:100:0)
[16:31:12.518] Timer tick, asking Buildbucket for the build status
[16:31:12.655] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:12.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:101:0) after 1m0s
[16:32:12.689] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:101:0)
[16:32:12.689] Timer tick, asking Buildbucket for the build status
[16:32:12.759] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:12.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:102:0) after 1m0s
[16:33:12.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:102:0)
[16:33:12.899] Timer tick, asking Buildbucket for the build status
[16:33:13.039] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:13.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:103:0) after 1m0s
[16:34:13.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:103:0)
[16:34:13.111] Timer tick, asking Buildbucket for the build status
[16:34:13.430] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:13.430] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:104:0) after 1m0s
[16:35:13.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:104:0)
[16:35:13.501] Timer tick, asking Buildbucket for the build status
[16:35:13.737] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:13.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:105:0) after 1m0s
[16:36:13.905] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:105:0)
[16:36:13.905] Timer tick, asking Buildbucket for the build status
[16:36:13.998] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:13.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:106:0) after 1m0s
[16:37:14.087] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:106:0)
[16:37:14.087] Timer tick, asking Buildbucket for the build status
[16:37:14.347] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:14.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:107:0) after 1m0s
[16:38:14.507] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:107:0)
[16:38:14.507] Timer tick, asking Buildbucket for the build status
[16:38:14.622] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:14.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:108:0) after 1m0s
[16:39:14.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:108:0)
[16:39:14.695] Timer tick, asking Buildbucket for the build status
[16:39:14.880] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:14.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:109:0) after 1m0s
[16:40:15.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:109:0)
[16:40:15.056] Timer tick, asking Buildbucket for the build status
[16:40:15.115] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:15.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:110:0) after 1m0s
[16:41:15.127] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:110:0)
[16:41:15.127] Timer tick, asking Buildbucket for the build status
[16:41:15.192] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:15.192] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:111:0) after 1m0s
[16:42:16.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:111:0)
[16:42:16.599] Timer tick, asking Buildbucket for the build status
[16:42:16.934] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:16.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:112:0) after 1m0s
[16:43:17.183] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:112:0)
[16:43:17.183] Timer tick, asking Buildbucket for the build status
[16:43:17.297] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:17.298] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:113:0) after 1m0s
[16:44:17.398] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:113:0)
[16:44:17.398] Timer tick, asking Buildbucket for the build status
[16:44:17.457] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:17.457] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:114:0) after 1m0s
[16:45:17.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:114:0)
[16:45:17.530] Timer tick, asking Buildbucket for the build status
[16:45:17.824] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:17.824] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:115:0) after 1m0s
[16:46:17.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:115:0)
[16:46:17.874] Timer tick, asking Buildbucket for the build status
[16:46:18.368] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:18.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:116:0) after 1m0s
[16:47:18.392] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:116:0)
[16:47:18.392] Timer tick, asking Buildbucket for the build status
[16:47:18.485] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:18.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:117:0) after 1m0s
[16:48:18.615] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:117:0)
[16:48:18.615] Timer tick, asking Buildbucket for the build status
[16:48:19.033] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:19.033] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:118:0) after 1m0s
[16:49:19.079] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:118:0)
[16:49:19.079] Timer tick, asking Buildbucket for the build status
[16:49:19.133] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:19.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:119:0) after 1m0s
[16:50:19.163] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:119:0)
[16:50:19.163] Timer tick, asking Buildbucket for the build status
[16:50:19.783] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:19.783] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:120:0) after 1m0s
[16:51:19.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:120:0)
[16:51:19.814] Timer tick, asking Buildbucket for the build status
[16:51:20.236] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:20.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:121:0) after 1m0s
[16:52:20.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:121:0)
[16:52:20.302] Timer tick, asking Buildbucket for the build status
[16:52:20.447] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:20.447] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:122:0) after 1m0s
[16:53:20.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:122:0)
[16:53:20.501] Timer tick, asking Buildbucket for the build status
[16:53:20.623] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:20.623] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:123:0) after 1m0s
[16:54:20.718] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:123:0)
[16:54:20.718] Timer tick, asking Buildbucket for the build status
[16:54:21.479] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:21.479] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:124:0) after 1m0s
[16:55:21.549] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:124:0)
[16:55:21.549] Timer tick, asking Buildbucket for the build status
[16:55:21.664] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:21.664] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:125:0) after 1m0s
[16:56:21.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:125:0)
[16:56:21.663] Timer tick, asking Buildbucket for the build status
[16:56:22.452] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:22.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:126:0) after 1m0s
[16:57:22.480] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:126:0)
[16:57:22.480] Timer tick, asking Buildbucket for the build status
[16:57:22.585] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:22.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:127:0) after 1m0s
[16:58:22.709] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:127:0)
[16:58:22.709] Timer tick, asking Buildbucket for the build status
[16:58:22.886] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:22.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:128:0) after 1m0s
[16:59:22.927] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:128:0)
[16:59:22.927] Timer tick, asking Buildbucket for the build status
[16:59:23.038] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:23.038] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:129:0) after 1m0s
[17:00:23.162] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:129:0)
[17:00:23.162] Timer tick, asking Buildbucket for the build status
[17:00:23.311] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:23.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:130:0) after 1m0s
[17:01:23.747] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:130:0)
[17:01:23.747] Timer tick, asking Buildbucket for the build status
[17:01:23.911] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:23.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:131:0) after 1m0s
[17:02:23.993] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:131:0)
[17:02:23.993] Timer tick, asking Buildbucket for the build status
[17:02:24.137] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:24.137] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:132:0) after 1m0s
[17:03:24.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:132:0)
[17:03:24.216] Timer tick, asking Buildbucket for the build status
[17:03:24.609] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:24.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:133:0) after 1m0s
[17:04:24.695] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:133:0)
[17:04:24.695] Timer tick, asking Buildbucket for the build status
[17:04:24.764] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:24.764] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:134:0) after 1m0s
[17:05:24.810] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:134:0)
[17:05:24.810] Timer tick, asking Buildbucket for the build status
[17:05:24.903] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:24.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:135:0) after 1m0s
[17:06:24.934] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:135:0)
[17:06:24.934] Timer tick, asking Buildbucket for the build status
[17:06:25.024] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:25.024] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:136:0) after 1m0s
[17:07:25.149] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:136:0)
[17:07:25.149] Timer tick, asking Buildbucket for the build status
[17:07:25.235] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:25.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:137:0) after 1m0s
[17:08:25.402] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:137:0)
[17:08:25.402] Timer tick, asking Buildbucket for the build status
[17:08:25.533] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:25.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:138:0) after 1m0s
[17:09:25.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:138:0)
[17:09:25.577] Timer tick, asking Buildbucket for the build status
[17:09:25.700] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:25.700] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:139:0) after 1m0s
[17:10:25.752] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:139:0)
[17:10:25.752] Timer tick, asking Buildbucket for the build status
[17:10:26.337] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:26.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:140:0) after 1m0s
[17:11:26.464] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:140:0)
[17:11:26.464] Timer tick, asking Buildbucket for the build status
[17:11:26.575] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:26.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:141:0) after 1m0s
[17:12:26.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:141:0)
[17:12:26.763] Timer tick, asking Buildbucket for the build status
[17:12:26.924] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:26.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:142:0) after 1m0s
[17:13:27.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:142:0)
[17:13:27.146] Timer tick, asking Buildbucket for the build status
[17:13:27.272] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:27.272] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:143:0) after 1m0s
[17:14:27.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:143:0)
[17:14:27.605] Timer tick, asking Buildbucket for the build status
[17:14:27.672] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:27.672] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:144:0) after 1m0s
[17:15:27.795] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:144:0)
[17:15:27.795] Timer tick, asking Buildbucket for the build status
[17:15:27.910] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:27.910] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:145:0) after 1m0s
[17:16:27.958] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:145:0)
[17:16:27.958] Timer tick, asking Buildbucket for the build status
[17:16:28.066] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:28.066] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:146:0) after 1m0s
[17:17:28.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:146:0)
[17:17:28.099] Timer tick, asking Buildbucket for the build status
[17:17:28.232] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:28.232] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:147:0) after 1m0s
[17:18:29.063] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:147:0)
[17:18:29.063] Timer tick, asking Buildbucket for the build status
[17:18:29.210] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:29.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:148:0) after 1m0s
[17:19:29.405] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:148:0)
[17:19:29.405] Timer tick, asking Buildbucket for the build status
[17:19:29.475] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:29.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:149:0) after 1m0s
[17:20:29.712] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:149:0)
[17:20:29.712] Timer tick, asking Buildbucket for the build status
[17:20:31.648] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:31.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:150:0) after 1m0s
[17:21:31.825] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:150:0)
[17:21:31.825] Timer tick, asking Buildbucket for the build status
[17:21:32.163] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:32.163] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:151:0) after 1m0s
[17:22:32.233] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:151:0)
[17:22:32.233] Timer tick, asking Buildbucket for the build status
[17:22:32.377] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:32.377] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:152:0) after 1m0s
[17:23:32.376] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:152:0)
[17:23:32.376] Timer tick, asking Buildbucket for the build status
[17:23:32.992] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:32.992] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:153:0) after 1m0s
[17:24:33.083] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:153:0)
[17:24:33.083] Timer tick, asking Buildbucket for the build status
[17:24:33.349] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:33.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:154:0) after 1m0s
[17:25:33.410] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:154:0)
[17:25:33.410] Timer tick, asking Buildbucket for the build status
[17:25:33.503] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:33.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:155:0) after 1m0s
[17:26:33.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:155:0)
[17:26:33.568] Timer tick, asking Buildbucket for the build status
[17:26:33.723] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:33.723] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:156:0) after 1m0s
[17:27:33.865] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:156:0)
[17:27:33.865] Timer tick, asking Buildbucket for the build status
[17:27:34.016] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:34.016] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:157:0) after 1m0s
[17:28:34.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:157:0)
[17:28:34.064] Timer tick, asking Buildbucket for the build status
[17:28:35.529] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:35.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:158:0) after 1m0s
[17:29:35.685] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:158:0)
[17:29:35.685] Timer tick, asking Buildbucket for the build status
[17:29:35.773] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:35.773] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:159:0) after 1m0s
[17:30:35.803] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:159:0)
[17:30:35.803] Timer tick, asking Buildbucket for the build status
[17:30:36.139] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:36.139] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:160:0) after 1m0s
[17:31:36.261] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:160:0)
[17:31:36.261] Timer tick, asking Buildbucket for the build status
[17:31:36.579] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:36.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:161:0) after 1m0s
[17:32:36.670] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:161:0)
[17:32:36.670] Timer tick, asking Buildbucket for the build status
[17:32:37.200] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:37.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:162:0) after 1m0s
[17:33:37.302] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:162:0)
[17:33:37.302] Timer tick, asking Buildbucket for the build status
[17:33:38.135] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:38.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:163:0) after 1m0s
[17:34:38.175] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:163:0)
[17:34:38.175] Timer tick, asking Buildbucket for the build status
[17:34:38.253] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:38.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:164:0) after 1m0s
[17:35:38.423] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:164:0)
[17:35:38.423] Timer tick, asking Buildbucket for the build status
[17:35:38.561] Build 8855763984904537744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:38.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9021194046898315712:165:0) after 1m0s
[17:36:37.685] Received PubSub notification, asking Buildbucket for the build status
[17:36:37.750] Build 8855763984904537744: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:36:37.750] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612892196532953",
"created_by": "project:chromium",
"created_ts": "1612882357649640",
"id": "8855763984904537744",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"205edcdad46078c51a30ee931ac33b9273903624\"}}",
"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\": \"205edcdad46078c51a30ee931ac33b9273903624\", \"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-1-ckf5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17256, \"clang_revision\": \"llvmorg-13-init-794-g83e2710e-1\", \"got_angle_revision\": \"80335a11165f7809a736429f0a5e13bd63e09765\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"205edcdad46078c51a30ee931ac33b9273903624\", \"got_revision_cp\": \"refs/heads/master@{#852186}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"9d35d544ce966098fdcb36107835d57a4dc1f32d\", \"got_v8_revision\": \"b19b2448ed8ecdc8965621750ac648a2331c0c18\", \"got_v8_revision_cp\": \"refs/heads/9.0.144@{#1}\", \"got_webrtc_revision\": \"54ea85c2cd3a2cb1b8f440a71aa9676a9b88135c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33190}\", \"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\": \"205edcdad46078c51a30ee931ac33b9273903624\", \"swarm_hashes_refs/heads/master(at){#852186}_without_patch\": {\"absl_hardening_tests\": \"f331f07e4f044c08d5c0d20f693676c4c1280438\", \"accessibility_unittests\": \"af2e81ba16b725e9c7e1cb1697f5f6db81448a3c\", \"angle_unittests\": \"e3909920f379b2f34e029a89fdae37ab77f9629e\", \"app_shell_unittests\": \"1309655790e2192d708ece367ba78f366d52a16d\", \"aura_unittests\": \"d36a427ef7bd6e70dc5561615ea04a17052a2fa0\", \"base_unittests\": \"675db4488167c5e81359d09a44149af02fde85eb\", \"base_util_unittests\": \"7836d726d566757266ca0f74aa0b8e9ceabffe6f\", \"blink_common_unittests\": \"d6b99fb33de6e327908e4d6b80739b00ac28194b\", \"blink_fuzzer_unittests\": \"04309ca358ad2a811bdbaf4217fd7de8e650673d\", \"blink_heap_unittests\": \"5b3fb51cbf8c5148c0f4fe90a038886ef1e4ed3a\", \"blink_platform_unittests\": \"e62391de4be70b073b1e11b423cec8ffa8339575\", \"blink_unittests\": \"89055c6cf5403817956890d80f6af78ce09af9b7\", \"boringssl_crypto_tests\": \"911304cf904d33614972214a63a87322a1e112a0\", \"boringssl_ssl_tests\": \"9475bd0d9cbfe45413a1c9d5ccc8c06685e90752\", \"browser_switcher_bho_unittests\": \"7058291fe52e761a0205ec7b04f1597874ca0236\", \"browser_tests\": \"03da82723233ad2d9ab7bc7de91e087584439490\", \"capture_unittests\": \"b914526c3c7eac81b4715b1c48f6dcb0d4b65e1e\", \"cast_unittests\": \"f539b5b8df8ae1c916aff847d6529b73505a42ee\", \"cc_unittests\": \"f6e1ea64418c986aade13af4c16416da11c4bbe7\", \"chrome_app_unittests\": \"c6ae669afa483087502d62af54833fc30bb1f816\", \"chrome_cleaner_unittests\": \"ac9191a246951be32c661f5198b7b15e2295b124\", \"chrome_elf_unittests\": \"e82be66d5038b0c14896e82143d96b4386b557df\", \"chromedriver_unittests\": \"afac3507c313619586369d3bd81c56da80863e4c\", \"components_browsertests\": \"bf3119ec7b9889934740f9991d588aa27d55764f\", \"components_unittests\": \"35895c09e294d2f09310d0a3dc60fb024f5e2dca\", \"compositor_unittests\": \"31611b65194def9b8307cd7b76646b151dc64c2e\", \"content_browsertests\": \"ffd065495bf8af8375fffe13465dd03635d0dd37\", \"content_unittests\": \"b4d494ed47766f22d72ea4821b336277839e169f\", \"courgette_unittests\": \"87d32dea05815b1174d2e84749c4d9cacc6ab5b2\", \"crashpad_tests\": \"6fb1526f275802064f63b61493ea8e0f331e4d56\", \"cronet_tests\": \"1b1e74f82a0555e71f97482123e504ef4e57434c\", \"cronet_unittests\": \"9aef8fa3f8ddced33885a380feafc95b290cbb52\", \"crypto_unittests\": \"0f201dd55aef6809f632c65053c1e37bd82b26b4\", \"delayloads_unittests\": \"ebb0b9f65cfe3ac5beeff7d2305ac8f65aacecd0\", \"device_unittests\": \"c5521f7b1022bc8ccddb9f4704ce4def81c64bb1\", \"display_unittests\": \"bff8206ea1621bf9b9f9aaff62e92ed59881a33d\", \"elevation_service_unittests\": \"ad58a7e80a88fb325f011076bf740be5ba2a478c\", \"events_unittests\": \"89c61a80ce581eb9febdec6f9ce642d09eacf19b\", \"extensions_browsertests\": \"ee03e6796da4c250e32473d5162c2e431f6d5e94\", \"extensions_unittests\": \"a459392fd69e10f099b6d67f485ef8dd08de0954\", \"filesystem_service_unittests\": \"9ec2b7db0717684d76b80bd51f7d16e14c098187\", \"gcm_unit_tests\": \"1589b409d18f5539eb79a1a656911a23860035a4\", \"gcp_unittests\": \"2009a70d7e7810b7b7d3ccc96cf612b31277bb17\", \"gfx_unittests\": \"618c708a37fe7ac03929a2ed9fb989a53b1f0910\", \"gin_unittests\": \"0ec65cae1ed9ded1be84b2c0e27f5945b7073e44\", \"google_apis_unittests\": \"72bd9475e09621898057ff5c1cd5b57620de815f\", \"gpu_unittests\": \"f4fb06caf52f403d5cf5cb2fefc77fe2795c0a2f\", \"gwp_asan_unittests\": \"156ee908928ea6952f6263e20bf296f0b3bff850\", \"headless_browsertests\": \"0496149604e4b36aeb3a4e87d9b5b628171d6a6f\", \"headless_unittests\": \"65231a23720fb252c690c27cf43b858726a78ba7\", \"install_static_unittests\": \"99636eeb7242f3f49034460fbbbdf7dd0f34829e\", \"installer_util_unittests\": \"78fcd21d641d7b2f84d70c31a64baf960e5238ff\", \"interactive_ui_tests\": \"0592ca26444b8bcb4a65147d561ac7c5c2f78eca\", \"ipc_tests\": \"099f0ae01ad3960efb110e173cf4d35fb6f2c455\", \"jingle_unittests\": \"3616fb98d027a9f2d7b8fa8856d39d31032f1fb3\", \"latency_unittests\": \"6466db07c978e68db6ce9f7c0f7777d4260de28e\", \"libjingle_xmpp_unittests\": \"0d71a6aba8bbae36633a43291510bbca0c27b3a5\", \"liburlpattern_unittests\": \"ad593f62064d240095e5074f003b80fab4134ca8\", \"media_blink_unittests\": \"09480d1a5444c5029ad9fe1298d1912d3926555b\", \"media_unittests\": \"4cb1076469edad298ee01e5ac62a4d0753a4a346\", \"message_center_unittests\": \"f736a6d207df17dc32c676177be65e8b61b1ad95\", \"midi_unittests\": \"0696ff047d751677bdbafdb867d50f4345176680\", \"mojo_core_unittests\": \"ba6590fa2625f65a18c0454c12cfec227e1d6eda\", \"mojo_unittests\": \"32b50d9a61b9f69dd45c2971f1a5b459ccd7ebe1\", \"nacl_loader_unittests\": \"e9ac6d2b53943925799d82297fbe37c2d7f657f7\", \"native_theme_unittests\": \"43b86aa38a21bbd35d179be57ac3ba32746a2ca6\", \"net_unittests\": \"ebfb394b95732d2e748c00bf37e2cbd1f11aff96\", \"notification_helper_unittests\": \"03824650032ffbea9e424788a6c85670d172addd\", \"pdf_unittests\": \"b67cc37963751c8874df37bd1e07db9bca36f708\", \"perfetto_unittests\": \"f543f582118a9110adbf9eef37e24c5f1068ab5c\", \"ppapi_unittests\": \"91add944b1c69022c953b096762fca988a1fed00\", \"printing_unittests\": \"eb49747455561025f8362d2661916a4693a89cc5\", \"remoting_unittests\": \"699c9294dae7e68129f6a6620a26ff555363cf4f\", \"sbox_integration_tests\": \"d54c43f26216b11f7b347418b866628090d973cd\", \"sbox_unittests\": \"a7ffac1c2bdf296e359ff62247d4f54ef97d07e6\", \"sbox_validation_tests\": \"169a995a596dd8941fabb1b723a9aa340679f19c\", \"service_manager_unittests\": \"e56a90c39b0372694de6e272192d14bf6cdd46ae\", \"services_unittests\": \"cd1dbaab3c83f590094f1b70f6303e171d8ef997\", \"setup_unittests\": \"4f6dec7b1df78856990febf8eb66adfbdc714a50\", \"shell_dialogs_unittests\": \"d74b5a16b78995b7778fac63fc5f3dad0b6e78b8\", \"skia_unittests\": \"a9fad134c9840f9ac1fc99555db737edb5fd0323\", \"snapshot_unittests\": \"46d8e8ba49cbb0033ccbc7bf485c99e4518d5d6c\", \"sql_unittests\": \"1bf0618e639208cdc4fb05c781b4560723a1ebb6\", \"storage_unittests\": \"0bf65edc739a7a39ea71eeb8789e3546c8ab9f47\", \"sync_integration_tests\": \"6c7e3b3077c2ba44e70d56cfc6d62b66b6664179\", \"traffic_annotation_auditor_unittests\": \"18abf95296726d10437c3c33a66df746c9287465\", \"ui_base_unittests\": \"c803fd575bb72285859ac2b8acaca109cac63f3e\", \"ui_touch_selection_unittests\": \"c6f02c5669c5b880776f780f4b00172e93eac40c\", \"unit_tests\": \"da4d5e0bdebf18d36495d533bcb4c802f75c1d81\", \"updater_tests\": \"e6229beaed09859ee0eb94f184a99e214fda2cdf\", \"url_unittests\": \"f1fa5f09d62680717cdab275a559092e75f0af14\", \"views_unittests\": \"0e81890425e103fc148af98391e178bfb931dfd0\", \"viz_unittests\": \"30bca789f494d1c8798370637fc3495c38fd6621\", \"vr_common_unittests\": \"a5afb85f7893a1feddee56f87f4eadf67cd6d3f8\", \"vr_pixeltests\": \"e063719f0fe5e2cc3b83b5798bf16d76930da43e\", \"weblayer_browsertests\": \"df9a9b36e133b42f0f82dea6787923d86c7668b7\", \"weblayer_unittests\": \"932dd56ceb10094fa01bd923f3b63ee241607897\", \"wm_unittests\": \"95b58ba5e882bf476c2dbeba98e9d956f0fd07c5\", \"wtf_unittests\": \"e55beb5eea015edce5d5e5d51620746314f03208\", \"zlib_unittests\": \"1e93b0009accfca348e2bfab05834c119feed9dd\", \"zucchini_unittests\": \"d3db0455926873c5516fdd54f258d610aa865ff0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_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-1-ckf5\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5685-1877293\"], \"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": "1612882646707193",
"status": "COMPLETED",
"status_changed_ts": "1612892196994084",
"tags": [
"build_address:luci.chromium.ci/win-asan/17256",
"builder:win-asan",
"buildset:commit/git/205edcdad46078c51a30ee931ac33b9273903624",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/205edcdad46078c51a30ee931ac33b9273903624",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021194046898315712",
"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/8855763984904537744/+/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:51a01938efd47110",
"user_agent:luci-scheduler"
],
"updated_ts": "1612892197020697",
"url": "https://ci.chromium.org/b/8855763984904537744",
"utcnow_ts": "1612892197741610"
}
}
[17:36:37.750] Invocation finished in 2h44m1.386281087s with status SUCCEEDED