[04:08:16.239] New invocation is queued and will start shortly
[04:08:17.391] Starting the invocation (attempt 1)
[04:08:17.421] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:08:17.421] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:08:17.421] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019513242630404160",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"94e031b6cd2d63861ed7f2c9ec4710fcab204f5f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019513242630404160",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/94e031b6cd2d63861ed7f2c9ec4710fcab204f5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/94e031b6cd2d63861ed7f2c9ec4710fcab204f5f",
"gitiles_ref:refs/heads/master"
]
}
[04:08:18.347] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614485297494307",
"id": "8854083180653599104",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"94e031b6cd2d63861ed7f2c9ec4710fcab204f5f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614485298083214",
"tags": [
"build_address:luci.chromium.ci/win-asan/17561",
"builder:win-asan",
"buildset:commit/git/94e031b6cd2d63861ed7f2c9ec4710fcab204f5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/94e031b6cd2d63861ed7f2c9ec4710fcab204f5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019513242630404160",
"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/8854083180653599104/+/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": "1614485298083322",
"url": "https://ci.chromium.org/b/8854083180653599104",
"utcnow_ts": "1614485298331951"
}
}
[04:08:18.347] Task URL: https://ci.chromium.org/b/8854083180653599104
[04:08:18.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:2:0) after 1m0s
[04:09:15.611] Received PubSub notification, asking Buildbucket for the build status
[04:09:15.711] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:18.681] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:2:0)
[04:09:18.681] Timer tick, asking Buildbucket for the build status
[04:09:18.774] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:18.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:4:0) after 1m0s
[04:10:18.788] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:4:0)
[04:10:18.788] Timer tick, asking Buildbucket for the build status
[04:10:18.862] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:18.862] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:5:0) after 1m0s
[04:11:18.900] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:5:0)
[04:11:18.900] Timer tick, asking Buildbucket for the build status
[04:11:18.981] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:18.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:6:0) after 1m0s
[04:12:18.950] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:6:0)
[04:12:18.950] Timer tick, asking Buildbucket for the build status
[04:12:19.316] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:19.316] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:7:0) after 1m0s
[04:13:19.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:7:0)
[04:13:19.341] Timer tick, asking Buildbucket for the build status
[04:13:21.113] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:21.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:8:0) after 1m0s
[04:14:21.130] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:8:0)
[04:14:21.130] Timer tick, asking Buildbucket for the build status
[04:14:21.313] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:21.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:9:0) after 1m0s
[04:15:21.321] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:9:0)
[04:15:21.321] Timer tick, asking Buildbucket for the build status
[04:15:21.428] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:21.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:10:0) after 1m0s
[04:16:21.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:10:0)
[04:16:21.544] Timer tick, asking Buildbucket for the build status
[04:16:21.738] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:21.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:11:0) after 1m0s
[04:17:21.804] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:11:0)
[04:17:21.804] Timer tick, asking Buildbucket for the build status
[04:17:21.881] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:21.881] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:12:0) after 1m0s
[04:18:21.896] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:12:0)
[04:18:21.896] Timer tick, asking Buildbucket for the build status
[04:18:22.059] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:22.059] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:13:0) after 1m0s
[04:19:22.150] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:13:0)
[04:19:22.150] Timer tick, asking Buildbucket for the build status
[04:19:22.235] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:22.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:14:0) after 1m0s
[04:20:22.301] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:14:0)
[04:20:22.301] Timer tick, asking Buildbucket for the build status
[04:20:22.370] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:22.371] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:15:0) after 1m0s
[04:21:22.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:15:0)
[04:21:22.388] Timer tick, asking Buildbucket for the build status
[04:21:22.464] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:22.464] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:16:0) after 1m0s
[04:22:22.479] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:16:0)
[04:22:22.479] Timer tick, asking Buildbucket for the build status
[04:22:22.665] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:22.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:17:0) after 1m0s
[04:23:22.682] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:17:0)
[04:23:22.682] Timer tick, asking Buildbucket for the build status
[04:23:22.760] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:22.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:18:0) after 1m0s
[04:24:22.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:18:0)
[04:24:22.775] Timer tick, asking Buildbucket for the build status
[04:24:22.842] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:22.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:19:0) after 1m0s
[04:25:22.856] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:19:0)
[04:25:22.856] Timer tick, asking Buildbucket for the build status
[04:25:22.982] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:22.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:20:0) after 1m0s
[04:26:23.000] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:20:0)
[04:26:23.000] Timer tick, asking Buildbucket for the build status
[04:26:23.125] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:23.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:21:0) after 1m0s
[04:27:23.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:21:0)
[04:27:23.140] Timer tick, asking Buildbucket for the build status
[04:27:23.200] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:23.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:22:0) after 1m0s
[04:28:23.216] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:22:0)
[04:28:23.216] Timer tick, asking Buildbucket for the build status
[04:28:23.346] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:23.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:23:0) after 1m0s
[04:29:23.361] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:23:0)
[04:29:23.361] Timer tick, asking Buildbucket for the build status
[04:29:23.606] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:23.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:24:0) after 1m0s
[04:30:23.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:24:0)
[04:30:23.729] Timer tick, asking Buildbucket for the build status
[04:30:23.968] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:23.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:25:0) after 1m0s
[04:31:24.033] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:25:0)
[04:31:24.033] Timer tick, asking Buildbucket for the build status
[04:31:24.116] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:24.116] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:26:0) after 1m0s
[04:32:24.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:26:0)
[04:32:24.133] Timer tick, asking Buildbucket for the build status
[04:32:24.206] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:24.206] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:27:0) after 1m0s
[04:33:24.223] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:27:0)
[04:33:24.223] Timer tick, asking Buildbucket for the build status
[04:33:24.341] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:24.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:28:0) after 1m0s
[04:34:24.363] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:28:0)
[04:34:24.363] Timer tick, asking Buildbucket for the build status
[04:34:24.454] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:24.454] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:29:0) after 1m0s
[04:35:24.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:29:0)
[04:35:24.520] Timer tick, asking Buildbucket for the build status
[04:35:24.600] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:24.600] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:30:0) after 1m0s
[04:36:24.632] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:30:0)
[04:36:24.632] Timer tick, asking Buildbucket for the build status
[04:36:25.076] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:25.076] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:31:0) after 1m0s
[04:37:25.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:31:0)
[04:37:25.146] Timer tick, asking Buildbucket for the build status
[04:37:25.207] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:25.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:32:0) after 1m0s
[04:38:25.247] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:32:0)
[04:38:25.247] Timer tick, asking Buildbucket for the build status
[04:38:25.552] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:25.552] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:33:0) after 1m0s
[04:39:25.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:33:0)
[04:39:25.568] Timer tick, asking Buildbucket for the build status
[04:39:25.651] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:25.651] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:34:0) after 1m0s
[04:40:25.720] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:34:0)
[04:40:25.720] Timer tick, asking Buildbucket for the build status
[04:40:25.790] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:25.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:35:0) after 1m0s
[04:41:25.830] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:35:0)
[04:41:25.830] Timer tick, asking Buildbucket for the build status
[04:41:25.903] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:25.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:36:0) after 1m0s
[04:42:25.938] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:36:0)
[04:42:25.939] Timer tick, asking Buildbucket for the build status
[04:42:26.199] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:26.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:37:0) after 1m0s
[04:43:26.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:37:0)
[04:43:26.218] Timer tick, asking Buildbucket for the build status
[04:43:26.427] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:26.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:38:0) after 1m0s
[04:44:26.444] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:38:0)
[04:44:26.444] Timer tick, asking Buildbucket for the build status
[04:44:26.656] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:26.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:39:0) after 1m0s
[04:45:26.667] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:39:0)
[04:45:26.667] Timer tick, asking Buildbucket for the build status
[04:45:26.846] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:26.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:40:0) after 1m0s
[04:46:26.869] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:40:0)
[04:46:26.869] Timer tick, asking Buildbucket for the build status
[04:46:26.943] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:26.943] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:41:0) after 1m0s
[04:47:26.960] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:41:0)
[04:47:26.960] Timer tick, asking Buildbucket for the build status
[04:47:27.041] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:27.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:42:0) after 1m0s
[04:48:27.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:42:0)
[04:48:27.174] Timer tick, asking Buildbucket for the build status
[04:48:27.287] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:27.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:43:0) after 1m0s
[04:49:27.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:43:0)
[04:49:27.362] Timer tick, asking Buildbucket for the build status
[04:49:27.472] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:27.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:44:0) after 1m0s
[04:50:27.530] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:44:0)
[04:50:27.530] Timer tick, asking Buildbucket for the build status
[04:50:27.710] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:27.710] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:45:0) after 1m0s
[04:51:27.729] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:45:0)
[04:51:27.729] Timer tick, asking Buildbucket for the build status
[04:51:27.903] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:27.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:46:0) after 1m0s
[04:52:27.919] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:46:0)
[04:52:27.919] Timer tick, asking Buildbucket for the build status
[04:52:28.073] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:28.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:47:0) after 1m0s
[04:53:28.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:47:0)
[04:53:28.094] Timer tick, asking Buildbucket for the build status
[04:53:28.200] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:28.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:48:0) after 1m0s
[04:54:28.269] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:48:0)
[04:54:28.269] Timer tick, asking Buildbucket for the build status
[04:54:28.354] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:28.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:49:0) after 1m0s
[04:55:28.339] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:49:0)
[04:55:28.339] Timer tick, asking Buildbucket for the build status
[04:55:28.521] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:28.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:50:0) after 1m0s
[04:56:28.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:50:0)
[04:56:28.594] Timer tick, asking Buildbucket for the build status
[04:56:28.689] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:28.689] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:51:0) after 1m0s
[04:57:28.660] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:51:0)
[04:57:28.660] Timer tick, asking Buildbucket for the build status
[04:57:28.808] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:28.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:52:0) after 1m0s
[04:58:28.958] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:52:0)
[04:58:28.958] Timer tick, asking Buildbucket for the build status
[04:58:29.174] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:29.174] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:53:0) after 1m0s
[04:59:29.244] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:53:0)
[04:59:29.244] Timer tick, asking Buildbucket for the build status
[04:59:29.467] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:29.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:54:0) after 1m0s
[05:00:29.541] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:54:0)
[05:00:29.541] Timer tick, asking Buildbucket for the build status
[05:00:29.659] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:29.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:55:0) after 1m0s
[05:01:29.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:55:0)
[05:01:29.677] Timer tick, asking Buildbucket for the build status
[05:01:29.989] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:29.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:56:0) after 1m0s
[05:02:30.013] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:56:0)
[05:02:30.013] Timer tick, asking Buildbucket for the build status
[05:02:30.097] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:30.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:57:0) after 1m0s
[05:03:30.121] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:57:0)
[05:03:30.121] Timer tick, asking Buildbucket for the build status
[05:03:30.382] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:30.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:58:0) after 1m0s
[05:04:30.400] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:58:0)
[05:04:30.400] Timer tick, asking Buildbucket for the build status
[05:04:30.473] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:30.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:59:0) after 1m0s
[05:05:30.501] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:59:0)
[05:05:30.501] Timer tick, asking Buildbucket for the build status
[05:05:30.906] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:30.906] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:60:0) after 1m0s
[05:06:30.925] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:60:0)
[05:06:30.925] Timer tick, asking Buildbucket for the build status
[05:06:31.000] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:31.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:61:0) after 1m0s
[05:07:31.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:61:0)
[05:07:31.069] Timer tick, asking Buildbucket for the build status
[05:07:31.157] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:31.157] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:62:0) after 1m0s
[05:08:31.176] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:62:0)
[05:08:31.176] Timer tick, asking Buildbucket for the build status
[05:08:31.339] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:31.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:63:0) after 1m0s
[05:09:31.355] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:63:0)
[05:09:31.355] Timer tick, asking Buildbucket for the build status
[05:09:31.608] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:31.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:64:0) after 1m0s
[05:10:31.628] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:64:0)
[05:10:31.628] Timer tick, asking Buildbucket for the build status
[05:10:31.718] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:31.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:65:0) after 1m0s
[05:11:31.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:65:0)
[05:11:31.736] Timer tick, asking Buildbucket for the build status
[05:11:31.863] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:31.863] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:66:0) after 1m0s
[05:12:31.883] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:66:0)
[05:12:31.883] Timer tick, asking Buildbucket for the build status
[05:12:31.956] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:31.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:67:0) after 1m0s
[05:13:31.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:67:0)
[05:13:31.994] Timer tick, asking Buildbucket for the build status
[05:13:32.130] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:32.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:68:0) after 1m0s
[05:14:32.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:68:0)
[05:14:32.147] Timer tick, asking Buildbucket for the build status
[05:14:32.231] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:32.231] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:69:0) after 1m0s
[05:15:32.265] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:69:0)
[05:15:32.265] Timer tick, asking Buildbucket for the build status
[05:15:32.365] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:32.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:70:0) after 1m0s
[05:16:32.386] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:70:0)
[05:16:32.386] Timer tick, asking Buildbucket for the build status
[05:16:32.473] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:32.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:71:0) after 1m0s
[05:17:32.481] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:71:0)
[05:17:32.481] Timer tick, asking Buildbucket for the build status
[05:17:32.631] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:32.631] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:72:0) after 1m0s
[05:18:32.981] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:72:0)
[05:18:32.981] Timer tick, asking Buildbucket for the build status
[05:18:33.098] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:33.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:73:0) after 1m0s
[05:19:33.190] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:73:0)
[05:19:33.190] Timer tick, asking Buildbucket for the build status
[05:19:33.553] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:33.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:74:0) after 1m0s
[05:20:33.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:74:0)
[05:20:33.577] Timer tick, asking Buildbucket for the build status
[05:20:33.655] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:33.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:75:0) after 1m0s
[05:21:33.732] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:75:0)
[05:21:33.732] Timer tick, asking Buildbucket for the build status
[05:21:33.810] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:33.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:76:0) after 1m0s
[05:22:34.037] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:76:0)
[05:22:34.037] Timer tick, asking Buildbucket for the build status
[05:22:34.118] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:34.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:77:0) after 1m0s
[05:23:34.238] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:77:0)
[05:23:34.238] Timer tick, asking Buildbucket for the build status
[05:23:34.331] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:34.331] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:78:0) after 1m0s
[05:24:34.347] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:78:0)
[05:24:34.347] Timer tick, asking Buildbucket for the build status
[05:24:34.628] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:34.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:79:0) after 1m0s
[05:25:34.677] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:79:0)
[05:25:34.678] Timer tick, asking Buildbucket for the build status
[05:25:34.760] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:34.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:80:0) after 1m0s
[05:26:34.877] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:80:0)
[05:26:34.877] Timer tick, asking Buildbucket for the build status
[05:26:35.311] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:35.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:81:0) after 1m0s
[05:27:35.313] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:81:0)
[05:27:35.313] Timer tick, asking Buildbucket for the build status
[05:27:35.420] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:35.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:82:0) after 1m0s
[05:28:35.534] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:82:0)
[05:28:35.534] Timer tick, asking Buildbucket for the build status
[05:28:35.864] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:35.864] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:83:0) after 1m0s
[05:29:35.879] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:83:0)
[05:29:35.879] Timer tick, asking Buildbucket for the build status
[05:29:36.008] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:36.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:84:0) after 1m0s
[05:30:36.134] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:84:0)
[05:30:36.134] Timer tick, asking Buildbucket for the build status
[05:30:36.235] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:36.235] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:85:0) after 1m0s
[05:31:36.353] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:85:0)
[05:31:36.353] Timer tick, asking Buildbucket for the build status
[05:31:36.473] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:36.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:86:0) after 1m0s
[05:32:36.493] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:86:0)
[05:32:36.493] Timer tick, asking Buildbucket for the build status
[05:32:36.727] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:36.727] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:87:0) after 1m0s
[05:33:36.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:87:0)
[05:33:36.757] Timer tick, asking Buildbucket for the build status
[05:33:36.876] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:36.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:88:0) after 1m0s
[05:34:36.899] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:88:0)
[05:34:36.899] Timer tick, asking Buildbucket for the build status
[05:34:36.981] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:36.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:89:0) after 1m0s
[05:35:37.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:89:0)
[05:35:37.056] Timer tick, asking Buildbucket for the build status
[05:35:37.160] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:37.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:90:0) after 1m0s
[05:36:37.167] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:90:0)
[05:36:37.167] Timer tick, asking Buildbucket for the build status
[05:36:37.252] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:37.252] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:91:0) after 1m0s
[05:37:37.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:91:0)
[05:37:37.333] Timer tick, asking Buildbucket for the build status
[05:37:37.423] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:37.423] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:92:0) after 1m0s
[05:38:37.667] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:92:0)
[05:38:37.667] Timer tick, asking Buildbucket for the build status
[05:38:37.750] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:37.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:93:0) after 1m0s
[05:39:38.002] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:93:0)
[05:39:38.002] Timer tick, asking Buildbucket for the build status
[05:39:38.130] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:38.130] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:94:0) after 1m0s
[05:40:38.236] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:94:0)
[05:40:38.236] Timer tick, asking Buildbucket for the build status
[05:40:38.755] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:38.755] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:95:0) after 1m0s
[05:41:38.777] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:95:0)
[05:41:38.777] Timer tick, asking Buildbucket for the build status
[05:41:38.855] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:38.855] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:96:0) after 1m0s
[05:42:38.984] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:96:0)
[05:42:38.984] Timer tick, asking Buildbucket for the build status
[05:42:39.440] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:39.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:97:0) after 1m0s
[05:43:39.458] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:97:0)
[05:43:39.458] Timer tick, asking Buildbucket for the build status
[05:43:39.576] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:39.576] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:98:0) after 1m0s
[05:44:39.594] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:98:0)
[05:44:39.594] Timer tick, asking Buildbucket for the build status
[05:44:39.802] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:39.802] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:99:0) after 1m0s
[05:45:39.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:99:0)
[05:45:39.888] Timer tick, asking Buildbucket for the build status
[05:45:39.986] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:39.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:100:0) after 1m0s
[05:46:40.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:100:0)
[05:46:40.011] Timer tick, asking Buildbucket for the build status
[05:46:40.111] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:40.111] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:101:0) after 1m0s
[05:47:40.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:101:0)
[05:47:40.147] Timer tick, asking Buildbucket for the build status
[05:47:40.908] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:40.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:102:0) after 1m0s
[05:48:41.120] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:102:0)
[05:48:41.120] Timer tick, asking Buildbucket for the build status
[05:48:41.221] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:41.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:103:0) after 1m0s
[05:49:41.266] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:103:0)
[05:49:41.266] Timer tick, asking Buildbucket for the build status
[05:49:41.361] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:41.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:104:0) after 1m0s
[05:50:41.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:104:0)
[05:50:41.454] Timer tick, asking Buildbucket for the build status
[05:50:41.529] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:41.529] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:105:0) after 1m0s
[05:51:41.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:105:0)
[05:51:41.551] Timer tick, asking Buildbucket for the build status
[05:51:41.887] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:41.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:106:0) after 1m0s
[05:52:41.908] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:106:0)
[05:52:41.908] Timer tick, asking Buildbucket for the build status
[05:52:41.991] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:41.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:107:0) after 1m0s
[05:53:42.023] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:107:0)
[05:53:42.023] Timer tick, asking Buildbucket for the build status
[05:53:42.525] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:42.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:108:0) after 1m0s
[05:54:42.564] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:108:0)
[05:54:42.564] Timer tick, asking Buildbucket for the build status
[05:54:43.132] Build 8854083180653599104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:43.132] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019513242630404160:109:0) after 1m0s
[05:55:18.607] Received PubSub notification, asking Buildbucket for the build status
[05:55:18.758] Build 8854083180653599104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:55:18.758] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614491716350677",
"created_by": "project:chromium",
"created_ts": "1614485297494307",
"id": "8854083180653599104",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"94e031b6cd2d63861ed7f2c9ec4710fcab204f5f\"}}",
"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\": \"94e031b6cd2d63861ed7f2c9ec4710fcab204f5f\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-3-xpf4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17561, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"c508e707f9a18cd20d04a02a4274364835113e95\", \"got_dawn_revision\": \"329c1c98fef964ea532a0579ae6f2553ff3382c5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"94e031b6cd2d63861ed7f2c9ec4710fcab204f5f\", \"got_revision_cp\": \"refs/heads/master@{#858410}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"45e415150419491d6d12428ba6ee98876a405ba4\", \"got_v8_revision_cp\": \"refs/heads/9.1.1@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"94e031b6cd2d63861ed7f2c9ec4710fcab204f5f\", \"swarm_hashes_refs/heads/master(at){#858410}_without_patch\": {\"absl_hardening_tests\": \"f5e1ce4ad7e40415ddea9e8ef815f5b57a0d2c18\", \"accessibility_unittests\": \"7dba6b9ae55d7ef1e802be0be1b1994ec39358b0\", \"angle_unittests\": \"3f5f6201046f46da609f19d5642dbc427e491c6a\", \"app_shell_unittests\": \"00b82dc68428131d91813563369fe3ab81cdaaca\", \"aura_unittests\": \"49a29af277a0ea50abf12e7292ba6dd064bb7b8e\", \"base_unittests\": \"01853cb85811b8c8365282ed0afb8268d2f22314\", \"base_util_unittests\": \"390d6530e4fa409c433121b77371dd212ad1af41\", \"blink_common_unittests\": \"5a91401970613a95a917276dbb9ef2c06774f659\", \"blink_fuzzer_unittests\": \"3e57a5ccd324a071c450e53417f88b3625ff0cc5\", \"blink_heap_unittests\": \"fd8505a789f0922480e3a722b001451d600ec8db\", \"blink_platform_unittests\": \"b4459097d02889d8cdef5e5066b5f675025a51f6\", \"blink_unittests\": \"dc786724e928f3fe257497760b422db9fa25a812\", \"boringssl_crypto_tests\": \"528ebea48188e1814a6ee22def74c8231dc74003\", \"boringssl_ssl_tests\": \"d596a7b849e989259aeec311e9cc7773ee3c68b4\", \"browser_switcher_bho_unittests\": \"3dbf17372a522a319ccc3069a550a9967bdaf8cb\", \"browser_tests\": \"84671543c12c28944746392dc0f41d665d5f6485\", \"capture_unittests\": \"6dfc7fa7e333f9cadfbee6cfb5ad66ad7b07e184\", \"cast_unittests\": \"e95ac2d40a340d053e2bccd3dd487018f83e8964\", \"cc_unittests\": \"79d9db0eebc8dbdddb00d76a6d10e877a61604c4\", \"chrome_app_unittests\": \"3e239a9e7b645d4d7097eed14b5c17e206ed73fa\", \"chrome_cleaner_unittests\": \"7ef8dea8d274410a4fc40b576403958397524932\", \"chrome_elf_unittests\": \"2d2547791a3e47e2acc490778f9115d4fe423682\", \"chromedriver_unittests\": \"d0e15075219910447e93e2a1ebcf6558f677c5a2\", \"color_unittests\": \"9f2857a8c9aabca5753df9e774773f0c0e9a0628\", \"components_browsertests\": \"dd6a6b65a2e3c801612e353f628d9a00aba685c8\", \"components_unittests\": \"687c581a66ad2e8e8bade19e1791530b7533a128\", \"compositor_unittests\": \"2dcec2d05fa8f6b2b66ddaef22f24360f9127fcf\", \"content_browsertests\": \"a1dae00571cb0a2f67e0f6b94b2b44a6182afc71\", \"content_unittests\": \"d6812f5427842a25db29e31f694e4059011725f6\", \"courgette_unittests\": \"59c59bab3c51ca8e94da45218a5dde1d2ef5ab67\", \"crashpad_tests\": \"1b9426b7d4fc6473e0a161573de9a49794f93a07\", \"cronet_tests\": \"9f15a2df98a7a1f60fa5d4ab2c729b8300292474\", \"cronet_unittests\": \"7ef5ff1a22d69c992d1a836b55e33b67c07289f2\", \"crypto_unittests\": \"cddc7164b413377d2e880e5ca5487d9c924cb581\", \"delayloads_unittests\": \"63283a354f22f54fabba152ed8ee73ba10a366f2\", \"device_unittests\": \"6a839e9c0d92b12d611851cbd8dcb7a71ca3a0e7\", \"display_unittests\": \"f46abbd3e213f03e143f8aae407a5d2c16225b28\", \"elevation_service_unittests\": \"e539a4998e98725e820c4838e73f5587971b17db\", \"events_unittests\": \"43fd64566157b9da9e97243137c99d816b364bf8\", \"extensions_browsertests\": \"10a9c4fc13bd7eaad79360d569dc72ba0e7f412a\", \"extensions_unittests\": \"41be7d39733dd49fb4fbb76d398aadc7435840fc\", \"filesystem_service_unittests\": \"f81ed029515b192d62855f5128d6f4dafde23ae3\", \"gcm_unit_tests\": \"542b4d1fc03a6de748fb27d4bd0e3a1f0768d08d\", \"gcp_unittests\": \"079659507e27d701c1ba80403be977a4b547a133\", \"gfx_unittests\": \"68aa73cb050a6bb46599715f00b6e266a5e31f8d\", \"gin_unittests\": \"15e9e19310b2e9e4d3570b5c40b1de28de387dbf\", \"google_apis_unittests\": \"b15856665b3cb344ccab0c1e84d450113de66eb1\", \"gpu_unittests\": \"0a40d9fd06208dda72c7cfc1c9089bd3678bd117\", \"gwp_asan_unittests\": \"6deb2b30fcdd3958858f8ec97653377a5dca3a2f\", \"headless_browsertests\": \"74b6a8d1a6261b0d6441aadd1ce1beaa58cb55fa\", \"headless_unittests\": \"3739232b6b9662e4c894032613b5b9f83cec1117\", \"install_static_unittests\": \"cf4b93be4d79f37bbec3ce30e482c81040b9ff3e\", \"installer_util_unittests\": \"343d63873778a2d05ef93511c84173acee7e5c56\", \"interactive_ui_tests\": \"40ca27f8a782ea02f6ed3f46b01b6e1ec7eb42cb\", \"ipc_tests\": \"40a7327f0a89fbfb006d502d26b24ffe6d19692a\", \"jingle_unittests\": \"6e595e15530b5424ffd99c80a483be0b1120c065\", \"latency_unittests\": \"581f7f213eec9aa3fa3efcb1bbb02f0da3cd7bb1\", \"libjingle_xmpp_unittests\": \"fae9c8c71df405a6f926c4fcd79bc03fed54a728\", \"liburlpattern_unittests\": \"978bab83b37b4e12fcc9513bcc904ee465d152ac\", \"media_blink_unittests\": \"375575b10102087ec6d4f2da36bddd84fc3fdd1e\", \"media_unittests\": \"fbacb672d547ead1cc05f240c89692a060c43b1d\", \"message_center_unittests\": \"f06196acbf178b6f5214df1c9f9388e05a4c4bc2\", \"midi_unittests\": \"948beec888f31195e333b5429fe05c5a317460fe\", \"mojo_core_unittests\": \"ca9350603b6c3e09a40423b98aecac4bed421aa6\", \"mojo_unittests\": \"129d7c5cc28f18473a982f98d2ac56e8200aafc7\", \"nacl_loader_unittests\": \"2932ef8a8253492099b1e0a4d225cfa7c3b68b4c\", \"native_theme_unittests\": \"c0710c312ade76fc0d12c146e769cefe67a1b725\", \"net_unittests\": \"b447b1b0d498b5461bbbc80bbb41531f516b1009\", \"notification_helper_unittests\": \"66d300d05a0eef3100a9f8f1b517ebeb11e60e08\", \"pdf_unittests\": \"067fb65d31b2178046fea6aa973e4ac1e4d92f33\", \"perfetto_unittests\": \"05d2c7111aa4ba8c37b26a3013e1090d026aeecf\", \"ppapi_unittests\": \"5982504f81cb6e455c7924dcdd2c1816ad83a40f\", \"printing_unittests\": \"2a8b391372716df7c6c77c284418cb953fa508fd\", \"remoting_unittests\": \"77dd17a391ce954164ad65152263130691044b6a\", \"sbox_integration_tests\": \"d6a13f3919e3bfcb0c4410a459492d3dad92ca01\", \"sbox_unittests\": \"4f542d709d703943db53b68924d3f0bc0ac786c0\", \"sbox_validation_tests\": \"8d4b53e9f495aa47eae28d07f5ff7c3586da1251\", \"service_manager_unittests\": \"ab3a0e27094975367a798b43d34d3c9c3c47bf15\", \"services_unittests\": \"ec4610c5903596f66e54c28f5d5a9edfec3b5fb8\", \"setup_unittests\": \"eb2d2ca406e56550c15b3bfb334c7e81c6b87b17\", \"shell_dialogs_unittests\": \"87b580359c817e606536baf6535928506652ab52\", \"skia_unittests\": \"3075204c19c7cfb90ed9aaca2771568bb37db2b2\", \"snapshot_unittests\": \"de52e086754ce00413259c5e69a013e614c207d8\", \"sql_unittests\": \"42bfde58e860dffbc3c5d69c33dddbdf4ad6b498\", \"storage_unittests\": \"4ba87dd80f553822e36ab53812612a2767a5f857\", \"sync_integration_tests\": \"85b07c36ab54f5ffd9705adda4a83d283213f806\", \"traffic_annotation_auditor_unittests\": \"db28e429fb6781c752c695f797614042bcddc7b7\", \"ui_base_unittests\": \"4f3b99714a9e0cf72adfc0e14774237103cc6366\", \"ui_touch_selection_unittests\": \"175f9049293c432201d9a518a5651b247945c6cd\", \"unit_tests\": \"c05c84d9decae4e686559ff1ca1d19a4d4581e87\", \"updater_tests\": \"52a504a6ef81fdb1e74af22ba3cef5994d66b838\", \"url_unittests\": \"f6476b583e5fea9211322a5ee9ea31c836017311\", \"views_unittests\": \"73c52b2525c286406745e054c741aa762a43183a\", \"viz_unittests\": \"068f8cfd6c3a8f9b92483b23c9d19690820bdbe7\", \"vr_common_unittests\": \"fbb4971965f1241a9ca03daed025a9a55ffee86a\", \"vr_pixeltests\": \"cdd0d0825807601db26183112d868765665d81f3\", \"weblayer_browsertests\": \"befac9f6f38c20c0dd61b1157d35a267b4b6c1ab\", \"weblayer_unittests\": \"ab2d113473da4b97bbba7655a6b71c8575738fb4\", \"wm_unittests\": \"da7cd857d7cacdc5fffe82e77333c97fbea2c52b\", \"wtf_unittests\": \"b18aab10feab7b6f50164b1d4c75502ca223fafb\", \"zlib_unittests\": \"2d4ff3fa2ab1390d2327e6f5a9a147984bfad37e\", \"zucchini_unittests\": \"312d32fda38a462031f96f88a44c6a8f9e23ae22\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-xpf4\"], \"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\": [\"5712-339372b\"], \"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": "1614485353787986",
"status": "COMPLETED",
"status_changed_ts": "1614491716908546",
"tags": [
"build_address:luci.chromium.ci/win-asan/17561",
"builder:win-asan",
"buildset:commit/git/94e031b6cd2d63861ed7f2c9ec4710fcab204f5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/94e031b6cd2d63861ed7f2c9ec4710fcab204f5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019513242630404160",
"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/8854083180653599104/+/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:51ffa42659ffbc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614491716922269",
"url": "https://ci.chromium.org/b/8854083180653599104",
"utcnow_ts": "1614491718748439"
}
}
[05:55:18.759] Invocation finished in 1h47m2.533532402s with status SUCCEEDED