[11:37:50.412] New invocation is queued and will start shortly
[11:37:51.498] Starting the invocation (attempt 1)
[11:37:51.538] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:37:51.538] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:37:51.538] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019847346045440480",
"parameters_json": "{\"builder_name\":\"ToTWindowsCoverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e394c565631c20c7097cc33fb3f82cc6256c6f44\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWindowsCoverage",
"scheduler_invocation_id:9019847346045440480",
"scheduler_job_id:chromium/ToTWindowsCoverage",
"user_agent:luci-scheduler",
"buildset:commit/git/e394c565631c20c7097cc33fb3f82cc6256c6f44",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e394c565631c20c7097cc33fb3f82cc6256c6f44",
"gitiles_ref:refs/heads/master"
]
}
[11:37:53.214] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614166671683843",
"id": "8854417284031082144",
"parameters_json": "{\"builder_name\": \"ToTWindowsCoverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e394c565631c20c7097cc33fb3f82cc6256c6f44\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614166672728784",
"tags": [
"build_address:luci.chromium.ci/ToTWindowsCoverage/2880",
"builder:ToTWindowsCoverage",
"buildset:commit/git/e394c565631c20c7097cc33fb3f82cc6256c6f44",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e394c565631c20c7097cc33fb3f82cc6256c6f44",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019847346045440480",
"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/8854417284031082144/+/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": "1614166672728913",
"url": "https://ci.chromium.org/b/8854417284031082144",
"utcnow_ts": "1614166673199596"
}
}
[11:37:53.214] Task URL: https://ci.chromium.org/b/8854417284031082144
[11:37:53.214] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:2:0) after 1m0s
[11:38:53.233] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:2:0)
[11:38:53.233] Timer tick, asking Buildbucket for the build status
[11:38:53.345] Build 8854417284031082144: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:38:53.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:3:0) after 1m0s
[11:39:34.064] Received PubSub notification, asking Buildbucket for the build status
[11:39:34.173] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:53.395] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:3:0)
[11:39:53.395] Timer tick, asking Buildbucket for the build status
[11:39:53.566] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:53.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:5:0) after 1m0s
[11:40:53.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:5:0)
[11:40:53.585] Timer tick, asking Buildbucket for the build status
[11:40:53.759] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:53.759] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:6:0) after 1m0s
[11:41:53.805] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:6:0)
[11:41:53.805] Timer tick, asking Buildbucket for the build status
[11:41:53.876] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:53.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:7:0) after 1m0s
[11:42:53.869] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:7:0)
[11:42:53.869] Timer tick, asking Buildbucket for the build status
[11:42:53.995] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:53.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:8:0) after 1m0s
[11:43:54.114] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:8:0)
[11:43:54.114] Timer tick, asking Buildbucket for the build status
[11:43:54.185] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:54.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:9:0) after 1m0s
[11:44:54.273] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:9:0)
[11:44:54.273] Timer tick, asking Buildbucket for the build status
[11:44:54.382] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:54.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:10:0) after 1m0s
[11:45:54.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:10:0)
[11:45:54.720] Timer tick, asking Buildbucket for the build status
[11:45:54.813] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:54.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:11:0) after 1m0s
[11:46:55.098] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:11:0)
[11:46:55.098] Timer tick, asking Buildbucket for the build status
[11:46:55.313] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:55.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:12:0) after 1m0s
[11:47:55.432] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:12:0)
[11:47:55.432] Timer tick, asking Buildbucket for the build status
[11:47:55.661] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:55.661] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:13:0) after 1m0s
[11:48:55.890] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:13:0)
[11:48:55.890] Timer tick, asking Buildbucket for the build status
[11:48:55.957] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:55.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:14:0) after 1m0s
[11:49:56.138] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:14:0)
[11:49:56.138] Timer tick, asking Buildbucket for the build status
[11:49:56.223] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:56.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:15:0) after 1m0s
[11:50:56.387] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:15:0)
[11:50:56.387] Timer tick, asking Buildbucket for the build status
[11:50:56.460] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:56.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:16:0) after 1m0s
[11:51:56.534] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:16:0)
[11:51:56.534] Timer tick, asking Buildbucket for the build status
[11:51:56.726] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:56.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:17:0) after 1m0s
[11:52:56.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:17:0)
[11:52:56.788] Timer tick, asking Buildbucket for the build status
[11:52:56.905] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:56.905] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:18:0) after 1m0s
[11:53:56.889] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:18:0)
[11:53:56.889] Timer tick, asking Buildbucket for the build status
[11:53:57.000] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:57.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:19:0) after 1m0s
[11:54:56.971] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:19:0)
[11:54:56.971] Timer tick, asking Buildbucket for the build status
[11:54:58.230] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:58.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:20:0) after 1m0s
[11:55:58.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:20:0)
[11:55:58.310] Timer tick, asking Buildbucket for the build status
[11:55:58.391] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:58.391] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:21:0) after 1m0s
[11:56:58.433] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:21:0)
[11:56:58.433] Timer tick, asking Buildbucket for the build status
[11:56:58.543] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:58.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:22:0) after 1m0s
[11:57:58.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:22:0)
[11:57:58.658] Timer tick, asking Buildbucket for the build status
[11:57:58.808] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:58.808] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:23:0) after 1m0s
[11:58:58.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:23:0)
[11:58:58.974] Timer tick, asking Buildbucket for the build status
[11:58:59.112] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:59.112] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:24:0) after 1m0s
[11:59:59.154] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:24:0)
[11:59:59.154] Timer tick, asking Buildbucket for the build status
[11:59:59.236] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:59.236] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:25:0) after 1m0s
[12:00:59.277] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:25:0)
[12:00:59.277] Timer tick, asking Buildbucket for the build status
[12:00:59.549] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:59.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:26:0) after 1m0s
[12:01:59.545] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:26:0)
[12:01:59.545] Timer tick, asking Buildbucket for the build status
[12:01:59.662] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:59.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:27:0) after 1m0s
[12:02:59.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:27:0)
[12:02:59.704] Timer tick, asking Buildbucket for the build status
[12:02:59.790] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:59.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:28:0) after 1m0s
[12:03:59.829] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:28:0)
[12:03:59.829] Timer tick, asking Buildbucket for the build status
[12:03:59.890] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:59.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:29:0) after 1m0s
[12:05:00.163] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:29:0)
[12:05:00.163] Timer tick, asking Buildbucket for the build status
[12:05:00.329] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:00.329] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:30:0) after 1m0s
[12:06:03.154] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:30:0)
[12:06:03.155] Timer tick, asking Buildbucket for the build status
[12:06:03.424] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:03.424] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:31:0) after 1m0s
[12:07:03.665] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:31:0)
[12:07:03.665] Timer tick, asking Buildbucket for the build status
[12:07:03.734] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:03.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:32:0) after 1m0s
[12:08:11.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:32:0)
[12:08:11.009] Timer tick, asking Buildbucket for the build status
[12:08:11.103] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:11.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:33:0) after 1m0s
[12:09:11.132] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:33:0)
[12:09:11.132] Timer tick, asking Buildbucket for the build status
[12:09:11.221] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:11.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:34:0) after 1m0s
[12:10:11.238] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:34:0)
[12:10:11.238] Timer tick, asking Buildbucket for the build status
[12:10:11.777] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:11.777] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:35:0) after 1m0s
[12:11:11.806] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:35:0)
[12:11:11.806] Timer tick, asking Buildbucket for the build status
[12:11:11.885] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:11.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:36:0) after 1m0s
[12:12:11.945] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:36:0)
[12:12:11.945] Timer tick, asking Buildbucket for the build status
[12:12:12.189] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:12.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:37:0) after 1m0s
[12:13:12.302] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:37:0)
[12:13:12.302] Timer tick, asking Buildbucket for the build status
[12:13:12.419] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:12.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:38:0) after 1m0s
[12:14:12.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:38:0)
[12:14:12.402] Timer tick, asking Buildbucket for the build status
[12:14:12.565] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:12.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:39:0) after 1m0s
[12:15:12.671] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:39:0)
[12:15:12.671] Timer tick, asking Buildbucket for the build status
[12:15:12.739] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:12.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:40:0) after 1m0s
[12:16:12.813] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:40:0)
[12:16:12.813] Timer tick, asking Buildbucket for the build status
[12:16:12.894] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:12.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:41:0) after 1m0s
[12:17:12.934] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:41:0)
[12:17:12.934] Timer tick, asking Buildbucket for the build status
[12:17:13.110] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:13.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:42:0) after 1m0s
[12:18:13.268] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:42:0)
[12:18:13.268] Timer tick, asking Buildbucket for the build status
[12:18:13.357] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:13.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:43:0) after 1m0s
[12:19:13.494] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:43:0)
[12:19:13.494] Timer tick, asking Buildbucket for the build status
[12:19:13.783] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:13.783] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:44:0) after 1m0s
[12:20:13.799] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:44:0)
[12:20:13.799] Timer tick, asking Buildbucket for the build status
[12:20:13.875] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:13.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:45:0) after 1m0s
[12:21:13.923] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:45:0)
[12:21:13.923] Timer tick, asking Buildbucket for the build status
[12:21:14.014] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:14.014] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:46:0) after 1m0s
[12:22:14.086] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:46:0)
[12:22:14.086] Timer tick, asking Buildbucket for the build status
[12:22:14.156] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:14.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:47:0) after 1m0s
[12:23:14.233] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:47:0)
[12:23:14.233] Timer tick, asking Buildbucket for the build status
[12:23:14.522] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:14.522] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:48:0) after 1m0s
[12:24:14.654] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:48:0)
[12:24:14.654] Timer tick, asking Buildbucket for the build status
[12:24:14.754] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:14.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:49:0) after 1m0s
[12:25:14.861] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:49:0)
[12:25:14.861] Timer tick, asking Buildbucket for the build status
[12:25:14.956] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:14.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:50:0) after 1m0s
[12:26:15.054] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:50:0)
[12:26:15.054] Timer tick, asking Buildbucket for the build status
[12:26:15.232] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:15.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:51:0) after 1m0s
[12:27:15.240] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:51:0)
[12:27:15.240] Timer tick, asking Buildbucket for the build status
[12:27:15.330] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:15.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:52:0) after 1m0s
[12:28:15.398] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:52:0)
[12:28:15.398] Timer tick, asking Buildbucket for the build status
[12:28:15.754] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:15.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:53:0) after 1m0s
[12:29:15.777] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:53:0)
[12:29:15.777] Timer tick, asking Buildbucket for the build status
[12:29:15.844] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:15.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:54:0) after 1m0s
[12:30:15.890] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:54:0)
[12:30:15.890] Timer tick, asking Buildbucket for the build status
[12:30:15.980] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:15.980] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:55:0) after 1m0s
[12:31:16.002] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:55:0)
[12:31:16.002] Timer tick, asking Buildbucket for the build status
[12:31:16.067] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:16.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:56:0) after 1m0s
[12:32:16.178] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:56:0)
[12:32:16.178] Timer tick, asking Buildbucket for the build status
[12:32:16.541] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:16.541] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:57:0) after 1m0s
[12:33:16.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:57:0)
[12:33:16.556] Timer tick, asking Buildbucket for the build status
[12:33:16.656] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:16.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:58:0) after 1m0s
[12:34:16.679] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:58:0)
[12:34:16.679] Timer tick, asking Buildbucket for the build status
[12:34:16.875] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:16.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:59:0) after 1m0s
[12:35:16.931] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:59:0)
[12:35:16.931] Timer tick, asking Buildbucket for the build status
[12:35:16.997] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:16.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:60:0) after 1m0s
[12:36:17.118] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:60:0)
[12:36:17.118] Timer tick, asking Buildbucket for the build status
[12:36:17.491] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:17.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:61:0) after 1m0s
[12:37:17.558] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:61:0)
[12:37:17.558] Timer tick, asking Buildbucket for the build status
[12:37:17.670] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:17.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:62:0) after 1m0s
[12:38:17.718] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:62:0)
[12:38:17.718] Timer tick, asking Buildbucket for the build status
[12:38:18.026] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:18.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:63:0) after 1m0s
[12:39:18.061] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:63:0)
[12:39:18.061] Timer tick, asking Buildbucket for the build status
[12:39:18.202] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:18.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:64:0) after 1m0s
[12:40:18.202] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:64:0)
[12:40:18.202] Timer tick, asking Buildbucket for the build status
[12:40:18.271] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:18.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:65:0) after 1m0s
[12:41:18.264] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:65:0)
[12:41:18.264] Timer tick, asking Buildbucket for the build status
[12:41:18.345] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:18.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:66:0) after 1m0s
[12:42:18.364] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:66:0)
[12:42:18.364] Timer tick, asking Buildbucket for the build status
[12:42:18.440] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:18.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:67:0) after 1m0s
[12:43:18.485] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:67:0)
[12:43:18.485] Timer tick, asking Buildbucket for the build status
[12:43:18.602] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:18.602] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:68:0) after 1m0s
[12:44:18.668] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:68:0)
[12:44:18.668] Timer tick, asking Buildbucket for the build status
[12:44:18.726] Build 8854417284031082144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:18.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019847346045440480:69:0) after 1m0s
[12:45:14.949] Received PubSub notification, asking Buildbucket for the build status
[12:45:15.015] Build 8854417284031082144: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:45:15.015] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614170713562685",
"created_by": "project:chromium",
"created_ts": "1614166671683843",
"id": "8854417284031082144",
"parameters_json": "{\"builder_name\": \"ToTWindowsCoverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e394c565631c20c7097cc33fb3f82cc6256c6f44\"}}",
"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-7-wxwh\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTWindowsCoverage\", \"buildnumber\": 2880, \"got_angle_revision\": \"d81e5d17b26ad7a401c764bacdfd96604eac8802\", \"got_dawn_revision\": \"d67544797e54d3866f378c2a7c05181db552f125\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"e394c565631c20c7097cc33fb3f82cc6256c6f44\", \"got_revision_cp\": \"refs/heads/master@{#857105}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"27931735fc4450a71eacf39ce96e46f47e1c0acf\", \"got_v8_revision_cp\": \"refs/heads/9.0.252@{#1}\", \"got_webrtc_revision\": \"d0844a80deaab28d7df8e5dff9f71e6ab6919025\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33323}\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium_clang_coverage_tot\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e394c565631c20c7097cc33fb3f82cc6256c6f44\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_27a86a15ec8feb386a5b02e9d1f544a49194bc134f7348519b0bd6cd38b20371_v2\", \"builder_91b2ef8341586e76bd64fa3093e74ce43aef344c2e2134fb3b046b47c3d4bcdb_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-7-wxwh\"], \"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\": [\"5709-d3c4474\"], \"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": "1614166773354190",
"status": "COMPLETED",
"status_changed_ts": "1614170714184362",
"tags": [
"build_address:luci.chromium.ci/ToTWindowsCoverage/2880",
"builder:ToTWindowsCoverage",
"buildset:commit/git/e394c565631c20c7097cc33fb3f82cc6256c6f44",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e394c565631c20c7097cc33fb3f82cc6256c6f44",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019847346045440480",
"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/8854417284031082144/+/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:51eca64f9f931d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614170714295676",
"url": "https://ci.chromium.org/b/8854417284031082144",
"utcnow_ts": "1614170715008810"
}
}
[12:45:15.015] Invocation finished in 1h7m24.636138965s with status SUCCEEDED