[00:13:08.501] New invocation is queued and will start shortly
[00:13:09.801] Starting the invocation (attempt 1)
[00:13:09.848] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:13:09.848] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:13:09.848] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019346841735468464",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7466e1a93a815b8bd9244a5fd8b8a64b4f083cee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9019346841735468464",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/7466e1a93a815b8bd9244a5fd8b8a64b4f083cee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7466e1a93a815b8bd9244a5fd8b8a64b4f083cee",
"gitiles_ref:refs/heads/master"
]
}
[00:13:10.791] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614643989950012",
"id": "8853916779552688320",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7466e1a93a815b8bd9244a5fd8b8a64b4f083cee\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614643990422499",
"tags": [
"build_address:luci.chromium.ci/win-asan/17582",
"builder:win-asan",
"buildset:commit/git/7466e1a93a815b8bd9244a5fd8b8a64b4f083cee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7466e1a93a815b8bd9244a5fd8b8a64b4f083cee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019346841735468464",
"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/8853916779552688320/+/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": "1614643990422660",
"url": "https://ci.chromium.org/b/8853916779552688320",
"utcnow_ts": "1614643990782525"
}
}
[00:13:10.791] Task URL: https://ci.chromium.org/b/8853916779552688320
[00:13:10.791] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:2:0) after 1m0s
[00:14:10.821] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:2:0)
[00:14:10.821] Timer tick, asking Buildbucket for the build status
[00:14:11.124] Build 8853916779552688320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:11.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:3:0) after 1m0s
[00:15:11.159] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:3:0)
[00:15:11.159] Timer tick, asking Buildbucket for the build status
[00:15:11.236] Build 8853916779552688320: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:11.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:4:0) after 1m0s
[00:15:45.892] Received PubSub notification, asking Buildbucket for the build status
[00:15:46.011] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:11.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:4:0)
[00:16:11.278] Timer tick, asking Buildbucket for the build status
[00:16:11.362] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:11.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:6:0) after 1m0s
[00:17:11.649] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:6:0)
[00:17:11.649] Timer tick, asking Buildbucket for the build status
[00:17:11.717] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:11.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:7:0) after 1m0s
[00:18:12.114] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:7:0)
[00:18:12.114] Timer tick, asking Buildbucket for the build status
[00:18:12.181] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:12.181] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:8:0) after 1m0s
[00:19:12.752] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:8:0)
[00:19:12.752] Timer tick, asking Buildbucket for the build status
[00:19:12.938] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:12.938] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:9:0) after 1m0s
[00:20:13.056] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:9:0)
[00:20:13.056] Timer tick, asking Buildbucket for the build status
[00:20:13.708] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:13.709] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:10:0) after 1m0s
[00:21:13.756] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:10:0)
[00:21:13.756] Timer tick, asking Buildbucket for the build status
[00:21:14.064] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:14.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:11:0) after 1m0s
[00:22:14.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:11:0)
[00:22:14.124] Timer tick, asking Buildbucket for the build status
[00:22:14.188] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:14.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:12:0) after 1m0s
[00:23:14.278] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:12:0)
[00:23:14.278] Timer tick, asking Buildbucket for the build status
[00:23:14.442] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:14.442] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:13:0) after 1m0s
[00:24:14.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:13:0)
[00:24:14.504] Timer tick, asking Buildbucket for the build status
[00:24:15.149] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:15.149] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:14:0) after 1m0s
[00:25:15.201] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:14:0)
[00:25:15.201] Timer tick, asking Buildbucket for the build status
[00:25:15.533] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:15.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:15:0) after 1m0s
[00:26:15.560] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:15:0)
[00:26:15.560] Timer tick, asking Buildbucket for the build status
[00:26:16.883] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:16.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:16:0) after 1m0s
[00:27:17.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:16:0)
[00:27:17.131] Timer tick, asking Buildbucket for the build status
[00:27:18.647] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:18.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:17:0) after 1m0s
[00:28:18.776] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:17:0)
[00:28:18.776] Timer tick, asking Buildbucket for the build status
[00:28:19.050] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:19.050] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:18:0) after 1m0s
[00:29:19.062] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:18:0)
[00:29:19.062] Timer tick, asking Buildbucket for the build status
[00:29:19.347] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:19.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:19:0) after 1m0s
[00:30:19.441] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:19:0)
[00:30:19.441] Timer tick, asking Buildbucket for the build status
[00:30:19.512] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:19.512] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:20:0) after 1m0s
[00:31:19.524] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:20:0)
[00:31:19.524] Timer tick, asking Buildbucket for the build status
[00:31:19.611] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:19.611] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:21:0) after 1m0s
[00:32:19.690] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:21:0)
[00:32:19.690] Timer tick, asking Buildbucket for the build status
[00:32:19.772] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:19.772] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:22:0) after 1m0s
[00:33:19.874] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:22:0)
[00:33:19.874] Timer tick, asking Buildbucket for the build status
[00:33:19.970] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:19.970] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:23:0) after 1m0s
[00:34:20.064] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:23:0)
[00:34:20.064] Timer tick, asking Buildbucket for the build status
[00:34:20.310] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:20.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:24:0) after 1m0s
[00:35:20.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:24:0)
[00:35:20.545] Timer tick, asking Buildbucket for the build status
[00:35:20.671] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:20.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:25:0) after 1m0s
[00:36:20.739] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:25:0)
[00:36:20.739] Timer tick, asking Buildbucket for the build status
[00:36:20.806] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:20.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:26:0) after 1m0s
[00:37:20.966] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:26:0)
[00:37:20.966] Timer tick, asking Buildbucket for the build status
[00:37:21.048] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:21.048] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:27:0) after 1m0s
[00:38:21.107] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:27:0)
[00:38:21.107] Timer tick, asking Buildbucket for the build status
[00:38:21.211] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:21.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:28:0) after 1m0s
[00:39:21.194] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:28:0)
[00:39:21.194] Timer tick, asking Buildbucket for the build status
[00:39:21.289] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:21.289] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:29:0) after 1m0s
[00:40:21.365] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:29:0)
[00:40:21.365] Timer tick, asking Buildbucket for the build status
[00:40:21.451] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:21.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:30:0) after 1m0s
[00:41:22.638] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:30:0)
[00:41:22.638] Timer tick, asking Buildbucket for the build status
[00:41:24.694] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:24.694] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:31:0) after 1m0s
[00:42:24.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:31:0)
[00:42:24.820] Timer tick, asking Buildbucket for the build status
[00:42:24.887] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:24.887] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:32:0) after 1m0s
[00:43:24.961] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:32:0)
[00:43:24.961] Timer tick, asking Buildbucket for the build status
[00:43:25.146] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:25.146] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:33:0) after 1m0s
[00:44:25.239] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:33:0)
[00:44:25.239] Timer tick, asking Buildbucket for the build status
[00:44:25.679] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:25.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:34:0) after 1m0s
[00:45:25.938] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:34:0)
[00:45:25.938] Timer tick, asking Buildbucket for the build status
[00:45:26.012] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:26.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:35:0) after 1m0s
[00:46:26.069] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:35:0)
[00:46:26.069] Timer tick, asking Buildbucket for the build status
[00:46:26.189] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:26.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:36:0) after 1m0s
[00:47:26.244] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:36:0)
[00:47:26.244] Timer tick, asking Buildbucket for the build status
[00:47:26.332] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:26.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:37:0) after 1m0s
[00:48:26.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:37:0)
[00:48:26.415] Timer tick, asking Buildbucket for the build status
[00:48:26.486] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:26.486] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:38:0) after 1m0s
[00:49:26.641] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:38:0)
[00:49:26.641] Timer tick, asking Buildbucket for the build status
[00:49:26.704] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:26.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:39:0) after 1m0s
[00:50:26.748] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:39:0)
[00:50:26.748] Timer tick, asking Buildbucket for the build status
[00:50:26.876] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:26.876] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:40:0) after 1m0s
[00:51:26.952] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:40:0)
[00:51:26.952] Timer tick, asking Buildbucket for the build status
[00:51:27.062] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:27.062] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:41:0) after 1m0s
[00:52:27.082] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:41:0)
[00:52:27.082] Timer tick, asking Buildbucket for the build status
[00:52:27.151] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:27.151] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:42:0) after 1m0s
[00:53:27.764] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:42:0)
[00:53:27.764] Timer tick, asking Buildbucket for the build status
[00:53:27.959] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:27.959] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:43:0) after 1m0s
[00:54:28.686] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:43:0)
[00:54:28.686] Timer tick, asking Buildbucket for the build status
[00:54:30.007] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:30.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:44:0) after 1m0s
[00:55:30.086] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:44:0)
[00:55:30.086] Timer tick, asking Buildbucket for the build status
[00:55:30.169] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:30.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:45:0) after 1m0s
[00:56:30.192] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:45:0)
[00:56:30.192] Timer tick, asking Buildbucket for the build status
[00:56:31.156] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:31.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:46:0) after 1m0s
[00:57:31.589] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:46:0)
[00:57:31.589] Timer tick, asking Buildbucket for the build status
[00:57:31.750] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:31.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:47:0) after 1m0s
[00:58:31.809] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:47:0)
[00:58:31.809] Timer tick, asking Buildbucket for the build status
[00:58:31.886] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:31.886] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:48:0) after 1m0s
[00:59:32.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:48:0)
[00:59:32.214] Timer tick, asking Buildbucket for the build status
[00:59:32.350] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:32.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:49:0) after 1m0s
[01:00:32.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:49:0)
[01:00:32.544] Timer tick, asking Buildbucket for the build status
[01:00:32.620] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:32.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:50:0) after 1m0s
[01:01:32.716] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:50:0)
[01:01:32.716] Timer tick, asking Buildbucket for the build status
[01:01:32.848] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:32.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:51:0) after 1m0s
[01:02:32.939] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:51:0)
[01:02:32.939] Timer tick, asking Buildbucket for the build status
[01:02:33.031] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:33.031] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:52:0) after 1m0s
[01:03:33.075] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:52:0)
[01:03:33.075] Timer tick, asking Buildbucket for the build status
[01:03:33.362] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:33.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:53:0) after 1m0s
[01:04:33.385] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:53:0)
[01:04:33.385] Timer tick, asking Buildbucket for the build status
[01:04:33.465] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:33.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:54:0) after 1m0s
[01:05:33.461] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:54:0)
[01:05:33.461] Timer tick, asking Buildbucket for the build status
[01:05:33.579] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:33.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:55:0) after 1m0s
[01:06:33.628] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:55:0)
[01:06:33.628] Timer tick, asking Buildbucket for the build status
[01:06:36.622] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:36.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:56:0) after 1m0s
[01:07:36.645] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:56:0)
[01:07:36.645] Timer tick, asking Buildbucket for the build status
[01:07:36.758] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:36.758] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:57:0) after 1m0s
[01:08:36.784] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:57:0)
[01:08:36.784] Timer tick, asking Buildbucket for the build status
[01:08:36.883] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:36.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:58:0) after 1m0s
[01:09:36.929] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:58:0)
[01:09:36.929] Timer tick, asking Buildbucket for the build status
[01:09:37.039] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:37.039] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:59:0) after 1m0s
[01:10:37.014] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:59:0)
[01:10:37.014] Timer tick, asking Buildbucket for the build status
[01:10:37.160] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:37.160] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:60:0) after 1m0s
[01:11:37.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:60:0)
[01:11:37.211] Timer tick, asking Buildbucket for the build status
[01:11:38.045] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:38.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:61:0) after 1m0s
[01:12:38.219] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:61:0)
[01:12:38.219] Timer tick, asking Buildbucket for the build status
[01:12:39.771] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:39.771] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:62:0) after 1m0s
[01:13:39.840] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:62:0)
[01:13:39.840] Timer tick, asking Buildbucket for the build status
[01:13:39.926] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:39.926] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:63:0) after 1m0s
[01:14:39.957] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:63:0)
[01:14:39.957] Timer tick, asking Buildbucket for the build status
[01:14:40.034] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:40.034] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:64:0) after 1m0s
[01:15:40.126] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:64:0)
[01:15:40.126] Timer tick, asking Buildbucket for the build status
[01:15:40.215] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:40.215] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:65:0) after 1m0s
[01:16:40.244] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:65:0)
[01:16:40.244] Timer tick, asking Buildbucket for the build status
[01:16:40.348] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:40.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:66:0) after 1m0s
[01:17:40.352] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:66:0)
[01:17:40.352] Timer tick, asking Buildbucket for the build status
[01:17:40.520] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:40.520] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:67:0) after 1m0s
[01:18:40.577] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:67:0)
[01:18:40.577] Timer tick, asking Buildbucket for the build status
[01:18:40.846] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:40.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:68:0) after 1m0s
[01:19:40.963] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:68:0)
[01:19:40.964] Timer tick, asking Buildbucket for the build status
[01:19:41.055] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:41.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:69:0) after 1m0s
[01:20:41.112] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:69:0)
[01:20:41.112] Timer tick, asking Buildbucket for the build status
[01:20:41.187] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:41.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:70:0) after 1m0s
[01:21:41.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:70:0)
[01:21:41.514] Timer tick, asking Buildbucket for the build status
[01:21:41.685] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:41.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:71:0) after 1m0s
[01:22:41.818] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:71:0)
[01:22:41.818] Timer tick, asking Buildbucket for the build status
[01:22:41.891] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:41.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:72:0) after 1m0s
[01:23:42.017] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:72:0)
[01:23:42.017] Timer tick, asking Buildbucket for the build status
[01:23:42.115] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:42.115] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:73:0) after 1m0s
[01:24:42.214] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:73:0)
[01:24:42.214] Timer tick, asking Buildbucket for the build status
[01:24:42.350] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:42.350] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:74:0) after 1m0s
[01:25:42.449] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:74:0)
[01:25:42.449] Timer tick, asking Buildbucket for the build status
[01:25:42.763] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:42.763] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:75:0) after 1m0s
[01:26:42.829] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:75:0)
[01:26:42.829] Timer tick, asking Buildbucket for the build status
[01:26:42.901] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:42.901] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:76:0) after 1m0s
[01:27:43.045] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:76:0)
[01:27:43.045] Timer tick, asking Buildbucket for the build status
[01:27:43.136] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:43.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:77:0) after 1m0s
[01:28:43.328] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:77:0)
[01:28:43.328] Timer tick, asking Buildbucket for the build status
[01:28:43.931] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:43.931] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:78:0) after 1m0s
[01:29:44.066] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:78:0)
[01:29:44.066] Timer tick, asking Buildbucket for the build status
[01:29:44.242] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:44.242] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:79:0) after 1m0s
[01:30:44.290] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:79:0)
[01:30:44.290] Timer tick, asking Buildbucket for the build status
[01:30:44.383] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:44.383] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:80:0) after 1m0s
[01:31:44.482] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:80:0)
[01:31:44.482] Timer tick, asking Buildbucket for the build status
[01:31:44.568] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:44.568] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:81:0) after 1m0s
[01:32:44.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:81:0)
[01:32:44.663] Timer tick, asking Buildbucket for the build status
[01:32:45.178] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:45.178] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:82:0) after 1m0s
[01:33:45.349] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:82:0)
[01:33:45.349] Timer tick, asking Buildbucket for the build status
[01:33:45.456] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:45.456] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:83:0) after 1m0s
[01:34:45.544] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:83:0)
[01:34:45.544] Timer tick, asking Buildbucket for the build status
[01:34:45.900] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:45.900] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:84:0) after 1m0s
[01:35:45.972] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:84:0)
[01:35:45.972] Timer tick, asking Buildbucket for the build status
[01:35:46.061] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:46.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:85:0) after 1m0s
[01:36:46.151] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:85:0)
[01:36:46.151] Timer tick, asking Buildbucket for the build status
[01:36:46.401] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:46.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:86:0) after 1m0s
[01:37:46.624] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:86:0)
[01:37:46.624] Timer tick, asking Buildbucket for the build status
[01:37:46.718] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:46.718] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:87:0) after 1m0s
[01:38:46.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:87:0)
[01:38:46.820] Timer tick, asking Buildbucket for the build status
[01:38:46.905] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:46.905] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:88:0) after 1m0s
[01:39:46.954] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:88:0)
[01:39:46.954] Timer tick, asking Buildbucket for the build status
[01:39:47.114] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:47.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:89:0) after 1m0s
[01:40:47.449] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:89:0)
[01:40:47.449] Timer tick, asking Buildbucket for the build status
[01:40:47.642] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:47.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:90:0) after 1m0s
[01:41:47.946] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:90:0)
[01:41:47.946] Timer tick, asking Buildbucket for the build status
[01:41:48.236] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:48.236] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:91:0) after 1m0s
[01:42:48.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:91:0)
[01:42:48.284] Timer tick, asking Buildbucket for the build status
[01:42:48.997] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:48.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:92:0) after 1m0s
[01:43:49.155] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:92:0)
[01:43:49.155] Timer tick, asking Buildbucket for the build status
[01:43:49.230] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:49.230] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:93:0) after 1m0s
[01:44:49.304] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:93:0)
[01:44:49.304] Timer tick, asking Buildbucket for the build status
[01:44:49.425] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:49.425] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:94:0) after 1m0s
[01:45:49.448] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:94:0)
[01:45:49.448] Timer tick, asking Buildbucket for the build status
[01:45:49.553] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:49.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:95:0) after 1m0s
[01:46:49.734] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:95:0)
[01:46:49.734] Timer tick, asking Buildbucket for the build status
[01:46:49.831] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:49.831] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:96:0) after 1m0s
[01:47:50.229] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:96:0)
[01:47:50.229] Timer tick, asking Buildbucket for the build status
[01:47:50.533] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:50.533] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:97:0) after 1m0s
[01:48:50.605] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:97:0)
[01:48:50.605] Timer tick, asking Buildbucket for the build status
[01:48:51.352] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:51.352] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:98:0) after 1m0s
[01:49:51.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:98:0)
[01:49:51.454] Timer tick, asking Buildbucket for the build status
[01:49:53.556] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:53.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:99:0) after 1m0s
[01:50:54.084] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:99:0)
[01:50:54.084] Timer tick, asking Buildbucket for the build status
[01:50:54.436] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:54.436] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:100:0) after 1m0s
[01:51:54.487] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:100:0)
[01:51:54.487] Timer tick, asking Buildbucket for the build status
[01:51:54.560] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:54.560] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:101:0) after 1m0s
[01:52:54.663] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:101:0)
[01:52:54.663] Timer tick, asking Buildbucket for the build status
[01:52:54.757] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:54.757] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:102:0) after 1m0s
[01:53:55.038] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:102:0)
[01:53:55.038] Timer tick, asking Buildbucket for the build status
[01:53:55.118] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:55.118] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:103:0) after 1m0s
[01:54:55.290] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:103:0)
[01:54:55.290] Timer tick, asking Buildbucket for the build status
[01:54:55.394] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:55.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:104:0) after 1m0s
[01:55:55.545] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:104:0)
[01:55:55.545] Timer tick, asking Buildbucket for the build status
[01:55:55.620] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:55.620] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:105:0) after 1m0s
[01:56:57.026] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:105:0)
[01:56:57.026] Timer tick, asking Buildbucket for the build status
[01:56:57.105] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:57.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:106:0) after 1m0s
[01:57:57.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:106:0)
[01:57:57.295] Timer tick, asking Buildbucket for the build status
[01:57:57.363] Build 8853916779552688320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:57.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9019346841735468464:107:0) after 1m0s
[01:58:32.130] Received PubSub notification, asking Buildbucket for the build status
[01:58:32.249] Build 8853916779552688320: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:58:32.249] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614650311688326",
"created_by": "project:chromium",
"created_ts": "1614643989950012",
"failure_reason": "BUILD_FAILURE",
"id": "8853916779552688320",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7466e1a93a815b8bd9244a5fd8b8a64b4f083cee\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**webkit_unit_tests** failed because of:\\n\\n- MediaStreamRemoteVideoSourceTest.PopulateRequestAnimationFrameMetadata\"}, \"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\": \"7466e1a93a815b8bd9244a5fd8b8a64b4f083cee\", \"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-2-2mmz\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17582, \"clang_revision\": \"llvmorg-13-init-1559-g01b87444-3\", \"got_angle_revision\": \"5b82fa2e842475cd93c6a6119b6e07635054e836\", \"got_dawn_revision\": \"931182485579d2eec3b24c1f2df646870f80da68\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"7466e1a93a815b8bd9244a5fd8b8a64b4f083cee\", \"got_revision_cp\": \"refs/heads/master@{#858777}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"851ca4314ae4a367bcc4cabb20326029eff18492\", \"got_v8_revision_cp\": \"refs/heads/9.1.7@{#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\": \"7466e1a93a815b8bd9244a5fd8b8a64b4f083cee\", \"swarm_hashes_refs/heads/master(at){#858777}_without_patch\": {\"absl_hardening_tests\": \"c01035acad2dfba3781275cd59af314acb39fc87\", \"accessibility_unittests\": \"9468103cafa6a894f1a6543eb165b433e78c26b0\", \"angle_unittests\": \"b3edf7475e7911a38a973e1e6b7cf430b61d918c\", \"app_shell_unittests\": \"b2489ca3101c958fc9049540a17fda0b1d940e21\", \"aura_unittests\": \"468a66e0b1687059accd70396010a58705c3476d\", \"base_unittests\": \"35be9b57c075d3d7f28ec68f9986f87f026b5522\", \"base_util_unittests\": \"fe6ceed6c3d9853f9d3df1bbd5766b23126f382a\", \"blink_common_unittests\": \"215621870f349ce87cc86164e76f698d72fb249d\", \"blink_fuzzer_unittests\": \"f9a90aa3c36a24be9e27915fb4e64b53ec112176\", \"blink_heap_unittests\": \"9b309a5b854eba2c484e01130fea345cf32a4d50\", \"blink_platform_unittests\": \"7ddf6aa77bd87e5937ca903c310a7405f013f162\", \"blink_unittests\": \"5b94bd5ed59362d0b2ac6ac76e8ec42db0730d06\", \"boringssl_crypto_tests\": \"d82758f809c4bf087c422f55008135e6b52c4a1e\", \"boringssl_ssl_tests\": \"30ee380e42f46179de34d16e233dca2a9ea50558\", \"browser_switcher_bho_unittests\": \"f2230c66177d01ddc59524d13b329623368b48aa\", \"browser_tests\": \"dd336fb57358c36c97eceba0bec19de0e36ecbca\", \"capture_unittests\": \"b94561c6edd552008883fb309ebb2b2148880d34\", \"cast_unittests\": \"e194df1ac12272bbc67d956ae5afc96a785c6e3a\", \"cc_unittests\": \"0e878e47be6332c7c9bfad2978e32f824e6b9eac\", \"chrome_app_unittests\": \"834c2b0f8c7230f8e744945e7509a200aa1bc65e\", \"chrome_cleaner_unittests\": \"7d4123465cebdcfa0b42a24fb4538ae1294f4eba\", \"chrome_elf_unittests\": \"0574595729d6380a7826809f431a3cd30c9e2a59\", \"chromedriver_unittests\": \"2ae8bd322460d1eaed1503d0ba07cf4045a1a426\", \"color_unittests\": \"c06ab9dacb90c8f7f06c301303b882554068ea4c\", \"components_browsertests\": \"be6a67d18373bf4c6bcc8e6418da3e0d75d1093d\", \"components_unittests\": \"e049dadbdc161864357c39d0fae202465d552b1b\", \"compositor_unittests\": \"ab7e8ccd606337a429c0807c1e2d5b174e9de0a8\", \"content_browsertests\": \"f263285391cfd308f5e975821f4b432dc651c803\", \"content_unittests\": \"516ab9103e4733ffd4febe693723995aee903a0f\", \"courgette_unittests\": \"b220c45e91ec385c052ba07cfe753f73068fa90a\", \"crashpad_tests\": \"5ee1c265f77ce3af571eec616db44ed553dcaaf1\", \"cronet_tests\": \"062946ad745726705d7aa56304829e826a5d9fd2\", \"cronet_unittests\": \"d0267a24887f820adfebc758b02cdb95a27d6003\", \"crypto_unittests\": \"71ca496a52779c652ea7da91a7d3f81e76cc9cfe\", \"delayloads_unittests\": \"9f8e852b669c2b1ec292871730891666950a65d9\", \"device_unittests\": \"86f51befd5a24d813844f970e930ca5d09f8f652\", \"display_unittests\": \"4f269cae6f624babec39e56d6848b95c37479bdb\", \"elevation_service_unittests\": \"246810543fe3e28935f50a2185b474085361e291\", \"events_unittests\": \"df163ba7b1819bcff2a2ac981f44fc0c050b804c\", \"extensions_browsertests\": \"069ddc9a60113eb9396deb4c5b75b0439274e383\", \"extensions_unittests\": \"51f8181eaed5fc90b95fd224c9eaffb3aba33da7\", \"filesystem_service_unittests\": \"c595772c2163ce6099c0884b0ab3a7669f8135b8\", \"gcm_unit_tests\": \"074605b089773495618ede3075697a31c27f1197\", \"gcp_unittests\": \"d6338aa80f7548778a5bcc5ef0640cd6e6e81bb3\", \"gfx_unittests\": \"8b28d66c6c615117df3838b9082cdd4db31d12a2\", \"gin_unittests\": \"ddb3939773f5297f3dc41f7436fe6029baf4d909\", \"google_apis_unittests\": \"0afb143dd06dcbb72c1d75298e4a89f2f407cd03\", \"gpu_unittests\": \"18cf8bbd8074a1865106ce726051f5b47a5b9f57\", \"gwp_asan_unittests\": \"6edaf29c557a308d2da1d8da7346ac055b1a1aa9\", \"headless_browsertests\": \"d35b530e2cf9dd89cd5290ea08c58e501fc46570\", \"headless_unittests\": \"916d9da4e0dd02426e8d3baa2c2a269b76973829\", \"install_static_unittests\": \"cf3b1b2d5540f8eefead121037150b767dc4e675\", \"installer_util_unittests\": \"6b675654b59ad380168289bbbbd62b350540c7e0\", \"interactive_ui_tests\": \"4a2bd1c8312504b1cd0f77e749ad5b471cd86bfc\", \"ipc_tests\": \"d908694d78e379fed898f23796e6bb8670f6d378\", \"jingle_unittests\": \"3e86efc02e2ef66d46c178d2bab29de20fa0c38c\", \"latency_unittests\": \"6065d75b65149e3e2eb0f0c86ccb2b1328776c33\", \"libjingle_xmpp_unittests\": \"771bfd9dd79946455f86a577e2692197442ddd68\", \"liburlpattern_unittests\": \"b623ae7c0d867683f96d4823e12ccca1a8ff60c2\", \"media_blink_unittests\": \"328aa4f3af96920b96c197ee650c76457f7f1421\", \"media_unittests\": \"d36a893e6debe4b63da833daf4e4023a4a1aafa1\", \"message_center_unittests\": \"5eaa156339824cc76f6f676f938a3488a28cbcbd\", \"midi_unittests\": \"c385f2040768c66aad1d23844417df0d33412dc1\", \"mojo_core_unittests\": \"3f3d7d12ba0725674c9acde42af3281362f58290\", \"mojo_unittests\": \"061ad6e10c303bc37883c2b25a84757f473cf4a0\", \"nacl_loader_unittests\": \"994f613aacb67a1322848425fbcff114a9de12e3\", \"native_theme_unittests\": \"bd8ebc85eb644258dffe255dce39998fb381b57b\", \"net_unittests\": \"6aad2375c8a58b4e9a7f1f91def568b8beeb4adb\", \"notification_helper_unittests\": \"eb1104afe4d3aa053dc8105a290176bd89e51c35\", \"pdf_unittests\": \"5657289d4f1ed9ad75d22ac815af3ade49864a28\", \"perfetto_unittests\": \"268a4feeb52f057c04ac6f077e201fa78fb4181c\", \"ppapi_unittests\": \"4e9003b68afd7ad89090eb73a8e23e6ee44519a3\", \"printing_unittests\": \"43a3e04091511f3611f8336aedc26eb18707eb5b\", \"remoting_unittests\": \"af3e934478c044d6f97dd0f66c50ef434171c70d\", \"sbox_integration_tests\": \"04d06121508fb2d2facaa786824dd806b2f1a19c\", \"sbox_unittests\": \"9f06d69c0c045ecaad9f2a8f6f82dc4d837aa0d0\", \"sbox_validation_tests\": \"2d7d63b87b9b3d69f5056b18bc59616b611a956c\", \"service_manager_unittests\": \"214c3e7c9ca00252327f7bae5ecbb61cccf95fcd\", \"services_unittests\": \"f5b7b6c28622c061e5d58bae2df57b81e9d2ef66\", \"setup_unittests\": \"4002069880ea7688caa0fff0baa150fd45d6f904\", \"shell_dialogs_unittests\": \"a715b96f14109ba122a3a1d0f05bde8a07ad893f\", \"skia_unittests\": \"35f8c67f0eef5c9f2063fd0702c6d6b19fc5cd8d\", \"snapshot_unittests\": \"ee84dc2c9177d792eeb28bea181f889e2af70348\", \"sql_unittests\": \"baba5f5f4d8052c406a5c1434c939f30234c7dc5\", \"storage_unittests\": \"216700c69514a21bffa60e9121f3bb1ba3658233\", \"sync_integration_tests\": \"30ffa70bc465b1b0536c5cbc900e47ae7662e013\", \"traffic_annotation_auditor_unittests\": \"270d15bd89f03a538ea83df1930dce769890b14e\", \"ui_base_unittests\": \"40c01dea510643e49936c771e8c7f111b0d69745\", \"ui_touch_selection_unittests\": \"14742fb537c6835341a4a0f57ed7303d79efdcaa\", \"unit_tests\": \"b5af721bf2de79c706482e1ecd3ff88762b36415\", \"updater_tests\": \"29694a95f0325d08e41bfdee52db0f8a778740b1\", \"url_unittests\": \"87f91e53ee38756b67cbf201eadb5741f717efb5\", \"views_unittests\": \"0c1bb67c25bc36b92e6f4a63f35af1e7a1895f45\", \"viz_unittests\": \"a1c12f8236f71ef0a216509d876a76cb7904e239\", \"vr_common_unittests\": \"12429a44477111857fe9e4e722f0004600155aab\", \"vr_pixeltests\": \"7f5e656bc685a0523a269408183da5ab0225ffcd\", \"weblayer_browsertests\": \"9411b1c0659be5851a9f7a74fd929c981fd76c6d\", \"weblayer_unittests\": \"b50a838e837c951f492c5d5da1dca4fcb1f8b0e8\", \"wm_unittests\": \"39f334bd594a55fa956cdd3277ae8ca6afcb923c\", \"wtf_unittests\": \"ba37d98fc0abc38fccabc2130b2dc531bb4bb9d6\", \"zlib_unittests\": \"8e2d611edef4b9e6cde2cb5d16fbd2c7e4527117\", \"zucchini_unittests\": \"5345fc2475cba90eebd3f3d5761432645793b2fe\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02613bacee8cd1c41158238da4ce7615021ecb28a4b52e6029f89cb601af0790_v2\", \"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-2-2mmz\"], \"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\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**webkit_unit_tests** failed because of:\\n\\n- MediaStreamRemoteVideoSourceTest.PopulateRequestAnimationFrameMetadata\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614644145162867",
"status": "COMPLETED",
"status_changed_ts": "1614644145518900",
"tags": [
"build_address:luci.chromium.ci/win-asan/17582",
"builder:win-asan",
"buildset:commit/git/7466e1a93a815b8bd9244a5fd8b8a64b4f083cee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7466e1a93a815b8bd9244a5fd8b8a64b4f083cee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019346841735468464",
"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/8853916779552688320/+/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:520919aa8e22bb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614650311689005",
"url": "https://ci.chromium.org/b/8853916779552688320",
"utcnow_ts": "1614650312211976"
}
}
[01:58:32.249] Invocation finished in 1h45m23.763698243s with status FAILED