[18:39:04.205] New invocation is queued and will start shortly
[18:39:04.205] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[18:39:05.250] Starting the invocation (attempt 1)
[18:39:05.285] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:39:05.285] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:39:05.285] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9082242154382959552",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-win\",\"properties\":{\"root_solution_revision\":\"1b64cdf4a02d1d5bffcae0b3e872d77f754eacff\",\"root_solution_revision_timestamp\":1554659382}}",
"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:9082242154382959552",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8155",
"user_agent:recipe"
]
}
[18:39:05.985] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "project:infra",
"created_ts": "1554662345438582",
"id": "8916812092427933264",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"1b64cdf4a02d1d5bffcae0b3e872d77f754eacff\", \"root_solution_revision_timestamp\": 1554659382}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554662345883985",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3502",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8155",
"scheduler_invocation_id:9082242154382959552",
"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/8916812092427933264/+/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": "1554662345884106",
"url": "https://ci.chromium.org/b/8916812092427933264",
"utcnow_ts": "1554662345975540"
}
}
[18:39:05.985] Task URL: https://ci.chromium.org/b/8916812092427933264
[18:39:05.985] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:2:0) after 1m0s
[18:40:06.037] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:2:0)
[18:40:06.037] Timer tick, asking Buildbucket for the build status
[18:40:06.101] Build 8916812092427933264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:06.101] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:3:0) after 1m0s
[18:46:24.955] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:3:0)
[18:46:24.955] Timer tick, asking Buildbucket for the build status
[18:46:25.188] Build 8916812092427933264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:25.188] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:4:0) after 1m0s
[18:47:25.208] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:4:0)
[18:47:25.208] Timer tick, asking Buildbucket for the build status
[18:47:25.302] Build 8916812092427933264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:25.302] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:5:0) after 1m0s
[18:47:38.275] Received PubSub notification, asking Buildbucket for the build status
[18:47:38.346] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:25.336] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:5:0)
[18:48:25.336] Timer tick, asking Buildbucket for the build status
[18:48:25.401] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:25.401] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:7:0) after 1m0s
[18:49:25.401] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:7:0)
[18:49:25.401] Timer tick, asking Buildbucket for the build status
[18:49:25.741] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:25.741] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:8:0) after 1m0s
[18:50:25.757] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:8:0)
[18:50:25.757] Timer tick, asking Buildbucket for the build status
[18:50:25.854] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:25.854] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:9:0) after 1m0s
[18:51:25.871] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:9:0)
[18:51:25.871] Timer tick, asking Buildbucket for the build status
[18:51:25.975] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:25.975] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:10:0) after 1m0s
[18:52:25.998] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:10:0)
[18:52:25.998] Timer tick, asking Buildbucket for the build status
[18:52:26.221] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:26.221] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:11:0) after 1m0s
[18:53:26.248] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:11:0)
[18:53:26.248] Timer tick, asking Buildbucket for the build status
[18:53:26.360] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:26.360] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:12:0) after 1m0s
[18:54:26.401] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:12:0)
[18:54:26.401] Timer tick, asking Buildbucket for the build status
[18:54:26.502] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:26.502] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:13:0) after 1m0s
[18:55:26.522] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:13:0)
[18:55:26.522] Timer tick, asking Buildbucket for the build status
[18:55:26.610] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:26.611] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:14:0) after 1m0s
[18:56:26.626] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:14:0)
[18:56:26.626] Timer tick, asking Buildbucket for the build status
[18:56:26.689] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:26.689] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:15:0) after 1m0s
[18:57:26.676] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:15:0)
[18:57:26.676] Timer tick, asking Buildbucket for the build status
[18:57:27.867] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:27.867] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:16:0) after 1m0s
[18:58:27.887] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:16:0)
[18:58:27.887] Timer tick, asking Buildbucket for the build status
[18:58:27.990] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:27.991] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:17:0) after 1m0s
[18:59:28.026] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:17:0)
[18:59:28.026] Timer tick, asking Buildbucket for the build status
[18:59:28.234] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:28.234] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:18:0) after 1m0s
[19:00:28.224] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:18:0)
[19:00:28.224] Timer tick, asking Buildbucket for the build status
[19:00:28.384] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:28.384] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:19:0) after 1m0s
[19:01:28.407] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:19:0)
[19:01:28.407] Timer tick, asking Buildbucket for the build status
[19:01:28.496] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:28.496] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:20:0) after 1m0s
[19:02:28.514] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:20:0)
[19:02:28.514] Timer tick, asking Buildbucket for the build status
[19:02:28.700] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:28.700] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:21:0) after 1m0s
[19:03:28.717] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:21:0)
[19:03:28.717] Timer tick, asking Buildbucket for the build status
[19:03:28.768] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:28.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:22:0) after 1m0s
[19:04:28.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:22:0)
[19:04:28.802] Timer tick, asking Buildbucket for the build status
[19:04:28.863] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:28.863] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:23:0) after 1m0s
[19:05:28.881] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:23:0)
[19:05:28.881] Timer tick, asking Buildbucket for the build status
[19:05:28.923] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:28.923] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:24:0) after 1m0s
[19:06:28.942] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:24:0)
[19:06:28.942] Timer tick, asking Buildbucket for the build status
[19:06:29.014] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:29.014] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:25:0) after 1m0s
[19:07:29.073] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:25:0)
[19:07:29.073] Timer tick, asking Buildbucket for the build status
[19:07:29.138] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:29.138] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:26:0) after 1m0s
[19:08:29.164] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:26:0)
[19:08:29.164] Timer tick, asking Buildbucket for the build status
[19:08:29.263] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:29.263] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:27:0) after 1m0s
[19:09:29.280] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:27:0)
[19:09:29.280] Timer tick, asking Buildbucket for the build status
[19:09:29.363] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:29.363] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:28:0) after 1m0s
[19:10:29.418] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:28:0)
[19:10:29.418] Timer tick, asking Buildbucket for the build status
[19:10:29.491] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:29.491] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:29:0) after 1m0s
[19:11:29.510] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:29:0)
[19:11:29.510] Timer tick, asking Buildbucket for the build status
[19:11:29.628] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:29.628] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:30:0) after 1m0s
[19:12:29.653] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:30:0)
[19:12:29.653] Timer tick, asking Buildbucket for the build status
[19:12:29.752] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:29.752] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:31:0) after 1m0s
[19:13:29.771] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:31:0)
[19:13:29.771] Timer tick, asking Buildbucket for the build status
[19:13:29.963] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:29.963] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:32:0) after 1m0s
[19:14:30.062] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:32:0)
[19:14:30.062] Timer tick, asking Buildbucket for the build status
[19:14:30.108] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:30.108] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:33:0) after 1m0s
[19:15:30.215] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:33:0)
[19:15:30.215] Timer tick, asking Buildbucket for the build status
[19:15:30.271] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:30.271] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:34:0) after 1m0s
[19:16:30.316] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:34:0)
[19:16:30.316] Timer tick, asking Buildbucket for the build status
[19:16:30.533] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:30.533] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:35:0) after 1m0s
[19:17:30.550] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:35:0)
[19:17:30.550] Timer tick, asking Buildbucket for the build status
[19:17:30.598] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:30.598] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:36:0) after 1m0s
[19:18:30.617] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:36:0)
[19:18:30.617] Timer tick, asking Buildbucket for the build status
[19:18:30.682] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:30.682] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:37:0) after 1m0s
[19:19:30.700] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:37:0)
[19:19:30.700] Timer tick, asking Buildbucket for the build status
[19:19:30.760] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:30.760] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:38:0) after 1m0s
[19:20:30.780] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:38:0)
[19:20:30.780] Timer tick, asking Buildbucket for the build status
[19:20:31.067] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:31.067] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:39:0) after 1m0s
[19:21:31.085] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:39:0)
[19:21:31.085] Timer tick, asking Buildbucket for the build status
[19:21:31.196] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:31.196] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:40:0) after 1m0s
[19:22:31.223] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:40:0)
[19:22:31.223] Timer tick, asking Buildbucket for the build status
[19:22:31.307] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:31.307] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:41:0) after 1m0s
[19:23:31.327] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:41:0)
[19:23:31.327] Timer tick, asking Buildbucket for the build status
[19:23:31.369] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:31.369] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:42:0) after 1m0s
[19:24:31.404] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:42:0)
[19:24:31.404] Timer tick, asking Buildbucket for the build status
[19:24:31.483] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:31.483] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:43:0) after 1m0s
[19:25:31.503] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:43:0)
[19:25:31.503] Timer tick, asking Buildbucket for the build status
[19:25:31.743] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:31.743] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:44:0) after 1m0s
[19:26:31.766] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:44:0)
[19:26:31.766] Timer tick, asking Buildbucket for the build status
[19:26:31.901] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:31.901] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:45:0) after 1m0s
[19:27:31.886] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:45:0)
[19:27:31.886] Timer tick, asking Buildbucket for the build status
[19:27:32.004] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:32.004] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:46:0) after 1m0s
[19:28:32.029] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:46:0)
[19:28:32.029] Timer tick, asking Buildbucket for the build status
[19:28:32.139] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:32.139] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:47:0) after 1m0s
[19:29:32.117] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:47:0)
[19:29:32.117] Timer tick, asking Buildbucket for the build status
[19:29:32.188] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:32.188] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:48:0) after 1m0s
[19:30:32.223] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:48:0)
[19:30:32.223] Timer tick, asking Buildbucket for the build status
[19:30:32.412] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:32.412] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:49:0) after 1m0s
[19:31:32.391] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:49:0)
[19:31:32.391] Timer tick, asking Buildbucket for the build status
[19:31:32.484] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:32.484] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:50:0) after 1m0s
[19:32:32.557] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:50:0)
[19:32:32.557] Timer tick, asking Buildbucket for the build status
[19:32:32.783] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:32.783] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:51:0) after 1m0s
[19:33:32.789] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:51:0)
[19:33:32.789] Timer tick, asking Buildbucket for the build status
[19:33:32.893] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:32.893] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:52:0) after 1m0s
[19:34:32.918] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:52:0)
[19:34:32.918] Timer tick, asking Buildbucket for the build status
[19:34:33.261] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:33.261] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:53:0) after 1m0s
[19:35:33.283] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:53:0)
[19:35:33.283] Timer tick, asking Buildbucket for the build status
[19:35:33.364] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:33.364] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:54:0) after 1m0s
[19:36:33.379] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:54:0)
[19:36:33.379] Timer tick, asking Buildbucket for the build status
[19:36:33.446] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:33.446] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:55:0) after 1m0s
[19:37:33.465] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:55:0)
[19:37:33.465] Timer tick, asking Buildbucket for the build status
[19:37:33.661] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:33.661] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:56:0) after 1m0s
[19:38:33.644] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:56:0)
[19:38:33.644] Timer tick, asking Buildbucket for the build status
[19:38:33.778] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:33.778] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:57:0) after 1m0s
[19:39:33.782] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:57:0)
[19:39:33.782] Timer tick, asking Buildbucket for the build status
[19:39:33.842] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:33.842] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:58:0) after 1m0s
[19:40:33.861] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:58:0)
[19:40:33.861] Timer tick, asking Buildbucket for the build status
[19:40:33.922] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:33.922] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:59:0) after 1m0s
[19:41:33.942] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:59:0)
[19:41:33.942] Timer tick, asking Buildbucket for the build status
[19:41:34.051] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:34.051] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:60:0) after 1m0s
[19:42:34.082] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:60:0)
[19:42:34.083] Timer tick, asking Buildbucket for the build status
[19:42:34.189] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:34.189] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:61:0) after 1m0s
[19:43:34.210] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:61:0)
[19:43:34.210] Timer tick, asking Buildbucket for the build status
[19:43:34.313] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:34.313] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:62:0) after 1m0s
[19:44:34.339] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:62:0)
[19:44:34.339] Timer tick, asking Buildbucket for the build status
[19:44:34.399] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:34.399] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:63:0) after 1m0s
[19:45:34.420] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:63:0)
[19:45:34.420] Timer tick, asking Buildbucket for the build status
[19:45:34.486] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:34.486] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:64:0) after 1m0s
[19:46:34.504] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:64:0)
[19:46:34.504] Timer tick, asking Buildbucket for the build status
[19:46:34.645] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:34.646] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:65:0) after 1m0s
[19:47:34.622] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:65:0)
[19:47:34.622] Timer tick, asking Buildbucket for the build status
[19:47:34.730] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:34.730] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:66:0) after 1m0s
[19:48:34.749] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:66:0)
[19:48:34.749] Timer tick, asking Buildbucket for the build status
[19:48:34.851] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:34.851] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:67:0) after 1m0s
[19:49:34.873] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:67:0)
[19:49:34.873] Timer tick, asking Buildbucket for the build status
[19:49:34.968] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:34.968] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:68:0) after 1m0s
[19:50:34.989] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:68:0)
[19:50:34.989] Timer tick, asking Buildbucket for the build status
[19:50:35.046] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:35.046] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:69:0) after 1m0s
[19:51:35.065] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:69:0)
[19:51:35.065] Timer tick, asking Buildbucket for the build status
[19:51:35.145] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:35.145] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:70:0) after 1m0s
[19:52:35.189] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:70:0)
[19:52:35.189] Timer tick, asking Buildbucket for the build status
[19:52:35.361] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:35.361] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:71:0) after 1m0s
[19:53:35.393] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:71:0)
[19:53:35.393] Timer tick, asking Buildbucket for the build status
[19:53:35.692] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:35.692] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:72:0) after 1m0s
[19:54:35.715] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:72:0)
[19:54:35.715] Timer tick, asking Buildbucket for the build status
[19:54:35.935] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:35.935] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:73:0) after 1m0s
[19:55:35.957] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:73:0)
[19:55:35.957] Timer tick, asking Buildbucket for the build status
[19:55:36.038] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:36.038] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:74:0) after 1m0s
[19:56:36.106] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:74:0)
[19:56:36.106] Timer tick, asking Buildbucket for the build status
[19:56:36.172] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:36.172] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:75:0) after 1m0s
[19:57:36.226] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:75:0)
[19:57:36.226] Timer tick, asking Buildbucket for the build status
[19:57:36.305] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:36.305] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:76:0) after 1m0s
[19:58:36.329] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:76:0)
[19:58:36.329] Timer tick, asking Buildbucket for the build status
[19:58:36.465] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:36.465] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:77:0) after 1m0s
[19:59:36.489] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:77:0)
[19:59:36.489] Timer tick, asking Buildbucket for the build status
[19:59:36.548] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:36.548] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:78:0) after 1m0s
[20:00:36.576] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:78:0)
[20:00:36.576] Timer tick, asking Buildbucket for the build status
[20:00:36.637] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:36.637] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:79:0) after 1m0s
[20:01:36.660] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:79:0)
[20:01:36.660] Timer tick, asking Buildbucket for the build status
[20:01:36.716] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:36.716] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:80:0) after 1m0s
[20:02:36.738] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:80:0)
[20:02:36.738] Timer tick, asking Buildbucket for the build status
[20:02:36.892] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:36.892] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:81:0) after 1m0s
[20:03:36.904] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:81:0)
[20:03:36.904] Timer tick, asking Buildbucket for the build status
[20:03:36.975] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:36.975] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:82:0) after 1m0s
[20:04:36.996] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:82:0)
[20:04:36.996] Timer tick, asking Buildbucket for the build status
[20:04:37.095] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:37.095] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:83:0) after 1m0s
[20:05:37.122] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:83:0)
[20:05:37.122] Timer tick, asking Buildbucket for the build status
[20:05:37.186] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:37.186] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:84:0) after 1m0s
[20:06:37.208] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:84:0)
[20:06:37.208] Timer tick, asking Buildbucket for the build status
[20:06:37.272] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:37.272] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:85:0) after 1m0s
[20:07:37.293] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:85:0)
[20:07:37.293] Timer tick, asking Buildbucket for the build status
[20:07:37.368] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:37.368] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:86:0) after 1m0s
[20:08:37.391] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:86:0)
[20:08:37.391] Timer tick, asking Buildbucket for the build status
[20:08:37.500] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:37.500] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:87:0) after 1m0s
[20:09:37.525] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:87:0)
[20:09:37.525] Timer tick, asking Buildbucket for the build status
[20:09:37.656] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:37.656] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:88:0) after 1m0s
[20:10:37.680] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:88:0)
[20:10:37.680] Timer tick, asking Buildbucket for the build status
[20:10:37.744] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:37.744] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:89:0) after 1m0s
[20:11:37.775] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:89:0)
[20:11:37.775] Timer tick, asking Buildbucket for the build status
[20:11:37.997] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:37.997] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:90:0) after 1m0s
[20:12:38.015] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:90:0)
[20:12:38.015] Timer tick, asking Buildbucket for the build status
[20:12:38.155] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:38.155] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:91:0) after 1m0s
[20:13:38.143] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:91:0)
[20:13:38.143] Timer tick, asking Buildbucket for the build status
[20:13:38.200] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:38.200] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:92:0) after 1m0s
[20:14:38.228] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:92:0)
[20:14:38.228] Timer tick, asking Buildbucket for the build status
[20:14:38.303] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:38.303] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:93:0) after 1m0s
[20:15:38.338] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:93:0)
[20:15:38.338] Timer tick, asking Buildbucket for the build status
[20:15:38.409] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:38.409] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:94:0) after 1m0s
[20:16:38.431] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:94:0)
[20:16:38.431] Timer tick, asking Buildbucket for the build status
[20:16:38.649] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:38.649] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:95:0) after 1m0s
[20:17:38.673] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:95:0)
[20:17:38.673] Timer tick, asking Buildbucket for the build status
[20:17:39.076] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:39.076] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:96:0) after 1m0s
[20:18:39.098] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:96:0)
[20:18:39.098] Timer tick, asking Buildbucket for the build status
[20:18:39.213] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:39.213] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:97:0) after 1m0s
[20:19:39.238] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:97:0)
[20:19:39.238] Timer tick, asking Buildbucket for the build status
[20:19:39.352] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:39.352] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:98:0) after 1m0s
[20:20:39.390] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:98:0)
[20:20:39.390] Timer tick, asking Buildbucket for the build status
[20:20:39.457] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:39.457] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:99:0) after 1m0s
[20:21:39.479] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:99:0)
[20:21:39.479] Timer tick, asking Buildbucket for the build status
[20:21:39.570] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:39.570] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:100:0) after 1m0s
[20:22:39.638] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:100:0)
[20:22:39.638] Timer tick, asking Buildbucket for the build status
[20:22:39.803] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:39.803] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:101:0) after 1m0s
[20:23:39.827] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:101:0)
[20:23:39.827] Timer tick, asking Buildbucket for the build status
[20:23:39.886] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:39.886] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:102:0) after 1m0s
[20:24:39.911] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:102:0)
[20:24:39.911] Timer tick, asking Buildbucket for the build status
[20:24:39.948] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:39.948] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:103:0) after 1m0s
[20:25:40.026] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:103:0)
[20:25:40.026] Timer tick, asking Buildbucket for the build status
[20:25:40.187] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:40.188] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:104:0) after 1m0s
[20:26:40.215] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:104:0)
[20:26:40.215] Timer tick, asking Buildbucket for the build status
[20:26:40.302] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:40.302] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:105:0) after 1m0s
[20:27:40.332] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:105:0)
[20:27:40.332] Timer tick, asking Buildbucket for the build status
[20:27:40.379] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:40.379] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:106:0) after 1m0s
[20:28:40.413] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:106:0)
[20:28:40.413] Timer tick, asking Buildbucket for the build status
[20:28:40.505] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:40.505] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:107:0) after 1m0s
[20:29:40.526] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:107:0)
[20:29:40.526] Timer tick, asking Buildbucket for the build status
[20:29:40.652] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:40.652] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:108:0) after 1m0s
[20:30:40.697] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:108:0)
[20:30:40.697] Timer tick, asking Buildbucket for the build status
[20:30:40.777] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:40.777] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:109:0) after 1m0s
[20:31:40.812] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:109:0)
[20:31:40.812] Timer tick, asking Buildbucket for the build status
[20:31:40.882] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:40.882] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:110:0) after 1m0s
[20:32:40.942] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:110:0)
[20:32:40.942] Timer tick, asking Buildbucket for the build status
[20:32:41.036] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:41.036] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:111:0) after 1m0s
[20:33:41.026] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:111:0)
[20:33:41.026] Timer tick, asking Buildbucket for the build status
[20:33:41.105] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:41.105] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:112:0) after 1m0s
[20:34:41.166] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:112:0)
[20:34:41.166] Timer tick, asking Buildbucket for the build status
[20:34:41.467] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:41.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:113:0) after 1m0s
[20:35:41.492] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:113:0)
[20:35:41.492] Timer tick, asking Buildbucket for the build status
[20:35:41.692] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:41.692] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:114:0) after 1m0s
[20:36:41.714] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:114:0)
[20:36:41.714] Timer tick, asking Buildbucket for the build status
[20:36:41.775] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:41.775] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:115:0) after 1m0s
[20:37:41.826] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:115:0)
[20:37:41.826] Timer tick, asking Buildbucket for the build status
[20:37:41.914] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:41.914] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:116:0) after 1m0s
[20:38:41.975] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:116:0)
[20:38:41.975] Timer tick, asking Buildbucket for the build status
[20:38:42.045] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:42.045] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:117:0) after 1m0s
[20:39:42.073] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:117:0)
[20:39:42.073] Timer tick, asking Buildbucket for the build status
[20:39:42.225] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:42.225] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:118:0) after 1m0s
[20:40:42.253] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:118:0)
[20:40:42.253] Timer tick, asking Buildbucket for the build status
[20:40:42.318] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:42.318] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:119:0) after 1m0s
[20:41:42.363] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:119:0)
[20:41:42.363] Timer tick, asking Buildbucket for the build status
[20:41:42.768] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:42.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:120:0) after 1m0s
[20:42:42.793] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:120:0)
[20:42:42.793] Timer tick, asking Buildbucket for the build status
[20:42:43.100] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:43.100] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:121:0) after 1m0s
[20:43:43.127] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:121:0)
[20:43:43.127] Timer tick, asking Buildbucket for the build status
[20:43:43.187] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:43.187] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:122:0) after 1m0s
[20:44:43.226] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:122:0)
[20:44:43.226] Timer tick, asking Buildbucket for the build status
[20:44:43.301] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:43.301] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:123:0) after 1m0s
[20:45:43.323] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:123:0)
[20:45:43.323] Timer tick, asking Buildbucket for the build status
[20:45:43.406] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:43.406] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:124:0) after 1m0s
[20:46:43.469] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:124:0)
[20:46:43.469] Timer tick, asking Buildbucket for the build status
[20:46:43.554] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:43.554] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:125:0) after 1m0s
[20:47:43.580] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:125:0)
[20:47:43.580] Timer tick, asking Buildbucket for the build status
[20:47:43.692] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:43.692] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:126:0) after 1m0s
[20:48:43.714] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:126:0)
[20:48:43.714] Timer tick, asking Buildbucket for the build status
[20:48:43.769] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:43.769] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:127:0) after 1m0s
[20:49:43.810] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:127:0)
[20:49:43.810] Timer tick, asking Buildbucket for the build status
[20:49:43.934] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:43.934] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:128:0) after 1m0s
[20:50:43.955] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:128:0)
[20:50:43.955] Timer tick, asking Buildbucket for the build status
[20:50:44.148] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:44.149] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:129:0) after 1m0s
[20:51:44.177] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:129:0)
[20:51:44.177] Timer tick, asking Buildbucket for the build status
[20:51:44.376] Build 8916812092427933264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:44.376] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082242154382959552:130:0) after 1m0s
[20:52:29.704] Received PubSub notification, asking Buildbucket for the build status
[20:52:29.900] Build 8916812092427933264: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:52:29.900] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1554670349248851",
"created_by": "project:infra",
"created_ts": "1554662345438582",
"failure_reason": "BUILD_FAILURE",
"id": "8916812092427933264",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"1b64cdf4a02d1d5bffcae0b3e872d77f754eacff\", \"root_solution_revision_timestamp\": 1554659382}}",
"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\": 3502, \"got_angle_revision\": \"90b1865e2a8b644bc3e200726de9e3a321ee5c18\", \"got_clang_revision\": \"357692-1\", \"got_dawn_revision\": \"20b0c33913e45cd3d553b42a43b75b27af817833\", \"got_nacl_revision\": \"067afa275dcb4b3c6eca979ea5e3fe75073c4080\", \"got_revision\": \"1b64cdf4a02d1d5bffcae0b3e872d77f754eacff\", \"got_revision_cp\": \"refs/heads/master@{#648545}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"ff7e80ae2c1880a7f578f9119805b06b1c9bbe56\", \"got_v8_revision_cp\": \"refs/heads/7.5.211@{#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\": \"1b64cdf4a02d1d5bffcae0b3e872d77f754eacff\", \"root_solution_revision_timestamp\": 1554659382.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": "1554662857737759",
"status": "COMPLETED",
"status_changed_ts": "1554662858033615",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3502",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8155",
"scheduler_invocation_id:9082242154382959552",
"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/8916812092427933264/+/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:4411ea5595a65310",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554670349381145",
"url": "https://ci.chromium.org/b/8916812092427933264",
"utcnow_ts": "1554670349881934"
}
}
[20:52:29.900] Invocation finished in 2h13m25.710481419s with status FAILED