[14:13:18.737] New invocation is queued and will start shortly
[14:13:20.112] Starting the invocation (attempt 1)
[14:13:20.146] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:13:20.146] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:13:20.146] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020652937281231536",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"cc8bd90a15451ac06f27142fa7e966b057ac4691\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9020652937281231536",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/cc8bd90a15451ac06f27142fa7e966b057ac4691",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc8bd90a15451ac06f27142fa7e966b057ac4691",
"gitiles_ref:refs/heads/master"
]
}
[14:13:21.106] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613398400227587",
"id": "8855222875041414864",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cc8bd90a15451ac06f27142fa7e966b057ac4691\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613398400808862",
"tags": [
"build_address:luci.chromium.ci/win-asan/17359",
"builder:win-asan",
"buildset:commit/git/cc8bd90a15451ac06f27142fa7e966b057ac4691",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc8bd90a15451ac06f27142fa7e966b057ac4691",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020652937281231536",
"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/8855222875041414864/+/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": "1613398400809038",
"url": "https://ci.chromium.org/b/8855222875041414864",
"utcnow_ts": "1613398401057008"
}
}
[14:13:21.106] Task URL: https://ci.chromium.org/b/8855222875041414864
[14:13:21.106] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:2:0) after 1m0s
[14:14:21.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:2:0)
[14:14:21.159] Timer tick, asking Buildbucket for the build status
[14:14:21.260] Build 8855222875041414864: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:14:21.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:3:0) after 1m0s
[14:15:21.308] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:3:0)
[14:15:21.308] Timer tick, asking Buildbucket for the build status
[14:15:21.405] Build 8855222875041414864: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:15:21.405] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:4:0) after 1m0s
[14:16:21.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:4:0)
[14:16:21.498] Timer tick, asking Buildbucket for the build status
[14:16:21.585] Build 8855222875041414864: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:16:21.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:5:0) after 1m0s
[14:17:21.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:5:0)
[14:17:21.650] Timer tick, asking Buildbucket for the build status
[14:17:21.790] Build 8855222875041414864: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:17:21.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:6:0) after 1m0s
[14:17:22.169] Received PubSub notification, asking Buildbucket for the build status
[14:17:22.286] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:21.844] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:6:0)
[14:18:21.844] Timer tick, asking Buildbucket for the build status
[14:18:22.067] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:22.067] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:8:0) after 1m0s
[14:19:22.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:8:0)
[14:19:22.147] Timer tick, asking Buildbucket for the build status
[14:19:22.425] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:22.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:9:0) after 1m0s
[14:20:22.484] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:9:0)
[14:20:22.484] Timer tick, asking Buildbucket for the build status
[14:20:22.567] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:22.567] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:10:0) after 1m0s
[14:21:22.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:10:0)
[14:21:22.605] Timer tick, asking Buildbucket for the build status
[14:21:22.729] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:22.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:11:0) after 1m0s
[14:22:22.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:11:0)
[14:22:22.784] Timer tick, asking Buildbucket for the build status
[14:22:22.899] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:22.899] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:12:0) after 1m0s
[14:23:23.001] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:12:0)
[14:23:23.001] Timer tick, asking Buildbucket for the build status
[14:23:23.133] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:23.133] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:13:0) after 1m0s
[14:24:23.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:13:0)
[14:24:23.170] Timer tick, asking Buildbucket for the build status
[14:24:23.287] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:23.287] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:14:0) after 1m0s
[14:25:23.371] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:14:0)
[14:25:23.371] Timer tick, asking Buildbucket for the build status
[14:25:23.696] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:23.696] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:15:0) after 1m0s
[14:26:23.752] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:15:0)
[14:26:23.752] Timer tick, asking Buildbucket for the build status
[14:26:23.834] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:23.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:16:0) after 1m0s
[14:27:23.872] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:16:0)
[14:27:23.873] Timer tick, asking Buildbucket for the build status
[14:27:24.060] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:24.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:17:0) after 1m0s
[14:28:24.098] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:17:0)
[14:28:24.098] Timer tick, asking Buildbucket for the build status
[14:28:24.215] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:24.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:18:0) after 1m0s
[14:29:24.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:18:0)
[14:29:24.298] Timer tick, asking Buildbucket for the build status
[14:29:24.475] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:24.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:19:0) after 1m0s
[14:30:24.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:19:0)
[14:30:24.543] Timer tick, asking Buildbucket for the build status
[14:30:25.465] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:25.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:20:0) after 1m0s
[14:31:25.568] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:20:0)
[14:31:25.568] Timer tick, asking Buildbucket for the build status
[14:31:25.762] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:25.762] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:21:0) after 1m0s
[14:32:25.774] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:21:0)
[14:32:25.774] Timer tick, asking Buildbucket for the build status
[14:32:26.030] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:26.030] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:22:0) after 1m0s
[14:33:26.109] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:22:0)
[14:33:26.109] Timer tick, asking Buildbucket for the build status
[14:33:26.318] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:26.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:23:0) after 1m0s
[14:34:26.327] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:23:0)
[14:34:26.327] Timer tick, asking Buildbucket for the build status
[14:34:26.442] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:26.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:24:0) after 1m0s
[14:35:26.531] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:24:0)
[14:35:26.531] Timer tick, asking Buildbucket for the build status
[14:35:26.759] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:26.759] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:25:0) after 1m0s
[14:36:26.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:25:0)
[14:36:26.784] Timer tick, asking Buildbucket for the build status
[14:36:27.138] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:27.138] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:26:0) after 1m0s
[14:37:27.264] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:26:0)
[14:37:27.264] Timer tick, asking Buildbucket for the build status
[14:37:27.619] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:27.619] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:27:0) after 1m0s
[14:38:27.775] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:27:0)
[14:38:27.775] Timer tick, asking Buildbucket for the build status
[14:38:27.852] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:27.852] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:28:0) after 1m0s
[14:39:27.884] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:28:0)
[14:39:27.884] Timer tick, asking Buildbucket for the build status
[14:39:27.976] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:27.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:29:0) after 1m0s
[14:40:28.012] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:29:0)
[14:40:28.012] Timer tick, asking Buildbucket for the build status
[14:40:28.108] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:28.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:30:0) after 1m0s
[14:41:28.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:30:0)
[14:41:28.135] Timer tick, asking Buildbucket for the build status
[14:41:28.536] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:28.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:31:0) after 1m0s
[14:42:28.561] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:31:0)
[14:42:28.561] Timer tick, asking Buildbucket for the build status
[14:42:28.698] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:28.698] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:32:0) after 1m0s
[14:43:28.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:32:0)
[14:43:28.731] Timer tick, asking Buildbucket for the build status
[14:43:28.810] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:28.810] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:33:0) after 1m0s
[14:44:28.822] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:33:0)
[14:44:28.822] Timer tick, asking Buildbucket for the build status
[14:44:28.957] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:28.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:34:0) after 1m0s
[14:45:29.055] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:34:0)
[14:45:29.055] Timer tick, asking Buildbucket for the build status
[14:45:29.515] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:29.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:35:0) after 1m0s
[14:46:29.521] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:35:0)
[14:46:29.521] Timer tick, asking Buildbucket for the build status
[14:46:29.639] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:29.639] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:36:0) after 1m0s
[14:47:29.614] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:36:0)
[14:47:29.614] Timer tick, asking Buildbucket for the build status
[14:47:29.703] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:29.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:37:0) after 1m0s
[14:48:29.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:37:0)
[14:48:29.728] Timer tick, asking Buildbucket for the build status
[14:48:30.028] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:30.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:38:0) after 1m0s
[14:49:31.029] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:38:0)
[14:49:31.029] Timer tick, asking Buildbucket for the build status
[14:49:31.227] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:31.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:39:0) after 1m0s
[14:50:31.364] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:39:0)
[14:50:31.364] Timer tick, asking Buildbucket for the build status
[14:50:31.444] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:31.444] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:40:0) after 1m0s
[14:51:31.455] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:40:0)
[14:51:31.455] Timer tick, asking Buildbucket for the build status
[14:51:31.551] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:31.551] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:41:0) after 1m0s
[14:52:31.599] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:41:0)
[14:52:31.599] Timer tick, asking Buildbucket for the build status
[14:52:32.000] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:32.000] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:42:0) after 1m0s
[14:53:31.985] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:42:0)
[14:53:31.985] Timer tick, asking Buildbucket for the build status
[14:53:32.077] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:32.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:43:0) after 1m0s
[14:54:32.101] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:43:0)
[14:54:32.101] Timer tick, asking Buildbucket for the build status
[14:54:32.226] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:32.226] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:44:0) after 1m0s
[14:55:32.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:44:0)
[14:55:32.273] Timer tick, asking Buildbucket for the build status
[14:55:32.536] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:32.536] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:45:0) after 1m0s
[14:56:32.579] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:45:0)
[14:56:32.579] Timer tick, asking Buildbucket for the build status
[14:56:32.662] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:32.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:46:0) after 1m0s
[14:57:32.681] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:46:0)
[14:57:32.681] Timer tick, asking Buildbucket for the build status
[14:57:32.776] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:32.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:47:0) after 1m0s
[14:58:32.839] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:47:0)
[14:58:32.839] Timer tick, asking Buildbucket for the build status
[14:58:33.010] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:33.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:48:0) after 1m0s
[14:59:33.044] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:48:0)
[14:59:33.044] Timer tick, asking Buildbucket for the build status
[14:59:33.161] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:33.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:49:0) after 1m0s
[15:00:33.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:49:0)
[15:00:33.194] Timer tick, asking Buildbucket for the build status
[15:00:33.868] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:33.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:50:0) after 1m0s
[15:01:33.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:50:0)
[15:01:33.966] Timer tick, asking Buildbucket for the build status
[15:01:34.168] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:34.168] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:51:0) after 1m0s
[15:02:34.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:51:0)
[15:02:34.144] Timer tick, asking Buildbucket for the build status
[15:02:34.249] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:34.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:52:0) after 1m0s
[15:03:34.297] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:52:0)
[15:03:34.297] Timer tick, asking Buildbucket for the build status
[15:03:34.384] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:34.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:53:0) after 1m0s
[15:04:34.453] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:53:0)
[15:04:34.453] Timer tick, asking Buildbucket for the build status
[15:04:34.586] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:34.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:54:0) after 1m0s
[15:05:34.639] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:54:0)
[15:05:34.639] Timer tick, asking Buildbucket for the build status
[15:05:34.725] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:34.725] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:55:0) after 1m0s
[15:06:34.753] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:55:0)
[15:06:34.753] Timer tick, asking Buildbucket for the build status
[15:06:34.934] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:34.934] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:56:0) after 1m0s
[15:07:34.955] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:56:0)
[15:07:34.955] Timer tick, asking Buildbucket for the build status
[15:07:35.039] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:35.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:57:0) after 1m0s
[15:08:35.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:57:0)
[15:08:35.094] Timer tick, asking Buildbucket for the build status
[15:08:35.218] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:35.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:58:0) after 1m0s
[15:09:35.248] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:58:0)
[15:09:35.248] Timer tick, asking Buildbucket for the build status
[15:09:35.620] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:35.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:59:0) after 1m0s
[15:10:35.676] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:59:0)
[15:10:35.676] Timer tick, asking Buildbucket for the build status
[15:10:35.800] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:35.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:60:0) after 1m0s
[15:11:35.892] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:60:0)
[15:11:35.892] Timer tick, asking Buildbucket for the build status
[15:11:35.972] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:35.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:61:0) after 1m0s
[15:12:36.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:61:0)
[15:12:36.008] Timer tick, asking Buildbucket for the build status
[15:12:36.107] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:36.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:62:0) after 1m0s
[15:13:36.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:62:0)
[15:13:36.144] Timer tick, asking Buildbucket for the build status
[15:13:36.241] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:36.241] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:63:0) after 1m0s
[15:14:36.285] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:63:0)
[15:14:36.285] Timer tick, asking Buildbucket for the build status
[15:14:36.579] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:36.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:64:0) after 1m0s
[15:15:36.666] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:64:0)
[15:15:36.666] Timer tick, asking Buildbucket for the build status
[15:15:36.790] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:36.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:65:0) after 1m0s
[15:16:36.792] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:65:0)
[15:16:36.792] Timer tick, asking Buildbucket for the build status
[15:16:36.894] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:36.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:66:0) after 1m0s
[15:17:36.961] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:66:0)
[15:17:36.961] Timer tick, asking Buildbucket for the build status
[15:17:37.073] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:37.073] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:67:0) after 1m0s
[15:18:37.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:67:0)
[15:18:37.146] Timer tick, asking Buildbucket for the build status
[15:18:37.230] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:37.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:68:0) after 1m0s
[15:19:37.254] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:68:0)
[15:19:37.254] Timer tick, asking Buildbucket for the build status
[15:19:37.498] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:37.498] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:69:0) after 1m0s
[15:20:37.539] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:69:0)
[15:20:37.539] Timer tick, asking Buildbucket for the build status
[15:20:37.657] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:37.657] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:70:0) after 1m0s
[15:21:37.678] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:70:0)
[15:21:37.678] Timer tick, asking Buildbucket for the build status
[15:21:37.977] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:37.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:71:0) after 1m0s
[15:22:38.008] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:71:0)
[15:22:38.008] Timer tick, asking Buildbucket for the build status
[15:22:38.142] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:38.142] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:72:0) after 1m0s
[15:23:38.168] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:72:0)
[15:23:38.168] Timer tick, asking Buildbucket for the build status
[15:23:38.243] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:38.243] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:73:0) after 1m0s
[15:24:38.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:73:0)
[15:24:38.304] Timer tick, asking Buildbucket for the build status
[15:24:38.400] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:38.400] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:74:0) after 1m0s
[15:25:38.457] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:74:0)
[15:25:38.457] Timer tick, asking Buildbucket for the build status
[15:25:38.542] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:38.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:75:0) after 1m0s
[15:26:38.556] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:75:0)
[15:26:38.556] Timer tick, asking Buildbucket for the build status
[15:26:38.663] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:38.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:76:0) after 1m0s
[15:27:38.717] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:76:0)
[15:27:38.717] Timer tick, asking Buildbucket for the build status
[15:27:38.823] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:38.823] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:77:0) after 1m0s
[15:28:38.848] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:77:0)
[15:28:38.848] Timer tick, asking Buildbucket for the build status
[15:28:39.013] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:39.013] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:78:0) after 1m0s
[15:29:39.067] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:78:0)
[15:29:39.067] Timer tick, asking Buildbucket for the build status
[15:29:39.154] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:39.154] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:79:0) after 1m0s
[15:30:39.169] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:79:0)
[15:30:39.169] Timer tick, asking Buildbucket for the build status
[15:30:39.332] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:39.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:80:0) after 1m0s
[15:31:39.475] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:80:0)
[15:31:39.475] Timer tick, asking Buildbucket for the build status
[15:31:39.586] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:39.586] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:81:0) after 1m0s
[15:32:39.698] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:81:0)
[15:32:39.698] Timer tick, asking Buildbucket for the build status
[15:32:39.795] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:39.795] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:82:0) after 1m0s
[15:33:39.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:82:0)
[15:33:39.929] Timer tick, asking Buildbucket for the build status
[15:33:40.125] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:40.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:83:0) after 1m0s
[15:34:40.204] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:83:0)
[15:34:40.204] Timer tick, asking Buildbucket for the build status
[15:34:40.372] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:40.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:84:0) after 1m0s
[15:35:40.449] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:84:0)
[15:35:40.449] Timer tick, asking Buildbucket for the build status
[15:35:40.620] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:40.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:85:0) after 1m0s
[15:36:40.715] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:85:0)
[15:36:40.715] Timer tick, asking Buildbucket for the build status
[15:36:40.868] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:40.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:86:0) after 1m0s
[15:37:41.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:86:0)
[15:37:41.014] Timer tick, asking Buildbucket for the build status
[15:37:41.155] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:41.155] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:87:0) after 1m0s
[15:38:41.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:87:0)
[15:38:41.229] Timer tick, asking Buildbucket for the build status
[15:38:41.315] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:41.315] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:88:0) after 1m0s
[15:39:41.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:88:0)
[15:39:41.435] Timer tick, asking Buildbucket for the build status
[15:39:41.513] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:41.513] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:89:0) after 1m0s
[15:40:41.644] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:89:0)
[15:40:41.644] Timer tick, asking Buildbucket for the build status
[15:40:41.742] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:41.742] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:90:0) after 1m0s
[15:41:41.857] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:90:0)
[15:41:41.857] Timer tick, asking Buildbucket for the build status
[15:41:42.194] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:42.194] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:91:0) after 1m0s
[15:42:42.336] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:91:0)
[15:42:42.336] Timer tick, asking Buildbucket for the build status
[15:42:42.506] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:42.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:92:0) after 1m0s
[15:43:42.565] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:92:0)
[15:43:42.565] Timer tick, asking Buildbucket for the build status
[15:43:42.665] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:42.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:93:0) after 1m0s
[15:44:42.795] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:93:0)
[15:44:42.795] Timer tick, asking Buildbucket for the build status
[15:44:43.080] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:43.080] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:94:0) after 1m0s
[15:45:43.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:94:0)
[15:45:43.217] Timer tick, asking Buildbucket for the build status
[15:45:43.421] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:43.421] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:95:0) after 1m0s
[15:46:43.547] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:95:0)
[15:46:43.547] Timer tick, asking Buildbucket for the build status
[15:46:43.787] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:43.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:96:0) after 1m0s
[15:47:43.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:96:0)
[15:47:43.820] Timer tick, asking Buildbucket for the build status
[15:47:44.074] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:44.074] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:97:0) after 1m0s
[15:48:44.096] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:97:0)
[15:48:44.096] Timer tick, asking Buildbucket for the build status
[15:48:44.233] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:44.233] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:98:0) after 1m0s
[15:49:44.303] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:98:0)
[15:49:44.303] Timer tick, asking Buildbucket for the build status
[15:49:44.456] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:44.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:99:0) after 1m0s
[15:50:44.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:99:0)
[15:50:44.469] Timer tick, asking Buildbucket for the build status
[15:50:44.557] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:44.557] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:100:0) after 1m0s
[15:51:44.621] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:100:0)
[15:51:44.621] Timer tick, asking Buildbucket for the build status
[15:51:45.006] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:45.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:101:0) after 1m0s
[15:52:45.099] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:101:0)
[15:52:45.099] Timer tick, asking Buildbucket for the build status
[15:52:45.193] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:45.193] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:102:0) after 1m0s
[15:53:45.221] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:102:0)
[15:53:45.221] Timer tick, asking Buildbucket for the build status
[15:53:45.309] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:45.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:103:0) after 1m0s
[15:54:45.342] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:103:0)
[15:54:45.342] Timer tick, asking Buildbucket for the build status
[15:54:45.654] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:45.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:104:0) after 1m0s
[15:55:45.713] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:104:0)
[15:55:45.713] Timer tick, asking Buildbucket for the build status
[15:55:45.807] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:45.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:105:0) after 1m0s
[15:56:45.780] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:105:0)
[15:56:45.780] Timer tick, asking Buildbucket for the build status
[15:56:45.872] Build 8855222875041414864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:45.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9020652937281231536:106:0) after 1m0s
[15:57:27.732] Received PubSub notification, asking Buildbucket for the build status
[15:57:28.011] Build 8855222875041414864: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[15:57:28.011] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613404646529624",
"created_by": "project:chromium",
"created_ts": "1613398400227587",
"failure_reason": "BUILD_FAILURE",
"id": "8855222875041414864",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"cc8bd90a15451ac06f27142fa7e966b057ac4691\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**components_unittests** failed because of:\\n\\n- AccessTokenFetcherTest.FetcherWithUnconsentedClientAccessToConsentAPI\\n\\n- AccessTokenFetcherTest.FetcherWithUnconsentedClientAccessToPrivelegedAPI\\n\\n- AccessTokenFetcherTest.FetcherWithConsentedClientAccessToPrivilegedAPI\"}, \"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\": \"cc8bd90a15451ac06f27142fa7e966b057ac4691\", \"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-0-6l07\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17359, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-1\", \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"cc8bd90a15451ac06f27142fa7e966b057ac4691\", \"got_revision_cp\": \"refs/heads/master@{#854033}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"ebacb645b20531cd78dc088730fb72269822eeb6\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#2}\", \"got_webrtc_revision\": \"a24f3d035f7d9acee551d5547f4fb16838cf98d6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33258}\", \"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\": \"cc8bd90a15451ac06f27142fa7e966b057ac4691\", \"swarm_hashes_refs/heads/master(at){#854033}_without_patch\": {\"absl_hardening_tests\": \"afdaf8fb9e7e3bbe086ac4f3edb0886c18d6bb6c\", \"accessibility_unittests\": \"83848df2aaebdcddea023b9f5917d1487c19dc72\", \"angle_unittests\": \"c1047ff7deefb7e201e8b976c1760ba3367b390f\", \"app_shell_unittests\": \"4d5f010ee5c2521d572c95338bca3d4eea04b9bc\", \"aura_unittests\": \"0234c263ae6ef0afe7d39bcb2cbfe0c75200c477\", \"base_unittests\": \"2af05f2e8ed5c90470a39fba09c470596fdfb3cd\", \"base_util_unittests\": \"14de1c0b724bb8bccd71a0ec0b98e583477da4d9\", \"blink_common_unittests\": \"576be94b853028ecb1fc42b6e9fceaea57e15360\", \"blink_fuzzer_unittests\": \"bed7046cfdb31ea787fd28a2fd8173aee5a6e425\", \"blink_heap_unittests\": \"bb3164cfda01b21ac05e9f8d0aa7370b816b55b4\", \"blink_platform_unittests\": \"c737d6a96d1db85d3de326b4020de4db3941d942\", \"blink_unittests\": \"53139c20e7b67e23b80084008117bc52b19c7295\", \"boringssl_crypto_tests\": \"7aeb4bb05dc84266e5c60e77ed80589758a5c0e4\", \"boringssl_ssl_tests\": \"15cf89cefde1d8cf8190eff5f6c558c3c2af8802\", \"browser_switcher_bho_unittests\": \"ea72cb516837fb745fdfc936b6ac589a282d50be\", \"browser_tests\": \"adb40964a5f35852062ff45657d1e483b987f37b\", \"capture_unittests\": \"bcdba88138d51a199d3d81ee4e8a109fc8405108\", \"cast_unittests\": \"7767b5afc1318aa4a3492e5828c3dfca9963db79\", \"cc_unittests\": \"d6882e9fc9a00c0e4f2359b4d622c4d9eb185315\", \"chrome_app_unittests\": \"a4e3ae255db0f10aedf23bd2751b4dc2fe1a622f\", \"chrome_cleaner_unittests\": \"e8424c58a730dd39bd355d6e65146fe0314ac10d\", \"chrome_elf_unittests\": \"d30948ad9ef41625a24356bf7a247724acc57e4a\", \"chromedriver_unittests\": \"9d84d6c3bd2417e7fbcc400e40b091bfaaa41017\", \"components_browsertests\": \"353940195afdc1a08abc8ed16d049599528c3f7d\", \"components_unittests\": \"0d2033c0e73689a24ba9c59633a5c13d5e58eea2\", \"compositor_unittests\": \"8ab2b84aecceca28aa047a327ee7316a55fccf58\", \"content_browsertests\": \"5630831088f91e2c778010d2faedccbbeabdc24c\", \"content_unittests\": \"76b0b40676a8d6de0537cfda1788594521963f0e\", \"courgette_unittests\": \"15ab31fbf368ccc8a38180cdc3bf3c4954ffd39c\", \"crashpad_tests\": \"30c378b0f9d3b0de0e07f2f843e79d2b9ccb256e\", \"cronet_tests\": \"fff78f0d1039d08581b0b3e36fee985c92e0160a\", \"cronet_unittests\": \"898fbcc40dc1648d176cba156acde44efd4a963f\", \"crypto_unittests\": \"62b6c6040f2fd3c38f74f3591184cf492f6f36d6\", \"delayloads_unittests\": \"1c0763a478d1c6a223ddc88a7f12ada2e8e4b62f\", \"device_unittests\": \"d53c4358ea86de6eafc460d0564b799b116c2404\", \"display_unittests\": \"407c0d3d78404669132dd1eddbe8d617e57f6c1f\", \"elevation_service_unittests\": \"25b220464202ebef984586fb5db3104efc5719c3\", \"events_unittests\": \"e2ad9f4930c8e2aea25a22440553e79037d3bdd3\", \"extensions_browsertests\": \"ce9c55d2e84bad4e15aca6cecaf9a326998fcd59\", \"extensions_unittests\": \"ddb87bf01042bb2a4a8593b354065c1b59a4d850\", \"filesystem_service_unittests\": \"1710061b7747fc61dba1e0f9f89d3141cdeb445f\", \"gcm_unit_tests\": \"7f67abf60702bbae3648cca7a96bbebadf7e12d6\", \"gcp_unittests\": \"3123ea1541b10cc08178ff90fce4549f384363e2\", \"gfx_unittests\": \"a2e9e93780854b5307cdf86e64c82887d8e9c508\", \"gin_unittests\": \"831f3f554fe8f4a534d414bacdbcb88bed21cc5f\", \"google_apis_unittests\": \"1f66783fa0fc0488cad9848ff7cd6762cd908aca\", \"gpu_unittests\": \"245697df621c65c606883737487b0e4e9ae918c0\", \"gwp_asan_unittests\": \"20294debdff08d5d56f1f82fee493ec5dfa3b27b\", \"headless_browsertests\": \"fb55337f521811815dc5bb783a2456eb459a50c7\", \"headless_unittests\": \"63e0c7a8e8ea595578540c0f583381b9715b227b\", \"install_static_unittests\": \"fdc8b0c64bb4c23a3a482b04d8bd4e60c9b576d6\", \"installer_util_unittests\": \"156f28437f6f00cb52f1dfc6ad6ca2f9b3200333\", \"interactive_ui_tests\": \"976bca53e78d008405d6e13222a2ecb16ce0674e\", \"ipc_tests\": \"8cf1d6beb363efef4eddcac23c8a9994856a2c81\", \"jingle_unittests\": \"0a8afa42ee58f7acb43e28103cecc8458591dd2d\", \"latency_unittests\": \"d5e74cc318ad686c8ced45e8d02102e0ddeb0981\", \"libjingle_xmpp_unittests\": \"69206b862e1fca6938cb899469af50fa7004ac4a\", \"liburlpattern_unittests\": \"f1ddfa2880eb9781485dbeeadcf0e941d03af116\", \"media_blink_unittests\": \"a9699fc20320653533d37acf1869c44d42bc398f\", \"media_unittests\": \"aa8f36cf9538265d2c633e5949884952131a6601\", \"message_center_unittests\": \"6caffb2b70cd1eed357d4b0a10edffb02aafd5b8\", \"midi_unittests\": \"51604c433ce50800a7c557dbd17b77651a6520b2\", \"mojo_core_unittests\": \"52f45d71dc7ad51d7a8d3ad7b9e3bf593f715fef\", \"mojo_unittests\": \"94f14ea3850e0e705548d93c4339d037b620a2fd\", \"nacl_loader_unittests\": \"97b7380b085189e76418192d6a70e7d9709ef31d\", \"native_theme_unittests\": \"1b53c0bc2334c04d8bcbd54faeadc7fb1ba75b68\", \"net_unittests\": \"fb50e6df3fb61de8258632f912f1d64b42e027df\", \"notification_helper_unittests\": \"19a6659e8f01beb256f7373dbb2c5bc1b4ab0844\", \"pdf_unittests\": \"fdb288b7ee9102a67b8cc266a4052a011dcccf07\", \"perfetto_unittests\": \"0763773394380063857cc00e412e8da64753cd7b\", \"ppapi_unittests\": \"877abee039af4eb1b48dfa042cd79878b641c323\", \"printing_unittests\": \"8fe6866e27c4073f0fc2ea7c54bca01c33a764dc\", \"remoting_unittests\": \"8c571111c4ad55a69f2ee6d2af4fd486942c50b7\", \"sbox_integration_tests\": \"993a6c4aa066cb3c357c2dfa103e8de70697c668\", \"sbox_unittests\": \"da2be722a6332d30119a9981941aef5bd205cbf1\", \"sbox_validation_tests\": \"7f70a8ceeda43afef32487de4c9d98e4758656c6\", \"service_manager_unittests\": \"157f0dd64c0307ba09ec206771020c6624171e7a\", \"services_unittests\": \"f09d1eb6e88f47c989e00c3747362132bdfa7790\", \"setup_unittests\": \"98125f9188820f10df0078387bec8bbf93bae0f1\", \"shell_dialogs_unittests\": \"51a4b52c9d726556485217892f16483c7ea00c34\", \"skia_unittests\": \"8a495af898180591095c7b2d5a57bead895b1d2f\", \"snapshot_unittests\": \"d22e33f31846f850e6ab1a8cf2f2bc648c8b219d\", \"sql_unittests\": \"76d037e560ffc5be4d1688e891a029a3a9f53563\", \"storage_unittests\": \"ef2347cf0e9cf49de27186f08c97556110df7022\", \"sync_integration_tests\": \"ad606e72a4dd52839be377b9c2000bff3cfd0d9a\", \"traffic_annotation_auditor_unittests\": \"f6f77f72f9b954cb1ccc16d933d3b7f0aa57f577\", \"ui_base_unittests\": \"b2ccb4be8ed660e8d30e46288f5f08bc445c1855\", \"ui_touch_selection_unittests\": \"e81af4825a2de56cf6356191245f70f383362fef\", \"unit_tests\": \"aa0ed71ac4559a57f92f5fe46db9368e87a35dab\", \"updater_tests\": \"2019c5362dddf3893c656abf32ad91596a7bb86d\", \"url_unittests\": \"554ff354c736dc6c49bdc6a1083b4ea37e8da39e\", \"views_unittests\": \"e15b7cc39c73ea603f677f664450785f6c52cdd5\", \"viz_unittests\": \"645cee95a7c2291523f75f7fc5264636b7f7a73b\", \"vr_common_unittests\": \"acfed30eb9eefc68253992bd91eba9a6ebc35f0a\", \"vr_pixeltests\": \"7887bbf29f6dc4fcc8fc06b909850ddcd7663988\", \"weblayer_browsertests\": \"fd45fc0c15bab5b1bece33d3d2acedb4bb77f4a7\", \"weblayer_unittests\": \"9435d8e517a1b555b71ac9f36b15d46e110b619b\", \"wm_unittests\": \"2ef640d2c49a07f5554996810aaa34249fe64917\", \"wtf_unittests\": \"a8448f762f4b1f26461fab3ab7bc55ae7b0b4c2a\", \"zlib_unittests\": \"f9960112c3c647cab72610de9abadfa3010e5532\", \"zucchini_unittests\": \"b1ac7069795b506f67b9405cf2b9c6ae731e2bfe\"}}, \"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-0-6l07\"], \"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\": [\"5696-2a606bc\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**components_unittests** failed because of:\\n\\n- AccessTokenFetcherTest.FetcherWithUnconsentedClientAccessToConsentAPI\\n\\n- AccessTokenFetcherTest.FetcherWithUnconsentedClientAccessToPrivelegedAPI\\n\\n- AccessTokenFetcherTest.FetcherWithConsentedClientAccessToPrivilegedAPI\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613398641355245",
"status": "COMPLETED",
"status_changed_ts": "1613398641927313",
"tags": [
"build_address:luci.chromium.ci/win-asan/17359",
"builder:win-asan",
"buildset:commit/git/cc8bd90a15451ac06f27142fa7e966b057ac4691",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc8bd90a15451ac06f27142fa7e966b057ac4691",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020652937281231536",
"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/8855222875041414864/+/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:51bedb68a5b6ac10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613404647333227",
"url": "https://ci.chromium.org/b/8855222875041414864",
"utcnow_ts": "1613404647949126"
}
}
[15:57:28.011] Invocation finished in 1h44m9.303055234s with status FAILED