[21:58:42.366] New invocation is queued and will start shortly
[21:58:43.502] Starting the invocation (attempt 1)
[21:58:43.533] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:58:43.533] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:58:43.533] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020804851152651728",
"parameters_json": "{\"builder_name\":\"ToTWindowsCoverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"90ff004284b59e43fcfa842ab8868a3ef9732e8b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWindowsCoverage",
"scheduler_invocation_id:9020804851152651728",
"scheduler_job_id:chromium/ToTWindowsCoverage",
"user_agent:luci-scheduler",
"buildset:commit/git/90ff004284b59e43fcfa842ab8868a3ef9732e8b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90ff004284b59e43fcfa842ab8868a3ef9732e8b",
"gitiles_ref:refs/heads/master"
]
}
[21:58:44.169] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613253523619897",
"id": "8855374789175721216",
"parameters_json": "{\"builder_name\": \"ToTWindowsCoverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90ff004284b59e43fcfa842ab8868a3ef9732e8b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613253523988268",
"tags": [
"build_address:luci.chromium.ci/ToTWindowsCoverage/2621",
"builder:ToTWindowsCoverage",
"buildset:commit/git/90ff004284b59e43fcfa842ab8868a3ef9732e8b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90ff004284b59e43fcfa842ab8868a3ef9732e8b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020804851152651728",
"scheduler_job_id:chromium/ToTWindowsCoverage",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855374789175721216/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium_clang_coverage_tot",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1613253523988378",
"url": "https://ci.chromium.org/b/8855374789175721216",
"utcnow_ts": "1613253524161813"
}
}
[21:58:44.169] Task URL: https://ci.chromium.org/b/8855374789175721216
[21:58:44.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:2:0) after 1m0s
[21:59:47.225] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:2:0)
[21:59:47.225] Timer tick, asking Buildbucket for the build status
[21:59:47.691] Build 8855374789175721216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:59:47.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:3:0) after 1m0s
[22:00:47.814] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:3:0)
[22:00:47.814] Timer tick, asking Buildbucket for the build status
[22:00:47.893] Build 8855374789175721216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:00:47.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:4:0) after 1m0s
[22:01:48.726] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:4:0)
[22:01:48.726] Timer tick, asking Buildbucket for the build status
[22:01:48.856] Build 8855374789175721216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:01:48.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:5:0) after 1m0s
[22:02:49.628] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:5:0)
[22:02:49.628] Timer tick, asking Buildbucket for the build status
[22:02:49.696] Build 8855374789175721216: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:49.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:6:0) after 1m0s
[22:03:12.244] Received PubSub notification, asking Buildbucket for the build status
[22:03:12.370] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:49.923] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:6:0)
[22:03:49.923] Timer tick, asking Buildbucket for the build status
[22:03:50.400] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:50.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:8:0) after 1m0s
[22:04:50.530] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:8:0)
[22:04:50.530] Timer tick, asking Buildbucket for the build status
[22:04:50.910] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:50.910] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:9:0) after 1m0s
[22:05:51.325] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:9:0)
[22:05:51.325] Timer tick, asking Buildbucket for the build status
[22:05:51.392] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:51.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:10:0) after 1m0s
[22:06:51.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:10:0)
[22:06:51.658] Timer tick, asking Buildbucket for the build status
[22:06:51.822] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:51.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:11:0) after 1m0s
[22:07:51.824] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:11:0)
[22:07:51.824] Timer tick, asking Buildbucket for the build status
[22:07:51.888] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:51.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:12:0) after 1m0s
[22:08:52.072] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:12:0)
[22:08:52.072] Timer tick, asking Buildbucket for the build status
[22:08:52.430] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:52.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:13:0) after 1m0s
[22:09:52.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:13:0)
[22:09:52.453] Timer tick, asking Buildbucket for the build status
[22:09:52.528] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:52.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:14:0) after 1m0s
[22:10:52.544] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:14:0)
[22:10:52.544] Timer tick, asking Buildbucket for the build status
[22:10:52.708] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:52.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:15:0) after 1m0s
[22:11:52.727] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:15:0)
[22:11:52.727] Timer tick, asking Buildbucket for the build status
[22:11:52.842] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:52.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:16:0) after 1m0s
[22:12:52.858] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:16:0)
[22:12:52.858] Timer tick, asking Buildbucket for the build status
[22:12:53.004] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:53.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:17:0) after 1m0s
[22:13:53.049] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:17:0)
[22:13:53.049] Timer tick, asking Buildbucket for the build status
[22:13:53.132] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:53.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:18:0) after 1m0s
[22:14:53.184] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:18:0)
[22:14:53.184] Timer tick, asking Buildbucket for the build status
[22:14:53.274] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:53.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:19:0) after 1m0s
[22:15:53.285] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:19:0)
[22:15:53.285] Timer tick, asking Buildbucket for the build status
[22:15:53.387] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:53.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:20:0) after 1m0s
[22:16:53.420] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:20:0)
[22:16:53.420] Timer tick, asking Buildbucket for the build status
[22:16:53.496] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:53.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:21:0) after 1m0s
[22:17:53.524] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:21:0)
[22:17:53.524] Timer tick, asking Buildbucket for the build status
[22:17:53.595] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:53.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:22:0) after 1m0s
[22:18:53.632] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:22:0)
[22:18:53.632] Timer tick, asking Buildbucket for the build status
[22:18:53.741] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:53.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:23:0) after 1m0s
[22:19:53.866] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:23:0)
[22:19:53.866] Timer tick, asking Buildbucket for the build status
[22:19:53.944] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:53.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:24:0) after 1m0s
[22:20:53.990] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:24:0)
[22:20:53.990] Timer tick, asking Buildbucket for the build status
[22:20:54.064] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:54.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:25:0) after 1m0s
[22:21:54.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:25:0)
[22:21:54.079] Timer tick, asking Buildbucket for the build status
[22:21:54.211] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:54.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:26:0) after 1m0s
[22:22:54.235] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:26:0)
[22:22:54.235] Timer tick, asking Buildbucket for the build status
[22:22:54.310] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:54.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:27:0) after 1m0s
[22:23:54.377] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:27:0)
[22:23:54.377] Timer tick, asking Buildbucket for the build status
[22:23:54.814] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:54.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:28:0) after 1m0s
[22:24:54.865] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:28:0)
[22:24:54.865] Timer tick, asking Buildbucket for the build status
[22:24:54.950] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:54.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:29:0) after 1m0s
[22:25:55.036] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:29:0)
[22:25:55.036] Timer tick, asking Buildbucket for the build status
[22:25:55.165] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:55.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:30:0) after 1m0s
[22:26:55.282] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:30:0)
[22:26:55.282] Timer tick, asking Buildbucket for the build status
[22:26:55.348] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:55.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:31:0) after 1m0s
[22:27:55.423] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:31:0)
[22:27:55.423] Timer tick, asking Buildbucket for the build status
[22:27:55.685] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:55.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:32:0) after 1m0s
[22:28:55.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:32:0)
[22:28:55.658] Timer tick, asking Buildbucket for the build status
[22:28:55.894] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:55.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:33:0) after 1m0s
[22:29:55.953] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:33:0)
[22:29:55.953] Timer tick, asking Buildbucket for the build status
[22:29:56.224] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:56.224] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:34:0) after 1m0s
[22:30:56.221] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:34:0)
[22:30:56.221] Timer tick, asking Buildbucket for the build status
[22:30:56.294] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:56.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:35:0) after 1m0s
[22:31:56.323] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:35:0)
[22:31:56.323] Timer tick, asking Buildbucket for the build status
[22:31:56.404] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:56.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:36:0) after 1m0s
[22:32:56.536] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:36:0)
[22:32:56.536] Timer tick, asking Buildbucket for the build status
[22:32:56.766] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:56.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:37:0) after 1m0s
[22:33:56.843] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:37:0)
[22:33:56.843] Timer tick, asking Buildbucket for the build status
[22:33:56.948] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:56.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:38:0) after 1m0s
[22:34:57.011] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:38:0)
[22:34:57.011] Timer tick, asking Buildbucket for the build status
[22:34:57.116] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:57.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:39:0) after 1m0s
[22:35:57.198] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:39:0)
[22:35:57.198] Timer tick, asking Buildbucket for the build status
[22:35:57.285] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:57.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:40:0) after 1m0s
[22:36:57.415] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:40:0)
[22:36:57.415] Timer tick, asking Buildbucket for the build status
[22:36:57.514] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:57.514] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:41:0) after 1m0s
[22:37:57.534] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:41:0)
[22:37:57.534] Timer tick, asking Buildbucket for the build status
[22:37:57.701] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:57.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:42:0) after 1m0s
[22:38:57.845] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:42:0)
[22:38:57.845] Timer tick, asking Buildbucket for the build status
[22:38:57.958] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:57.958] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:43:0) after 1m0s
[22:39:57.975] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:43:0)
[22:39:57.975] Timer tick, asking Buildbucket for the build status
[22:39:58.044] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:58.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:44:0) after 1m0s
[22:40:58.203] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:44:0)
[22:40:58.203] Timer tick, asking Buildbucket for the build status
[22:40:58.280] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:58.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:45:0) after 1m0s
[22:41:58.320] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:45:0)
[22:41:58.320] Timer tick, asking Buildbucket for the build status
[22:41:58.467] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:58.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:46:0) after 1m0s
[22:42:58.485] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:46:0)
[22:42:58.486] Timer tick, asking Buildbucket for the build status
[22:42:58.576] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:58.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:47:0) after 1m0s
[22:43:58.659] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:47:0)
[22:43:58.659] Timer tick, asking Buildbucket for the build status
[22:43:58.754] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:58.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:48:0) after 1m0s
[22:44:58.733] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:48:0)
[22:44:58.733] Timer tick, asking Buildbucket for the build status
[22:44:58.812] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:58.812] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:49:0) after 1m0s
[22:45:58.831] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:49:0)
[22:45:58.831] Timer tick, asking Buildbucket for the build status
[22:45:58.909] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:58.909] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:50:0) after 1m0s
[22:46:58.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:50:0)
[22:46:58.928] Timer tick, asking Buildbucket for the build status
[22:46:58.990] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:58.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:51:0) after 1m0s
[22:47:59.020] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:51:0)
[22:47:59.020] Timer tick, asking Buildbucket for the build status
[22:47:59.105] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:59.105] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:52:0) after 1m0s
[22:48:59.124] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:52:0)
[22:48:59.124] Timer tick, asking Buildbucket for the build status
[22:48:59.204] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:59.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:53:0) after 1m0s
[22:49:59.226] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:53:0)
[22:49:59.226] Timer tick, asking Buildbucket for the build status
[22:49:59.298] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:59.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:54:0) after 1m0s
[22:50:59.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:54:0)
[22:50:59.402] Timer tick, asking Buildbucket for the build status
[22:50:59.490] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:59.490] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:55:0) after 1m0s
[22:51:59.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:55:0)
[22:51:59.498] Timer tick, asking Buildbucket for the build status
[22:51:59.578] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:59.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:56:0) after 1m0s
[22:52:59.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:56:0)
[22:52:59.574] Timer tick, asking Buildbucket for the build status
[22:52:59.636] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:59.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:57:0) after 1m0s
[22:53:59.688] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:57:0)
[22:53:59.689] Timer tick, asking Buildbucket for the build status
[22:53:59.809] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:59.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:58:0) after 1m0s
[22:54:59.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:58:0)
[22:54:59.860] Timer tick, asking Buildbucket for the build status
[22:54:59.927] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:59.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:59:0) after 1m0s
[22:55:59.981] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:59:0)
[22:55:59.981] Timer tick, asking Buildbucket for the build status
[22:56:00.059] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:00.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:60:0) after 1m0s
[22:57:00.167] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:60:0)
[22:57:00.167] Timer tick, asking Buildbucket for the build status
[22:57:00.333] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:00.333] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:61:0) after 1m0s
[22:58:00.444] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:61:0)
[22:58:00.444] Timer tick, asking Buildbucket for the build status
[22:58:00.513] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:00.513] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:62:0) after 1m0s
[22:59:00.906] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:62:0)
[22:59:00.906] Timer tick, asking Buildbucket for the build status
[22:59:01.102] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:01.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:63:0) after 1m0s
[23:00:01.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:63:0)
[23:00:01.115] Timer tick, asking Buildbucket for the build status
[23:00:01.603] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:01.603] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:64:0) after 1m0s
[23:01:01.626] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:64:0)
[23:01:01.626] Timer tick, asking Buildbucket for the build status
[23:01:02.634] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:02.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:65:0) after 1m0s
[23:02:02.686] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:65:0)
[23:02:02.686] Timer tick, asking Buildbucket for the build status
[23:02:02.805] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:02.805] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:66:0) after 1m0s
[23:03:02.830] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:66:0)
[23:03:02.830] Timer tick, asking Buildbucket for the build status
[23:03:02.917] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:02.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:67:0) after 1m0s
[23:04:02.937] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:67:0)
[23:04:02.937] Timer tick, asking Buildbucket for the build status
[23:04:03.048] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:03.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:68:0) after 1m0s
[23:05:03.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:68:0)
[23:05:03.079] Timer tick, asking Buildbucket for the build status
[23:05:03.162] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:03.162] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:69:0) after 1m0s
[23:06:03.225] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:69:0)
[23:06:03.225] Timer tick, asking Buildbucket for the build status
[23:06:03.307] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:03.307] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:70:0) after 1m0s
[23:07:03.368] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:70:0)
[23:07:03.368] Timer tick, asking Buildbucket for the build status
[23:07:03.612] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:03.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:71:0) after 1m0s
[23:08:03.631] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:71:0)
[23:08:03.631] Timer tick, asking Buildbucket for the build status
[23:08:03.898] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:03.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:72:0) after 1m0s
[23:09:03.918] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:72:0)
[23:09:03.918] Timer tick, asking Buildbucket for the build status
[23:09:04.109] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:04.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:73:0) after 1m0s
[23:10:04.142] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:73:0)
[23:10:04.142] Timer tick, asking Buildbucket for the build status
[23:10:04.440] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:04.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:74:0) after 1m0s
[23:11:04.772] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:74:0)
[23:11:04.772] Timer tick, asking Buildbucket for the build status
[23:11:04.871] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:04.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:75:0) after 1m0s
[23:12:05.044] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:75:0)
[23:12:05.044] Timer tick, asking Buildbucket for the build status
[23:12:05.130] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:05.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:76:0) after 1m0s
[23:13:05.304] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:76:0)
[23:13:05.304] Timer tick, asking Buildbucket for the build status
[23:13:05.393] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:05.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:77:0) after 1m0s
[23:14:05.444] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:77:0)
[23:14:05.444] Timer tick, asking Buildbucket for the build status
[23:14:05.742] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:05.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:78:0) after 1m0s
[23:15:05.773] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:78:0)
[23:15:05.773] Timer tick, asking Buildbucket for the build status
[23:15:05.921] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:05.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:79:0) after 1m0s
[23:16:05.981] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:79:0)
[23:16:05.981] Timer tick, asking Buildbucket for the build status
[23:16:06.050] Build 8855374789175721216: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:06.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9020804851152651728:80:0) after 1m0s
[23:16:10.295] Received PubSub notification, asking Buildbucket for the build status
[23:16:10.377] Build 8855374789175721216: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:16:10.377] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613258168949502",
"created_by": "project:chromium",
"created_ts": "1613253523619897",
"id": "8855374789175721216",
"parameters_json": "{\"builder_name\": \"ToTWindowsCoverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90ff004284b59e43fcfa842ab8868a3ef9732e8b\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-3-02em\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTWindowsCoverage\", \"buildnumber\": 2621, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"90ff004284b59e43fcfa842ab8868a3ef9732e8b\", \"got_revision_cp\": \"refs/heads/master@{#853855}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"554b7ee535b3eca3f041dc45d00de5cbd490729c\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#1}\", \"got_webrtc_revision\": \"f28d7e89b7a3c985d83f59d16b9f3c3f45ef7997\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33224}\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium_clang_coverage_tot\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"90ff004284b59e43fcfa842ab8868a3ef9732e8b\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_32bcab4cf484e052115811812b759d41ea58513be642cb87501843a8f7df98a3_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-3-02em\"], \"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\": [\"5690-40331dd\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613253791464156",
"status": "COMPLETED",
"status_changed_ts": "1613258169502614",
"tags": [
"build_address:luci.chromium.ci/ToTWindowsCoverage/2621",
"builder:ToTWindowsCoverage",
"buildset:commit/git/90ff004284b59e43fcfa842ab8868a3ef9732e8b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/90ff004284b59e43fcfa842ab8868a3ef9732e8b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020804851152651728",
"scheduler_job_id:chromium/ToTWindowsCoverage",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8855374789175721216/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium_clang_coverage_tot",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:51b638c8d104c010",
"user_agent:luci-scheduler"
],
"updated_ts": "1613258169617553",
"url": "https://ci.chromium.org/b/8855374789175721216",
"utcnow_ts": "1613258170370345"
}
}
[23:16:10.377] Invocation finished in 1h17m28.026752502s with status SUCCEEDED