[08:01:57.171] New invocation is queued and will start shortly
[08:01:57.171] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[08:01:58.549] Starting the invocation (attempt 1)
[08:01:58.627] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:01:58.627] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:01:58.628] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9058092848308609584",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-linux\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"codesearch_mirror_revision\":\"5fc1935af2e21296d3866a6f70585192ff4180d8\",\"codesearch_mirror_revision_timestamp\":1577690959,\"root_solution_revision\":\"add326bae9c343f8ef91fa7e7b439f02b8a989a0\",\"root_solution_revision_timestamp\":1577690852},\"tags\":[\"parent_buildername:codesearch-gen-chromium-initiator\",\"parent_buildnumber:9901\",\"user_agent:recipe\"]},\"id\":\"e9ddb18d-6413-4710-9457-dd0ec536e61c\",\"title\":\"codesearch-gen-chromium-initiator/9901\"}]},\"codesearch_mirror_revision\":\"5fc1935af2e21296d3866a6f70585192ff4180d8\",\"codesearch_mirror_revision_timestamp\":1577690959,\"root_solution_revision\":\"add326bae9c343f8ef91fa7e7b439f02b8a989a0\",\"root_solution_revision_timestamp\":1577690852}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-linux",
"scheduler_invocation_id:9058092848308609584",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:9901",
"user_agent:recipe"
]
}
[08:02:00.296] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1577692918953022",
"id": "8892662785774311344",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"5fc1935af2e21296d3866a6f70585192ff4180d8\", \"codesearch_mirror_revision_timestamp\": 1577690959.0, \"root_solution_revision\": \"add326bae9c343f8ef91fa7e7b439f02b8a989a0\", \"root_solution_revision_timestamp\": 1577690852.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:9901\", \"user_agent:recipe\"]}, \"id\": \"e9ddb18d-6413-4710-9457-dd0ec536e61c\", \"title\": \"codesearch-gen-chromium-initiator/9901\"}]}, \"codesearch_mirror_revision\": \"5fc1935af2e21296d3866a6f70585192ff4180d8\", \"codesearch_mirror_revision_timestamp\": 1577690959.0, \"root_solution_revision\": \"add326bae9c343f8ef91fa7e7b439f02b8a989a0\", \"root_solution_revision_timestamp\": 1577690852.0}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577692919975319",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/7583",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:9901",
"scheduler_invocation_id:9058092848308609584",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8892662785774311344/+/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": "1577692919975504",
"url": "https://ci.chromium.org/b/8892662785774311344",
"utcnow_ts": "1577692920246208"
}
}
[08:02:00.296] Task URL: https://ci.chromium.org/b/8892662785774311344
[08:02:00.296] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:2:0) after 1m0s
[08:02:23.886] Received PubSub notification, asking Buildbucket for the build status
[08:02:23.988] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:00.366] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:2:0)
[08:03:00.366] Timer tick, asking Buildbucket for the build status
[08:03:00.551] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:00.551] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:4:0) after 1m0s
[08:04:00.650] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:4:0)
[08:04:00.650] Timer tick, asking Buildbucket for the build status
[08:04:01.043] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:01.043] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:5:0) after 1m0s
[08:05:01.073] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:5:0)
[08:05:01.073] Timer tick, asking Buildbucket for the build status
[08:05:04.190] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:04.190] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:6:0) after 1m0s
[08:06:04.282] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:6:0)
[08:06:04.282] Timer tick, asking Buildbucket for the build status
[08:06:08.803] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:08.803] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:7:0) after 1m0s
[08:07:08.881] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:7:0)
[08:07:08.881] Timer tick, asking Buildbucket for the build status
[08:07:09.103] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:09.103] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:8:0) after 1m0s
[08:08:09.109] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:8:0)
[08:08:09.109] Timer tick, asking Buildbucket for the build status
[08:08:09.484] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:09.484] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:9:0) after 1m0s
[08:09:09.493] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:9:0)
[08:09:09.493] Timer tick, asking Buildbucket for the build status
[08:09:09.649] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:09.649] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:10:0) after 1m0s
[08:10:09.744] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:10:0)
[08:10:09.744] Timer tick, asking Buildbucket for the build status
[08:10:10.302] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:10.302] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:11:0) after 1m0s
[08:11:10.284] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:11:0)
[08:11:10.284] Timer tick, asking Buildbucket for the build status
[08:11:10.605] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:10.605] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:12:0) after 1m0s
[08:12:10.665] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:12:0)
[08:12:10.665] Timer tick, asking Buildbucket for the build status
[08:12:10.814] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:10.814] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:13:0) after 1m0s
[08:13:10.889] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:13:0)
[08:13:10.889] Timer tick, asking Buildbucket for the build status
[08:13:11.186] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:11.186] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:14:0) after 1m0s
[08:14:11.214] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:14:0)
[08:14:11.214] Timer tick, asking Buildbucket for the build status
[08:14:11.399] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:11.399] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:15:0) after 1m0s
[08:15:11.414] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:15:0)
[08:15:11.414] Timer tick, asking Buildbucket for the build status
[08:15:11.561] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:11.561] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:16:0) after 1m0s
[08:16:11.572] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:16:0)
[08:16:11.572] Timer tick, asking Buildbucket for the build status
[08:16:12.168] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:12.168] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:17:0) after 1m0s
[08:17:12.185] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:17:0)
[08:17:12.185] Timer tick, asking Buildbucket for the build status
[08:17:12.596] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:12.596] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:18:0) after 1m0s
[08:18:12.646] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:18:0)
[08:18:12.646] Timer tick, asking Buildbucket for the build status
[08:18:13.076] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:13.076] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:19:0) after 1m0s
[08:19:13.233] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:19:0)
[08:19:13.233] Timer tick, asking Buildbucket for the build status
[08:19:13.351] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:13.351] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:20:0) after 1m0s
[08:20:13.470] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:20:0)
[08:20:13.470] Timer tick, asking Buildbucket for the build status
[08:20:13.610] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:13.610] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:21:0) after 1m0s
[08:21:13.660] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:21:0)
[08:21:13.660] Timer tick, asking Buildbucket for the build status
[08:21:13.984] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:13.984] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:22:0) after 1m0s
[08:22:14.013] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:22:0)
[08:22:14.014] Timer tick, asking Buildbucket for the build status
[08:22:15.981] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:15.981] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:23:0) after 1m0s
[08:23:16.116] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:23:0)
[08:23:16.116] Timer tick, asking Buildbucket for the build status
[08:23:16.421] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:16.421] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:24:0) after 1m0s
[08:24:16.482] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:24:0)
[08:24:16.482] Timer tick, asking Buildbucket for the build status
[08:24:16.655] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:16.655] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:25:0) after 1m0s
[08:25:16.679] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:25:0)
[08:25:16.679] Timer tick, asking Buildbucket for the build status
[08:25:16.842] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:16.842] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:26:0) after 1m0s
[08:26:16.914] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:26:0)
[08:26:16.914] Timer tick, asking Buildbucket for the build status
[08:26:17.349] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:17.349] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:27:0) after 1m0s
[08:27:17.419] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:27:0)
[08:27:17.419] Timer tick, asking Buildbucket for the build status
[08:27:17.499] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:17.499] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:28:0) after 1m0s
[08:28:17.524] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:28:0)
[08:28:17.524] Timer tick, asking Buildbucket for the build status
[08:28:17.841] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:17.841] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:29:0) after 1m0s
[08:29:17.861] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:29:0)
[08:29:17.861] Timer tick, asking Buildbucket for the build status
[08:29:17.978] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:17.978] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:30:0) after 1m0s
[08:30:18.028] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:30:0)
[08:30:18.028] Timer tick, asking Buildbucket for the build status
[08:30:18.319] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:18.319] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:31:0) after 1m0s
[08:31:18.338] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:31:0)
[08:31:18.338] Timer tick, asking Buildbucket for the build status
[08:31:18.472] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:18.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:32:0) after 1m0s
[08:32:18.549] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:32:0)
[08:32:18.549] Timer tick, asking Buildbucket for the build status
[08:32:18.760] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:18.760] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:33:0) after 1m0s
[08:33:18.961] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:33:0)
[08:33:18.961] Timer tick, asking Buildbucket for the build status
[08:33:19.421] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:19.421] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:34:0) after 1m0s
[08:34:19.525] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:34:0)
[08:34:19.525] Timer tick, asking Buildbucket for the build status
[08:34:19.684] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:19.684] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:35:0) after 1m0s
[08:35:19.832] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:35:0)
[08:35:19.832] Timer tick, asking Buildbucket for the build status
[08:35:20.058] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:20.058] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:36:0) after 1m0s
[08:36:20.129] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:36:0)
[08:36:20.129] Timer tick, asking Buildbucket for the build status
[08:36:20.493] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:20.493] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:37:0) after 1m0s
[08:37:20.640] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:37:0)
[08:37:20.640] Timer tick, asking Buildbucket for the build status
[08:37:20.956] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:20.956] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:38:0) after 1m0s
[08:38:21.028] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:38:0)
[08:38:21.028] Timer tick, asking Buildbucket for the build status
[08:38:21.144] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:21.144] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:39:0) after 1m0s
[08:39:21.165] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:39:0)
[08:39:21.165] Timer tick, asking Buildbucket for the build status
[08:39:21.383] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:21.383] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:40:0) after 1m0s
[08:40:21.402] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:40:0)
[08:40:21.402] Timer tick, asking Buildbucket for the build status
[08:40:21.639] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:21.639] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:41:0) after 1m0s
[08:41:21.617] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:41:0)
[08:41:21.617] Timer tick, asking Buildbucket for the build status
[08:41:22.034] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:22.034] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:42:0) after 1m0s
[08:42:22.061] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:42:0)
[08:42:22.061] Timer tick, asking Buildbucket for the build status
[08:42:22.151] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:22.151] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:43:0) after 1m0s
[08:43:22.225] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:43:0)
[08:43:22.225] Timer tick, asking Buildbucket for the build status
[08:43:22.421] Build 8892662785774311344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:22.421] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9058092848308609584:44:0) after 1m0s
[08:43:25.345] Received PubSub notification, asking Buildbucket for the build status
[08:43:25.435] Build 8892662785774311344: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:43:25.435] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"completed_ts": "1577695404764119",
"created_by": "project:infra",
"created_ts": "1577692918953022",
"failure_reason": "BUILD_FAILURE",
"id": "8892662785774311344",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"5fc1935af2e21296d3866a6f70585192ff4180d8\", \"codesearch_mirror_revision_timestamp\": 1577690959.0, \"root_solution_revision\": \"add326bae9c343f8ef91fa7e7b439f02b8a989a0\", \"root_solution_revision_timestamp\": 1577690852.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:9901\", \"user_agent:recipe\"]}, \"id\": \"e9ddb18d-6413-4710-9457-dd0ec536e61c\", \"title\": \"codesearch-gen-chromium-initiator/9901\"}]}, \"codesearch_mirror_revision\": \"5fc1935af2e21296d3866a6f70585192ff4180d8\", \"codesearch_mirror_revision_timestamp\": 1577690959.0, \"root_solution_revision\": \"add326bae9c343f8ef91fa7e7b439f02b8a989a0\", \"root_solution_revision_timestamp\": 1577690852.0}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\nFailing build because ninja reported work to do.\\nThis means that after completing a compile, another was run and\\nit resulted in still having work to do (that is, a no-op build\\nwasn't a no-op). Consult the first \\\"ninja explain:\\\" line for a\\nlikely culprit.\\n```\\n#### More information in raw_io.output[failure_summary]\"}, \"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\": \"5fc1935af2e21296d3866a6f70585192ff4180d8\", \"codesearch_mirror_revision_timestamp\": 1577690959.0, \"root_solution_revision\": \"add326bae9c343f8ef91fa7e7b439f02b8a989a0\", \"root_solution_revision_timestamp\": 1577690852.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:9901\", \"user_agent:recipe\"]}, \"id\": \"e9ddb18d-6413-4710-9457-dd0ec536e61c\", \"title\": \"codesearch-gen-chromium-initiator/9901\"}]}, \"bot_id\": \"luci-infra-codesearch-xenial-4-ugoz\", \"buildername\": \"codesearch-gen-chromium-linux\", \"buildnumber\": 7583, \"codesearch_mirror_revision\": \"5fc1935af2e21296d3866a6f70585192ff4180d8\", \"codesearch_mirror_revision_timestamp\": 1577690959.0, \"got_angle_revision\": \"fca5a005aa880a51672c091fcb82f084b620670a\", \"got_clang_revision\": \"n332890-c2443155-1\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"add326bae9c343f8ef91fa7e7b439f02b8a989a0\", \"got_revision_cp\": \"refs/heads/master@{#727732}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"59465799210b3f4962af1a9dc44a4ffecb422c10\", \"got_v8_revision\": \"4c53f9a51444393133ff303952f1296603d44ab7\", \"got_v8_revision_cp\": \"refs/heads/8.1.80@{#1}\", \"got_webrtc_revision\": \"8ac79125c05256f4b6ad29533b99c7733e5ac219\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30127}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"add326bae9c343f8ef91fa7e7b439f02b8a989a0\", \"root_solution_revision_timestamp\": 1577690852.0}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_14b4f73c8b95a6615516bba597f721e10c68093aeabbb388e9a5697d2f7f84cc_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\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-codesearch-xenial-4-ugoz\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"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\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-a\"]}}, \"ui\": {\"info\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\nFailing build because ninja reported work to do.\\nThis means that after completing a compile, another was run and\\nit resulted in still having work to do (that is, a no-op build\\nwasn't a no-op). Consult the first \\\"ninja explain:\\\" line for a\\nlikely culprit.\\n```\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577692939891570",
"status": "COMPLETED",
"status_changed_ts": "1577692943262192",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/7583",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:9901",
"scheduler_invocation_id:9058092848308609584",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8892662785774311344/+/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:496ea501c811a610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1577695404856500",
"url": "https://ci.chromium.org/b/8892662785774311344",
"utcnow_ts": "1577695405426140"
}
}
[08:43:25.435] Invocation finished in 41m28.282397276s with status FAILED