[00:02:24.295] New invocation is queued and will start shortly
[00:02:24.295] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[00:02:25.369] Starting the invocation (attempt 1)
[00:02:25.457] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:02:25.457] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:02:25.457] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9050422276709402768",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-fuchsia\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"codesearch_mirror_revision\":\"a90552bbf1e046ab317d7c686a263e57dfdd2573\",\"codesearch_mirror_revision_timestamp\":1585007911,\"root_solution_revision\":\"1ff7639fdf7e5978e80704e514072a2af2740dae\",\"root_solution_revision_timestamp\":1585007687},\"tags\":[\"parent_buildername:codesearch-gen-chromium-initiator\",\"parent_buildnumber:10409\",\"user_agent:recipe\"]},\"id\":\"58402199-9d7b-45de-a3d6-dcec13a1b9e4\",\"title\":\"codesearch-gen-chromium-initiator/10409\"}]},\"codesearch_mirror_revision\":\"a90552bbf1e046ab317d7c686a263e57dfdd2573\",\"codesearch_mirror_revision_timestamp\":1585007911,\"root_solution_revision\":\"1ff7639fdf7e5978e80704e514072a2af2740dae\",\"root_solution_revision_timestamp\":1585007687}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-fuchsia",
"scheduler_invocation_id:9050422276709402768",
"scheduler_job_id:infra/codesearch-gen-chromium-fuchsia",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:10409",
"user_agent:recipe"
]
}
[00:02:26.330] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1585008145553075",
"id": "8884992214727209536",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-fuchsia\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"a90552bbf1e046ab317d7c686a263e57dfdd2573\", \"codesearch_mirror_revision_timestamp\": 1585007911.0, \"root_solution_revision\": \"1ff7639fdf7e5978e80704e514072a2af2740dae\", \"root_solution_revision_timestamp\": 1585007687.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:10409\", \"user_agent:recipe\"]}, \"id\": \"58402199-9d7b-45de-a3d6-dcec13a1b9e4\", \"title\": \"codesearch-gen-chromium-initiator/10409\"}]}, \"codesearch_mirror_revision\": \"a90552bbf1e046ab317d7c686a263e57dfdd2573\", \"codesearch_mirror_revision_timestamp\": 1585007911.0, \"root_solution_revision\": \"1ff7639fdf7e5978e80704e514072a2af2740dae\", \"root_solution_revision_timestamp\": 1585007687.0}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585008146083052",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-fuchsia/3167",
"builder:codesearch-gen-chromium-fuchsia",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:10409",
"scheduler_invocation_id:9050422276709402768",
"scheduler_job_id:infra/codesearch-gen-chromium-fuchsia",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8884992214727209536/+/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": "1585008146083171",
"url": "https://ci.chromium.org/b/8884992214727209536",
"utcnow_ts": "1585008146321334"
}
}
[00:02:26.330] Task URL: https://ci.chromium.org/b/8884992214727209536
[00:02:26.330] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:2:0) after 1m0s
[00:03:01.555] Received PubSub notification, asking Buildbucket for the build status
[00:03:01.623] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:26.321] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:2:0)
[00:03:26.321] Timer tick, asking Buildbucket for the build status
[00:03:26.420] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:26.420] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:4:0) after 1m0s
[00:04:26.491] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:4:0)
[00:04:26.491] Timer tick, asking Buildbucket for the build status
[00:04:26.674] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:26.674] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:5:0) after 1m0s
[00:05:26.741] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:5:0)
[00:05:26.741] Timer tick, asking Buildbucket for the build status
[00:05:26.853] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:26.853] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:6:0) after 1m0s
[00:06:27.034] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:6:0)
[00:06:27.034] Timer tick, asking Buildbucket for the build status
[00:06:27.154] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:27.154] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:7:0) after 1m0s
[00:07:27.203] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:7:0)
[00:07:27.203] Timer tick, asking Buildbucket for the build status
[00:07:27.700] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:27.700] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:8:0) after 1m0s
[00:08:27.792] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:8:0)
[00:08:27.792] Timer tick, asking Buildbucket for the build status
[00:08:28.142] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:28.142] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:9:0) after 1m0s
[00:09:28.179] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:9:0)
[00:09:28.179] Timer tick, asking Buildbucket for the build status
[00:09:28.610] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:28.610] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:10:0) after 1m0s
[00:10:29.127] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:10:0)
[00:10:29.127] Timer tick, asking Buildbucket for the build status
[00:10:29.840] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:29.840] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:11:0) after 1m0s
[00:11:30.039] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:11:0)
[00:11:30.039] Timer tick, asking Buildbucket for the build status
[00:11:30.248] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:30.248] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:12:0) after 1m0s
[00:12:30.653] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:12:0)
[00:12:30.653] Timer tick, asking Buildbucket for the build status
[00:12:30.777] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:30.777] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:13:0) after 1m0s
[00:13:30.797] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:13:0)
[00:13:30.797] Timer tick, asking Buildbucket for the build status
[00:13:30.908] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:30.908] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:14:0) after 1m0s
[00:14:30.956] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:14:0)
[00:14:30.956] Timer tick, asking Buildbucket for the build status
[00:14:35.545] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:35.545] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:15:0) after 1m0s
[00:15:35.584] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:15:0)
[00:15:35.584] Timer tick, asking Buildbucket for the build status
[00:15:35.767] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:35.767] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:16:0) after 1m0s
[00:16:35.883] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:16:0)
[00:16:35.883] Timer tick, asking Buildbucket for the build status
[00:16:36.105] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:36.105] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:17:0) after 1m0s
[00:17:36.099] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:17:0)
[00:17:36.099] Timer tick, asking Buildbucket for the build status
[00:17:36.526] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:36.526] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:18:0) after 1m0s
[00:18:36.520] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:18:0)
[00:18:36.520] Timer tick, asking Buildbucket for the build status
[00:18:36.765] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:36.765] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:19:0) after 1m0s
[00:19:36.832] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:19:0)
[00:19:36.832] Timer tick, asking Buildbucket for the build status
[00:19:38.477] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:38.477] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:20:0) after 1m0s
[00:20:38.500] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:20:0)
[00:20:38.500] Timer tick, asking Buildbucket for the build status
[00:20:38.575] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:38.575] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:21:0) after 1m0s
[00:21:38.657] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:21:0)
[00:21:38.657] Timer tick, asking Buildbucket for the build status
[00:21:38.898] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:38.898] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:22:0) after 1m0s
[00:22:38.918] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:22:0)
[00:22:38.918] Timer tick, asking Buildbucket for the build status
[00:22:39.039] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:39.039] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:23:0) after 1m0s
[00:23:39.080] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:23:0)
[00:23:39.080] Timer tick, asking Buildbucket for the build status
[00:23:39.176] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:39.176] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:24:0) after 1m0s
[00:24:39.236] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:24:0)
[00:24:39.236] Timer tick, asking Buildbucket for the build status
[00:24:39.362] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:39.362] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:25:0) after 1m0s
[00:25:39.461] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:25:0)
[00:25:39.461] Timer tick, asking Buildbucket for the build status
[00:25:39.525] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:39.525] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:26:0) after 1m0s
[00:26:39.551] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:26:0)
[00:26:39.551] Timer tick, asking Buildbucket for the build status
[00:26:39.681] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:39.681] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:27:0) after 1m0s
[00:27:39.732] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:27:0)
[00:27:39.732] Timer tick, asking Buildbucket for the build status
[00:27:39.986] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:39.986] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:28:0) after 1m0s
[00:28:40.017] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:28:0)
[00:28:40.017] Timer tick, asking Buildbucket for the build status
[00:28:40.139] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:40.139] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:29:0) after 1m0s
[00:29:40.245] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:29:0)
[00:29:40.245] Timer tick, asking Buildbucket for the build status
[00:29:40.377] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:40.377] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:30:0) after 1m0s
[00:30:40.403] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:30:0)
[00:30:40.403] Timer tick, asking Buildbucket for the build status
[00:30:40.522] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:40.522] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:31:0) after 1m0s
[00:31:40.615] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:31:0)
[00:31:40.615] Timer tick, asking Buildbucket for the build status
[00:31:40.829] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:40.829] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:32:0) after 1m0s
[00:32:40.892] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:32:0)
[00:32:40.892] Timer tick, asking Buildbucket for the build status
[00:32:41.033] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:41.033] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:33:0) after 1m0s
[00:33:41.278] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:33:0)
[00:33:41.278] Timer tick, asking Buildbucket for the build status
[00:33:41.403] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:41.403] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:34:0) after 1m0s
[00:34:41.488] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:34:0)
[00:34:41.488] Timer tick, asking Buildbucket for the build status
[00:34:41.605] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:41.605] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:35:0) after 1m0s
[00:35:41.670] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:35:0)
[00:35:41.670] Timer tick, asking Buildbucket for the build status
[00:35:41.845] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:41.845] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:36:0) after 1m0s
[00:36:41.861] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:36:0)
[00:36:41.861] Timer tick, asking Buildbucket for the build status
[00:36:41.960] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:41.960] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:37:0) after 1m0s
[00:37:41.947] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:37:0)
[00:37:41.947] Timer tick, asking Buildbucket for the build status
[00:37:42.030] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:42.030] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:38:0) after 1m0s
[00:38:42.115] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:38:0)
[00:38:42.115] Timer tick, asking Buildbucket for the build status
[00:38:42.221] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:42.221] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:39:0) after 1m0s
[00:39:42.912] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:39:0)
[00:39:42.912] Timer tick, asking Buildbucket for the build status
[00:39:43.285] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:43.285] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:40:0) after 1m0s
[00:40:43.301] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:40:0)
[00:40:43.301] Timer tick, asking Buildbucket for the build status
[00:40:43.406] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:43.406] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:41:0) after 1m0s
[00:41:43.378] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:41:0)
[00:41:43.378] Timer tick, asking Buildbucket for the build status
[00:41:43.702] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:43.702] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:42:0) after 1m0s
[00:42:43.860] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:42:0)
[00:42:43.860] Timer tick, asking Buildbucket for the build status
[00:42:43.995] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:43.995] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:43:0) after 1m0s
[00:43:44.080] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:43:0)
[00:43:44.080] Timer tick, asking Buildbucket for the build status
[00:43:44.225] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:44.225] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:44:0) after 1m0s
[00:44:44.230] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:44:0)
[00:44:44.230] Timer tick, asking Buildbucket for the build status
[00:44:45.029] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:45.029] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:45:0) after 1m0s
[00:45:45.177] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:45:0)
[00:45:45.177] Timer tick, asking Buildbucket for the build status
[00:45:48.992] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:48.992] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:46:0) after 1m0s
[00:46:49.046] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:46:0)
[00:46:49.046] Timer tick, asking Buildbucket for the build status
[00:46:49.208] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:49.208] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:47:0) after 1m0s
[00:47:49.260] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:47:0)
[00:47:49.260] Timer tick, asking Buildbucket for the build status
[00:47:49.310] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:49.310] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:48:0) after 1m0s
[00:48:49.318] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:48:0)
[00:48:49.318] Timer tick, asking Buildbucket for the build status
[00:48:49.438] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:49.438] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:49:0) after 1m0s
[00:49:49.551] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:49:0)
[00:49:49.551] Timer tick, asking Buildbucket for the build status
[00:49:50.259] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:50.259] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:50:0) after 1m0s
[00:50:50.377] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:50:0)
[00:50:50.377] Timer tick, asking Buildbucket for the build status
[00:50:50.708] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:50.708] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:51:0) after 1m0s
[00:51:50.847] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:51:0)
[00:51:50.848] Timer tick, asking Buildbucket for the build status
[00:51:50.954] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:50.954] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:52:0) after 1m0s
[00:52:51.084] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:52:0)
[00:52:51.084] Timer tick, asking Buildbucket for the build status
[00:52:51.195] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:51.195] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:53:0) after 1m0s
[00:53:51.318] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:53:0)
[00:53:51.318] Timer tick, asking Buildbucket for the build status
[00:53:51.415] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:51.415] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:54:0) after 1m0s
[00:54:51.536] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:54:0)
[00:54:51.536] Timer tick, asking Buildbucket for the build status
[00:54:51.658] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:51.658] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:55:0) after 1m0s
[00:55:52.038] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:55:0)
[00:55:52.039] Timer tick, asking Buildbucket for the build status
[00:55:52.180] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:52.180] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:56:0) after 1m0s
[00:56:52.350] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:56:0)
[00:56:52.350] Timer tick, asking Buildbucket for the build status
[00:56:52.476] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:52.476] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:57:0) after 1m0s
[00:57:52.848] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:57:0)
[00:57:52.848] Timer tick, asking Buildbucket for the build status
[00:57:53.064] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:53.064] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:58:0) after 1m0s
[00:58:53.088] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:58:0)
[00:58:53.088] Timer tick, asking Buildbucket for the build status
[00:58:53.209] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:53.209] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:59:0) after 1m0s
[00:59:53.392] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:59:0)
[00:59:53.392] Timer tick, asking Buildbucket for the build status
[00:59:53.596] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:53.596] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:60:0) after 1m0s
[01:00:53.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:60:0)
[01:00:53.802] Timer tick, asking Buildbucket for the build status
[01:00:54.140] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:54.140] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:61:0) after 1m0s
[01:01:54.407] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:61:0)
[01:01:54.407] Timer tick, asking Buildbucket for the build status
[01:01:54.577] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:54.577] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:62:0) after 1m0s
[01:02:54.675] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:62:0)
[01:02:54.675] Timer tick, asking Buildbucket for the build status
[01:02:54.956] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:54.956] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:63:0) after 1m0s
[01:03:54.980] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:63:0)
[01:03:54.980] Timer tick, asking Buildbucket for the build status
[01:03:55.092] Build 8884992214727209536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:55.092] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9050422276709402768:64:0) after 1m0s
[01:04:43.831] Received PubSub notification, asking Buildbucket for the build status
[01:04:43.975] Build 8884992214727209536: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[01:04:43.976] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"completed_ts": "1585011883488240",
"created_by": "project:infra",
"created_ts": "1585008145553075",
"failure_reason": "BUILD_FAILURE",
"id": "8884992214727209536",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-fuchsia\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"a90552bbf1e046ab317d7c686a263e57dfdd2573\", \"codesearch_mirror_revision_timestamp\": 1585007911.0, \"root_solution_revision\": \"1ff7639fdf7e5978e80704e514072a2af2740dae\", \"root_solution_revision_timestamp\": 1585007687.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:10409\", \"user_agent:recipe\"]}, \"id\": \"58402199-9d7b-45de-a3d6-dcec13a1b9e4\", \"title\": \"codesearch-gen-chromium-initiator/10409\"}]}, \"codesearch_mirror_revision\": \"a90552bbf1e046ab317d7c686a263e57dfdd2573\", \"codesearch_mirror_revision_timestamp\": 1585007911.0, \"root_solution_revision\": \"1ff7639fdf7e5978e80704e514072a2af2740dae\", \"root_solution_revision_timestamp\": 1585007687.0}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"Step('create kythe index pack') (retcode: 1)\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"a90552bbf1e046ab317d7c686a263e57dfdd2573\", \"codesearch_mirror_revision_timestamp\": 1585007911.0, \"root_solution_revision\": \"1ff7639fdf7e5978e80704e514072a2af2740dae\", \"root_solution_revision_timestamp\": 1585007687.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:10409\", \"user_agent:recipe\"]}, \"id\": \"58402199-9d7b-45de-a3d6-dcec13a1b9e4\", \"title\": \"codesearch-gen-chromium-initiator/10409\"}]}, \"bot_id\": \"luci-infra-codesearch-xenial-5-gkcl\", \"buildername\": \"codesearch-gen-chromium-fuchsia\", \"buildnumber\": 3167, \"codesearch_mirror_revision\": \"a90552bbf1e046ab317d7c686a263e57dfdd2573\", \"codesearch_mirror_revision_timestamp\": 1585007911.0, \"got_angle_revision\": \"6fead3754375fb086cd7fa6ccef650d102dee06d\", \"got_clang_revision\": \"n345635-5d881dd8-1\", \"got_dawn_revision\": \"11652ff8f8b3c3104eb2627717fa652d432d5b84\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"1ff7639fdf7e5978e80704e514072a2af2740dae\", \"got_revision_cp\": \"refs/heads/master@{#752647}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"95b77b44a8a80b1311dc6f3bf197e931cd3d7083\", \"got_v8_revision\": \"e1cd685a19d2f47c5673efa410b9dbf5aad031fd\", \"got_v8_revision_cp\": \"refs/heads/8.3.58@{#1}\", \"got_webrtc_revision\": \"f1df04b094feabfe73000a7d17accc908e8b7b81\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30858}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"1ff7639fdf7e5978e80704e514072a2af2740dae\", \"root_solution_revision_timestamp\": 1585007687.0}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_14b4f73c8b95a6615516bba597f721e10c68093aeabbb388e9a5697d2f7f84cc_v2\", \"builder_b5ea7bb4091186e872937c4042f52c0c1d84281f1bc29c547e93e8efc0fd27bb_v2\", \"codesearch_git_genfiles_repo\", \"codesearch_update_submodules_mirror\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-codesearch-xenial-5-gkcl\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.codesearch\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4874-3598771\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-a\"]}}, \"ui\": {\"info\": \"Step('create kythe index pack') (retcode: 1)\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585008180770425",
"status": "COMPLETED",
"status_changed_ts": "1585008181168578",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-fuchsia/3167",
"builder:codesearch-gen-chromium-fuchsia",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:10409",
"scheduler_invocation_id:9050422276709402768",
"scheduler_job_id:infra/codesearch-gen-chromium-fuchsia",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8884992214727209536/+/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:4b22aaa8c9f06210",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1585011883548808",
"url": "https://ci.chromium.org/b/8884992214727209536",
"utcnow_ts": "1585011883961551"
}
}
[01:04:43.976] Invocation finished in 1h2m19.696327953s with status FAILED