[22:58:42.234] New invocation is queued and will start shortly
[22:58:42.234] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[22:58:43.277] Starting the invocation (attempt 1)
[22:58:43.352] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:58:43.352] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:58:43.352] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9082316416607900944",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-win\",\"properties\":{\"root_solution_revision\":\"b0d5655c1ee4591bfd873730eb2d0c6f66da8481\",\"root_solution_revision_timestamp\":1554586909}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-win",
"scheduler_invocation_id:9082316416607900944",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8145",
"user_agent:recipe"
]
}
[22:58:44.120] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "project:infra",
"created_ts": "1554591523551023",
"id": "8916886354559076080",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"b0d5655c1ee4591bfd873730eb2d0c6f66da8481\", \"root_solution_revision_timestamp\": 1554586909}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554591524012322",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3492",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8145",
"scheduler_invocation_id:9082316416607900944",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8916886354559076080/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554591524012461",
"url": "https://ci.chromium.org/b/8916886354559076080",
"utcnow_ts": "1554591524109554"
}
}
[22:58:44.120] Task URL: https://ci.chromium.org/b/8916886354559076080
[22:58:44.120] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:2:0) after 1m0s
[22:59:44.137] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:2:0)
[22:59:44.137] Timer tick, asking Buildbucket for the build status
[22:59:44.315] Build 8916886354559076080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:44.315] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:3:0) after 1m0s
[23:00:44.336] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:3:0)
[23:00:44.336] Timer tick, asking Buildbucket for the build status
[23:00:44.459] Build 8916886354559076080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:44.459] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:4:0) after 1m0s
[23:01:44.474] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:4:0)
[23:01:44.474] Timer tick, asking Buildbucket for the build status
[23:01:44.803] Build 8916886354559076080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:44.804] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:5:0) after 1m0s
[23:02:44.819] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:5:0)
[23:02:44.819] Timer tick, asking Buildbucket for the build status
[23:02:44.913] Build 8916886354559076080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:44.913] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:6:0) after 1m0s
[23:03:44.929] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:6:0)
[23:03:44.929] Timer tick, asking Buildbucket for the build status
[23:03:45.072] Build 8916886354559076080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:45.072] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:7:0) after 1m0s
[23:04:45.096] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:7:0)
[23:04:45.096] Timer tick, asking Buildbucket for the build status
[23:04:45.179] Build 8916886354559076080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:45.179] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:8:0) after 1m0s
[23:05:45.198] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:8:0)
[23:05:45.198] Timer tick, asking Buildbucket for the build status
[23:05:45.280] Build 8916886354559076080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:05:45.280] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:9:0) after 1m0s
[23:06:26.499] Received PubSub notification, asking Buildbucket for the build status
[23:06:26.544] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:45.297] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:9:0)
[23:06:45.297] Timer tick, asking Buildbucket for the build status
[23:06:45.341] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:45.341] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:11:0) after 1m0s
[23:07:45.362] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:11:0)
[23:07:45.362] Timer tick, asking Buildbucket for the build status
[23:07:45.436] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:45.436] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:12:0) after 1m0s
[23:08:45.413] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:12:0)
[23:08:45.413] Timer tick, asking Buildbucket for the build status
[23:08:45.472] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:45.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:13:0) after 1m0s
[23:09:45.488] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:13:0)
[23:09:45.488] Timer tick, asking Buildbucket for the build status
[23:09:45.577] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:45.577] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:14:0) after 1m0s
[23:10:45.602] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:14:0)
[23:10:45.602] Timer tick, asking Buildbucket for the build status
[23:10:45.899] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:45.899] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:15:0) after 1m0s
[23:11:45.869] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:15:0)
[23:11:45.869] Timer tick, asking Buildbucket for the build status
[23:11:46.003] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:46.003] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:16:0) after 1m0s
[23:12:46.024] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:16:0)
[23:12:46.024] Timer tick, asking Buildbucket for the build status
[23:12:46.148] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:46.148] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:17:0) after 1m0s
[23:13:46.166] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:17:0)
[23:13:46.166] Timer tick, asking Buildbucket for the build status
[23:13:46.311] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:46.312] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:18:0) after 1m0s
[23:14:46.341] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:18:0)
[23:14:46.341] Timer tick, asking Buildbucket for the build status
[23:14:46.493] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:46.493] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:19:0) after 1m0s
[23:15:46.595] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:19:0)
[23:15:46.595] Timer tick, asking Buildbucket for the build status
[23:15:46.654] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:46.654] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:20:0) after 1m0s
[23:16:46.672] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:20:0)
[23:16:46.672] Timer tick, asking Buildbucket for the build status
[23:16:46.829] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:46.829] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:21:0) after 1m0s
[23:17:46.847] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:21:0)
[23:17:46.847] Timer tick, asking Buildbucket for the build status
[23:17:46.998] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:46.998] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:22:0) after 1m0s
[23:18:47.016] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:22:0)
[23:18:47.016] Timer tick, asking Buildbucket for the build status
[23:18:47.097] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:47.097] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:23:0) after 1m0s
[23:19:47.095] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:23:0)
[23:19:47.095] Timer tick, asking Buildbucket for the build status
[23:19:47.194] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:47.194] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:24:0) after 1m0s
[23:20:47.219] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:24:0)
[23:20:47.219] Timer tick, asking Buildbucket for the build status
[23:20:47.316] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:47.316] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:25:0) after 1m0s
[23:21:47.335] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:25:0)
[23:21:47.335] Timer tick, asking Buildbucket for the build status
[23:21:47.397] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:47.397] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:26:0) after 1m0s
[23:22:47.495] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:26:0)
[23:22:47.495] Timer tick, asking Buildbucket for the build status
[23:22:47.552] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:47.552] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:27:0) after 1m0s
[23:23:47.570] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:27:0)
[23:23:47.570] Timer tick, asking Buildbucket for the build status
[23:23:47.636] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:47.636] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:28:0) after 1m0s
[23:24:47.653] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:28:0)
[23:24:47.653] Timer tick, asking Buildbucket for the build status
[23:24:47.744] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:47.744] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:29:0) after 1m0s
[23:25:47.766] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:29:0)
[23:25:47.766] Timer tick, asking Buildbucket for the build status
[23:25:47.881] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:47.882] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:30:0) after 1m0s
[23:26:47.899] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:30:0)
[23:26:47.899] Timer tick, asking Buildbucket for the build status
[23:26:47.988] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:47.988] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:31:0) after 1m0s
[23:27:48.007] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:31:0)
[23:27:48.007] Timer tick, asking Buildbucket for the build status
[23:27:48.085] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:48.085] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:32:0) after 1m0s
[23:28:48.103] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:32:0)
[23:28:48.103] Timer tick, asking Buildbucket for the build status
[23:28:48.347] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:48.347] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:33:0) after 1m0s
[23:29:48.367] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:33:0)
[23:29:48.367] Timer tick, asking Buildbucket for the build status
[23:29:48.506] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:48.506] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:34:0) after 1m0s
[23:30:48.514] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:34:0)
[23:30:48.514] Timer tick, asking Buildbucket for the build status
[23:30:48.577] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:48.577] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:35:0) after 1m0s
[23:31:48.597] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:35:0)
[23:31:48.597] Timer tick, asking Buildbucket for the build status
[23:31:48.686] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:48.686] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:36:0) after 1m0s
[23:32:48.676] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:36:0)
[23:32:48.676] Timer tick, asking Buildbucket for the build status
[23:32:48.762] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:48.762] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:37:0) after 1m0s
[23:33:48.783] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:37:0)
[23:33:48.783] Timer tick, asking Buildbucket for the build status
[23:33:48.881] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:48.881] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:38:0) after 1m0s
[23:34:48.899] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:38:0)
[23:34:48.899] Timer tick, asking Buildbucket for the build status
[23:34:48.988] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:48.988] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:39:0) after 1m0s
[23:35:49.007] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:39:0)
[23:35:49.007] Timer tick, asking Buildbucket for the build status
[23:35:49.109] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:49.109] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:40:0) after 1m0s
[23:36:49.109] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:40:0)
[23:36:49.109] Timer tick, asking Buildbucket for the build status
[23:36:49.273] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:49.273] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:41:0) after 1m0s
[23:37:49.291] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:41:0)
[23:37:49.291] Timer tick, asking Buildbucket for the build status
[23:37:49.399] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:49.399] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:42:0) after 1m0s
[23:38:49.429] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:42:0)
[23:38:49.429] Timer tick, asking Buildbucket for the build status
[23:38:49.594] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:49.594] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:43:0) after 1m0s
[23:39:49.572] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:43:0)
[23:39:49.572] Timer tick, asking Buildbucket for the build status
[23:39:49.684] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:49.684] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:44:0) after 1m0s
[23:40:49.675] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:44:0)
[23:40:49.675] Timer tick, asking Buildbucket for the build status
[23:40:49.729] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:49.729] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:45:0) after 1m0s
[23:41:49.748] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:45:0)
[23:41:49.748] Timer tick, asking Buildbucket for the build status
[23:41:49.804] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:49.805] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:46:0) after 1m0s
[23:42:49.803] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:46:0)
[23:42:49.803] Timer tick, asking Buildbucket for the build status
[23:42:50.063] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:50.063] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:47:0) after 1m0s
[23:43:50.085] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:47:0)
[23:43:50.085] Timer tick, asking Buildbucket for the build status
[23:43:50.192] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:50.192] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:48:0) after 1m0s
[23:44:50.172] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:48:0)
[23:44:50.172] Timer tick, asking Buildbucket for the build status
[23:44:50.268] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:50.268] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:49:0) after 1m0s
[23:45:50.298] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:49:0)
[23:45:50.298] Timer tick, asking Buildbucket for the build status
[23:45:50.386] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:50.386] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:50:0) after 1m0s
[23:46:50.361] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:50:0)
[23:46:50.361] Timer tick, asking Buildbucket for the build status
[23:46:50.495] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:50.495] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:51:0) after 1m0s
[23:47:50.468] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:51:0)
[23:47:50.468] Timer tick, asking Buildbucket for the build status
[23:47:50.597] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:50.597] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:52:0) after 1m0s
[23:48:50.594] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:52:0)
[23:48:50.594] Timer tick, asking Buildbucket for the build status
[23:48:50.689] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:50.689] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:53:0) after 1m0s
[23:49:50.682] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:53:0)
[23:49:50.682] Timer tick, asking Buildbucket for the build status
[23:49:50.739] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:50.739] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:54:0) after 1m0s
[23:50:50.757] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:54:0)
[23:50:50.757] Timer tick, asking Buildbucket for the build status
[23:50:50.835] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:50.835] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:55:0) after 1m0s
[23:51:50.851] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:55:0)
[23:51:50.851] Timer tick, asking Buildbucket for the build status
[23:51:51.163] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:51.163] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:56:0) after 1m0s
[23:52:51.189] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:56:0)
[23:52:51.189] Timer tick, asking Buildbucket for the build status
[23:52:51.507] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:51.507] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:57:0) after 1m0s
[23:53:51.529] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:57:0)
[23:53:51.529] Timer tick, asking Buildbucket for the build status
[23:53:51.675] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:51.675] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:58:0) after 1m0s
[23:54:51.706] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:58:0)
[23:54:51.706] Timer tick, asking Buildbucket for the build status
[23:54:51.794] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:51.794] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:59:0) after 1m0s
[23:55:51.771] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:59:0)
[23:55:51.771] Timer tick, asking Buildbucket for the build status
[23:55:51.850] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:51.850] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:60:0) after 1m0s
[23:56:51.868] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:60:0)
[23:56:51.868] Timer tick, asking Buildbucket for the build status
[23:56:52.074] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:52.074] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:61:0) after 1m0s
[23:57:52.100] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:61:0)
[23:57:52.100] Timer tick, asking Buildbucket for the build status
[23:57:52.371] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:52.371] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:62:0) after 1m0s
[23:58:52.390] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:62:0)
[23:58:52.390] Timer tick, asking Buildbucket for the build status
[23:58:52.684] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:52.684] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:63:0) after 1m0s
[23:59:52.704] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:63:0)
[23:59:52.704] Timer tick, asking Buildbucket for the build status
[23:59:52.900] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:52.900] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:64:0) after 1m0s
[00:00:52.920] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:64:0)
[00:00:52.920] Timer tick, asking Buildbucket for the build status
[00:00:53.058] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:53.058] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:65:0) after 1m0s
[00:01:53.078] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:65:0)
[00:01:53.078] Timer tick, asking Buildbucket for the build status
[00:01:53.255] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:53.255] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:66:0) after 1m0s
[00:02:53.277] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:66:0)
[00:02:53.277] Timer tick, asking Buildbucket for the build status
[00:02:53.370] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:53.370] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:67:0) after 1m0s
[00:03:53.385] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:67:0)
[00:03:53.385] Timer tick, asking Buildbucket for the build status
[00:03:53.488] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:53.488] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:68:0) after 1m0s
[00:04:53.505] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:68:0)
[00:04:53.505] Timer tick, asking Buildbucket for the build status
[00:04:53.728] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:53.728] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:69:0) after 1m0s
[00:05:53.750] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:69:0)
[00:05:53.750] Timer tick, asking Buildbucket for the build status
[00:05:53.985] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:53.985] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:70:0) after 1m0s
[00:06:54.016] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:70:0)
[00:06:54.016] Timer tick, asking Buildbucket for the build status
[00:06:54.142] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:54.142] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:71:0) after 1m0s
[00:07:54.161] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:71:0)
[00:07:54.161] Timer tick, asking Buildbucket for the build status
[00:07:54.288] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:54.288] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:72:0) after 1m0s
[00:08:54.310] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:72:0)
[00:08:54.310] Timer tick, asking Buildbucket for the build status
[00:08:54.412] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:54.412] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:73:0) after 1m0s
[00:09:54.430] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:73:0)
[00:09:54.430] Timer tick, asking Buildbucket for the build status
[00:09:54.598] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:54.598] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:74:0) after 1m0s
[00:10:54.639] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:74:0)
[00:10:54.639] Timer tick, asking Buildbucket for the build status
[00:10:54.895] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:54.895] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:75:0) after 1m0s
[00:11:54.915] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:75:0)
[00:11:54.915] Timer tick, asking Buildbucket for the build status
[00:11:54.983] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:54.983] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:76:0) after 1m0s
[00:12:55.013] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:76:0)
[00:12:55.013] Timer tick, asking Buildbucket for the build status
[00:12:55.088] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:55.088] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:77:0) after 1m0s
[00:13:55.108] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:77:0)
[00:13:55.108] Timer tick, asking Buildbucket for the build status
[00:13:55.192] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:55.192] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:78:0) after 1m0s
[00:14:55.283] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:78:0)
[00:14:55.283] Timer tick, asking Buildbucket for the build status
[00:14:55.431] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:55.431] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:79:0) after 1m0s
[00:15:55.455] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:79:0)
[00:15:55.455] Timer tick, asking Buildbucket for the build status
[00:15:55.658] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:55.658] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:80:0) after 1m0s
[00:16:55.672] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:80:0)
[00:16:55.672] Timer tick, asking Buildbucket for the build status
[00:16:55.838] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:55.838] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:81:0) after 1m0s
[00:17:55.826] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:81:0)
[00:17:55.826] Timer tick, asking Buildbucket for the build status
[00:17:55.925] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:55.925] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:82:0) after 1m0s
[00:18:55.935] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:82:0)
[00:18:55.935] Timer tick, asking Buildbucket for the build status
[00:18:56.102] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:56.102] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:83:0) after 1m0s
[00:19:56.142] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:83:0)
[00:19:56.142] Timer tick, asking Buildbucket for the build status
[00:19:56.262] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:56.262] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:84:0) after 1m0s
[00:20:56.285] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:84:0)
[00:20:56.285] Timer tick, asking Buildbucket for the build status
[00:20:56.345] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:56.345] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:85:0) after 1m0s
[00:21:56.365] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:85:0)
[00:21:56.365] Timer tick, asking Buildbucket for the build status
[00:21:56.568] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:56.568] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:86:0) after 1m0s
[00:22:56.589] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:86:0)
[00:22:56.589] Timer tick, asking Buildbucket for the build status
[00:22:56.756] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:56.756] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:87:0) after 1m0s
[00:23:56.778] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:87:0)
[00:23:56.778] Timer tick, asking Buildbucket for the build status
[00:23:56.956] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:56.956] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:88:0) after 1m0s
[00:24:56.983] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:88:0)
[00:24:56.983] Timer tick, asking Buildbucket for the build status
[00:24:57.110] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:57.110] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:89:0) after 1m0s
[00:25:57.200] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:89:0)
[00:25:57.200] Timer tick, asking Buildbucket for the build status
[00:25:57.294] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:57.295] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:90:0) after 1m0s
[00:26:57.316] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:90:0)
[00:26:57.316] Timer tick, asking Buildbucket for the build status
[00:26:57.406] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:57.406] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:91:0) after 1m0s
[00:27:57.435] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:91:0)
[00:27:57.435] Timer tick, asking Buildbucket for the build status
[00:27:57.566] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:57.566] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:92:0) after 1m0s
[00:28:57.601] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:92:0)
[00:28:57.601] Timer tick, asking Buildbucket for the build status
[00:28:57.659] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:57.659] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:93:0) after 1m0s
[00:29:57.680] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:93:0)
[00:29:57.680] Timer tick, asking Buildbucket for the build status
[00:29:57.750] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:57.750] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:94:0) after 1m0s
[00:30:57.772] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:94:0)
[00:30:57.772] Timer tick, asking Buildbucket for the build status
[00:30:57.911] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:57.911] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:95:0) after 1m0s
[00:31:57.913] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:95:0)
[00:31:57.913] Timer tick, asking Buildbucket for the build status
[00:31:58.067] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:58.067] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:96:0) after 1m0s
[00:32:58.088] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:96:0)
[00:32:58.088] Timer tick, asking Buildbucket for the build status
[00:32:58.150] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:58.150] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:97:0) after 1m0s
[00:33:58.175] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:97:0)
[00:33:58.175] Timer tick, asking Buildbucket for the build status
[00:33:58.276] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:58.276] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:98:0) after 1m0s
[00:34:58.297] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:98:0)
[00:34:58.297] Timer tick, asking Buildbucket for the build status
[00:34:58.587] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:58.587] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:99:0) after 1m0s
[00:35:58.611] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:99:0)
[00:35:58.611] Timer tick, asking Buildbucket for the build status
[00:35:58.780] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:58.780] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:100:0) after 1m0s
[00:36:58.776] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:100:0)
[00:36:58.776] Timer tick, asking Buildbucket for the build status
[00:36:58.830] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:58.830] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:101:0) after 1m0s
[00:37:58.835] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:101:0)
[00:37:58.835] Timer tick, asking Buildbucket for the build status
[00:37:58.955] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:58.955] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:102:0) after 1m0s
[00:38:58.984] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:102:0)
[00:38:58.984] Timer tick, asking Buildbucket for the build status
[00:38:59.121] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:59.121] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:103:0) after 1m0s
[00:39:59.400] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:103:0)
[00:39:59.400] Timer tick, asking Buildbucket for the build status
[00:39:59.486] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:59.486] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:104:0) after 1m0s
[00:40:59.459] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:104:0)
[00:40:59.459] Timer tick, asking Buildbucket for the build status
[00:40:59.604] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:59.604] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:105:0) after 1m0s
[00:41:59.633] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:105:0)
[00:41:59.633] Timer tick, asking Buildbucket for the build status
[00:41:59.701] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:59.701] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:106:0) after 1m0s
[00:42:59.691] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:106:0)
[00:42:59.691] Timer tick, asking Buildbucket for the build status
[00:42:59.845] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:59.845] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:107:0) after 1m0s
[00:43:59.866] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:107:0)
[00:43:59.866] Timer tick, asking Buildbucket for the build status
[00:43:59.993] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:59.993] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:108:0) after 1m0s
[00:45:00.029] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:108:0)
[00:45:00.029] Timer tick, asking Buildbucket for the build status
[00:45:00.176] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:00.176] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:109:0) after 1m0s
[00:46:00.257] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:109:0)
[00:46:00.257] Timer tick, asking Buildbucket for the build status
[00:46:00.506] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:00.506] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:110:0) after 1m0s
[00:47:00.510] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:110:0)
[00:47:00.510] Timer tick, asking Buildbucket for the build status
[00:47:00.595] Build 8916886354559076080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:00.595] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082316416607900944:111:0) after 1m0s
[00:47:23.441] Received PubSub notification, asking Buildbucket for the build status
[00:47:23.586] Build 8916886354559076080: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:47:23.586] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1554598043112403",
"created_by": "project:infra",
"created_ts": "1554591523551023",
"failure_reason": "BUILD_FAILURE",
"id": "8916886354559076080",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"b0d5655c1ee4591bfd873730eb2d0c6f66da8481\", \"root_solution_revision_timestamp\": 1554586909}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('add kythe metadata') failed with return_code 1\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm2223-c4\", \"buildername\": \"codesearch-gen-chromium-win\", \"buildnumber\": 3492, \"got_angle_revision\": \"5d50678ea9b0a8be594c700b8c9eaf5af019b8c7\", \"got_clang_revision\": \"357692-1\", \"got_dawn_revision\": \"20b0c33913e45cd3d553b42a43b75b27af817833\", \"got_nacl_revision\": \"067afa275dcb4b3c6eca979ea5e3fe75073c4080\", \"got_revision\": \"b0d5655c1ee4591bfd873730eb2d0c6f66da8481\", \"got_revision_cp\": \"refs/heads/master@{#648508}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"f19370068e0906ccff45aace0faac15ab3c5fc6a\", \"got_v8_revision_cp\": \"refs/heads/7.5.209@{#1}\", \"got_webrtc_revision\": \"59e875ce18bb24aa6d1ec5cdf128d7ef244fa37a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27463}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"b0d5655c1ee4591bfd873730eb2d0c6f66da8481\", \"root_solution_revision_timestamp\": 1554586909.0}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"codesearch-gen-chromium-win\"], \"caches\": [\"builder_51272234846e6a2cd04aa26557e39158e034c42367eea2a83e543ed93811995b_v2\", \"codesearch_git_genfiles_repo\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm2223-c4\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.infra.codesearch\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4243-f38882f\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-c\"]}}, \"ui\": {\"info\": \"Step('add kythe metadata') failed with return_code 1\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1554591985816517",
"status": "COMPLETED",
"status_changed_ts": "1554591986245410",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3492",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8145",
"scheduler_invocation_id:9082316416607900944",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8916886354559076080/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:440db1ae9f30b710",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554598043163401",
"url": "https://ci.chromium.org/b/8916886354559076080",
"utcnow_ts": "1554598043576347"
}
}
[00:47:23.586] Invocation finished in 1h48m41.371358117s with status FAILED