[09:09:54.158] New invocation is queued and will start shortly
[09:09:54.158] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[09:09:55.349] Starting the invocation (attempt 1)
[09:09:55.481] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:09:55.481] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:09:55.481] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9082459157237956272",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-win\",\"properties\":{\"root_solution_revision\":\"ccdb33af4bb8edf64e5e0ba60c64f98011c9a2bf\",\"root_solution_revision_timestamp\":1554451182}}",
"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:9082459157237956272",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8126",
"user_agent:recipe"
]
}
[09:09:56.276] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "project:infra",
"created_ts": "1554455395577984",
"id": "8917029095085416224",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"ccdb33af4bb8edf64e5e0ba60c64f98011c9a2bf\", \"root_solution_revision_timestamp\": 1554451182}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554455396022970",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3476",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8126",
"scheduler_invocation_id:9082459157237956272",
"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/8917029095085416224/+/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": "1554455396023091",
"url": "https://ci.chromium.org/b/8917029095085416224",
"utcnow_ts": "1554455396258684"
}
}
[09:09:56.276] Task URL: https://ci.chromium.org/b/8917029095085416224
[09:09:56.276] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:2:0) after 1m0s
[09:10:56.295] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:2:0)
[09:10:56.295] Timer tick, asking Buildbucket for the build status
[09:10:56.415] Build 8917029095085416224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:10:56.415] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:3:0) after 1m0s
[09:11:56.394] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:3:0)
[09:11:56.394] Timer tick, asking Buildbucket for the build status
[09:11:56.507] Build 8917029095085416224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:11:56.508] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:4:0) after 1m0s
[09:12:56.503] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:4:0)
[09:12:56.503] Timer tick, asking Buildbucket for the build status
[09:12:56.654] Build 8917029095085416224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:12:56.654] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:5:0) after 1m0s
[09:13:56.673] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:5:0)
[09:13:56.673] Timer tick, asking Buildbucket for the build status
[09:13:56.747] Build 8917029095085416224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:13:56.747] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:6:0) after 1m0s
[09:14:56.765] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:6:0)
[09:14:56.765] Timer tick, asking Buildbucket for the build status
[09:14:56.849] Build 8917029095085416224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:56.850] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:7:0) after 1m0s
[09:15:56.821] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:7:0)
[09:15:56.821] Timer tick, asking Buildbucket for the build status
[09:15:56.901] Build 8917029095085416224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:15:56.901] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:8:0) after 1m0s
[09:16:56.920] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:8:0)
[09:16:56.920] Timer tick, asking Buildbucket for the build status
[09:16:57.005] Build 8917029095085416224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:16:57.005] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:9:0) after 1m0s
[09:17:56.989] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:9:0)
[09:17:56.989] Timer tick, asking Buildbucket for the build status
[09:17:57.071] Build 8917029095085416224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:17:57.071] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:10:0) after 1m0s
[09:18:57.097] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:10:0)
[09:18:57.097] Timer tick, asking Buildbucket for the build status
[09:18:57.175] Build 8917029095085416224: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:18:57.175] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:11:0) after 1m0s
[09:19:19.654] Received PubSub notification, asking Buildbucket for the build status
[09:19:19.817] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:57.197] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:11:0)
[09:19:57.197] Timer tick, asking Buildbucket for the build status
[09:19:57.249] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:57.249] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:13:0) after 1m0s
[09:20:57.254] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:13:0)
[09:20:57.254] Timer tick, asking Buildbucket for the build status
[09:20:57.337] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:57.337] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:14:0) after 1m0s
[09:21:57.358] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:14:0)
[09:21:57.358] Timer tick, asking Buildbucket for the build status
[09:21:57.431] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:57.431] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:15:0) after 1m0s
[09:22:57.449] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:15:0)
[09:22:57.449] Timer tick, asking Buildbucket for the build status
[09:22:57.678] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:57.678] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:16:0) after 1m0s
[09:23:57.710] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:16:0)
[09:23:57.710] Timer tick, asking Buildbucket for the build status
[09:23:57.886] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:57.886] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:17:0) after 1m0s
[09:24:57.917] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:17:0)
[09:24:57.917] Timer tick, asking Buildbucket for the build status
[09:24:57.983] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:57.983] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:18:0) after 1m0s
[09:25:57.993] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:18:0)
[09:25:57.993] Timer tick, asking Buildbucket for the build status
[09:25:58.079] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:58.079] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:19:0) after 1m0s
[09:26:58.100] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:19:0)
[09:26:58.100] Timer tick, asking Buildbucket for the build status
[09:26:58.174] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:58.174] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:20:0) after 1m0s
[09:27:58.195] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:20:0)
[09:27:58.195] Timer tick, asking Buildbucket for the build status
[09:27:58.307] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:58.307] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:21:0) after 1m0s
[09:28:58.330] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:21:0)
[09:28:58.330] Timer tick, asking Buildbucket for the build status
[09:28:58.414] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:58.414] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:22:0) after 1m0s
[09:29:58.395] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:22:0)
[09:29:58.395] Timer tick, asking Buildbucket for the build status
[09:29:58.465] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:58.465] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:23:0) after 1m0s
[09:30:58.484] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:23:0)
[09:30:58.484] Timer tick, asking Buildbucket for the build status
[09:30:58.550] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:58.550] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:24:0) after 1m0s
[09:31:58.568] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:24:0)
[09:31:58.568] Timer tick, asking Buildbucket for the build status
[09:31:58.817] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:58.817] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:25:0) after 1m0s
[09:32:58.803] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:25:0)
[09:32:58.803] Timer tick, asking Buildbucket for the build status
[09:32:58.891] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:58.891] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:26:0) after 1m0s
[09:33:58.960] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:26:0)
[09:33:58.960] Timer tick, asking Buildbucket for the build status
[09:33:59.188] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:59.188] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:27:0) after 1m0s
[09:34:59.207] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:27:0)
[09:34:59.207] Timer tick, asking Buildbucket for the build status
[09:34:59.498] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:59.498] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:28:0) after 1m0s
[09:35:59.490] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:28:0)
[09:35:59.490] Timer tick, asking Buildbucket for the build status
[09:35:59.669] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:59.669] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:29:0) after 1m0s
[09:36:59.689] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:29:0)
[09:36:59.689] Timer tick, asking Buildbucket for the build status
[09:36:59.904] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:59.904] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:30:0) after 1m0s
[09:37:59.923] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:30:0)
[09:37:59.923] Timer tick, asking Buildbucket for the build status
[09:37:59.981] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:59.981] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:31:0) after 1m0s
[09:39:00.000] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:31:0)
[09:39:00.000] Timer tick, asking Buildbucket for the build status
[09:39:00.141] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:00.141] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:32:0) after 1m0s
[09:40:00.161] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:32:0)
[09:40:00.161] Timer tick, asking Buildbucket for the build status
[09:40:00.269] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:00.269] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:33:0) after 1m0s
[09:41:00.288] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:33:0)
[09:41:00.289] Timer tick, asking Buildbucket for the build status
[09:41:00.488] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:00.488] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:34:0) after 1m0s
[09:42:00.527] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:34:0)
[09:42:00.527] Timer tick, asking Buildbucket for the build status
[09:42:00.597] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:00.597] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:35:0) after 1m0s
[09:43:00.619] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:35:0)
[09:43:00.619] Timer tick, asking Buildbucket for the build status
[09:43:00.980] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:00.980] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:36:0) after 1m0s
[09:44:00.994] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:36:0)
[09:44:00.994] Timer tick, asking Buildbucket for the build status
[09:44:03.792] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:03.792] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:37:0) after 1m0s
[09:45:03.811] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:37:0)
[09:45:03.811] Timer tick, asking Buildbucket for the build status
[09:45:03.872] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:03.872] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:38:0) after 1m0s
[09:46:03.891] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:38:0)
[09:46:03.891] Timer tick, asking Buildbucket for the build status
[09:46:03.971] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:03.971] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:39:0) after 1m0s
[09:47:03.986] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:39:0)
[09:47:03.986] Timer tick, asking Buildbucket for the build status
[09:47:04.185] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:04.185] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:40:0) after 1m0s
[09:48:04.251] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:40:0)
[09:48:04.251] Timer tick, asking Buildbucket for the build status
[09:48:04.403] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:04.403] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:41:0) after 1m0s
[09:49:04.402] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:41:0)
[09:49:04.402] Timer tick, asking Buildbucket for the build status
[09:49:05.611] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:05.611] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:42:0) after 1m0s
[09:50:05.590] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:42:0)
[09:50:05.591] Timer tick, asking Buildbucket for the build status
[09:50:05.685] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:05.685] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:43:0) after 1m0s
[09:51:05.681] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:43:0)
[09:51:05.681] Timer tick, asking Buildbucket for the build status
[09:51:05.819] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:05.819] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:44:0) after 1m0s
[09:52:05.848] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:44:0)
[09:52:05.848] Timer tick, asking Buildbucket for the build status
[09:52:05.916] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:05.916] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:45:0) after 1m0s
[09:53:05.931] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:45:0)
[09:53:05.931] Timer tick, asking Buildbucket for the build status
[09:53:05.990] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:05.990] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:46:0) after 1m0s
[09:54:06.013] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:46:0)
[09:54:06.013] Timer tick, asking Buildbucket for the build status
[09:54:06.175] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:06.175] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:47:0) after 1m0s
[09:55:06.195] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:47:0)
[09:55:06.195] Timer tick, asking Buildbucket for the build status
[09:55:06.395] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:06.395] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:48:0) after 1m0s
[09:56:06.480] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:48:0)
[09:56:06.480] Timer tick, asking Buildbucket for the build status
[09:56:06.539] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:06.539] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:49:0) after 1m0s
[09:57:06.570] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:49:0)
[09:57:06.570] Timer tick, asking Buildbucket for the build status
[09:57:06.665] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:06.665] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:50:0) after 1m0s
[09:58:06.679] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:50:0)
[09:58:06.679] Timer tick, asking Buildbucket for the build status
[09:58:06.732] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:06.732] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:51:0) after 1m0s
[09:59:06.887] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:51:0)
[09:59:06.887] Timer tick, asking Buildbucket for the build status
[09:59:07.088] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:07.088] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:52:0) after 1m0s
[10:00:07.091] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:52:0)
[10:00:07.091] Timer tick, asking Buildbucket for the build status
[10:00:07.170] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:07.170] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:53:0) after 1m0s
[10:01:07.153] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:53:0)
[10:01:07.153] Timer tick, asking Buildbucket for the build status
[10:01:07.709] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:07.709] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:54:0) after 1m0s
[10:02:07.736] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:54:0)
[10:02:07.736] Timer tick, asking Buildbucket for the build status
[10:02:07.804] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:07.805] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:55:0) after 1m0s
[10:03:07.824] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:55:0)
[10:03:07.824] Timer tick, asking Buildbucket for the build status
[10:03:07.916] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:07.916] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:56:0) after 1m0s
[10:04:07.897] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:56:0)
[10:04:07.897] Timer tick, asking Buildbucket for the build status
[10:04:07.990] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:07.990] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:57:0) after 1m0s
[10:05:08.040] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:57:0)
[10:05:08.040] Timer tick, asking Buildbucket for the build status
[10:05:08.169] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:08.169] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:58:0) after 1m0s
[10:06:08.144] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:58:0)
[10:06:08.144] Timer tick, asking Buildbucket for the build status
[10:06:08.643] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:08.643] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:59:0) after 1m0s
[10:07:08.664] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:59:0)
[10:07:08.664] Timer tick, asking Buildbucket for the build status
[10:07:09.114] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:09.114] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:60:0) after 1m0s
[10:08:09.133] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:60:0)
[10:08:09.133] Timer tick, asking Buildbucket for the build status
[10:08:09.235] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:09.235] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:61:0) after 1m0s
[10:09:09.255] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:61:0)
[10:09:09.255] Timer tick, asking Buildbucket for the build status
[10:09:09.325] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:09.325] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:62:0) after 1m0s
[10:10:09.297] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:62:0)
[10:10:09.297] Timer tick, asking Buildbucket for the build status
[10:10:09.909] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:09.909] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:63:0) after 1m0s
[10:11:09.930] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:63:0)
[10:11:09.930] Timer tick, asking Buildbucket for the build status
[10:11:09.977] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:09.977] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:64:0) after 1m0s
[10:12:09.978] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:64:0)
[10:12:09.978] Timer tick, asking Buildbucket for the build status
[10:12:10.051] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:10.051] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:65:0) after 1m0s
[10:13:10.074] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:65:0)
[10:13:10.074] Timer tick, asking Buildbucket for the build status
[10:13:10.148] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:10.148] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:66:0) after 1m0s
[10:14:10.169] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:66:0)
[10:14:10.169] Timer tick, asking Buildbucket for the build status
[10:14:10.354] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:10.354] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:67:0) after 1m0s
[10:15:10.395] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:67:0)
[10:15:10.395] Timer tick, asking Buildbucket for the build status
[10:15:10.570] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:10.570] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:68:0) after 1m0s
[10:16:10.573] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:68:0)
[10:16:10.573] Timer tick, asking Buildbucket for the build status
[10:16:10.634] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:10.634] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:69:0) after 1m0s
[10:17:10.655] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:69:0)
[10:17:10.655] Timer tick, asking Buildbucket for the build status
[10:17:10.696] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:10.696] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:70:0) after 1m0s
[10:18:10.726] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:70:0)
[10:18:10.726] Timer tick, asking Buildbucket for the build status
[10:18:10.816] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:10.817] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:71:0) after 1m0s
[10:19:10.794] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:71:0)
[10:19:10.794] Timer tick, asking Buildbucket for the build status
[10:19:10.832] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:10.832] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:72:0) after 1m0s
[10:20:10.852] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:72:0)
[10:20:10.852] Timer tick, asking Buildbucket for the build status
[10:20:10.971] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:10.971] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:73:0) after 1m0s
[10:21:10.995] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:73:0)
[10:21:10.995] Timer tick, asking Buildbucket for the build status
[10:21:11.207] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:11.207] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:74:0) after 1m0s
[10:22:11.230] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:74:0)
[10:22:11.230] Timer tick, asking Buildbucket for the build status
[10:22:11.289] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:11.289] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:75:0) after 1m0s
[10:23:11.315] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:75:0)
[10:23:11.315] Timer tick, asking Buildbucket for the build status
[10:23:11.410] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:11.410] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:76:0) after 1m0s
[10:24:11.431] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:76:0)
[10:24:11.431] Timer tick, asking Buildbucket for the build status
[10:24:11.593] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:11.593] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:77:0) after 1m0s
[10:25:11.613] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:77:0)
[10:25:11.613] Timer tick, asking Buildbucket for the build status
[10:25:11.768] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:11.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:78:0) after 1m0s
[10:26:11.756] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:78:0)
[10:26:11.756] Timer tick, asking Buildbucket for the build status
[10:26:11.824] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:11.824] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:79:0) after 1m0s
[10:27:11.808] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:79:0)
[10:27:11.808] Timer tick, asking Buildbucket for the build status
[10:27:11.891] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:11.891] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:80:0) after 1m0s
[10:28:11.914] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:80:0)
[10:28:11.914] Timer tick, asking Buildbucket for the build status
[10:28:11.989] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:11.989] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:81:0) after 1m0s
[10:29:11.995] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:81:0)
[10:29:11.995] Timer tick, asking Buildbucket for the build status
[10:29:12.075] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:12.075] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:82:0) after 1m0s
[10:30:12.107] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:82:0)
[10:30:12.107] Timer tick, asking Buildbucket for the build status
[10:30:12.381] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:12.381] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:83:0) after 1m0s
[10:31:12.400] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:83:0)
[10:31:12.400] Timer tick, asking Buildbucket for the build status
[10:31:12.504] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:12.504] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:84:0) after 1m0s
[10:32:12.527] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:84:0)
[10:32:12.527] Timer tick, asking Buildbucket for the build status
[10:32:12.685] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:12.685] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:85:0) after 1m0s
[10:33:12.722] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:85:0)
[10:33:12.722] Timer tick, asking Buildbucket for the build status
[10:33:12.839] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:12.839] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:86:0) after 1m0s
[10:34:12.945] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:86:0)
[10:34:12.946] Timer tick, asking Buildbucket for the build status
[10:34:13.096] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:13.096] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:87:0) after 1m0s
[10:35:13.138] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:87:0)
[10:35:13.138] Timer tick, asking Buildbucket for the build status
[10:35:13.221] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:13.221] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:88:0) after 1m0s
[10:36:13.246] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:88:0)
[10:36:13.246] Timer tick, asking Buildbucket for the build status
[10:36:13.467] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:13.467] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:89:0) after 1m0s
[10:37:13.443] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:89:0)
[10:37:13.443] Timer tick, asking Buildbucket for the build status
[10:37:13.560] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:13.560] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:90:0) after 1m0s
[10:38:13.587] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:90:0)
[10:38:13.587] Timer tick, asking Buildbucket for the build status
[10:38:13.680] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:13.680] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:91:0) after 1m0s
[10:39:13.688] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:91:0)
[10:39:13.688] Timer tick, asking Buildbucket for the build status
[10:39:13.744] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:13.744] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:92:0) after 1m0s
[10:40:13.795] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:92:0)
[10:40:13.795] Timer tick, asking Buildbucket for the build status
[10:40:13.860] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:13.860] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:93:0) after 1m0s
[10:41:13.884] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:93:0)
[10:41:13.884] Timer tick, asking Buildbucket for the build status
[10:41:14.012] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:14.012] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:94:0) after 1m0s
[10:42:14.041] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:94:0)
[10:42:14.041] Timer tick, asking Buildbucket for the build status
[10:42:14.200] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:14.200] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:95:0) after 1m0s
[10:43:14.239] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:95:0)
[10:43:14.239] Timer tick, asking Buildbucket for the build status
[10:43:14.321] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:14.321] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:96:0) after 1m0s
[10:44:14.387] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:96:0)
[10:44:14.387] Timer tick, asking Buildbucket for the build status
[10:44:14.492] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:14.492] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:97:0) after 1m0s
[10:45:14.516] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:97:0)
[10:45:14.516] Timer tick, asking Buildbucket for the build status
[10:45:14.573] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:14.573] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:98:0) after 1m0s
[10:46:14.592] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:98:0)
[10:46:14.592] Timer tick, asking Buildbucket for the build status
[10:46:14.777] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:14.777] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:99:0) after 1m0s
[10:47:14.803] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:99:0)
[10:47:14.803] Timer tick, asking Buildbucket for the build status
[10:47:14.877] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:14.877] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:100:0) after 1m0s
[10:48:14.908] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:100:0)
[10:48:14.908] Timer tick, asking Buildbucket for the build status
[10:48:15.012] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:15.012] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:101:0) after 1m0s
[10:49:15.032] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:101:0)
[10:49:15.032] Timer tick, asking Buildbucket for the build status
[10:49:15.138] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:15.138] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:102:0) after 1m0s
[10:50:15.142] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:102:0)
[10:50:15.142] Timer tick, asking Buildbucket for the build status
[10:50:15.241] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:15.241] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:103:0) after 1m0s
[10:51:15.263] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:103:0)
[10:51:15.263] Timer tick, asking Buildbucket for the build status
[10:51:15.469] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:15.469] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:104:0) after 1m0s
[10:52:15.476] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:104:0)
[10:52:15.477] Timer tick, asking Buildbucket for the build status
[10:52:15.858] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:15.858] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:105:0) after 1m0s
[10:53:15.878] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:105:0)
[10:53:15.878] Timer tick, asking Buildbucket for the build status
[10:53:15.971] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:15.971] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:106:0) after 1m0s
[10:54:16.009] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:106:0)
[10:54:16.009] Timer tick, asking Buildbucket for the build status
[10:54:16.680] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:16.680] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:107:0) after 1m0s
[10:55:16.679] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:107:0)
[10:55:16.679] Timer tick, asking Buildbucket for the build status
[10:55:16.757] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:16.757] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:108:0) after 1m0s
[10:56:16.781] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:108:0)
[10:56:16.781] Timer tick, asking Buildbucket for the build status
[10:56:17.336] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:17.336] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:109:0) after 1m0s
[10:57:17.356] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:109:0)
[10:57:17.356] Timer tick, asking Buildbucket for the build status
[10:57:17.503] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:17.503] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:110:0) after 1m0s
[10:58:17.553] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:110:0)
[10:58:17.553] Timer tick, asking Buildbucket for the build status
[10:58:17.775] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:17.775] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:111:0) after 1m0s
[10:59:17.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:111:0)
[10:59:17.802] Timer tick, asking Buildbucket for the build status
[10:59:17.910] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:17.910] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:112:0) after 1m0s
[11:00:17.953] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:112:0)
[11:00:17.953] Timer tick, asking Buildbucket for the build status
[11:00:18.103] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:18.103] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:113:0) after 1m0s
[11:01:18.145] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:113:0)
[11:01:18.145] Timer tick, asking Buildbucket for the build status
[11:01:18.285] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:18.285] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:114:0) after 1m0s
[11:02:18.307] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:114:0)
[11:02:18.307] Timer tick, asking Buildbucket for the build status
[11:02:18.406] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:18.406] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:115:0) after 1m0s
[11:03:18.410] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:115:0)
[11:03:18.410] Timer tick, asking Buildbucket for the build status
[11:03:18.561] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:18.561] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:116:0) after 1m0s
[11:04:18.585] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:116:0)
[11:04:18.585] Timer tick, asking Buildbucket for the build status
[11:04:18.650] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:18.650] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:117:0) after 1m0s
[11:05:18.672] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:117:0)
[11:05:18.672] Timer tick, asking Buildbucket for the build status
[11:05:18.730] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:18.730] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:118:0) after 1m0s
[11:06:18.727] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:118:0)
[11:06:18.727] Timer tick, asking Buildbucket for the build status
[11:06:18.895] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:18.895] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:119:0) after 1m0s
[11:07:18.918] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:119:0)
[11:07:18.918] Timer tick, asking Buildbucket for the build status
[11:07:18.962] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:18.962] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:120:0) after 1m0s
[11:08:18.970] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:120:0)
[11:08:18.970] Timer tick, asking Buildbucket for the build status
[11:08:19.037] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:19.037] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:121:0) after 1m0s
[11:09:19.059] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:121:0)
[11:09:19.059] Timer tick, asking Buildbucket for the build status
[11:09:19.129] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:19.129] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:122:0) after 1m0s
[11:10:19.156] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:122:0)
[11:10:19.156] Timer tick, asking Buildbucket for the build status
[11:10:19.275] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:19.275] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:123:0) after 1m0s
[11:11:19.268] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:123:0)
[11:11:19.268] Timer tick, asking Buildbucket for the build status
[11:11:19.335] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:19.335] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:124:0) after 1m0s
[11:12:19.358] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:124:0)
[11:12:19.358] Timer tick, asking Buildbucket for the build status
[11:12:19.499] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:19.499] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:125:0) after 1m0s
[11:13:19.505] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:125:0)
[11:13:19.505] Timer tick, asking Buildbucket for the build status
[11:13:19.575] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:19.575] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:126:0) after 1m0s
[11:14:19.595] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:126:0)
[11:14:19.595] Timer tick, asking Buildbucket for the build status
[11:14:19.894] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:19.894] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:127:0) after 1m0s
[11:15:20.009] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:127:0)
[11:15:20.009] Timer tick, asking Buildbucket for the build status
[11:15:20.098] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:20.098] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:128:0) after 1m0s
[11:16:20.119] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:128:0)
[11:16:20.119] Timer tick, asking Buildbucket for the build status
[11:16:20.200] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:20.200] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:129:0) after 1m0s
[11:17:20.215] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:129:0)
[11:17:20.215] Timer tick, asking Buildbucket for the build status
[11:17:20.277] Build 8917029095085416224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:20.277] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082459157237956272:130:0) after 1m0s
[11:18:08.954] Received PubSub notification, asking Buildbucket for the build status
[11:18:09.012] Build 8917029095085416224: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:18:09.012] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1554463088256351",
"created_by": "project:infra",
"created_ts": "1554455395577984",
"failure_reason": "BUILD_FAILURE",
"id": "8917029095085416224",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"ccdb33af4bb8edf64e5e0ba60c64f98011c9a2bf\", \"root_solution_revision_timestamp\": 1554451182}}",
"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\": 3476, \"got_angle_revision\": \"fb201c5e208dda3fb657ae3c543f0f6059ecb4f0\", \"got_clang_revision\": \"356356-3\", \"got_dawn_revision\": \"20b0c33913e45cd3d553b42a43b75b27af817833\", \"got_nacl_revision\": \"2c300847c7700af6948ad78e79ccd21bd7ba0c14\", \"got_revision\": \"ccdb33af4bb8edf64e5e0ba60c64f98011c9a2bf\", \"got_revision_cp\": \"refs/heads/master@{#648107}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"c6983f4880540c602fe2754ba9dc8329320b95a9\", \"got_v8_revision_cp\": \"refs/heads/7.5.198@{#1}\", \"got_webrtc_revision\": \"1c747f5717bcbde029a2d496832ee52388dbda05\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27454}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"ccdb33af4bb8edf64e5e0ba60c64f98011c9a2bf\", \"root_solution_revision_timestamp\": 1554451182.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": "1554455959152574",
"status": "COMPLETED",
"status_changed_ts": "1554455959472421",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3476",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8126",
"scheduler_invocation_id:9082459157237956272",
"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/8917029095085416224/+/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:44059487e1c7ca10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554463088600706",
"url": "https://ci.chromium.org/b/8917029095085416224",
"utcnow_ts": "1554463089003618"
}
}
[11:18:09.012] Invocation finished in 2h8m14.871114939s with status FAILED