[14:10:36.135] New invocation is queued and will start shortly
[14:10:37.242] Starting the invocation (attempt 1)
[14:10:37.286] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:10:37.287] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:10:37.287] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019112959337720528",
"parameters_json": "{\"builder_name\":\"ToTWindowsCoverage\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c4ad628b965d077f2f3c1d35506beead744d5f85\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWindowsCoverage",
"scheduler_invocation_id:9019112959337720528",
"scheduler_job_id:chromium/ToTWindowsCoverage",
"user_agent:luci-scheduler",
"buildset:commit/git/c4ad628b965d077f2f3c1d35506beead744d5f85",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4ad628b965d077f2f3c1d35506beead744d5f85",
"gitiles_ref:refs/heads/master"
]
}
[14:10:38.151] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614867037407198",
"id": "8853682897341928816",
"parameters_json": "{\"builder_name\": \"ToTWindowsCoverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4ad628b965d077f2f3c1d35506beead744d5f85\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614867037912077",
"tags": [
"build_address:luci.chromium.ci/ToTWindowsCoverage/3057",
"builder:ToTWindowsCoverage",
"buildset:commit/git/c4ad628b965d077f2f3c1d35506beead744d5f85",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4ad628b965d077f2f3c1d35506beead744d5f85",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019112959337720528",
"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/8853682897341928816/+/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": "1614867037912180",
"url": "https://ci.chromium.org/b/8853682897341928816",
"utcnow_ts": "1614867038145211"
}
}
[14:10:38.151] Task URL: https://ci.chromium.org/b/8853682897341928816
[14:10:38.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:2:0) after 1m0s
[14:11:38.151] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:2:0)
[14:11:38.151] Timer tick, asking Buildbucket for the build status
[14:11:38.523] Build 8853682897341928816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:11:38.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:3:0) after 1m0s
[14:12:38.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:3:0)
[14:12:38.539] Timer tick, asking Buildbucket for the build status
[14:12:38.615] Build 8853682897341928816: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:12:38.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:4:0) after 1m0s
[14:12:47.030] Received PubSub notification, asking Buildbucket for the build status
[14:12:47.094] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:38.665] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:4:0)
[14:13:38.665] Timer tick, asking Buildbucket for the build status
[14:13:38.727] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:38.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:6:0) after 1m0s
[14:14:38.803] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:6:0)
[14:14:38.803] Timer tick, asking Buildbucket for the build status
[14:14:39.856] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:39.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:7:0) after 1m0s
[14:15:39.973] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:7:0)
[14:15:39.973] Timer tick, asking Buildbucket for the build status
[14:15:40.038] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:40.038] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:8:0) after 1m0s
[14:16:40.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:8:0)
[14:16:40.122] Timer tick, asking Buildbucket for the build status
[14:16:40.253] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:40.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:9:0) after 1m0s
[14:17:40.298] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:9:0)
[14:17:40.298] Timer tick, asking Buildbucket for the build status
[14:17:40.384] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:40.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:10:0) after 1m0s
[14:18:40.517] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:10:0)
[14:18:40.517] Timer tick, asking Buildbucket for the build status
[14:18:40.589] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:40.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:11:0) after 1m0s
[14:19:40.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:11:0)
[14:19:40.656] Timer tick, asking Buildbucket for the build status
[14:19:40.720] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:40.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:12:0) after 1m0s
[14:20:40.836] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:12:0)
[14:20:40.836] Timer tick, asking Buildbucket for the build status
[14:20:41.075] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:41.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:13:0) after 1m0s
[14:21:41.251] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:13:0)
[14:21:41.251] Timer tick, asking Buildbucket for the build status
[14:21:41.349] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:41.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:14:0) after 1m0s
[14:22:41.406] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:14:0)
[14:22:41.406] Timer tick, asking Buildbucket for the build status
[14:22:41.493] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:41.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:15:0) after 1m0s
[14:23:41.513] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:15:0)
[14:23:41.513] Timer tick, asking Buildbucket for the build status
[14:23:42.096] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:42.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:16:0) after 1m0s
[14:24:42.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:16:0)
[14:24:42.352] Timer tick, asking Buildbucket for the build status
[14:24:42.422] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:42.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:17:0) after 1m0s
[14:25:42.540] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:17:0)
[14:25:42.540] Timer tick, asking Buildbucket for the build status
[14:25:42.946] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:42.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:18:0) after 1m0s
[14:26:43.041] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:18:0)
[14:26:43.041] Timer tick, asking Buildbucket for the build status
[14:26:43.349] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:43.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:19:0) after 1m0s
[14:27:43.406] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:19:0)
[14:27:43.406] Timer tick, asking Buildbucket for the build status
[14:27:43.621] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:43.621] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:20:0) after 1m0s
[14:28:43.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:20:0)
[14:28:43.705] Timer tick, asking Buildbucket for the build status
[14:28:43.784] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:43.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:21:0) after 1m0s
[14:29:44.009] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:21:0)
[14:29:44.009] Timer tick, asking Buildbucket for the build status
[14:29:45.187] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:45.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:22:0) after 1m0s
[14:30:45.180] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:22:0)
[14:30:45.180] Timer tick, asking Buildbucket for the build status
[14:30:45.276] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:45.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:23:0) after 1m0s
[14:31:45.298] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:23:0)
[14:31:45.298] Timer tick, asking Buildbucket for the build status
[14:31:45.412] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:45.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:24:0) after 1m0s
[14:32:45.450] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:24:0)
[14:32:45.450] Timer tick, asking Buildbucket for the build status
[14:32:45.568] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:45.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:25:0) after 1m0s
[14:33:45.588] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:25:0)
[14:33:45.588] Timer tick, asking Buildbucket for the build status
[14:33:45.677] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:45.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:26:0) after 1m0s
[14:34:45.692] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:26:0)
[14:34:45.692] Timer tick, asking Buildbucket for the build status
[14:34:45.866] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:45.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:27:0) after 1m0s
[14:35:45.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:27:0)
[14:35:45.956] Timer tick, asking Buildbucket for the build status
[14:35:46.172] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:46.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:28:0) after 1m0s
[14:36:46.180] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:28:0)
[14:36:46.180] Timer tick, asking Buildbucket for the build status
[14:36:46.276] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:46.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:29:0) after 1m0s
[14:37:46.294] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:29:0)
[14:37:46.294] Timer tick, asking Buildbucket for the build status
[14:37:46.356] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:46.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:30:0) after 1m0s
[14:38:46.375] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:30:0)
[14:38:46.375] Timer tick, asking Buildbucket for the build status
[14:38:46.550] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:46.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:31:0) after 1m0s
[14:39:46.565] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:31:0)
[14:39:46.565] Timer tick, asking Buildbucket for the build status
[14:39:46.762] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:46.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:32:0) after 1m0s
[14:40:46.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:32:0)
[14:40:46.788] Timer tick, asking Buildbucket for the build status
[14:40:46.945] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:46.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:33:0) after 1m0s
[14:41:46.955] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:33:0)
[14:41:46.955] Timer tick, asking Buildbucket for the build status
[14:41:47.130] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:47.130] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:34:0) after 1m0s
[14:42:47.147] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:34:0)
[14:42:47.147] Timer tick, asking Buildbucket for the build status
[14:42:47.233] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:47.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:35:0) after 1m0s
[14:43:47.280] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:35:0)
[14:43:47.280] Timer tick, asking Buildbucket for the build status
[14:43:47.551] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:47.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:36:0) after 1m0s
[14:44:47.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:36:0)
[14:44:47.595] Timer tick, asking Buildbucket for the build status
[14:44:47.741] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:47.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:37:0) after 1m0s
[14:45:47.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:37:0)
[14:45:47.788] Timer tick, asking Buildbucket for the build status
[14:45:47.874] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:47.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:38:0) after 1m0s
[14:46:47.866] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:38:0)
[14:46:47.866] Timer tick, asking Buildbucket for the build status
[14:46:47.941] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:47.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:39:0) after 1m0s
[14:47:47.985] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:39:0)
[14:47:47.986] Timer tick, asking Buildbucket for the build status
[14:47:48.082] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:48.082] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:40:0) after 1m0s
[14:48:48.097] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:40:0)
[14:48:48.097] Timer tick, asking Buildbucket for the build status
[14:48:48.181] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:48.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:41:0) after 1m0s
[14:49:48.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:41:0)
[14:49:48.183] Timer tick, asking Buildbucket for the build status
[14:49:48.286] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:48.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:42:0) after 1m0s
[14:50:48.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:42:0)
[14:50:48.344] Timer tick, asking Buildbucket for the build status
[14:50:48.454] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:48.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:43:0) after 1m0s
[14:51:48.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:43:0)
[14:51:48.482] Timer tick, asking Buildbucket for the build status
[14:51:48.558] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:48.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:44:0) after 1m0s
[14:52:48.605] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:44:0)
[14:52:48.605] Timer tick, asking Buildbucket for the build status
[14:52:48.673] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:48.673] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:45:0) after 1m0s
[14:53:48.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:45:0)
[14:53:48.704] Timer tick, asking Buildbucket for the build status
[14:53:48.840] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:48.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:46:0) after 1m0s
[14:54:48.860] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:46:0)
[14:54:48.860] Timer tick, asking Buildbucket for the build status
[14:54:48.941] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:48.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:47:0) after 1m0s
[14:55:48.969] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:47:0)
[14:55:48.969] Timer tick, asking Buildbucket for the build status
[14:55:49.044] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:49.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:48:0) after 1m0s
[14:56:49.150] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:48:0)
[14:56:49.150] Timer tick, asking Buildbucket for the build status
[14:56:49.426] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:49.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:49:0) after 1m0s
[14:57:49.638] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:49:0)
[14:57:49.638] Timer tick, asking Buildbucket for the build status
[14:57:49.699] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:49.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:50:0) after 1m0s
[14:58:49.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:50:0)
[14:58:49.788] Timer tick, asking Buildbucket for the build status
[14:58:49.900] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:49.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:51:0) after 1m0s
[14:59:49.929] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:51:0)
[14:59:49.929] Timer tick, asking Buildbucket for the build status
[14:59:50.016] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:50.016] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:52:0) after 1m0s
[15:00:50.182] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:52:0)
[15:00:50.182] Timer tick, asking Buildbucket for the build status
[15:00:50.338] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:50.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:53:0) after 1m0s
[15:01:50.504] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:53:0)
[15:01:50.504] Timer tick, asking Buildbucket for the build status
[15:01:50.597] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:50.597] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:54:0) after 1m0s
[15:02:50.609] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:54:0)
[15:02:50.609] Timer tick, asking Buildbucket for the build status
[15:02:50.738] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:50.738] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:55:0) after 1m0s
[15:03:50.945] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:55:0)
[15:03:50.945] Timer tick, asking Buildbucket for the build status
[15:03:51.046] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:51.046] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:56:0) after 1m0s
[15:04:51.107] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:56:0)
[15:04:51.107] Timer tick, asking Buildbucket for the build status
[15:04:51.253] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:51.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:57:0) after 1m0s
[15:05:51.278] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:57:0)
[15:05:51.278] Timer tick, asking Buildbucket for the build status
[15:05:51.376] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:51.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:58:0) after 1m0s
[15:06:52.141] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:58:0)
[15:06:52.141] Timer tick, asking Buildbucket for the build status
[15:06:52.345] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:52.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:59:0) after 1m0s
[15:07:52.426] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:59:0)
[15:07:52.426] Timer tick, asking Buildbucket for the build status
[15:07:52.569] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:52.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:60:0) after 1m0s
[15:08:52.590] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:60:0)
[15:08:52.590] Timer tick, asking Buildbucket for the build status
[15:08:52.837] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:52.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:61:0) after 1m0s
[15:09:52.979] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:61:0)
[15:09:52.979] Timer tick, asking Buildbucket for the build status
[15:09:53.232] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:53.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:62:0) after 1m0s
[15:10:53.349] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:62:0)
[15:10:53.349] Timer tick, asking Buildbucket for the build status
[15:10:53.442] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:53.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:63:0) after 1m0s
[15:11:53.535] Handling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:63:0)
[15:11:53.535] Timer tick, asking Buildbucket for the build status
[15:11:53.609] Build 8853682897341928816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:53.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWindowsCoverage:9019112959337720528:64:0) after 1m0s
[15:12:45.618] Received PubSub notification, asking Buildbucket for the build status
[15:12:45.711] Build 8853682897341928816: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:12:45.711] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614870764936868",
"created_by": "project:chromium",
"created_ts": "1614867037407198",
"id": "8853682897341928816",
"parameters_json": "{\"builder_name\": \"ToTWindowsCoverage\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4ad628b965d077f2f3c1d35506beead744d5f85\"}}",
"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-9qis\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTWindowsCoverage\", \"buildnumber\": 3057, \"got_angle_revision\": \"90db604919ba6e3a5ffbdd43845ac33f91e7ddfa\", \"got_dawn_revision\": \"d9a96fb28648eaff2c54beca62f14c718f042217\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"c4ad628b965d077f2f3c1d35506beead744d5f85\", \"got_revision_cp\": \"refs/heads/master@{#859750}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"084529f3a9b9992a0de73fe333f677bced7b8fdb\", \"got_v8_revision\": \"d8ce89b999efc8327bfb5e7b9be78b594df14f1c\", \"got_v8_revision_cp\": \"refs/heads/9.1.42@{#1}\", \"got_webrtc_revision\": \"07d83c8a9af02a0afc473503f75f150f23e3e0ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33366}\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium_clang_coverage_tot\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4ad628b965d077f2f3c1d35506beead744d5f85\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"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-3-9qis\"], \"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\": [\"5725-1a0d85e\"], \"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": "1614867166085106",
"status": "COMPLETED",
"status_changed_ts": "1614870765383872",
"tags": [
"build_address:luci.chromium.ci/ToTWindowsCoverage/3057",
"builder:ToTWindowsCoverage",
"buildset:commit/git/c4ad628b965d077f2f3c1d35506beead744d5f85",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4ad628b965d077f2f3c1d35506beead744d5f85",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019112959337720528",
"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/8853682897341928816/+/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:52166507b1d4ef10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614870765415339",
"url": "https://ci.chromium.org/b/8853682897341928816",
"utcnow_ts": "1614870765705013"
}
}
[15:12:45.711] Invocation finished in 1h2m9.591168254s with status SUCCEEDED