[02:35:08.690] New invocation is queued and will start shortly
[02:35:09.912] Starting the invocation (attempt 1)
[02:35:09.965] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:35:09.965] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:35:09.965] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028578798246394352",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b3604ebbdbfb5291ebf39b34fdf314f93dc904b6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9028578798246394352",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/b3604ebbdbfb5291ebf39b34fdf314f93dc904b6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b3604ebbdbfb5291ebf39b34fdf314f93dc904b6",
"gitiles_ref:refs/heads/master"
]
}
[02:35:10.937] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605839710210971",
"id": "8863148735985542096",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b3604ebbdbfb5291ebf39b34fdf314f93dc904b6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605839710743250",
"tags": [
"build_address:luci.chromium.ci/win-asan/15732",
"builder:win-asan",
"buildset:commit/git/b3604ebbdbfb5291ebf39b34fdf314f93dc904b6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b3604ebbdbfb5291ebf39b34fdf314f93dc904b6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028578798246394352",
"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/8863148735985542096/+/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": "1605839710743355",
"url": "https://ci.chromium.org/b/8863148735985542096",
"utcnow_ts": "1605839710913293"
}
}
[02:35:10.937] Task URL: https://ci.chromium.org/b/8863148735985542096
[02:35:10.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:2:0) after 1m0s
[02:36:11.011] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:2:0)
[02:36:11.011] Timer tick, asking Buildbucket for the build status
[02:36:11.624] Build 8863148735985542096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:11.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:3:0) after 1m0s
[02:37:11.755] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:3:0)
[02:37:11.755] Timer tick, asking Buildbucket for the build status
[02:37:11.919] Build 8863148735985542096: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:11.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:4:0) after 1m0s
[02:38:02.562] Received PubSub notification, asking Buildbucket for the build status
[02:38:02.774] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:11.983] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:4:0)
[02:38:11.983] Timer tick, asking Buildbucket for the build status
[02:38:12.186] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:12.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:6:0) after 1m0s
[02:39:12.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:6:0)
[02:39:12.323] Timer tick, asking Buildbucket for the build status
[02:39:12.445] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:12.445] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:7:0) after 1m0s
[02:40:12.543] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:7:0)
[02:40:12.543] Timer tick, asking Buildbucket for the build status
[02:40:12.697] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:12.697] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:8:0) after 1m0s
[02:41:12.878] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:8:0)
[02:41:12.878] Timer tick, asking Buildbucket for the build status
[02:41:12.960] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:12.960] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:9:0) after 1m0s
[02:42:13.057] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:9:0)
[02:42:13.057] Timer tick, asking Buildbucket for the build status
[02:42:13.113] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:13.113] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:10:0) after 1m0s
[02:43:13.178] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:10:0)
[02:43:13.178] Timer tick, asking Buildbucket for the build status
[02:43:13.249] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:13.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:11:0) after 1m0s
[02:44:13.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:11:0)
[02:44:13.295] Timer tick, asking Buildbucket for the build status
[02:44:13.385] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:13.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:12:0) after 1m0s
[02:45:13.432] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:12:0)
[02:45:13.432] Timer tick, asking Buildbucket for the build status
[02:45:13.686] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:13.686] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:13:0) after 1m0s
[02:46:13.843] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:13:0)
[02:46:13.843] Timer tick, asking Buildbucket for the build status
[02:46:13.912] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:13.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:14:0) after 1m0s
[02:47:14.140] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:14:0)
[02:47:14.140] Timer tick, asking Buildbucket for the build status
[02:47:14.225] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:14.225] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:15:0) after 1m0s
[02:48:14.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:15:0)
[02:48:14.317] Timer tick, asking Buildbucket for the build status
[02:48:14.385] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:14.385] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:16:0) after 1m0s
[02:49:14.434] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:16:0)
[02:49:14.434] Timer tick, asking Buildbucket for the build status
[02:49:14.548] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:14.548] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:17:0) after 1m0s
[02:50:14.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:17:0)
[02:50:14.668] Timer tick, asking Buildbucket for the build status
[02:50:14.866] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:14.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:18:0) after 1m0s
[02:51:14.969] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:18:0)
[02:51:14.969] Timer tick, asking Buildbucket for the build status
[02:51:15.246] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:15.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:19:0) after 1m0s
[02:52:15.301] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:19:0)
[02:52:15.301] Timer tick, asking Buildbucket for the build status
[02:52:15.463] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:15.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:20:0) after 1m0s
[02:53:15.523] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:20:0)
[02:53:15.523] Timer tick, asking Buildbucket for the build status
[02:53:15.721] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:15.721] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:21:0) after 1m0s
[02:54:15.714] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:21:0)
[02:54:15.714] Timer tick, asking Buildbucket for the build status
[02:54:15.774] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:15.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:22:0) after 1m0s
[02:55:15.914] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:22:0)
[02:55:15.914] Timer tick, asking Buildbucket for the build status
[02:55:16.049] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:16.049] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:23:0) after 1m0s
[02:56:16.119] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:23:0)
[02:56:16.119] Timer tick, asking Buildbucket for the build status
[02:56:16.188] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:16.188] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:24:0) after 1m0s
[02:57:16.273] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:24:0)
[02:57:16.273] Timer tick, asking Buildbucket for the build status
[02:57:16.362] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:16.362] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:25:0) after 1m0s
[02:58:16.416] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:25:0)
[02:58:16.416] Timer tick, asking Buildbucket for the build status
[02:58:16.496] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:16.496] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:26:0) after 1m0s
[02:59:16.606] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:26:0)
[02:59:16.606] Timer tick, asking Buildbucket for the build status
[02:59:16.812] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:16.812] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:27:0) after 1m0s
[03:00:16.912] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:27:0)
[03:00:16.912] Timer tick, asking Buildbucket for the build status
[03:00:17.090] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:17.090] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:28:0) after 1m0s
[03:01:17.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:28:0)
[03:01:17.257] Timer tick, asking Buildbucket for the build status
[03:01:17.774] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:17.774] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:29:0) after 1m0s
[03:02:17.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:29:0)
[03:02:17.902] Timer tick, asking Buildbucket for the build status
[03:02:20.903] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:20.903] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:30:0) after 1m0s
[03:03:20.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:30:0)
[03:03:20.978] Timer tick, asking Buildbucket for the build status
[03:03:21.534] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:21.534] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:31:0) after 1m0s
[03:04:21.582] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:31:0)
[03:04:21.582] Timer tick, asking Buildbucket for the build status
[03:04:21.648] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:21.648] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:32:0) after 1m0s
[03:05:21.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:32:0)
[03:05:21.659] Timer tick, asking Buildbucket for the build status
[03:05:21.770] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:21.770] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:33:0) after 1m0s
[03:06:21.752] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:33:0)
[03:06:21.752] Timer tick, asking Buildbucket for the build status
[03:06:22.281] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:22.281] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:34:0) after 1m0s
[03:07:22.329] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:34:0)
[03:07:22.329] Timer tick, asking Buildbucket for the build status
[03:07:22.439] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:22.439] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:35:0) after 1m0s
[03:08:22.465] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:35:0)
[03:08:22.465] Timer tick, asking Buildbucket for the build status
[03:08:22.609] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:22.609] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:36:0) after 1m0s
[03:09:22.603] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:36:0)
[03:09:22.603] Timer tick, asking Buildbucket for the build status
[03:09:22.662] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:22.662] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:37:0) after 1m0s
[03:10:22.675] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:37:0)
[03:10:22.675] Timer tick, asking Buildbucket for the build status
[03:10:23.303] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:23.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:38:0) after 1m0s
[03:11:23.393] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:38:0)
[03:11:23.393] Timer tick, asking Buildbucket for the build status
[03:11:23.472] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:23.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:39:0) after 1m0s
[03:12:23.526] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:39:0)
[03:12:23.526] Timer tick, asking Buildbucket for the build status
[03:12:23.608] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:23.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:40:0) after 1m0s
[03:13:23.791] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:40:0)
[03:13:23.791] Timer tick, asking Buildbucket for the build status
[03:13:23.895] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:23.895] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:41:0) after 1m0s
[03:14:24.053] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:41:0)
[03:14:24.053] Timer tick, asking Buildbucket for the build status
[03:14:24.121] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:24.121] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:42:0) after 1m0s
[03:15:24.333] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:42:0)
[03:15:24.333] Timer tick, asking Buildbucket for the build status
[03:15:24.622] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:24.622] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:43:0) after 1m0s
[03:16:24.950] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:43:0)
[03:16:24.950] Timer tick, asking Buildbucket for the build status
[03:16:25.022] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:25.022] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:44:0) after 1m0s
[03:17:25.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:44:0)
[03:17:25.147] Timer tick, asking Buildbucket for the build status
[03:17:25.313] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:25.313] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:45:0) after 1m0s
[03:18:25.395] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:45:0)
[03:18:25.395] Timer tick, asking Buildbucket for the build status
[03:18:25.482] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:25.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:46:0) after 1m0s
[03:19:25.509] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:46:0)
[03:19:25.509] Timer tick, asking Buildbucket for the build status
[03:19:25.570] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:25.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:47:0) after 1m0s
[03:20:25.665] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:47:0)
[03:20:25.665] Timer tick, asking Buildbucket for the build status
[03:20:25.781] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:25.781] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:48:0) after 1m0s
[03:21:25.916] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:48:0)
[03:21:25.916] Timer tick, asking Buildbucket for the build status
[03:21:26.219] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:26.219] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:49:0) after 1m0s
[03:22:26.469] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:49:0)
[03:22:26.469] Timer tick, asking Buildbucket for the build status
[03:22:27.487] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:27.487] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:50:0) after 1m0s
[03:23:27.506] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:50:0)
[03:23:27.506] Timer tick, asking Buildbucket for the build status
[03:23:27.714] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:27.714] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:51:0) after 1m0s
[03:24:27.717] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:51:0)
[03:24:27.717] Timer tick, asking Buildbucket for the build status
[03:24:27.778] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:27.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:52:0) after 1m0s
[03:25:27.799] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:52:0)
[03:25:27.799] Timer tick, asking Buildbucket for the build status
[03:25:28.092] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:28.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:53:0) after 1m0s
[03:26:28.122] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:53:0)
[03:26:28.122] Timer tick, asking Buildbucket for the build status
[03:26:28.198] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:28.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:54:0) after 1m0s
[03:27:28.265] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:54:0)
[03:27:28.265] Timer tick, asking Buildbucket for the build status
[03:27:28.349] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:28.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:55:0) after 1m0s
[03:28:28.513] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:55:0)
[03:28:28.513] Timer tick, asking Buildbucket for the build status
[03:28:28.815] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:28.815] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:56:0) after 1m0s
[03:29:28.891] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:56:0)
[03:29:28.892] Timer tick, asking Buildbucket for the build status
[03:29:29.060] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:29.060] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:57:0) after 1m0s
[03:30:29.174] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:57:0)
[03:30:29.174] Timer tick, asking Buildbucket for the build status
[03:30:29.309] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:29.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:58:0) after 1m0s
[03:31:29.437] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:58:0)
[03:31:29.437] Timer tick, asking Buildbucket for the build status
[03:31:29.553] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:29.553] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:59:0) after 1m0s
[03:32:29.665] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:59:0)
[03:32:29.665] Timer tick, asking Buildbucket for the build status
[03:32:29.835] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:29.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:60:0) after 1m0s
[03:33:29.902] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:60:0)
[03:33:29.902] Timer tick, asking Buildbucket for the build status
[03:33:30.078] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:30.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:61:0) after 1m0s
[03:34:30.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:61:0)
[03:34:30.211] Timer tick, asking Buildbucket for the build status
[03:34:30.368] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:30.368] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:62:0) after 1m0s
[03:35:30.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:62:0)
[03:35:30.359] Timer tick, asking Buildbucket for the build status
[03:35:30.633] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:30.633] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:63:0) after 1m0s
[03:36:30.680] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:63:0)
[03:36:30.680] Timer tick, asking Buildbucket for the build status
[03:36:30.745] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:30.745] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:64:0) after 1m0s
[03:37:30.783] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:64:0)
[03:37:30.783] Timer tick, asking Buildbucket for the build status
[03:37:30.861] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:30.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:65:0) after 1m0s
[03:38:30.928] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:65:0)
[03:38:30.928] Timer tick, asking Buildbucket for the build status
[03:38:30.991] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:30.991] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:66:0) after 1m0s
[03:39:31.133] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:66:0)
[03:39:31.133] Timer tick, asking Buildbucket for the build status
[03:39:31.311] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:31.311] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:67:0) after 1m0s
[03:40:31.375] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:67:0)
[03:40:31.375] Timer tick, asking Buildbucket for the build status
[03:40:31.704] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:31.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:68:0) after 1m0s
[03:41:31.836] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:68:0)
[03:41:31.836] Timer tick, asking Buildbucket for the build status
[03:41:32.279] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:32.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:69:0) after 1m0s
[03:42:32.298] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:69:0)
[03:42:32.298] Timer tick, asking Buildbucket for the build status
[03:42:32.463] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:32.463] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:70:0) after 1m0s
[03:43:32.504] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:70:0)
[03:43:32.504] Timer tick, asking Buildbucket for the build status
[03:43:33.384] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:33.384] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:71:0) after 1m0s
[03:44:33.378] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:71:0)
[03:44:33.378] Timer tick, asking Buildbucket for the build status
[03:44:33.562] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:33.562] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:72:0) after 1m0s
[03:45:33.618] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:72:0)
[03:45:33.618] Timer tick, asking Buildbucket for the build status
[03:45:33.871] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:33.871] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:73:0) after 1m0s
[03:46:33.910] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:73:0)
[03:46:33.910] Timer tick, asking Buildbucket for the build status
[03:46:34.099] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:34.099] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:74:0) after 1m0s
[03:47:34.135] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:74:0)
[03:47:34.135] Timer tick, asking Buildbucket for the build status
[03:47:34.481] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:34.481] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:75:0) after 1m0s
[03:48:34.587] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:75:0)
[03:48:34.587] Timer tick, asking Buildbucket for the build status
[03:48:35.156] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:35.156] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:76:0) after 1m0s
[03:49:35.243] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:76:0)
[03:49:35.243] Timer tick, asking Buildbucket for the build status
[03:49:35.367] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:35.367] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:77:0) after 1m0s
[03:50:35.471] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:77:0)
[03:50:35.471] Timer tick, asking Buildbucket for the build status
[03:50:35.597] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:35.597] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:78:0) after 1m0s
[03:51:35.611] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:78:0)
[03:51:35.611] Timer tick, asking Buildbucket for the build status
[03:51:35.726] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:35.726] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:79:0) after 1m0s
[03:52:35.731] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:79:0)
[03:52:35.731] Timer tick, asking Buildbucket for the build status
[03:52:36.702] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:36.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:80:0) after 1m0s
[03:53:36.794] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:80:0)
[03:53:36.794] Timer tick, asking Buildbucket for the build status
[03:53:36.868] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:36.868] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:81:0) after 1m0s
[03:54:36.898] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:81:0)
[03:54:36.898] Timer tick, asking Buildbucket for the build status
[03:54:37.296] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:37.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:82:0) after 1m0s
[03:55:37.388] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:82:0)
[03:55:37.388] Timer tick, asking Buildbucket for the build status
[03:55:37.583] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:37.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:83:0) after 1m0s
[03:56:37.627] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:83:0)
[03:56:37.627] Timer tick, asking Buildbucket for the build status
[03:56:37.761] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:37.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:84:0) after 1m0s
[03:57:37.814] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:84:0)
[03:57:37.814] Timer tick, asking Buildbucket for the build status
[03:57:37.973] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:37.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:85:0) after 1m0s
[03:58:37.994] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:85:0)
[03:58:37.994] Timer tick, asking Buildbucket for the build status
[03:58:38.107] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:38.107] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:86:0) after 1m0s
[03:59:38.164] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:86:0)
[03:59:38.164] Timer tick, asking Buildbucket for the build status
[03:59:38.261] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:38.261] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:87:0) after 1m0s
[04:00:38.341] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:87:0)
[04:00:38.341] Timer tick, asking Buildbucket for the build status
[04:00:38.525] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:38.525] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:88:0) after 1m0s
[04:01:38.562] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:88:0)
[04:01:38.562] Timer tick, asking Buildbucket for the build status
[04:01:39.217] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:39.217] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:89:0) after 1m0s
[04:02:39.203] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:89:0)
[04:02:39.203] Timer tick, asking Buildbucket for the build status
[04:02:39.401] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:39.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:90:0) after 1m0s
[04:03:39.390] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:90:0)
[04:03:39.390] Timer tick, asking Buildbucket for the build status
[04:03:39.517] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:39.517] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:91:0) after 1m0s
[04:04:39.767] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:91:0)
[04:04:39.767] Timer tick, asking Buildbucket for the build status
[04:04:40.040] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:40.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:92:0) after 1m0s
[04:05:40.218] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:92:0)
[04:05:40.218] Timer tick, asking Buildbucket for the build status
[04:05:41.078] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:41.078] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:93:0) after 1m0s
[04:06:41.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:93:0)
[04:06:41.196] Timer tick, asking Buildbucket for the build status
[04:06:41.677] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:41.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:94:0) after 1m0s
[04:07:41.816] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:94:0)
[04:07:41.816] Timer tick, asking Buildbucket for the build status
[04:07:42.018] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:42.018] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:95:0) after 1m0s
[04:08:42.104] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:95:0)
[04:08:42.104] Timer tick, asking Buildbucket for the build status
[04:08:42.220] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:42.220] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:96:0) after 1m0s
[04:09:42.294] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:96:0)
[04:09:42.294] Timer tick, asking Buildbucket for the build status
[04:09:42.765] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:42.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:97:0) after 1m0s
[04:10:42.854] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:97:0)
[04:10:42.854] Timer tick, asking Buildbucket for the build status
[04:10:42.995] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:42.995] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:98:0) after 1m0s
[04:11:43.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:98:0)
[04:11:43.165] Timer tick, asking Buildbucket for the build status
[04:11:43.278] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:43.278] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:99:0) after 1m0s
[04:12:43.429] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:99:0)
[04:12:43.429] Timer tick, asking Buildbucket for the build status
[04:12:43.504] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:43.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:100:0) after 1m0s
[04:13:43.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:100:0)
[04:13:43.584] Timer tick, asking Buildbucket for the build status
[04:13:43.884] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:43.884] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:101:0) after 1m0s
[04:14:43.930] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:101:0)
[04:14:43.930] Timer tick, asking Buildbucket for the build status
[04:14:44.096] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:44.096] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:102:0) after 1m0s
[04:15:44.147] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:102:0)
[04:15:44.147] Timer tick, asking Buildbucket for the build status
[04:15:44.260] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:44.260] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:103:0) after 1m0s
[04:16:44.362] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:103:0)
[04:16:44.362] Timer tick, asking Buildbucket for the build status
[04:16:45.244] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:45.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:104:0) after 1m0s
[04:17:45.311] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:104:0)
[04:17:45.311] Timer tick, asking Buildbucket for the build status
[04:17:45.404] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:45.404] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:105:0) after 1m0s
[04:18:45.518] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:105:0)
[04:18:45.518] Timer tick, asking Buildbucket for the build status
[04:18:45.608] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:45.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:106:0) after 1m0s
[04:19:45.746] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:106:0)
[04:19:45.746] Timer tick, asking Buildbucket for the build status
[04:19:45.878] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:45.878] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:107:0) after 1m0s
[04:20:45.909] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:107:0)
[04:20:45.909] Timer tick, asking Buildbucket for the build status
[04:20:46.092] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:46.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:108:0) after 1m0s
[04:21:46.144] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:108:0)
[04:21:46.144] Timer tick, asking Buildbucket for the build status
[04:21:46.274] Build 8863148735985542096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:46.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9028578798246394352:109:0) after 1m0s
[04:21:49.156] Received PubSub notification, asking Buildbucket for the build status
[04:21:49.390] Build 8863148735985542096: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:21:49.390] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605846107702967",
"created_by": "project:chromium",
"created_ts": "1605839710210971",
"failure_reason": "BUILD_FAILURE",
"id": "8863148735985542096",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b3604ebbdbfb5291ebf39b34fdf314f93dc904b6\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- MSE_ExternalClearKey/EncryptedMediaTest.Playback_VP9Video_WebM_Subsample/0\"}, \"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\": \"b3604ebbdbfb5291ebf39b34fdf314f93dc904b6\", \"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-us-central1-b-32-0-7rud\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 15732, \"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"46107d3ece07f5cd1946b1013f69c110c0229a93\", \"got_dawn_revision\": \"1a14e7e0244114fe737caf46e3a2690355aceafe\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"b3604ebbdbfb5291ebf39b34fdf314f93dc904b6\", \"got_revision_cp\": \"refs/heads/master@{#829487}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"de9e649438ed3cc2ecf5c30ebf08f033d01270e6\", \"got_v8_revision\": \"94b2c943f7f37e0450e7c5d029fbd22a9d7f6946\", \"got_v8_revision_cp\": \"refs/heads/8.9.14@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"b3604ebbdbfb5291ebf39b34fdf314f93dc904b6\", \"swarm_hashes_refs/heads/master(at){#829487}_without_patch\": {\"absl_hardening_tests\": \"f06b8e182f91d96c374e3bd1b5a8dd24a0c457bf\", \"accessibility_unittests\": \"9e2665c6a8d505ad1079653c8ceda2ecd5bc876d\", \"angle_unittests\": \"88151034b4a5874b934e9eee32bbe8ea3334662d\", \"app_shell_unittests\": \"869e6a041800f977442e6e495c58e2573fee3f32\", \"aura_unittests\": \"e68d1b98d5c203ef7c236fe5cfea50ac07b273cc\", \"base_unittests\": \"473272e083484aa0234eaf6e3d4b71a1bdc85545\", \"base_util_unittests\": \"d73d41d68eafcbb3f43c03c5d0342e893c08f580\", \"blink_common_unittests\": \"04cf279cefee74113868509d77327404ffc3249d\", \"blink_fuzzer_unittests\": \"fc86e2972e3a4bc44679bfd47fad0d423cabf080\", \"blink_heap_unittests\": \"510d03c7e17499edb93c1acb3fc3333e8f566c10\", \"blink_platform_unittests\": \"f5564fd83523f06eb506bb0bff26ed6a72b59c55\", \"blink_unittests\": \"9fd71f471978d98ac8196727fa5689d49a02c0bf\", \"boringssl_crypto_tests\": \"8e4bcc4f5953c9f5b5158e19e6264b9b7cb27058\", \"boringssl_ssl_tests\": \"677a8f73ff635b8eb4519d731e438b303065d3f3\", \"browser_switcher_bho_unittests\": \"ae6de0200892e1a957cbc8f1723658c00c36c86b\", \"browser_tests\": \"806cda1affb537f47a37919507d713b82ecaa4b8\", \"capture_unittests\": \"78ebf56ec851297c418c117815256819bd3f2ace\", \"cast_unittests\": \"da24b5f593edcc95d245ab49079a80c5bbe1295d\", \"cc_unittests\": \"6d58541e5e95dbe3507cf793a5ecb8c493f8c63c\", \"chrome_app_unittests\": \"d3ec3134a2c47a45dc44b046292c9104da6e067c\", \"chrome_cleaner_unittests\": \"39cf17b7a919afc3ce1aff1c28bc2a203b27d953\", \"chrome_elf_unittests\": \"737019b1b80668208d1d3a6c5716df3949907c32\", \"chromedriver_unittests\": \"c3bd64530fceea8f2e9a541150a384f0dff51bfb\", \"components_browsertests\": \"509439942eda9b7bde1213dbea87f8c25832b969\", \"components_unittests\": \"ef2a1905deadc61c2ec3a4eb505575c51d2a8082\", \"compositor_unittests\": \"674d185f47cedf3badbbb551ba19b5c179110b4e\", \"content_browsertests\": \"967d871747a3f4820ca63c362c770e09424af72e\", \"content_unittests\": \"8367ca0454ee5e68605787fb7d95c3f3e18ee66f\", \"courgette_unittests\": \"fa19ef6d7ebf6ec93ad130f7913803e81b6f20fe\", \"crashpad_tests\": \"15e00eeb7ed95f8bc5bd165c521a53d1f5af3b95\", \"cronet_tests\": \"8a71c6e1cfa5b11fe2ad7f35ccd286681b188b78\", \"cronet_unittests\": \"9658c7f89fc51cf637fe6e2b97d1ae329332c899\", \"crypto_unittests\": \"938653690544de6ce0eabf6d3d0cbf246c1aee87\", \"delayloads_unittests\": \"1d4205215c11a489251ce4535244986d8b95d5d7\", \"device_unittests\": \"ee0e50549bd4943392a21d0ec555786c79e53a90\", \"display_unittests\": \"be94fd98718c6b268974d2aaced3cfd233be8228\", \"elevation_service_unittests\": \"f9d282925e6d620bbf87f7b13d8b5fc22a63ec74\", \"events_unittests\": \"77b8296649e39f9dab71e8b198ae092ad6fe66ed\", \"extensions_browsertests\": \"4f0895b62eeea44805251242028abf0d1d94fad2\", \"extensions_unittests\": \"a47aad5a23c72166fecb851b732ce3084540497d\", \"filesystem_service_unittests\": \"66b36c33255fec5244c2029902a3c3f1231aaa31\", \"gcm_unit_tests\": \"88845cc22c2baf9edc75f67a28c1f8c7ce45f89a\", \"gcp_unittests\": \"3cbd53ec329debb43e51cf60a05ee48ebd4e742c\", \"gfx_unittests\": \"19b0e9fb4849939ead170ad170aba486980e6cff\", \"gin_unittests\": \"8e758b2c076f2200b7008d76337a91fff8c6d53a\", \"google_apis_unittests\": \"62f6ce2a289173b30a5eade5efd321c9e594edab\", \"gpu_unittests\": \"819d9f700d2e035dab1554c4c6f8a1ee6183559b\", \"gwp_asan_unittests\": \"01843b85ea0b88ad478fd17011a60db2adec67cf\", \"headless_browsertests\": \"74e9e984b3dab827dcb1bf0afc97bb7e5c5d4cf7\", \"headless_unittests\": \"ed16765eeedd2859b7e8ee8b90f4c56fb1a61a4b\", \"install_static_unittests\": \"ec6d0d57d63b8f6645a011da2ce2e5271ce4ce97\", \"installer_util_unittests\": \"0d6f2bfb3f4c3b17aad992c510d0cfd8f7cf1832\", \"interactive_ui_tests\": \"9465cc1c7355172fa22fe4bf9d741c0fc109a69f\", \"ipc_tests\": \"e7e5c71304485d399deb9ba5f6ddce4dfa057d01\", \"jingle_unittests\": \"c3b3dcfc047b71817b55520b27f5b91ef180a7dd\", \"latency_unittests\": \"8ca4b27fd198052b336e8a494fa6132f6b8fd594\", \"libjingle_xmpp_unittests\": \"792622c33152c5491fc9ba928a35297b41185bc8\", \"liburlpattern_unittests\": \"6e575255f6fb1ede93a071fb0f21de50fbf88a0b\", \"media_blink_unittests\": \"fce5915094c5de4d47278cf495721e2f2da48a80\", \"media_unittests\": \"b9b7871163b49f6b30df8cff28257c6afd9fe942\", \"message_center_unittests\": \"f9691d599bb1c925744fc3778a7912f2232e1c0e\", \"midi_unittests\": \"cda286ac549a1355673963038ffd7ad747cb8dfe\", \"mojo_core_unittests\": \"3701867261c5349b5e73169b8b4c5652c9cf50f3\", \"mojo_unittests\": \"be1f494c973cce91433ab9a70de9caad658356b7\", \"nacl_loader_unittests\": \"80e67bf2863f392a1167c9e5a91a539e7a0d4981\", \"native_theme_unittests\": \"281ce9a5a4eabf42d681b970393af58f09583d2f\", \"net_unittests\": \"dff3646dc7be03746cc8c34667150d8cfe55f667\", \"notification_helper_unittests\": \"56a9d3a913e8338df231d76ba05fe8951f5e6970\", \"pdf_unittests\": \"216001214bdd04eb3e3073eae017c6f3f7a8b8ee\", \"perfetto_unittests\": \"7387bc504a826fa5f29206c79b5e5ccd03a9f8cc\", \"ppapi_unittests\": \"19eaa0a54084bd97640c908c2afe2cc71af9dbfb\", \"printing_unittests\": \"f05fd8b10caafb1efd873ab4efb10d4a0fdcedba\", \"remoting_unittests\": \"3571cb4b41f7118b8458fd2b59a74489937d6a4e\", \"sbox_integration_tests\": \"849204802376b773aee17daa2645adc83c4d6ccd\", \"sbox_unittests\": \"201a7c606e6e7c4c5ad33e1c2a3e2cf39bcad4a2\", \"sbox_validation_tests\": \"eaa3301c9fcaf90cfa392f43759b3107f14cf32b\", \"service_manager_unittests\": \"5ec765f2057196cf48b02e46ce5adc9067b01814\", \"services_unittests\": \"bd0a02533628c8ed3ba9b156cf5d892efc81318c\", \"setup_unittests\": \"58b6620feb036c8b22b2b848f85e3d2e4f512acc\", \"shell_dialogs_unittests\": \"a3a0fa732f580c9dda9264afcedc3d3dd0ec66ea\", \"skia_unittests\": \"6adadbd332d6ada032d86b1c9beeb2ddf1781f60\", \"snapshot_unittests\": \"eaff9176e0f00346ac68b53bfe3802c711cb532c\", \"sql_unittests\": \"c63938f50f1f58bde2e21f6766f9bf9869aa9b64\", \"storage_unittests\": \"f1ac984785c4a3f6c559ac530fe20114f1e3ae3f\", \"sync_integration_tests\": \"98d6ff610ec0e725e83ac214c7635a35b98277a2\", \"traffic_annotation_auditor_unittests\": \"1469774ae276551f99d85270020edebadc88145b\", \"ui_base_unittests\": \"febe042e4ed89c08edcef2c415e25a941e1f084e\", \"ui_touch_selection_unittests\": \"ad06a089f0fb4a5401fb32ebb7ee3b9d56f375bd\", \"unit_tests\": \"bc1a44fd8ac31e61ffa12b411ccf08ab2a846efe\", \"updater_tests\": \"b9b663e1a6d4be24d45c6a400841e032669527e2\", \"url_unittests\": \"11992bef47edb650ce3b182a97f3a2023e5d723c\", \"views_unittests\": \"850f3cf516169c8a151489478390edd303181df8\", \"viz_unittests\": \"262297f7954d7a1b82360bb43dabe57660d78c81\", \"vr_common_unittests\": \"78becb4a92bc68c3c43e87d82f152057b5e7bf6c\", \"vr_pixeltests\": \"5597d0bfb932f0dda367772724489152fe0bbbdb\", \"weblayer_browsertests\": \"ef639c2ad08028c9dac7fbcee6db873d95575aad\", \"weblayer_unittests\": \"f86261aa8fbee5f8bf76e126a131557b406ebcac\", \"wm_unittests\": \"2bd3eae2505ce7ef8b5165a30d0167cae93d84fc\", \"wtf_unittests\": \"827296b579d6aadd1f2c009db554e1c050da4605\", \"zlib_unittests\": \"5080115b9399fe5445165daf863d6aa3d42eb15a\", \"zucchini_unittests\": \"64f0dc7b9f2e9aed2fb7eef771fba318df698d9f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_64c7a62a02e0da5ef76200bb7658267e40edf0984fe7c0f995e5999242969052_v2\", \"builder_c244a7c1904bb59c4b6cd021ade0aa3730bbe3d07abc076b32cf6cdc63527337_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-us-central1-b-32-0-7rud\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- MSE_ExternalClearKey/EncryptedMediaTest.Playback_VP9Video_WebM_Subsample/0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605839880517355",
"status": "COMPLETED",
"status_changed_ts": "1605839882032105",
"tags": [
"build_address:luci.chromium.ci/win-asan/15732",
"builder:win-asan",
"buildset:commit/git/b3604ebbdbfb5291ebf39b34fdf314f93dc904b6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b3604ebbdbfb5291ebf39b34fdf314f93dc904b6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028578798246394352",
"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/8863148735985542096/+/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:4ffc52f339a03f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605846108502789",
"url": "https://ci.chromium.org/b/8863148735985542096",
"utcnow_ts": "1605846109364333"
}
}
[04:21:49.390] Invocation finished in 1h46m40.719947932s with status FAILED