[12:20:10.292] New invocation is queued and will start shortly
[12:20:11.414] Starting the invocation (attempt 1)
[12:20:11.483] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:20:11.483] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:20:11.483] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018123340405557312",
"parameters_json": "{\"builder_name\":\"win-asan\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4b8318a8fa9a37b5d2312dc958087ade8ee61623\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-asan",
"scheduler_invocation_id:9018123340405557312",
"scheduler_job_id:chromium/win-asan",
"user_agent:luci-scheduler",
"buildset:commit/git/4b8318a8fa9a37b5d2312dc958087ade8ee61623",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4b8318a8fa9a37b5d2312dc958087ade8ee61623",
"gitiles_ref:refs/heads/master"
]
}
[12:20:12.488] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1615810811607071",
"id": "8852693278366630496",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4b8318a8fa9a37b5d2312dc958087ade8ee61623\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615810812301133",
"tags": [
"build_address:luci.chromium.ci/win-asan/17802",
"builder:win-asan",
"buildset:commit/git/4b8318a8fa9a37b5d2312dc958087ade8ee61623",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4b8318a8fa9a37b5d2312dc958087ade8ee61623",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018123340405557312",
"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/8852693278366630496/+/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": "1615810812301244",
"url": "https://ci.chromium.org/b/8852693278366630496",
"utcnow_ts": "1615810812480013"
}
}
[12:20:12.488] Task URL: https://ci.chromium.org/b/8852693278366630496
[12:20:12.488] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:2:0) after 1m0s
[12:21:13.260] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:2:0)
[12:21:13.260] Timer tick, asking Buildbucket for the build status
[12:21:13.354] Build 8852693278366630496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:21:13.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:3:0) after 1m0s
[12:22:13.517] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:3:0)
[12:22:13.517] Timer tick, asking Buildbucket for the build status
[12:22:13.577] Build 8852693278366630496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:22:13.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:4:0) after 1m0s
[12:23:13.802] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:4:0)
[12:23:13.802] Timer tick, asking Buildbucket for the build status
[12:23:13.929] Build 8852693278366630496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:23:13.929] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:5:0) after 1m0s
[12:24:14.078] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:5:0)
[12:24:14.078] Timer tick, asking Buildbucket for the build status
[12:24:14.175] Build 8852693278366630496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:24:14.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:6:0) after 1m0s
[12:25:14.323] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:6:0)
[12:25:14.323] Timer tick, asking Buildbucket for the build status
[12:25:14.434] Build 8852693278366630496: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:25:14.434] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:7:0) after 1m0s
[12:25:28.446] Received PubSub notification, asking Buildbucket for the build status
[12:25:28.699] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:14.580] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:7:0)
[12:26:14.580] Timer tick, asking Buildbucket for the build status
[12:26:14.704] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:14.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:9:0) after 1m0s
[12:27:14.820] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:9:0)
[12:27:14.820] Timer tick, asking Buildbucket for the build status
[12:27:14.908] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:14.908] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:10:0) after 1m0s
[12:28:14.960] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:10:0)
[12:28:14.960] Timer tick, asking Buildbucket for the build status
[12:28:15.061] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:15.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:11:0) after 1m0s
[12:29:15.181] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:11:0)
[12:29:15.181] Timer tick, asking Buildbucket for the build status
[12:29:15.246] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:15.246] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:12:0) after 1m0s
[12:30:15.372] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:12:0)
[12:30:15.372] Timer tick, asking Buildbucket for the build status
[12:30:15.462] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:15.462] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:13:0) after 1m0s
[12:31:15.535] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:13:0)
[12:31:15.535] Timer tick, asking Buildbucket for the build status
[12:31:15.642] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:15.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:14:0) after 1m0s
[12:32:15.612] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:14:0)
[12:32:15.612] Timer tick, asking Buildbucket for the build status
[12:32:15.737] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:15.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:15:0) after 1m0s
[12:33:15.762] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:15:0)
[12:33:15.762] Timer tick, asking Buildbucket for the build status
[12:33:15.835] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:15.835] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:16:0) after 1m0s
[12:34:15.855] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:16:0)
[12:34:15.855] Timer tick, asking Buildbucket for the build status
[12:34:15.940] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:15.940] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:17:0) after 1m0s
[12:35:15.991] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:17:0)
[12:35:15.991] Timer tick, asking Buildbucket for the build status
[12:35:16.097] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:16.097] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:18:0) after 1m0s
[12:36:16.111] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:18:0)
[12:36:16.111] Timer tick, asking Buildbucket for the build status
[12:36:16.182] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:16.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:19:0) after 1m0s
[12:37:16.164] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:19:0)
[12:37:16.164] Timer tick, asking Buildbucket for the build status
[12:37:16.244] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:16.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:20:0) after 1m0s
[12:38:16.284] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:20:0)
[12:38:16.284] Timer tick, asking Buildbucket for the build status
[12:38:16.440] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:16.440] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:21:0) after 1m0s
[12:39:16.487] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:21:0)
[12:39:16.487] Timer tick, asking Buildbucket for the build status
[12:39:16.572] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:16.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:22:0) after 1m0s
[12:40:16.660] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:22:0)
[12:40:16.660] Timer tick, asking Buildbucket for the build status
[12:40:17.006] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:17.006] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:23:0) after 1m0s
[12:41:17.061] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:23:0)
[12:41:17.061] Timer tick, asking Buildbucket for the build status
[12:41:17.121] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:17.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:24:0) after 1m0s
[12:42:17.139] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:24:0)
[12:42:17.139] Timer tick, asking Buildbucket for the build status
[12:42:17.209] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:17.209] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:25:0) after 1m0s
[12:43:17.211] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:25:0)
[12:43:17.211] Timer tick, asking Buildbucket for the build status
[12:43:17.452] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:17.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:26:0) after 1m0s
[12:44:17.557] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:26:0)
[12:44:17.557] Timer tick, asking Buildbucket for the build status
[12:44:17.634] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:17.634] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:27:0) after 1m0s
[12:45:17.696] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:27:0)
[12:45:17.696] Timer tick, asking Buildbucket for the build status
[12:45:17.854] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:17.854] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:28:0) after 1m0s
[12:46:17.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:28:0)
[12:46:17.923] Timer tick, asking Buildbucket for the build status
[12:46:18.007] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:18.007] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:29:0) after 1m0s
[12:47:18.025] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:29:0)
[12:47:18.025] Timer tick, asking Buildbucket for the build status
[12:47:18.135] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:18.135] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:30:0) after 1m0s
[12:48:18.189] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:30:0)
[12:48:18.189] Timer tick, asking Buildbucket for the build status
[12:48:18.306] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:18.306] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:31:0) after 1m0s
[12:49:19.911] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:31:0)
[12:49:19.911] Timer tick, asking Buildbucket for the build status
[12:49:20.143] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:20.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:32:0) after 1m0s
[12:50:20.257] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:32:0)
[12:50:20.257] Timer tick, asking Buildbucket for the build status
[12:50:20.503] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:20.503] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:33:0) after 1m0s
[12:51:20.702] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:33:0)
[12:51:20.702] Timer tick, asking Buildbucket for the build status
[12:51:20.955] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:20.955] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:34:0) after 1m0s
[12:52:20.944] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:34:0)
[12:52:20.944] Timer tick, asking Buildbucket for the build status
[12:52:21.505] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:21.505] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:35:0) after 1m0s
[12:53:21.527] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:35:0)
[12:53:21.527] Timer tick, asking Buildbucket for the build status
[12:53:21.834] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:21.834] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:36:0) after 1m0s
[12:54:21.938] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:36:0)
[12:54:21.938] Timer tick, asking Buildbucket for the build status
[12:54:22.041] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:22.041] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:37:0) after 1m0s
[12:55:22.196] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:37:0)
[12:55:22.196] Timer tick, asking Buildbucket for the build status
[12:55:22.318] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:22.318] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:38:0) after 1m0s
[12:56:22.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:38:0)
[12:56:22.359] Timer tick, asking Buildbucket for the build status
[12:56:22.577] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:22.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:39:0) after 1m0s
[12:57:22.596] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:39:0)
[12:57:22.596] Timer tick, asking Buildbucket for the build status
[12:57:22.671] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:22.671] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:40:0) after 1m0s
[12:58:22.703] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:40:0)
[12:58:22.703] Timer tick, asking Buildbucket for the build status
[12:58:22.780] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:22.780] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:41:0) after 1m0s
[12:59:22.895] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:41:0)
[12:59:22.895] Timer tick, asking Buildbucket for the build status
[12:59:22.978] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:22.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:42:0) after 1m0s
[13:00:23.199] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:42:0)
[13:00:23.199] Timer tick, asking Buildbucket for the build status
[13:00:23.292] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:23.292] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:43:0) after 1m0s
[13:01:23.310] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:43:0)
[13:01:23.310] Timer tick, asking Buildbucket for the build status
[13:01:23.428] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:23.428] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:44:0) after 1m0s
[13:02:23.514] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:44:0)
[13:02:23.515] Timer tick, asking Buildbucket for the build status
[13:02:23.628] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:23.628] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:45:0) after 1m0s
[13:03:23.668] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:45:0)
[13:03:23.668] Timer tick, asking Buildbucket for the build status
[13:03:23.750] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:23.750] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:46:0) after 1m0s
[13:04:23.876] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:46:0)
[13:04:23.876] Timer tick, asking Buildbucket for the build status
[13:04:23.998] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:23.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:47:0) after 1m0s
[13:05:24.131] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:47:0)
[13:05:24.131] Timer tick, asking Buildbucket for the build status
[13:05:24.365] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:24.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:48:0) after 1m0s
[13:06:24.435] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:48:0)
[13:06:24.435] Timer tick, asking Buildbucket for the build status
[13:06:24.641] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:24.642] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:49:0) after 1m0s
[13:07:24.821] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:49:0)
[13:07:24.821] Timer tick, asking Buildbucket for the build status
[13:07:24.919] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:24.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:50:0) after 1m0s
[13:08:24.978] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:50:0)
[13:08:24.978] Timer tick, asking Buildbucket for the build status
[13:08:25.114] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:25.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:51:0) after 1m0s
[13:09:25.165] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:51:0)
[13:09:25.165] Timer tick, asking Buildbucket for the build status
[13:09:25.253] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:25.253] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:52:0) after 1m0s
[13:10:25.295] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:52:0)
[13:10:25.295] Timer tick, asking Buildbucket for the build status
[13:10:25.531] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:25.531] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:53:0) after 1m0s
[13:11:25.584] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:53:0)
[13:11:25.584] Timer tick, asking Buildbucket for the build status
[13:11:26.711] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:26.711] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:54:0) after 1m0s
[13:12:26.728] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:54:0)
[13:12:26.728] Timer tick, asking Buildbucket for the build status
[13:12:26.953] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:26.954] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:55:0) after 1m0s
[13:13:27.005] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:55:0)
[13:13:27.005] Timer tick, asking Buildbucket for the build status
[13:13:27.071] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:27.071] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:56:0) after 1m0s
[13:14:27.124] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:56:0)
[13:14:27.124] Timer tick, asking Buildbucket for the build status
[13:14:27.190] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:27.190] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:57:0) after 1m0s
[13:15:27.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:57:0)
[13:15:27.200] Timer tick, asking Buildbucket for the build status
[13:15:27.291] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:27.291] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:58:0) after 1m0s
[13:16:27.317] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:58:0)
[13:16:27.321] Timer tick, asking Buildbucket for the build status
[13:16:27.409] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:27.409] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:59:0) after 1m0s
[13:17:27.468] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:59:0)
[13:17:27.468] Timer tick, asking Buildbucket for the build status
[13:17:27.573] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:27.573] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:60:0) after 1m0s
[13:18:27.582] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:60:0)
[13:18:27.582] Timer tick, asking Buildbucket for the build status
[13:18:27.778] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:27.778] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:61:0) after 1m0s
[13:19:27.870] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:61:0)
[13:19:27.870] Timer tick, asking Buildbucket for the build status
[13:19:28.125] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:28.125] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:62:0) after 1m0s
[13:20:28.154] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:62:0)
[13:20:28.154] Timer tick, asking Buildbucket for the build status
[13:20:28.254] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:28.254] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:63:0) after 1m0s
[13:21:28.380] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:63:0)
[13:21:28.380] Timer tick, asking Buildbucket for the build status
[13:21:28.470] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:28.470] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:64:0) after 1m0s
[13:22:28.520] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:64:0)
[13:22:28.520] Timer tick, asking Buildbucket for the build status
[13:22:29.002] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:29.002] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:65:0) after 1m0s
[13:23:29.100] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:65:0)
[13:23:29.100] Timer tick, asking Buildbucket for the build status
[13:23:32.052] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:32.052] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:66:0) after 1m0s
[13:24:32.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:66:0)
[13:24:32.200] Timer tick, asking Buildbucket for the build status
[13:24:32.354] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:32.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:67:0) after 1m0s
[13:25:32.512] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:67:0)
[13:25:32.512] Timer tick, asking Buildbucket for the build status
[13:25:32.621] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:32.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:68:0) after 1m0s
[13:26:32.682] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:68:0)
[13:26:32.682] Timer tick, asking Buildbucket for the build status
[13:26:32.836] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:32.836] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:69:0) after 1m0s
[13:27:32.917] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:69:0)
[13:27:32.917] Timer tick, asking Buildbucket for the build status
[13:27:32.985] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:32.985] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:70:0) after 1m0s
[13:28:33.010] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:70:0)
[13:28:33.010] Timer tick, asking Buildbucket for the build status
[13:28:33.085] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:33.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:71:0) after 1m0s
[13:29:33.089] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:71:0)
[13:29:33.089] Timer tick, asking Buildbucket for the build status
[13:29:33.158] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:33.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:72:0) after 1m0s
[13:30:33.209] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:72:0)
[13:30:33.209] Timer tick, asking Buildbucket for the build status
[13:30:33.303] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:33.303] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:73:0) after 1m0s
[13:31:33.454] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:73:0)
[13:31:33.454] Timer tick, asking Buildbucket for the build status
[13:31:33.765] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:33.765] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:74:0) after 1m0s
[13:32:33.831] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:74:0)
[13:32:33.831] Timer tick, asking Buildbucket for the build status
[13:32:34.088] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:34.088] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:75:0) after 1m0s
[13:33:34.207] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:75:0)
[13:33:34.207] Timer tick, asking Buildbucket for the build status
[13:33:34.349] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:34.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:76:0) after 1m0s
[13:34:34.452] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:76:0)
[13:34:34.452] Timer tick, asking Buildbucket for the build status
[13:34:34.730] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:34.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:77:0) after 1m0s
[13:35:34.796] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:77:0)
[13:35:34.796] Timer tick, asking Buildbucket for the build status
[13:35:34.872] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:34.872] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:78:0) after 1m0s
[13:36:34.923] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:78:0)
[13:36:34.923] Timer tick, asking Buildbucket for the build status
[13:36:35.056] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:35.056] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:79:0) after 1m0s
[13:37:35.075] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:79:0)
[13:37:35.075] Timer tick, asking Buildbucket for the build status
[13:37:35.211] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:35.211] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:80:0) after 1m0s
[13:38:35.210] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:80:0)
[13:38:35.210] Timer tick, asking Buildbucket for the build status
[13:38:35.403] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:35.403] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:81:0) after 1m0s
[13:39:35.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:81:0)
[13:39:35.502] Timer tick, asking Buildbucket for the build status
[13:39:35.572] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:35.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:82:0) after 1m0s
[13:40:35.659] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:82:0)
[13:40:35.659] Timer tick, asking Buildbucket for the build status
[13:40:36.363] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:36.363] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:83:0) after 1m0s
[13:41:36.415] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:83:0)
[13:41:36.415] Timer tick, asking Buildbucket for the build status
[13:41:36.679] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:36.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:84:0) after 1m0s
[13:42:36.736] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:84:0)
[13:42:36.736] Timer tick, asking Buildbucket for the build status
[13:42:37.012] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:37.012] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:85:0) after 1m0s
[13:43:37.032] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:85:0)
[13:43:37.032] Timer tick, asking Buildbucket for the build status
[13:43:37.128] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:37.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:86:0) after 1m0s
[13:44:37.170] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:86:0)
[13:44:37.170] Timer tick, asking Buildbucket for the build status
[13:44:37.981] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:37.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:87:0) after 1m0s
[13:45:38.049] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:87:0)
[13:45:38.049] Timer tick, asking Buildbucket for the build status
[13:45:38.150] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:38.150] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:88:0) after 1m0s
[13:46:38.173] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:88:0)
[13:46:38.173] Timer tick, asking Buildbucket for the build status
[13:46:38.257] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:38.257] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:89:0) after 1m0s
[13:47:38.309] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:89:0)
[13:47:38.309] Timer tick, asking Buildbucket for the build status
[13:47:38.397] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:38.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:90:0) after 1m0s
[13:48:38.502] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:90:0)
[13:48:38.502] Timer tick, asking Buildbucket for the build status
[13:48:38.665] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:38.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:91:0) after 1m0s
[13:49:38.693] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:91:0)
[13:49:38.693] Timer tick, asking Buildbucket for the build status
[13:49:38.779] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:38.779] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:92:0) after 1m0s
[13:50:38.773] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:92:0)
[13:50:38.773] Timer tick, asking Buildbucket for the build status
[13:50:39.346] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:39.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:93:0) after 1m0s
[13:51:39.367] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:93:0)
[13:51:39.367] Timer tick, asking Buildbucket for the build status
[13:51:39.450] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:39.451] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:94:0) after 1m0s
[13:52:39.510] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:94:0)
[13:52:39.510] Timer tick, asking Buildbucket for the build status
[13:52:39.612] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:39.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:95:0) after 1m0s
[13:53:39.646] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:95:0)
[13:53:39.646] Timer tick, asking Buildbucket for the build status
[13:53:39.717] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:39.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:96:0) after 1m0s
[13:54:39.763] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:96:0)
[13:54:39.763] Timer tick, asking Buildbucket for the build status
[13:54:39.843] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:39.843] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:97:0) after 1m0s
[13:55:39.891] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:97:0)
[13:55:39.891] Timer tick, asking Buildbucket for the build status
[13:55:40.003] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:40.003] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:98:0) after 1m0s
[13:56:40.046] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:98:0)
[13:56:40.046] Timer tick, asking Buildbucket for the build status
[13:56:40.143] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:40.143] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:99:0) after 1m0s
[13:57:40.200] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:99:0)
[13:57:40.200] Timer tick, asking Buildbucket for the build status
[13:57:40.320] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:40.320] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:100:0) after 1m0s
[13:58:40.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:100:0)
[13:58:40.359] Timer tick, asking Buildbucket for the build status
[13:58:40.624] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:40.624] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:101:0) after 1m0s
[13:59:40.694] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:101:0)
[13:59:40.694] Timer tick, asking Buildbucket for the build status
[13:59:40.777] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:40.777] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:102:0) after 1m0s
[14:00:40.973] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:102:0)
[14:00:40.973] Timer tick, asking Buildbucket for the build status
[14:00:41.061] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:41.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:103:0) after 1m0s
[14:01:41.146] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:103:0)
[14:01:41.146] Timer tick, asking Buildbucket for the build status
[14:01:41.244] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:41.244] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:104:0) after 1m0s
[14:02:41.265] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:104:0)
[14:02:41.265] Timer tick, asking Buildbucket for the build status
[14:02:41.389] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:41.389] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:105:0) after 1m0s
[14:03:41.381] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:105:0)
[14:03:41.381] Timer tick, asking Buildbucket for the build status
[14:03:41.569] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:41.569] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:106:0) after 1m0s
[14:04:41.551] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:106:0)
[14:04:41.551] Timer tick, asking Buildbucket for the build status
[14:04:41.626] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:41.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:107:0) after 1m0s
[14:05:41.650] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:107:0)
[14:05:41.650] Timer tick, asking Buildbucket for the build status
[14:05:41.739] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:41.739] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:108:0) after 1m0s
[14:06:41.757] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:108:0)
[14:06:41.757] Timer tick, asking Buildbucket for the build status
[14:06:41.904] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:41.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:109:0) after 1m0s
[14:07:41.892] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:109:0)
[14:07:41.892] Timer tick, asking Buildbucket for the build status
[14:07:42.040] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:42.040] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:110:0) after 1m0s
[14:08:42.094] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:110:0)
[14:08:42.094] Timer tick, asking Buildbucket for the build status
[14:08:42.166] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:42.166] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:111:0) after 1m0s
[14:09:42.227] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:111:0)
[14:09:42.227] Timer tick, asking Buildbucket for the build status
[14:09:42.492] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:42.492] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:112:0) after 1m0s
[14:10:42.498] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:112:0)
[14:10:42.498] Timer tick, asking Buildbucket for the build status
[14:10:42.677] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:42.677] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:113:0) after 1m0s
[14:11:42.724] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:113:0)
[14:11:42.724] Timer tick, asking Buildbucket for the build status
[14:11:42.867] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:42.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:114:0) after 1m0s
[14:12:42.888] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:114:0)
[14:12:42.888] Timer tick, asking Buildbucket for the build status
[14:12:43.295] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:43.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:115:0) after 1m0s
[14:13:43.359] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:115:0)
[14:13:43.359] Timer tick, asking Buildbucket for the build status
[14:13:43.465] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:43.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:116:0) after 1m0s
[14:14:44.217] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:116:0)
[14:14:44.217] Timer tick, asking Buildbucket for the build status
[14:14:44.354] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:44.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:117:0) after 1m0s
[14:15:44.600] Handling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:117:0)
[14:15:44.600] Timer tick, asking Buildbucket for the build status
[14:15:44.704] Build 8852693278366630496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:44.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-asan:9018123340405557312:118:0) after 1m0s
[14:16:42.427] Received PubSub notification, asking Buildbucket for the build status
[14:16:42.582] Build 8852693278366630496: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[14:16:42.582] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1615817802111401",
"created_by": "project:chromium",
"created_ts": "1615810811607071",
"failure_reason": "BUILD_FAILURE",
"id": "8852693278366630496",
"parameters_json": "{\"builder_name\": \"win-asan\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4b8318a8fa9a37b5d2312dc958087ade8ee61623\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**gcp_unittests** failed because of:\\n\\n- All/GcpGaiaCredentialBasePasswordRecoveryTest.PasswordRecovery/14\"}, \"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\": \"4b8318a8fa9a37b5d2312dc958087ade8ee61623\", \"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-10-dcpw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"win-asan\", \"buildnumber\": 17802, \"clang_revision\": \"llvmorg-13-init-3462-gfe5c2c3c-2\", \"got_angle_revision\": \"45ce8d1e89ea780ed7f87a10e65a6d12c0ca5d33\", \"got_dawn_revision\": \"d41aa4378d25e551e6e2f3ae0406757e994ff24b\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"4b8318a8fa9a37b5d2312dc958087ade8ee61623\", \"got_revision_cp\": \"refs/heads/master@{#862781}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"5cdf55ff2084d8aa719fe74fbe1622b61ff64294\", \"got_v8_revision\": \"0560234773bbbac133fbff9e109b07cc23df8752\", \"got_v8_revision_cp\": \"refs/heads/9.1.108@{#2}\", \"got_webrtc_revision\": \"86473404362e38131203537b8a8c8ec7c1abc31a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33444}\", \"is_cached\": false, \"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\": \"4b8318a8fa9a37b5d2312dc958087ade8ee61623\", \"swarm_hashes_refs/heads/master(at){#862781}_without_patch\": {\"absl_hardening_tests\": \"08a7b230d2fd9b5388ef38db6134dbe0e0cf2601\", \"accessibility_unittests\": \"75460339374714074b089ae0ff347bad3f6119e8\", \"angle_unittests\": \"8e78fbd99facaf666666a9aea3811048f4dcc120\", \"app_shell_unittests\": \"84a57304f7789600019321ea6621df8784dfa868\", \"aura_unittests\": \"9a02fac73d90a942dd664e1776ff95b0cbd8dc82\", \"base_unittests\": \"a0fd8eeb40bfb70ed1395236cb61b23405ee34e8\", \"base_util_unittests\": \"3c0842ec9961665e1c11c871c00e796b0e9b1914\", \"blink_common_unittests\": \"d2f9c1f7bd692029abc0f0fbc272dd52a31be4ac\", \"blink_fuzzer_unittests\": \"1dfb54ab479e95f6aabe67590f261013ffe0ddd3\", \"blink_heap_unittests\": \"97330db5a52707f66e8b37a443439c0b33cf337f\", \"blink_platform_unittests\": \"c2ca8152200165b8cf2e5554281be587b4346035\", \"blink_unittests\": \"d3a5bc410eb8ec1aba8df31ee4e67d18dc57a511\", \"boringssl_crypto_tests\": \"4f38fa4699c6895e2fae3b0ee09a2cc91c63b683\", \"boringssl_ssl_tests\": \"89f2fa68eb48e0e8f689bb85dd09ed1bdb3e56f4\", \"browser_switcher_bho_unittests\": \"1272233825fd17cc924931972bcdf61cbcc4b894\", \"browser_tests\": \"958516ad8cbac12df2bb219d40d74000d93d2ab5\", \"capture_unittests\": \"81e02d91c3af44997e9ad22352418b8237cc2d1c\", \"cast_unittests\": \"fa25783ef13bc22d0cf0960fe52addd6a0bb4414\", \"cc_unittests\": \"fc8a009628ca0c1674d430685d2ee2b3857946e2\", \"chrome_app_unittests\": \"1d4145f69ec5ecf90508d8245793820e1dec851c\", \"chrome_cleaner_unittests\": \"f4cadf1d61fbff8323085d14617f4975ff1f425a\", \"chrome_elf_unittests\": \"97f087f95ff88699d205b81a31f6402c1fbabb19\", \"chromedriver_unittests\": \"f97d1561767e2c12eb43b240a2ecdb0e534dfab0\", \"color_unittests\": \"88b7b3f6cc7dd0a20016d39fbf3f40d84c80ff71\", \"components_browsertests\": \"097a264d2d582564ed53c710c948bbb0689d642c\", \"components_unittests\": \"11c0f3bb843a25b1320e3e65e899ea6bfec0f005\", \"compositor_unittests\": \"14e9edd56f68dde56b560676ed8a0cdf640b0e53\", \"content_browsertests\": \"4861104d835adac4c9496cf481194370a89ebe23\", \"content_unittests\": \"24910157ab357267d7cb3290b012bc9712b69787\", \"courgette_unittests\": \"d72542338355c8d8880f56bf853ec2351049f4ab\", \"crashpad_tests\": \"08be87c04a80654ae20d020317a42151891562bf\", \"cronet_tests\": \"789af6d219d9c2a9d3b60c56fa9d0ad89ae4165c\", \"cronet_unittests\": \"1b4a032d1de48e3f7b27b5244ba1e2d1a9ec9fa6\", \"crypto_unittests\": \"6466dca4ccb3f1a6919862b2c4698af69677bfb4\", \"delayloads_unittests\": \"2cf2be3db934f401d1c03495e05f975d574a10b5\", \"device_unittests\": \"3fa56d1780793ddb449b47392e81816dd5c1b8d0\", \"display_unittests\": \"7b87251aea57500401b25f2c1e99298cec6b5dee\", \"elevation_service_unittests\": \"1101f6b5b7d3d2a2af365374c9712d8c1eb29f19\", \"events_unittests\": \"82d4d089f7125b1d7161507c4d80ab386df0dbbc\", \"extensions_browsertests\": \"cc8801d8cf55e84eb104d9ae12eb18cf19db83a1\", \"extensions_unittests\": \"dbdfb0e5d050c944a1f4f5045c126c8d49746bf5\", \"filesystem_service_unittests\": \"90a73adad6ac1edb76a11a4db45b15ae0e459edc\", \"gcm_unit_tests\": \"027435a68cd8c15982adae4c04ebf824a46fe9e2\", \"gcp_unittests\": \"d66aa757f0a5676efd03c0d4ed41547a41a230c9\", \"gfx_unittests\": \"73b013190851787e48aee034f967a2460186d5ae\", \"gin_unittests\": \"25e715c93195a90a12c3e4fe6eb959c8fb7b51d8\", \"google_apis_unittests\": \"327d28639654b259bdd9cd978ebcfe77c745ca29\", \"gpu_unittests\": \"8a38f1aba41173c125d86f381479ac640be568e0\", \"gwp_asan_unittests\": \"60efb8626fe269e38577e0387d90b522a9020ec8\", \"headless_browsertests\": \"c588bf8f4b4eafe7059a66d3a61cf04ade93421b\", \"headless_unittests\": \"33307e1c731ccc2828e7740f26f0bc078ebf4021\", \"install_static_unittests\": \"47c08ecd78d5a65ef7bf814b74b562737f6e9a3a\", \"installer_util_unittests\": \"649738a78efe64b3aa74a647ac7e6c17400c2a1a\", \"interactive_ui_tests\": \"985c1e4a12bc3d95ab551719b26f3402fb0dbeea\", \"ipc_tests\": \"0c079c6256b5a99b762c3787223239193b45d2a4\", \"jingle_unittests\": \"1ae30ab500175cee609bf9b79ef5f7edd8315b29\", \"latency_unittests\": \"99a493ed79bc29014448ac2089ad90ab54c9ec1e\", \"libjingle_xmpp_unittests\": \"f9aacd061be550e88d1fc70ccc2b7fb2a2ec3f4b\", \"liburlpattern_unittests\": \"14a4f3ea4326e8f4a168cae1e7f0cc7daddd862a\", \"media_blink_unittests\": \"9d2c0ed9e67ba526ac539e0bc2a09cc86f2f281c\", \"media_unittests\": \"e2eafc82d7d86480db255c2c021913a513251a91\", \"message_center_unittests\": \"02b6fee6d223359d9cfb938e792f6c6d7525afdb\", \"midi_unittests\": \"74b4b79a21cada8225a4f3960d1105409f505135\", \"mojo_core_unittests\": \"875c852221d33fab41bfed0f8805b457a2d193a2\", \"mojo_unittests\": \"7c3e77ed9f1331297846f0b6ab5a483e2251cf8f\", \"nacl_loader_unittests\": \"197ee6c83f282f0aadfdaf07525bcf046ffab2a5\", \"native_theme_unittests\": \"122a196d9baf7970d0d280c4148febdb012df1e2\", \"net_unittests\": \"850db818ac90fa47fd2c2ba78b4e3c81eff917cf\", \"notification_helper_unittests\": \"d31e79641f98b6fe7dc21bf4f42b6c79c9a8f95e\", \"pdf_unittests\": \"c7846c2b9ebc77d6052a8af1ffcdae382260ea19\", \"perfetto_unittests\": \"0197ce7f78ce447f1e3a49d2d84f3596c4e6a72e\", \"ppapi_unittests\": \"e98795abae1beea18e2f5455913b0eddd2bdd570\", \"printing_unittests\": \"980a8e8a0a86da883ffb2382ec95fefd4167c305\", \"remoting_unittests\": \"7721fdb7d2b11a8c90cb67832c519473bee43758\", \"sbox_integration_tests\": \"3e72cb87fa88f37dac2a2b06e9be2db1ea86c1b0\", \"sbox_unittests\": \"2f3fafa261ada9ef58e9ab1ad5c0cb7398807cb5\", \"sbox_validation_tests\": \"0d255f3a775653dc1cd018527d260028707f8b4a\", \"service_manager_unittests\": \"71ed7873d6e29d01cb11ce84cba1e412dbb69a60\", \"services_unittests\": \"6261b307ed0e22946e77269cb0d4957e2535b356\", \"setup_unittests\": \"2bd927d5c5a15008682dd4e95ddc963debe27b06\", \"shell_dialogs_unittests\": \"b2c35cc64e204937bc5f0b3b63b948328c316d2a\", \"skia_unittests\": \"f958ba7db25cbe0b02484c80187d4ff7bdb23f1b\", \"snapshot_unittests\": \"65d10a84a4322003a86db58ebab094bd117bd198\", \"sql_unittests\": \"ac6bb65964c05d27c104e8d50a399e0dd53922d7\", \"storage_unittests\": \"07c164fa5dbf540017c852d04e4f6de1cc611756\", \"sync_integration_tests\": \"c33c929e930ab8e97086d97baf3b2eea5aa72115\", \"traffic_annotation_auditor_unittests\": \"b87f8f088fd6ab66fce329881a2ef0ae558cabce\", \"ui_base_unittests\": \"e8007ee7d9252f298d08131e1ffa5e49b84dee37\", \"ui_touch_selection_unittests\": \"baecd57630f35c6faf8cb2f7db62b5ebc54a8e5a\", \"unit_tests\": \"950d0df43e8ca2fee209051e4a31017935675abe\", \"updater_tests\": \"61d7e0dd4783a088abbd37c34744392f5d803c03\", \"url_unittests\": \"d782655597ac0bdb5a7af16bf3fe355516d9c857\", \"views_unittests\": \"a5092c3f1a90f8ecf721f27e25f40a87a99be80b\", \"viz_unittests\": \"dc891aa3c1fdebc3366a606b12ea9d354179ef4c\", \"vr_common_unittests\": \"830c8eabef7d608efc90ef411150f973389c3f6d\", \"vr_pixeltests\": \"f04a54566c86e0e20f2313b3b081c833805d550f\", \"weblayer_browsertests\": \"0ab45a77deb351c13b128e24b544004bcc53a796\", \"weblayer_unittests\": \"0da1af61f3ab60b0630b7b35722eaf18c6ef3096\", \"wm_unittests\": \"2926747a82cd5688a381ada3cf226078b1b378a2\", \"wtf_unittests\": \"28ce3d2f3f06063370d5bd37a0fec08233167da2\", \"zlib_unittests\": \"46f0060fe1d7dcbd332a84fe57771d3a117fd717\", \"zucchini_unittests\": \"bcd248373452f0b35fb3ad17ac4f455b4034abd5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-10-dcpw\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**gcp_unittests** failed because of:\\n\\n- All/GcpGaiaCredentialBasePasswordRecoveryTest.PasswordRecovery/14\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615811127304490",
"status": "COMPLETED",
"status_changed_ts": "1615811128142218",
"tags": [
"build_address:luci.chromium.ci/win-asan/17802",
"builder:win-asan",
"buildset:commit/git/4b8318a8fa9a37b5d2312dc958087ade8ee61623",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4b8318a8fa9a37b5d2312dc958087ade8ee61623",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018123340405557312",
"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/8852693278366630496/+/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:524ea5e2f7234810",
"user_agent:luci-scheduler"
],
"updated_ts": "1615817802111749",
"url": "https://ci.chromium.org/b/8852693278366630496",
"utcnow_ts": "1615817802574401"
}
}
[14:16:42.582] Invocation finished in 1h56m32.303730421s with status FAILED