[03:05:44.544] New invocation is queued and will start shortly
[03:05:44.544] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[03:05:45.593] Starting the invocation (attempt 1)
[03:05:45.679] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:05:45.679] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:05:45.679] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9082482068224565456",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-android\",\"properties\":{\"root_solution_revision\":\"23eda3a8c58a3084ce407f647ed0194fc8698918\",\"root_solution_revision_timestamp\":1554429581}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-android",
"scheduler_invocation_id:9082482068224565456",
"scheduler_job_id:infra/codesearch-gen-chromium-android",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8123",
"user_agent:recipe"
]
}
[03:05:46.758] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "project:infra",
"created_ts": "1554433545786287",
"id": "8917052006251775616",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-android\", \"properties\": {\"root_solution_revision\": \"23eda3a8c58a3084ce407f647ed0194fc8698918\", \"root_solution_revision_timestamp\": 1554429581}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1554433546574606",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-android/4871",
"builder:codesearch-gen-chromium-android",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8123",
"scheduler_invocation_id:9082482068224565456",
"scheduler_job_id:infra/codesearch-gen-chromium-android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8917052006251775616/+/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": "1554433546574732",
"url": "https://ci.chromium.org/b/8917052006251775616",
"utcnow_ts": "1554433546748915"
}
}
[03:05:46.758] Task URL: https://ci.chromium.org/b/8917052006251775616
[03:05:46.758] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:2:0) after 1m0s
[03:05:50.688] Received PubSub notification, asking Buildbucket for the build status
[03:05:50.737] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:46.778] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:2:0)
[03:06:46.778] Timer tick, asking Buildbucket for the build status
[03:06:47.179] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:47.179] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:4:0) after 1m0s
[03:07:47.197] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:4:0)
[03:07:47.197] Timer tick, asking Buildbucket for the build status
[03:07:47.258] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:47.258] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:5:0) after 1m0s
[03:08:47.280] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:5:0)
[03:08:47.280] Timer tick, asking Buildbucket for the build status
[03:08:47.382] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:47.382] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:6:0) after 1m0s
[03:09:47.392] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:6:0)
[03:09:47.392] Timer tick, asking Buildbucket for the build status
[03:09:47.888] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:47.888] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:7:0) after 1m0s
[03:10:47.906] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:7:0)
[03:10:47.907] Timer tick, asking Buildbucket for the build status
[03:10:48.171] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:48.171] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:8:0) after 1m0s
[03:11:48.188] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:8:0)
[03:11:48.188] Timer tick, asking Buildbucket for the build status
[03:11:48.227] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:48.227] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:9:0) after 1m0s
[03:12:48.259] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:9:0)
[03:12:48.259] Timer tick, asking Buildbucket for the build status
[03:12:48.363] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:48.363] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:10:0) after 1m0s
[03:13:48.370] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:10:0)
[03:13:48.370] Timer tick, asking Buildbucket for the build status
[03:13:48.429] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:48.429] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:11:0) after 1m0s
[03:14:48.448] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:11:0)
[03:14:48.448] Timer tick, asking Buildbucket for the build status
[03:14:48.509] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:48.509] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:12:0) after 1m0s
[03:15:48.527] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:12:0)
[03:15:48.527] Timer tick, asking Buildbucket for the build status
[03:15:48.579] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:48.579] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:13:0) after 1m0s
[03:16:48.589] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:13:0)
[03:16:48.589] Timer tick, asking Buildbucket for the build status
[03:16:48.654] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:48.654] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:14:0) after 1m0s
[03:17:48.629] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:14:0)
[03:17:48.629] Timer tick, asking Buildbucket for the build status
[03:17:48.753] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:48.753] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:15:0) after 1m0s
[03:18:48.773] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:15:0)
[03:18:48.773] Timer tick, asking Buildbucket for the build status
[03:18:48.830] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:48.830] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:16:0) after 1m0s
[03:19:48.850] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:16:0)
[03:19:48.850] Timer tick, asking Buildbucket for the build status
[03:19:48.904] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:48.904] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:17:0) after 1m0s
[03:20:48.922] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:17:0)
[03:20:48.922] Timer tick, asking Buildbucket for the build status
[03:20:48.993] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:48.993] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:18:0) after 1m0s
[03:21:49.022] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:18:0)
[03:21:49.022] Timer tick, asking Buildbucket for the build status
[03:21:49.368] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:49.369] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:19:0) after 1m0s
[03:22:49.419] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:19:0)
[03:22:49.419] Timer tick, asking Buildbucket for the build status
[03:22:49.462] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:49.462] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:20:0) after 1m0s
[03:23:49.520] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:20:0)
[03:23:49.520] Timer tick, asking Buildbucket for the build status
[03:23:49.609] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:49.609] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:21:0) after 1m0s
[03:24:49.589] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:21:0)
[03:24:49.589] Timer tick, asking Buildbucket for the build status
[03:24:49.770] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:49.770] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:22:0) after 1m0s
[03:25:49.787] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:22:0)
[03:25:49.787] Timer tick, asking Buildbucket for the build status
[03:25:49.888] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:49.888] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:23:0) after 1m0s
[03:26:49.907] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:23:0)
[03:26:49.907] Timer tick, asking Buildbucket for the build status
[03:26:49.952] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:49.952] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:24:0) after 1m0s
[03:27:49.937] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:24:0)
[03:27:49.937] Timer tick, asking Buildbucket for the build status
[03:27:50.001] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:50.001] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:25:0) after 1m0s
[03:28:50.081] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:25:0)
[03:28:50.081] Timer tick, asking Buildbucket for the build status
[03:28:50.173] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:50.173] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:26:0) after 1m0s
[03:29:50.191] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:26:0)
[03:29:50.191] Timer tick, asking Buildbucket for the build status
[03:29:50.248] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:50.248] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:27:0) after 1m0s
[03:30:50.239] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:27:0)
[03:30:50.239] Timer tick, asking Buildbucket for the build status
[03:30:50.282] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:50.282] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:28:0) after 1m0s
[03:31:50.311] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:28:0)
[03:31:50.311] Timer tick, asking Buildbucket for the build status
[03:31:50.368] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:50.368] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:29:0) after 1m0s
[03:32:50.385] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:29:0)
[03:32:50.385] Timer tick, asking Buildbucket for the build status
[03:32:50.421] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:50.421] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:30:0) after 1m0s
[03:33:50.419] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:30:0)
[03:33:50.419] Timer tick, asking Buildbucket for the build status
[03:33:50.556] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:50.556] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:31:0) after 1m0s
[03:34:50.576] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:31:0)
[03:34:50.576] Timer tick, asking Buildbucket for the build status
[03:34:50.665] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:50.665] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:32:0) after 1m0s
[03:35:50.688] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:32:0)
[03:35:50.688] Timer tick, asking Buildbucket for the build status
[03:35:50.733] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:50.733] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:33:0) after 1m0s
[03:36:50.706] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:33:0)
[03:36:50.706] Timer tick, asking Buildbucket for the build status
[03:36:50.744] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:50.744] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:34:0) after 1m0s
[03:37:50.765] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:34:0)
[03:37:50.765] Timer tick, asking Buildbucket for the build status
[03:37:50.840] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:50.840] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:35:0) after 1m0s
[03:38:50.827] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:35:0)
[03:38:50.827] Timer tick, asking Buildbucket for the build status
[03:38:50.867] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:50.867] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:36:0) after 1m0s
[03:39:50.885] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:36:0)
[03:39:50.885] Timer tick, asking Buildbucket for the build status
[03:39:51.262] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:51.262] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:37:0) after 1m0s
[03:40:51.279] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:37:0)
[03:40:51.279] Timer tick, asking Buildbucket for the build status
[03:40:51.320] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:51.320] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:38:0) after 1m0s
[03:41:51.312] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:38:0)
[03:41:51.312] Timer tick, asking Buildbucket for the build status
[03:41:51.378] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:51.378] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:39:0) after 1m0s
[03:42:51.423] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:39:0)
[03:42:51.423] Timer tick, asking Buildbucket for the build status
[03:42:51.479] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:51.479] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:40:0) after 1m0s
[03:43:51.527] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:40:0)
[03:43:51.527] Timer tick, asking Buildbucket for the build status
[03:43:51.697] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:51.697] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:41:0) after 1m0s
[03:44:51.753] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:41:0)
[03:44:51.753] Timer tick, asking Buildbucket for the build status
[03:44:51.873] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:51.873] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:42:0) after 1m0s
[03:45:51.892] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:42:0)
[03:45:51.892] Timer tick, asking Buildbucket for the build status
[03:45:51.953] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:51.954] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:43:0) after 1m0s
[03:46:51.993] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:43:0)
[03:46:51.993] Timer tick, asking Buildbucket for the build status
[03:46:52.253] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:52.253] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:44:0) after 1m0s
[03:47:52.361] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:44:0)
[03:47:52.361] Timer tick, asking Buildbucket for the build status
[03:47:52.651] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:52.651] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:45:0) after 1m0s
[03:48:52.673] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:45:0)
[03:48:52.673] Timer tick, asking Buildbucket for the build status
[03:48:52.906] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:52.906] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:46:0) after 1m0s
[03:49:52.933] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:46:0)
[03:49:52.933] Timer tick, asking Buildbucket for the build status
[03:49:53.028] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:53.028] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:47:0) after 1m0s
[03:50:53.061] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:47:0)
[03:50:53.061] Timer tick, asking Buildbucket for the build status
[03:50:53.265] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:53.265] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:48:0) after 1m0s
[03:51:53.261] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:48:0)
[03:51:53.261] Timer tick, asking Buildbucket for the build status
[03:51:53.466] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:53.466] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:49:0) after 1m0s
[03:52:53.459] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:49:0)
[03:52:53.459] Timer tick, asking Buildbucket for the build status
[03:52:53.665] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:53.665] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:50:0) after 1m0s
[03:53:53.687] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:50:0)
[03:53:53.687] Timer tick, asking Buildbucket for the build status
[03:53:54.017] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:54.017] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:51:0) after 1m0s
[03:54:54.038] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:51:0)
[03:54:54.038] Timer tick, asking Buildbucket for the build status
[03:54:54.080] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:54.080] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:52:0) after 1m0s
[03:55:54.121] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:52:0)
[03:55:54.122] Timer tick, asking Buildbucket for the build status
[03:55:55.113] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:55.113] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:53:0) after 1m0s
[03:56:55.100] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:53:0)
[03:56:55.100] Timer tick, asking Buildbucket for the build status
[03:56:55.395] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:55.395] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:54:0) after 1m0s
[03:57:55.534] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:54:0)
[03:57:55.534] Timer tick, asking Buildbucket for the build status
[03:57:55.634] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:55.634] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:55:0) after 1m0s
[03:58:55.660] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:55:0)
[03:58:55.660] Timer tick, asking Buildbucket for the build status
[03:58:55.702] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:55.702] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:56:0) after 1m0s
[03:59:55.729] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:56:0)
[03:59:55.729] Timer tick, asking Buildbucket for the build status
[03:59:55.847] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:55.847] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:57:0) after 1m0s
[04:00:55.868] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:57:0)
[04:00:55.868] Timer tick, asking Buildbucket for the build status
[04:00:56.023] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:56.023] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:58:0) after 1m0s
[04:01:56.099] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:58:0)
[04:01:56.099] Timer tick, asking Buildbucket for the build status
[04:01:56.142] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:56.142] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:59:0) after 1m0s
[04:02:56.164] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:59:0)
[04:02:56.164] Timer tick, asking Buildbucket for the build status
[04:02:56.476] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:56.476] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:60:0) after 1m0s
[04:03:56.487] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:60:0)
[04:03:56.487] Timer tick, asking Buildbucket for the build status
[04:03:56.865] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:56.865] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:61:0) after 1m0s
[04:04:56.889] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:61:0)
[04:04:56.889] Timer tick, asking Buildbucket for the build status
[04:04:56.974] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:56.974] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:62:0) after 1m0s
[04:05:57.045] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:62:0)
[04:05:57.045] Timer tick, asking Buildbucket for the build status
[04:05:57.137] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:57.137] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:63:0) after 1m0s
[04:06:57.240] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:63:0)
[04:06:57.240] Timer tick, asking Buildbucket for the build status
[04:06:57.374] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:57.374] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:64:0) after 1m0s
[04:07:57.424] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:64:0)
[04:07:57.424] Timer tick, asking Buildbucket for the build status
[04:07:57.499] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:57.499] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:65:0) after 1m0s
[04:08:57.503] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:65:0)
[04:08:57.503] Timer tick, asking Buildbucket for the build status
[04:08:57.662] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:57.662] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:66:0) after 1m0s
[04:09:57.650] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:66:0)
[04:09:57.650] Timer tick, asking Buildbucket for the build status
[04:09:57.688] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:57.688] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:67:0) after 1m0s
[04:10:57.684] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:67:0)
[04:10:57.684] Timer tick, asking Buildbucket for the build status
[04:10:57.989] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:57.989] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:68:0) after 1m0s
[04:11:58.005] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:68:0)
[04:11:58.005] Timer tick, asking Buildbucket for the build status
[04:11:58.475] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:58.475] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:69:0) after 1m0s
[04:12:58.499] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:69:0)
[04:12:58.499] Timer tick, asking Buildbucket for the build status
[04:12:58.667] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:58.667] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:70:0) after 1m0s
[04:13:58.697] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:70:0)
[04:13:58.697] Timer tick, asking Buildbucket for the build status
[04:13:58.766] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:58.766] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:71:0) after 1m0s
[04:14:58.772] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:71:0)
[04:14:58.772] Timer tick, asking Buildbucket for the build status
[04:14:58.831] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:58.831] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:72:0) after 1m0s
[04:15:58.850] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:72:0)
[04:15:58.850] Timer tick, asking Buildbucket for the build status
[04:15:59.062] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:59.062] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:73:0) after 1m0s
[04:16:59.086] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:73:0)
[04:16:59.086] Timer tick, asking Buildbucket for the build status
[04:16:59.153] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:59.153] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:74:0) after 1m0s
[04:17:59.175] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:74:0)
[04:17:59.175] Timer tick, asking Buildbucket for the build status
[04:17:59.217] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:59.217] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:75:0) after 1m0s
[04:18:59.243] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:75:0)
[04:18:59.243] Timer tick, asking Buildbucket for the build status
[04:18:59.380] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:59.380] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:76:0) after 1m0s
[04:19:59.365] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:76:0)
[04:19:59.365] Timer tick, asking Buildbucket for the build status
[04:19:59.434] Build 8917052006251775616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:59.434] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9082482068224565456:77:0) after 1m0s
[04:20:44.494] Received PubSub notification, asking Buildbucket for the build status
[04:20:44.564] Build 8917052006251775616: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:20:44.564] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1554438044111511",
"created_by": "project:infra",
"created_ts": "1554433545786287",
"failure_reason": "BUILD_FAILURE",
"id": "8917052006251775616",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-android\", \"properties\": {\"root_solution_revision\": \"23eda3a8c58a3084ce407f647ed0194fc8698918\", \"root_solution_revision_timestamp\": 1554429581}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('add kythe metadata') failed with return_code 1\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1882-c4\", \"buildername\": \"codesearch-gen-chromium-android\", \"buildnumber\": 4871, \"got_angle_revision\": \"7a8c3e5ebe3e77e998f84e60ce0681b334a8c29c\", \"got_clang_revision\": \"356356-3\", \"got_dawn_revision\": \"20b0c33913e45cd3d553b42a43b75b27af817833\", \"got_nacl_revision\": \"2c300847c7700af6948ad78e79ccd21bd7ba0c14\", \"got_revision\": \"23eda3a8c58a3084ce407f647ed0194fc8698918\", \"got_revision_cp\": \"refs/heads/master@{#648037}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"2f88b9b20539a240a74256f647f249f32b355e9e\", \"got_v8_revision_cp\": \"refs/heads/7.5.195@{#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\": \"23eda3a8c58a3084ce407f647ed0194fc8698918\", \"root_solution_revision_timestamp\": 1554429581.0}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"codesearch-gen-chromium-android\"], \"caches\": [\"builder_4d14e380d83a89b4cb58aa2f3c73d8f515800858510b279900319844ebd58b92_v2\", \"codesearch_git_genfiles_repo\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1882-c4\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.infra.codesearch\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4243-f38882f\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"Step('add kythe metadata') failed with return_code 1\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1554433550032146",
"status": "COMPLETED",
"status_changed_ts": "1554433550464013",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-android/4871",
"builder:codesearch-gen-chromium-android",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8123",
"scheduler_invocation_id:9082482068224565456",
"scheduler_job_id:infra/codesearch-gen-chromium-android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8917052006251775616/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:440447228baacc10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1554438044164718",
"url": "https://ci.chromium.org/b/8917052006251775616",
"utcnow_ts": "1554438044554072"
}
}
[04:20:44.564] Invocation finished in 1h15m0.043024388s with status FAILED