[16:45:46.428] New invocation is queued and will start shortly
[16:45:46.428] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[16:45:47.495] Starting the invocation (attempt 1)
[16:45:47.536] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:45:47.537] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:45:47.537] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9082249282371681152",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-win\",\"properties\":{\"root_solution_revision\":\"d12bc960eafa087c967ba781c8a5050f64d69c2d\",\"root_solution_revision_timestamp\":1554650208}}",
"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:9082249282371681152",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8154",
"user_agent:recipe"
]
}
[16:45:48.165] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "project:infra",
"created_ts": "1554655547629446",
"id": "8916819220447618672",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"d12bc960eafa087c967ba781c8a5050f64d69c2d\", \"root_solution_revision_timestamp\": 1554650208}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554655548040629",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3501",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8154",
"scheduler_invocation_id:9082249282371681152",
"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/8916819220447618672/+/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": "1554655548040751",
"url": "https://ci.chromium.org/b/8916819220447618672",
"utcnow_ts": "1554655548155952"
}
}
[16:45:48.165] Task URL: https://ci.chromium.org/b/8916819220447618672
[16:45:48.165] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:2:0) after 1m0s
[16:46:48.170] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:2:0)
[16:46:48.170] Timer tick, asking Buildbucket for the build status
[16:46:48.509] Build 8916819220447618672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:46:48.509] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:3:0) after 1m0s
[16:47:48.545] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:3:0)
[16:47:48.545] Timer tick, asking Buildbucket for the build status
[16:47:48.687] Build 8916819220447618672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:47:48.687] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:4:0) after 1m0s
[16:48:48.706] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:4:0)
[16:48:48.706] Timer tick, asking Buildbucket for the build status
[16:48:48.776] Build 8916819220447618672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:48:48.776] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:5:0) after 1m0s
[16:49:48.793] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:5:0)
[16:49:48.793] Timer tick, asking Buildbucket for the build status
[16:49:48.873] Build 8916819220447618672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:49:48.873] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:6:0) after 1m0s
[16:50:48.860] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:6:0)
[16:50:48.860] Timer tick, asking Buildbucket for the build status
[16:50:49.067] Build 8916819220447618672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:49.067] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:7:0) after 1m0s
[16:51:49.076] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:7:0)
[16:51:49.076] Timer tick, asking Buildbucket for the build status
[16:51:49.175] Build 8916819220447618672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:49.175] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:8:0) after 1m0s
[16:52:49.208] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:8:0)
[16:52:49.208] Timer tick, asking Buildbucket for the build status
[16:52:49.317] Build 8916819220447618672: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:49.317] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:9:0) after 1m0s
[16:53:40.733] Received PubSub notification, asking Buildbucket for the build status
[16:53:40.948] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:49.334] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:9:0)
[16:53:49.334] Timer tick, asking Buildbucket for the build status
[16:53:49.390] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:49.390] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:11:0) after 1m0s
[16:54:49.401] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:11:0)
[16:54:49.401] Timer tick, asking Buildbucket for the build status
[16:54:49.673] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:49.673] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:12:0) after 1m0s
[16:55:49.694] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:12:0)
[16:55:49.694] Timer tick, asking Buildbucket for the build status
[16:55:50.146] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:50.146] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:13:0) after 1m0s
[16:56:50.167] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:13:0)
[16:56:50.167] Timer tick, asking Buildbucket for the build status
[16:56:50.471] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:50.471] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:14:0) after 1m0s
[16:57:50.491] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:14:0)
[16:57:50.491] Timer tick, asking Buildbucket for the build status
[16:57:50.554] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:50.555] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:15:0) after 1m0s
[16:58:50.573] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:15:0)
[16:58:50.573] Timer tick, asking Buildbucket for the build status
[16:58:50.669] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:50.669] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:16:0) after 1m0s
[16:59:50.688] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:16:0)
[16:59:50.688] Timer tick, asking Buildbucket for the build status
[16:59:50.749] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:50.749] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:17:0) after 1m0s
[17:00:50.873] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:17:0)
[17:00:50.873] Timer tick, asking Buildbucket for the build status
[17:00:51.066] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:51.066] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:18:0) after 1m0s
[17:01:51.089] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:18:0)
[17:01:51.089] Timer tick, asking Buildbucket for the build status
[17:01:51.203] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:51.203] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:19:0) after 1m0s
[17:02:51.210] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:19:0)
[17:02:51.210] Timer tick, asking Buildbucket for the build status
[17:02:51.271] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:51.271] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:20:0) after 1m0s
[17:03:51.304] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:20:0)
[17:03:51.304] Timer tick, asking Buildbucket for the build status
[17:03:51.380] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:51.380] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:21:0) after 1m0s
[17:04:51.398] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:21:0)
[17:04:51.398] Timer tick, asking Buildbucket for the build status
[17:04:51.492] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:51.492] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:22:0) after 1m0s
[17:05:51.499] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:22:0)
[17:05:51.499] Timer tick, asking Buildbucket for the build status
[17:05:51.617] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:51.617] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:23:0) after 1m0s
[17:06:51.610] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:23:0)
[17:06:51.610] Timer tick, asking Buildbucket for the build status
[17:06:51.881] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:51.882] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:24:0) after 1m0s
[17:07:51.901] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:24:0)
[17:07:51.901] Timer tick, asking Buildbucket for the build status
[17:07:51.978] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:51.978] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:25:0) after 1m0s
[17:08:52.092] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:25:0)
[17:08:52.092] Timer tick, asking Buildbucket for the build status
[17:08:52.309] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:52.309] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:26:0) after 1m0s
[17:09:52.339] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:26:0)
[17:09:52.339] Timer tick, asking Buildbucket for the build status
[17:09:52.560] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:52.560] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:27:0) after 1m0s
[17:10:52.581] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:27:0)
[17:10:52.581] Timer tick, asking Buildbucket for the build status
[17:10:52.880] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:52.880] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:28:0) after 1m0s
[17:11:52.898] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:28:0)
[17:11:52.898] Timer tick, asking Buildbucket for the build status
[17:11:52.966] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:52.966] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:29:0) after 1m0s
[17:12:52.941] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:29:0)
[17:12:52.941] Timer tick, asking Buildbucket for the build status
[17:12:53.011] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:53.011] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:30:0) after 1m0s
[17:13:52.983] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:30:0)
[17:13:52.983] Timer tick, asking Buildbucket for the build status
[17:13:53.224] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:53.224] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:31:0) after 1m0s
[17:14:53.228] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:31:0)
[17:14:53.228] Timer tick, asking Buildbucket for the build status
[17:14:53.298] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:53.298] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:32:0) after 1m0s
[17:15:53.315] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:32:0)
[17:15:53.315] Timer tick, asking Buildbucket for the build status
[17:15:53.468] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:53.468] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:33:0) after 1m0s
[17:16:53.487] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:33:0)
[17:16:53.487] Timer tick, asking Buildbucket for the build status
[17:16:53.560] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:53.560] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:34:0) after 1m0s
[17:17:53.568] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:34:0)
[17:17:53.568] Timer tick, asking Buildbucket for the build status
[17:17:53.709] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:53.709] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:35:0) after 1m0s
[17:18:53.728] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:35:0)
[17:18:53.728] Timer tick, asking Buildbucket for the build status
[17:18:53.874] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:53.874] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:36:0) after 1m0s
[17:19:53.893] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:36:0)
[17:19:53.893] Timer tick, asking Buildbucket for the build status
[17:19:53.979] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:53.979] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:37:0) after 1m0s
[17:20:53.986] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:37:0)
[17:20:53.986] Timer tick, asking Buildbucket for the build status
[17:20:54.149] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:54.149] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:38:0) after 1m0s
[17:21:54.134] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:38:0)
[17:21:54.134] Timer tick, asking Buildbucket for the build status
[17:21:55.057] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:55.057] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:39:0) after 1m0s
[17:22:55.098] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:39:0)
[17:22:55.098] Timer tick, asking Buildbucket for the build status
[17:22:55.160] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:55.160] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:40:0) after 1m0s
[17:23:55.186] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:40:0)
[17:23:55.186] Timer tick, asking Buildbucket for the build status
[17:23:55.253] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:55.253] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:41:0) after 1m0s
[17:24:55.274] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:41:0)
[17:24:55.274] Timer tick, asking Buildbucket for the build status
[17:24:55.354] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:55.354] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:42:0) after 1m0s
[17:25:55.377] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:42:0)
[17:25:55.377] Timer tick, asking Buildbucket for the build status
[17:25:55.502] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:55.502] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:43:0) after 1m0s
[17:26:55.515] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:43:0)
[17:26:55.515] Timer tick, asking Buildbucket for the build status
[17:26:55.665] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:55.665] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:44:0) after 1m0s
[17:27:55.659] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:44:0)
[17:27:55.659] Timer tick, asking Buildbucket for the build status
[17:27:55.758] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:55.758] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:45:0) after 1m0s
[17:28:55.777] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:45:0)
[17:28:55.777] Timer tick, asking Buildbucket for the build status
[17:28:55.898] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:55.899] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:46:0) after 1m0s
[17:29:55.921] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:46:0)
[17:29:55.921] Timer tick, asking Buildbucket for the build status
[17:29:55.984] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:55.984] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:47:0) after 1m0s
[17:30:55.974] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:47:0)
[17:30:55.974] Timer tick, asking Buildbucket for the build status
[17:30:56.050] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:56.050] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:48:0) after 1m0s
[17:31:56.026] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:48:0)
[17:31:56.026] Timer tick, asking Buildbucket for the build status
[17:31:56.102] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:56.102] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:49:0) after 1m0s
[17:32:56.086] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:49:0)
[17:32:56.086] Timer tick, asking Buildbucket for the build status
[17:32:56.160] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:56.160] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:50:0) after 1m0s
[17:33:56.181] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:50:0)
[17:33:56.181] Timer tick, asking Buildbucket for the build status
[17:33:56.352] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:56.352] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:51:0) after 1m0s
[17:34:56.375] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:51:0)
[17:34:56.375] Timer tick, asking Buildbucket for the build status
[17:34:56.449] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:56.449] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:52:0) after 1m0s
[17:35:56.468] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:52:0)
[17:35:56.468] Timer tick, asking Buildbucket for the build status
[17:35:56.527] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:56.527] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:53:0) after 1m0s
[17:36:56.501] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:53:0)
[17:36:56.501] Timer tick, asking Buildbucket for the build status
[17:36:56.676] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:56.676] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:54:0) after 1m0s
[17:37:56.702] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:54:0)
[17:37:56.702] Timer tick, asking Buildbucket for the build status
[17:37:56.877] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:56.877] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:55:0) after 1m0s
[17:38:56.982] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:55:0)
[17:38:56.982] Timer tick, asking Buildbucket for the build status
[17:38:57.039] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:57.039] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:56:0) after 1m0s
[17:39:57.046] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:56:0)
[17:39:57.046] Timer tick, asking Buildbucket for the build status
[17:39:57.195] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:57.195] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:57:0) after 1m0s
[17:40:57.237] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:57:0)
[17:40:57.237] Timer tick, asking Buildbucket for the build status
[17:40:57.424] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:57.424] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:58:0) after 1m0s
[17:41:57.438] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:58:0)
[17:41:57.438] Timer tick, asking Buildbucket for the build status
[17:41:57.646] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:57.646] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:59:0) after 1m0s
[17:42:57.669] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:59:0)
[17:42:57.669] Timer tick, asking Buildbucket for the build status
[17:42:57.881] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:57.881] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:60:0) after 1m0s
[17:43:57.927] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:60:0)
[17:43:57.927] Timer tick, asking Buildbucket for the build status
[17:43:58.078] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:58.078] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:61:0) after 1m0s
[17:44:58.087] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:61:0)
[17:44:58.087] Timer tick, asking Buildbucket for the build status
[17:44:58.173] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:58.173] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:62:0) after 1m0s
[17:45:58.195] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:62:0)
[17:45:58.195] Timer tick, asking Buildbucket for the build status
[17:45:58.343] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:58.343] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:63:0) after 1m0s
[17:46:58.362] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:63:0)
[17:46:58.362] Timer tick, asking Buildbucket for the build status
[17:46:58.470] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:58.470] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:64:0) after 1m0s
[17:47:58.489] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:64:0)
[17:47:58.489] Timer tick, asking Buildbucket for the build status
[17:47:58.550] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:58.550] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:65:0) after 1m0s
[17:48:58.621] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:65:0)
[17:48:58.621] Timer tick, asking Buildbucket for the build status
[17:48:58.872] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:58.872] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:66:0) after 1m0s
[17:49:58.911] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:66:0)
[17:49:58.911] Timer tick, asking Buildbucket for the build status
[17:49:58.998] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:58.998] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:67:0) after 1m0s
[17:50:59.018] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:67:0)
[17:50:59.018] Timer tick, asking Buildbucket for the build status
[17:50:59.112] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:59.112] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:68:0) after 1m0s
[17:51:59.135] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:68:0)
[17:51:59.135] Timer tick, asking Buildbucket for the build status
[17:51:59.274] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:59.274] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:69:0) after 1m0s
[17:52:59.269] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:69:0)
[17:52:59.269] Timer tick, asking Buildbucket for the build status
[17:52:59.327] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:59.327] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:70:0) after 1m0s
[17:53:59.351] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:70:0)
[17:53:59.351] Timer tick, asking Buildbucket for the build status
[17:53:59.529] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:59.529] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:71:0) after 1m0s
[17:54:59.549] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:71:0)
[17:54:59.549] Timer tick, asking Buildbucket for the build status
[17:54:59.664] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:59.664] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:72:0) after 1m0s
[17:55:59.685] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:72:0)
[17:55:59.685] Timer tick, asking Buildbucket for the build status
[17:55:59.803] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:59.803] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:73:0) after 1m0s
[17:56:59.827] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:73:0)
[17:56:59.827] Timer tick, asking Buildbucket for the build status
[17:56:59.911] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:59.911] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:74:0) after 1m0s
[17:57:59.934] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:74:0)
[17:57:59.934] Timer tick, asking Buildbucket for the build status
[17:58:00.043] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:00.043] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:75:0) after 1m0s
[17:59:00.081] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:75:0)
[17:59:00.081] Timer tick, asking Buildbucket for the build status
[17:59:00.141] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:00.141] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:76:0) after 1m0s
[18:00:00.159] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:76:0)
[18:00:00.159] Timer tick, asking Buildbucket for the build status
[18:00:00.224] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:00.224] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:77:0) after 1m0s
[18:01:00.244] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:77:0)
[18:01:00.244] Timer tick, asking Buildbucket for the build status
[18:01:00.327] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:00.327] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:78:0) after 1m0s
[18:02:00.321] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:78:0)
[18:02:00.321] Timer tick, asking Buildbucket for the build status
[18:02:00.393] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:00.393] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:79:0) after 1m0s
[18:03:00.417] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:79:0)
[18:03:00.417] Timer tick, asking Buildbucket for the build status
[18:03:00.577] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:00.577] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:80:0) after 1m0s
[18:04:00.598] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:80:0)
[18:04:00.598] Timer tick, asking Buildbucket for the build status
[18:04:00.814] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:00.814] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:81:0) after 1m0s
[18:05:00.838] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:81:0)
[18:05:00.838] Timer tick, asking Buildbucket for the build status
[18:05:00.918] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:00.918] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:82:0) after 1m0s
[18:06:00.940] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:82:0)
[18:06:00.940] Timer tick, asking Buildbucket for the build status
[18:06:01.176] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:01.176] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:83:0) after 1m0s
[18:07:01.199] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:83:0)
[18:07:01.199] Timer tick, asking Buildbucket for the build status
[18:07:01.347] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:01.347] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:84:0) after 1m0s
[18:08:01.402] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:84:0)
[18:08:01.402] Timer tick, asking Buildbucket for the build status
[18:08:01.683] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:01.683] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:85:0) after 1m0s
[18:09:01.705] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:85:0)
[18:09:01.705] Timer tick, asking Buildbucket for the build status
[18:09:01.826] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:01.826] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:86:0) after 1m0s
[18:10:01.842] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:86:0)
[18:10:01.842] Timer tick, asking Buildbucket for the build status
[18:10:01.966] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:01.966] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:87:0) after 1m0s
[18:11:01.947] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:87:0)
[18:11:01.947] Timer tick, asking Buildbucket for the build status
[18:11:02.090] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:02.090] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:88:0) after 1m0s
[18:12:02.087] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:88:0)
[18:12:02.087] Timer tick, asking Buildbucket for the build status
[18:12:02.160] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:02.160] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:89:0) after 1m0s
[18:13:02.189] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:89:0)
[18:13:02.189] Timer tick, asking Buildbucket for the build status
[18:13:02.310] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:02.310] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:90:0) after 1m0s
[18:14:02.367] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:90:0)
[18:14:02.367] Timer tick, asking Buildbucket for the build status
[18:14:02.561] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:02.561] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:91:0) after 1m0s
[18:15:02.597] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:91:0)
[18:15:02.597] Timer tick, asking Buildbucket for the build status
[18:15:02.666] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:02.666] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:92:0) after 1m0s
[18:16:02.693] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:92:0)
[18:16:02.693] Timer tick, asking Buildbucket for the build status
[18:16:02.841] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:02.841] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:93:0) after 1m0s
[18:17:02.865] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:93:0)
[18:17:02.865] Timer tick, asking Buildbucket for the build status
[18:17:03.006] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:03.006] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:94:0) after 1m0s
[18:18:03.028] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:94:0)
[18:18:03.028] Timer tick, asking Buildbucket for the build status
[18:18:03.091] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:03.091] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:95:0) after 1m0s
[18:19:03.114] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:95:0)
[18:19:03.114] Timer tick, asking Buildbucket for the build status
[18:19:03.265] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:03.265] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:96:0) after 1m0s
[18:20:03.294] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:96:0)
[18:20:03.294] Timer tick, asking Buildbucket for the build status
[18:20:03.370] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:03.370] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:97:0) after 1m0s
[18:21:03.392] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:97:0)
[18:21:03.392] Timer tick, asking Buildbucket for the build status
[18:21:03.519] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:03.519] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:98:0) after 1m0s
[18:22:03.542] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:98:0)
[18:22:03.542] Timer tick, asking Buildbucket for the build status
[18:22:03.702] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:03.702] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:99:0) after 1m0s
[18:23:03.723] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:99:0)
[18:23:03.723] Timer tick, asking Buildbucket for the build status
[18:23:03.789] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:03.789] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:100:0) after 1m0s
[18:24:03.806] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:100:0)
[18:24:03.806] Timer tick, asking Buildbucket for the build status
[18:24:03.882] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:03.882] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:101:0) after 1m0s
[18:25:03.905] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:101:0)
[18:25:03.905] Timer tick, asking Buildbucket for the build status
[18:25:04.088] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:04.088] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:102:0) after 1m0s
[18:26:04.072] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:102:0)
[18:26:04.072] Timer tick, asking Buildbucket for the build status
[18:26:04.137] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:04.137] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:103:0) after 1m0s
[18:27:04.166] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:103:0)
[18:27:04.166] Timer tick, asking Buildbucket for the build status
[18:27:04.345] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:04.345] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:104:0) after 1m0s
[18:28:04.363] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:104:0)
[18:28:04.363] Timer tick, asking Buildbucket for the build status
[18:28:04.458] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:04.458] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:105:0) after 1m0s
[18:29:04.485] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:105:0)
[18:29:04.485] Timer tick, asking Buildbucket for the build status
[18:29:04.587] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:04.587] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:106:0) after 1m0s
[18:30:04.613] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:106:0)
[18:30:04.613] Timer tick, asking Buildbucket for the build status
[18:30:04.694] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:04.694] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:107:0) after 1m0s
[18:31:04.721] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:107:0)
[18:31:04.721] Timer tick, asking Buildbucket for the build status
[18:31:05.137] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:05.137] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:108:0) after 1m0s
[18:32:05.163] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:108:0)
[18:32:05.163] Timer tick, asking Buildbucket for the build status
[18:32:05.278] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:05.278] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:109:0) after 1m0s
[18:33:05.303] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:109:0)
[18:33:05.303] Timer tick, asking Buildbucket for the build status
[18:33:05.514] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:05.514] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:110:0) after 1m0s
[18:34:05.592] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:110:0)
[18:34:05.592] Timer tick, asking Buildbucket for the build status
[18:34:05.700] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:05.700] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:111:0) after 1m0s
[18:35:05.724] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:111:0)
[18:35:05.724] Timer tick, asking Buildbucket for the build status
[18:35:05.777] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:05.777] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:112:0) after 1m0s
[18:36:05.800] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:112:0)
[18:36:05.800] Timer tick, asking Buildbucket for the build status
[18:36:05.872] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:05.872] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:113:0) after 1m0s
[18:37:05.898] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:113:0)
[18:37:05.898] Timer tick, asking Buildbucket for the build status
[18:37:06.112] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:06.112] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:114:0) after 1m0s
[18:38:06.134] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:114:0)
[18:38:06.135] Timer tick, asking Buildbucket for the build status
[18:38:06.228] Build 8916819220447618672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:06.228] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082249282371681152:115:0) after 1m0s
[18:39:02.705] Received PubSub notification, asking Buildbucket for the build status
[18:39:02.804] Build 8916819220447618672: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[18:39:02.804] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1554662342212825",
"created_by": "project:infra",
"created_ts": "1554655547629446",
"failure_reason": "BUILD_FAILURE",
"id": "8916819220447618672",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"d12bc960eafa087c967ba781c8a5050f64d69c2d\", \"root_solution_revision_timestamp\": 1554650208}}",
"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\": 3501, \"got_angle_revision\": \"90b1865e2a8b644bc3e200726de9e3a321ee5c18\", \"got_clang_revision\": \"357692-1\", \"got_dawn_revision\": \"20b0c33913e45cd3d553b42a43b75b27af817833\", \"got_nacl_revision\": \"067afa275dcb4b3c6eca979ea5e3fe75073c4080\", \"got_revision\": \"d12bc960eafa087c967ba781c8a5050f64d69c2d\", \"got_revision_cp\": \"refs/heads/master@{#648541}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"a3c1051c26e72b7b86bd93d580e4a39ebdcbecd2\", \"got_v8_revision_cp\": \"refs/heads/7.5.210@{#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\": \"d12bc960eafa087c967ba781c8a5050f64d69c2d\", \"root_solution_revision_timestamp\": 1554650208.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": "1554656020012951",
"status": "COMPLETED",
"status_changed_ts": "1554656020465086",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3501",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8154",
"scheduler_invocation_id:9082249282371681152",
"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/8916819220447618672/+/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:4411829b92801b10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554662342369248",
"url": "https://ci.chromium.org/b/8916819220447618672",
"utcnow_ts": "1554662342795269"
}
}
[18:39:02.804] Invocation finished in 1h53m16.392765148s with status FAILED