[02:37:48.376] New invocation is queued and will start shortly
[02:37:48.376] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[02:37:49.561] Starting the invocation (attempt 1)
[02:37:49.605] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:37:49.605] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:37:49.605] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9082302631874763344",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-win\",\"properties\":{\"root_solution_revision\":\"75fa787427dd7e8380e0ff0ccd1816cb83ddbb98\",\"root_solution_revision_timestamp\":1554602104}}",
"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:9082302631874763344",
"scheduler_job_id:infra/codesearch-gen-chromium-win",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8147",
"user_agent:recipe"
]
}
[02:37:50.573] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:infra",
"created_ts": "1554604669746543",
"id": "8916872569774716720",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"75fa787427dd7e8380e0ff0ccd1816cb83ddbb98\", \"root_solution_revision_timestamp\": 1554602104}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554604670186670",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3494",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8147",
"scheduler_invocation_id:9082302631874763344",
"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/8916872569774716720/+/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": "1554604670186791",
"url": "https://ci.chromium.org/b/8916872569774716720",
"utcnow_ts": "1554604670561517"
}
}
[02:37:50.573] Task URL: https://ci.chromium.org/b/8916872569774716720
[02:37:50.573] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:2:0) after 1m0s
[02:38:50.592] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:2:0)
[02:38:50.592] Timer tick, asking Buildbucket for the build status
[02:38:50.757] Build 8916872569774716720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:50.757] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:3:0) after 1m0s
[02:39:50.777] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:3:0)
[02:39:50.777] Timer tick, asking Buildbucket for the build status
[02:39:50.989] Build 8916872569774716720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:50.989] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:4:0) after 1m0s
[02:40:51.006] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:4:0)
[02:40:51.006] Timer tick, asking Buildbucket for the build status
[02:40:51.077] Build 8916872569774716720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:51.077] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:5:0) after 1m0s
[02:41:51.095] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:5:0)
[02:41:51.095] Timer tick, asking Buildbucket for the build status
[02:41:51.191] Build 8916872569774716720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:51.191] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:6:0) after 1m0s
[02:42:51.209] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:6:0)
[02:42:51.209] Timer tick, asking Buildbucket for the build status
[02:42:51.350] Build 8916872569774716720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:51.350] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:7:0) after 1m0s
[02:43:51.369] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:7:0)
[02:43:51.369] Timer tick, asking Buildbucket for the build status
[02:43:51.504] Build 8916872569774716720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:51.504] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:8:0) after 1m0s
[02:44:51.522] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:8:0)
[02:44:51.522] Timer tick, asking Buildbucket for the build status
[02:44:51.605] Build 8916872569774716720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:51.605] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:9:0) after 1m0s
[02:45:34.506] Received PubSub notification, asking Buildbucket for the build status
[02:45:34.600] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:51.639] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:9:0)
[02:45:51.639] Timer tick, asking Buildbucket for the build status
[02:45:51.683] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:51.683] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:11:0) after 1m0s
[02:46:51.700] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:11:0)
[02:46:51.700] Timer tick, asking Buildbucket for the build status
[02:46:51.773] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:51.773] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:12:0) after 1m0s
[02:47:51.772] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:12:0)
[02:47:51.772] Timer tick, asking Buildbucket for the build status
[02:47:51.846] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:51.846] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:13:0) after 1m0s
[02:48:51.863] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:13:0)
[02:48:51.863] Timer tick, asking Buildbucket for the build status
[02:48:51.950] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:51.950] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:14:0) after 1m0s
[02:49:51.969] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:14:0)
[02:49:51.969] Timer tick, asking Buildbucket for the build status
[02:49:52.076] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:52.076] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:15:0) after 1m0s
[02:50:52.104] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:15:0)
[02:50:52.104] Timer tick, asking Buildbucket for the build status
[02:50:52.156] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:52.156] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:16:0) after 1m0s
[02:51:52.176] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:16:0)
[02:51:52.176] Timer tick, asking Buildbucket for the build status
[02:51:52.244] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:52.244] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:17:0) after 1m0s
[02:52:52.266] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:17:0)
[02:52:52.266] Timer tick, asking Buildbucket for the build status
[02:52:52.347] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:52.347] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:18:0) after 1m0s
[02:53:52.370] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:18:0)
[02:53:52.370] Timer tick, asking Buildbucket for the build status
[02:53:52.440] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:52.440] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:19:0) after 1m0s
[02:54:52.457] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:19:0)
[02:54:52.457] Timer tick, asking Buildbucket for the build status
[02:54:52.515] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:52.515] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:20:0) after 1m0s
[02:55:52.532] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:20:0)
[02:55:52.532] Timer tick, asking Buildbucket for the build status
[02:55:52.762] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:52.762] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:21:0) after 1m0s
[02:56:52.783] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:21:0)
[02:56:52.783] Timer tick, asking Buildbucket for the build status
[02:56:53.061] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:53.061] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:22:0) after 1m0s
[02:57:53.078] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:22:0)
[02:57:53.078] Timer tick, asking Buildbucket for the build status
[02:57:53.151] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:53.151] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:23:0) after 1m0s
[02:58:53.174] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:23:0)
[02:58:53.174] Timer tick, asking Buildbucket for the build status
[02:58:53.299] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:53.299] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:24:0) after 1m0s
[02:59:53.321] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:24:0)
[02:59:53.321] Timer tick, asking Buildbucket for the build status
[02:59:53.379] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:53.379] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:25:0) after 1m0s
[03:00:53.399] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:25:0)
[03:00:53.399] Timer tick, asking Buildbucket for the build status
[03:00:53.661] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:53.661] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:26:0) after 1m0s
[03:01:53.681] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:26:0)
[03:01:53.681] Timer tick, asking Buildbucket for the build status
[03:01:53.864] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:53.864] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:27:0) after 1m0s
[03:02:53.881] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:27:0)
[03:02:53.881] Timer tick, asking Buildbucket for the build status
[03:02:54.177] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:54.177] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:28:0) after 1m0s
[03:03:54.171] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:28:0)
[03:03:54.171] Timer tick, asking Buildbucket for the build status
[03:03:54.363] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:54.363] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:29:0) after 1m0s
[03:04:54.381] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:29:0)
[03:04:54.381] Timer tick, asking Buildbucket for the build status
[03:04:54.473] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:54.473] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:30:0) after 1m0s
[03:05:54.501] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:30:0)
[03:05:54.501] Timer tick, asking Buildbucket for the build status
[03:05:54.760] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:54.760] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:31:0) after 1m0s
[03:06:54.780] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:31:0)
[03:06:54.780] Timer tick, asking Buildbucket for the build status
[03:06:54.919] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:54.919] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:32:0) after 1m0s
[03:07:54.937] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:32:0)
[03:07:54.937] Timer tick, asking Buildbucket for the build status
[03:07:54.990] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:54.990] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:33:0) after 1m0s
[03:08:54.986] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:33:0)
[03:08:54.986] Timer tick, asking Buildbucket for the build status
[03:08:55.295] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:55.295] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:34:0) after 1m0s
[03:09:55.315] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:34:0)
[03:09:55.315] Timer tick, asking Buildbucket for the build status
[03:09:55.418] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:55.418] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:35:0) after 1m0s
[03:10:55.437] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:35:0)
[03:10:55.437] Timer tick, asking Buildbucket for the build status
[03:10:55.955] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:55.955] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:36:0) after 1m0s
[03:11:55.974] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:36:0)
[03:11:55.974] Timer tick, asking Buildbucket for the build status
[03:11:56.073] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:56.073] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:37:0) after 1m0s
[03:12:56.096] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:37:0)
[03:12:56.096] Timer tick, asking Buildbucket for the build status
[03:12:56.179] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:56.179] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:38:0) after 1m0s
[03:13:56.204] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:38:0)
[03:13:56.204] Timer tick, asking Buildbucket for the build status
[03:13:56.373] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:56.373] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:39:0) after 1m0s
[03:14:56.393] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:39:0)
[03:14:56.393] Timer tick, asking Buildbucket for the build status
[03:14:56.781] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:56.781] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:40:0) after 1m0s
[03:15:56.800] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:40:0)
[03:15:56.800] Timer tick, asking Buildbucket for the build status
[03:15:56.998] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:56.998] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:41:0) after 1m0s
[03:16:57.088] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:41:0)
[03:16:57.088] Timer tick, asking Buildbucket for the build status
[03:16:57.201] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:57.201] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:42:0) after 1m0s
[03:17:57.200] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:42:0)
[03:17:57.200] Timer tick, asking Buildbucket for the build status
[03:17:57.284] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:57.284] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:43:0) after 1m0s
[03:18:57.331] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:43:0)
[03:18:57.331] Timer tick, asking Buildbucket for the build status
[03:18:57.579] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:57.579] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:44:0) after 1m0s
[03:19:57.631] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:44:0)
[03:19:57.631] Timer tick, asking Buildbucket for the build status
[03:19:57.736] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:57.736] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:45:0) after 1m0s
[03:20:57.768] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:45:0)
[03:20:57.768] Timer tick, asking Buildbucket for the build status
[03:20:58.288] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:58.288] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:46:0) after 1m0s
[03:21:58.323] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:46:0)
[03:21:58.323] Timer tick, asking Buildbucket for the build status
[03:21:58.373] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:58.373] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:47:0) after 1m0s
[03:22:58.394] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:47:0)
[03:22:58.394] Timer tick, asking Buildbucket for the build status
[03:22:58.756] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:58.756] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:48:0) after 1m0s
[03:23:58.782] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:48:0)
[03:23:58.782] Timer tick, asking Buildbucket for the build status
[03:23:58.918] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:58.918] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:49:0) after 1m0s
[03:24:58.937] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:49:0)
[03:24:58.937] Timer tick, asking Buildbucket for the build status
[03:24:59.011] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:59.011] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:50:0) after 1m0s
[03:25:59.031] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:50:0)
[03:25:59.031] Timer tick, asking Buildbucket for the build status
[03:25:59.089] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:59.089] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:51:0) after 1m0s
[03:26:59.111] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:51:0)
[03:26:59.111] Timer tick, asking Buildbucket for the build status
[03:26:59.156] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:59.156] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:52:0) after 1m0s
[03:27:59.189] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:52:0)
[03:27:59.189] Timer tick, asking Buildbucket for the build status
[03:27:59.252] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:59.252] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:53:0) after 1m0s
[03:28:59.221] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:53:0)
[03:28:59.221] Timer tick, asking Buildbucket for the build status
[03:28:59.469] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:59.469] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:54:0) after 1m0s
[03:29:59.490] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:54:0)
[03:29:59.490] Timer tick, asking Buildbucket for the build status
[03:29:59.565] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:59.565] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:55:0) after 1m0s
[03:30:59.540] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:55:0)
[03:30:59.540] Timer tick, asking Buildbucket for the build status
[03:30:59.617] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:59.617] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:56:0) after 1m0s
[03:31:59.637] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:56:0)
[03:31:59.637] Timer tick, asking Buildbucket for the build status
[03:31:59.710] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:59.710] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:57:0) after 1m0s
[03:32:59.730] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:57:0)
[03:32:59.730] Timer tick, asking Buildbucket for the build status
[03:32:59.785] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:59.785] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:58:0) after 1m0s
[03:33:59.820] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:58:0)
[03:33:59.820] Timer tick, asking Buildbucket for the build status
[03:33:59.987] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:59.987] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:59:0) after 1m0s
[03:35:00.016] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:59:0)
[03:35:00.016] Timer tick, asking Buildbucket for the build status
[03:35:00.122] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:00.122] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:60:0) after 1m0s
[03:36:00.142] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:60:0)
[03:36:00.142] Timer tick, asking Buildbucket for the build status
[03:36:00.216] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:00.216] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:61:0) after 1m0s
[03:37:00.237] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:61:0)
[03:37:00.237] Timer tick, asking Buildbucket for the build status
[03:37:00.313] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:00.313] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:62:0) after 1m0s
[03:38:00.334] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:62:0)
[03:38:00.334] Timer tick, asking Buildbucket for the build status
[03:38:00.386] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:00.386] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:63:0) after 1m0s
[03:39:00.368] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:63:0)
[03:39:00.368] Timer tick, asking Buildbucket for the build status
[03:39:00.484] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:00.484] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:64:0) after 1m0s
[03:40:00.508] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:64:0)
[03:40:00.508] Timer tick, asking Buildbucket for the build status
[03:40:00.592] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:00.592] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:65:0) after 1m0s
[03:41:00.594] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:65:0)
[03:41:00.594] Timer tick, asking Buildbucket for the build status
[03:41:00.675] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:00.675] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:66:0) after 1m0s
[03:42:00.697] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:66:0)
[03:42:00.697] Timer tick, asking Buildbucket for the build status
[03:42:00.868] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:00.868] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:67:0) after 1m0s
[03:43:00.887] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:67:0)
[03:43:00.887] Timer tick, asking Buildbucket for the build status
[03:43:01.485] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:01.485] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:68:0) after 1m0s
[03:44:01.494] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:68:0)
[03:44:01.494] Timer tick, asking Buildbucket for the build status
[03:44:01.771] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:01.771] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:69:0) after 1m0s
[03:45:01.776] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:69:0)
[03:45:01.776] Timer tick, asking Buildbucket for the build status
[03:45:01.947] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:01.947] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:70:0) after 1m0s
[03:46:01.971] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:70:0)
[03:46:01.971] Timer tick, asking Buildbucket for the build status
[03:46:02.042] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:02.042] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:71:0) after 1m0s
[03:47:02.087] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:71:0)
[03:47:02.087] Timer tick, asking Buildbucket for the build status
[03:47:02.192] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:02.192] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:72:0) after 1m0s
[03:48:02.217] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:72:0)
[03:48:02.217] Timer tick, asking Buildbucket for the build status
[03:48:02.294] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:02.294] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:73:0) after 1m0s
[03:49:02.315] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:73:0)
[03:49:02.315] Timer tick, asking Buildbucket for the build status
[03:49:02.554] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:02.554] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:74:0) after 1m0s
[03:50:02.605] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:74:0)
[03:50:02.605] Timer tick, asking Buildbucket for the build status
[03:50:02.697] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:02.697] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:75:0) after 1m0s
[03:51:02.718] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:75:0)
[03:51:02.718] Timer tick, asking Buildbucket for the build status
[03:51:02.831] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:02.831] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:76:0) after 1m0s
[03:52:02.851] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:76:0)
[03:52:02.851] Timer tick, asking Buildbucket for the build status
[03:52:02.960] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:02.960] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:77:0) after 1m0s
[03:53:02.982] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:77:0)
[03:53:02.982] Timer tick, asking Buildbucket for the build status
[03:53:03.074] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:03.074] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:78:0) after 1m0s
[03:54:03.097] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:78:0)
[03:54:03.097] Timer tick, asking Buildbucket for the build status
[03:54:03.164] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:03.164] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:79:0) after 1m0s
[03:55:03.186] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:79:0)
[03:55:03.186] Timer tick, asking Buildbucket for the build status
[03:55:03.253] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:03.253] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:80:0) after 1m0s
[03:56:03.277] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:80:0)
[03:56:03.277] Timer tick, asking Buildbucket for the build status
[03:56:03.386] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:03.386] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:81:0) after 1m0s
[03:57:03.408] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:81:0)
[03:57:03.408] Timer tick, asking Buildbucket for the build status
[03:57:03.480] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:03.480] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:82:0) after 1m0s
[03:58:03.501] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:82:0)
[03:58:03.501] Timer tick, asking Buildbucket for the build status
[03:58:03.562] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:03.562] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:83:0) after 1m0s
[03:59:03.597] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:83:0)
[03:59:03.597] Timer tick, asking Buildbucket for the build status
[03:59:03.654] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:03.654] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:84:0) after 1m0s
[04:00:03.676] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:84:0)
[04:00:03.676] Timer tick, asking Buildbucket for the build status
[04:00:03.798] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:03.798] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:85:0) after 1m0s
[04:01:03.824] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:85:0)
[04:01:03.824] Timer tick, asking Buildbucket for the build status
[04:01:03.863] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:03.863] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:86:0) after 1m0s
[04:02:03.883] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:86:0)
[04:02:03.883] Timer tick, asking Buildbucket for the build status
[04:02:03.955] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:03.955] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:87:0) after 1m0s
[04:03:03.995] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:87:0)
[04:03:03.995] Timer tick, asking Buildbucket for the build status
[04:03:04.113] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:04.113] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:88:0) after 1m0s
[04:04:04.108] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:88:0)
[04:04:04.108] Timer tick, asking Buildbucket for the build status
[04:04:04.252] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:04.252] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:89:0) after 1m0s
[04:05:04.273] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:89:0)
[04:05:04.273] Timer tick, asking Buildbucket for the build status
[04:05:04.509] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:04.509] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:90:0) after 1m0s
[04:06:04.520] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:90:0)
[04:06:04.520] Timer tick, asking Buildbucket for the build status
[04:06:04.589] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:04.589] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:91:0) after 1m0s
[04:07:04.613] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:91:0)
[04:07:04.613] Timer tick, asking Buildbucket for the build status
[04:07:05.136] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:05.136] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:92:0) after 1m0s
[04:08:05.177] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:92:0)
[04:08:05.177] Timer tick, asking Buildbucket for the build status
[04:08:05.242] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:05.242] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:93:0) after 1m0s
[04:09:05.290] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:93:0)
[04:09:05.290] Timer tick, asking Buildbucket for the build status
[04:09:05.474] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:05.474] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:94:0) after 1m0s
[04:10:05.516] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:94:0)
[04:10:05.516] Timer tick, asking Buildbucket for the build status
[04:10:05.593] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:05.593] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:95:0) after 1m0s
[04:11:05.620] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:95:0)
[04:11:05.620] Timer tick, asking Buildbucket for the build status
[04:11:05.679] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:05.679] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:96:0) after 1m0s
[04:12:05.702] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:96:0)
[04:12:05.702] Timer tick, asking Buildbucket for the build status
[04:12:05.893] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:05.893] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:97:0) after 1m0s
[04:13:05.913] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:97:0)
[04:13:05.913] Timer tick, asking Buildbucket for the build status
[04:13:05.997] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:05.997] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:98:0) after 1m0s
[04:14:06.015] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:98:0)
[04:14:06.015] Timer tick, asking Buildbucket for the build status
[04:14:06.109] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:06.109] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:99:0) after 1m0s
[04:15:06.143] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:99:0)
[04:15:06.143] Timer tick, asking Buildbucket for the build status
[04:15:06.298] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:06.298] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:100:0) after 1m0s
[04:16:06.319] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:100:0)
[04:16:06.319] Timer tick, asking Buildbucket for the build status
[04:16:06.404] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:06.404] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:101:0) after 1m0s
[04:17:06.438] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:101:0)
[04:17:06.438] Timer tick, asking Buildbucket for the build status
[04:17:06.685] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:06.685] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:102:0) after 1m0s
[04:18:06.711] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:102:0)
[04:18:06.711] Timer tick, asking Buildbucket for the build status
[04:18:06.883] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:06.883] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:103:0) after 1m0s
[04:19:06.918] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:103:0)
[04:19:06.918] Timer tick, asking Buildbucket for the build status
[04:19:07.003] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:07.003] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:104:0) after 1m0s
[04:20:06.982] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:104:0)
[04:20:06.982] Timer tick, asking Buildbucket for the build status
[04:20:07.049] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:07.049] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:105:0) after 1m0s
[04:21:07.073] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:105:0)
[04:21:07.073] Timer tick, asking Buildbucket for the build status
[04:21:07.287] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:07.287] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:106:0) after 1m0s
[04:22:07.349] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:106:0)
[04:22:07.349] Timer tick, asking Buildbucket for the build status
[04:22:07.449] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:07.450] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:107:0) after 1m0s
[04:23:07.472] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:107:0)
[04:23:07.472] Timer tick, asking Buildbucket for the build status
[04:23:07.802] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:07.802] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:108:0) after 1m0s
[04:24:07.783] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:108:0)
[04:24:07.783] Timer tick, asking Buildbucket for the build status
[04:24:07.982] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:07.982] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:109:0) after 1m0s
[04:25:07.998] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:109:0)
[04:25:07.998] Timer tick, asking Buildbucket for the build status
[04:25:08.172] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:08.172] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:110:0) after 1m0s
[04:26:08.187] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:110:0)
[04:26:08.187] Timer tick, asking Buildbucket for the build status
[04:26:08.265] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:08.265] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:111:0) after 1m0s
[04:27:08.288] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:111:0)
[04:27:08.288] Timer tick, asking Buildbucket for the build status
[04:27:08.363] Build 8916872569774716720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:08.363] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-win:9082302631874763344:112:0) after 1m0s
[04:27:55.963] Received PubSub notification, asking Buildbucket for the build status
[04:27:56.067] Build 8916872569774716720: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:27:56.067] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1554611275705592",
"created_by": "project:infra",
"created_ts": "1554604669746543",
"failure_reason": "BUILD_FAILURE",
"id": "8916872569774716720",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-win\", \"properties\": {\"root_solution_revision\": \"75fa787427dd7e8380e0ff0ccd1816cb83ddbb98\", \"root_solution_revision_timestamp\": 1554602104}}",
"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\": 3494, \"got_angle_revision\": \"5d50678ea9b0a8be594c700b8c9eaf5af019b8c7\", \"got_clang_revision\": \"357692-1\", \"got_dawn_revision\": \"20b0c33913e45cd3d553b42a43b75b27af817833\", \"got_nacl_revision\": \"067afa275dcb4b3c6eca979ea5e3fe75073c4080\", \"got_revision\": \"75fa787427dd7e8380e0ff0ccd1816cb83ddbb98\", \"got_revision_cp\": \"refs/heads/master@{#648515}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"f19370068e0906ccff45aace0faac15ab3c5fc6a\", \"got_v8_revision_cp\": \"refs/heads/7.5.209@{#1}\", \"got_webrtc_revision\": \"59e875ce18bb24aa6d1ec5cdf128d7ef244fa37a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27463}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"75fa787427dd7e8380e0ff0ccd1816cb83ddbb98\", \"root_solution_revision_timestamp\": 1554602104.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": "1554605134046116",
"status": "COMPLETED",
"status_changed_ts": "1554605134305834",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-win/3494",
"builder:codesearch-gen-chromium-win",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8147",
"scheduler_invocation_id:9082302631874763344",
"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/8916872569774716720/+/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:440e7a472070af10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554611275766761",
"url": "https://ci.chromium.org/b/8916872569774716720",
"utcnow_ts": "1554611276051765"
}
}
[04:27:56.067] Invocation finished in 1h50m7.706930267s with status FAILED