[15:00:38.456] New invocation is queued and will start shortly
[15:00:39.698] Starting the invocation (attempt 1)
[15:00:39.766] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:00:39.766] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:00:39.766] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9101553050602413824",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-linux\",\"properties\":{\"root_solution_revision\":\"9b85bf74cd368d86d9d63e7811ac2fb94f2cd19c\",\"root_solution_revision_timestamp\":1536245722}}",
"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:9101553050602413824",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5624",
"user_agent:recipe"
]
}
[15:00:41.421] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536246039880049",
"id": "8936122988445539904",
"lease_expiration_ts": "1536361241126193",
"lease_key": "147096719",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"root_solution_revision\": \"9b85bf74cd368d86d9d63e7811ac2fb94f2cd19c\", \"root_solution_revision_timestamp\": 1536245722}}",
"project": "infra",
"result_details_json": "null",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1536246041278448",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/3480",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5624",
"scheduler_invocation_id:9101553050602413824",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_dimension:builder:codesearch-gen-chromium-linux",
"swarming_dimension:caches:builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.infra.codesearch",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/3480",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8936122988445539904",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:codesearch-gen-chromium-linux",
"swarming_tag:caches:builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8936122988445539904/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5624",
"swarming_tag:pool:luci.infra.codesearch",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9101553050602413824",
"swarming_tag:scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_tag:service_account:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:c1f54e554be68337486f8ef663ba8af3d4928375",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fc837d09464a510",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1536246041278555",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/3480",
"utcnow_ts": "1536246041410862"
}
}
[15:00:41.421] Task URL: https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/3480
[15:00:41.421] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:2:0) after 1m0s
[15:01:03.590] Received PubSub notification, asking Buildbucket for the build status
[15:01:03.628] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:41.541] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:2:0)
[15:01:41.541] Timer tick, asking Buildbucket for the build status
[15:01:41.629] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:41.629] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:4:0) after 1m0s
[15:02:41.645] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:4:0)
[15:02:41.645] Timer tick, asking Buildbucket for the build status
[15:02:41.712] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:41.712] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:5:0) after 1m0s
[15:03:41.728] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:5:0)
[15:03:41.728] Timer tick, asking Buildbucket for the build status
[15:03:41.771] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:41.771] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:6:0) after 1m0s
[15:04:41.876] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:6:0)
[15:04:41.876] Timer tick, asking Buildbucket for the build status
[15:04:41.946] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:41.946] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:7:0) after 1m0s
[15:05:41.963] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:7:0)
[15:05:41.963] Timer tick, asking Buildbucket for the build status
[15:05:42.023] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:42.023] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:8:0) after 1m0s
[15:06:42.039] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:8:0)
[15:06:42.039] Timer tick, asking Buildbucket for the build status
[15:06:42.109] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:42.110] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:9:0) after 1m0s
[15:07:42.241] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:9:0)
[15:07:42.241] Timer tick, asking Buildbucket for the build status
[15:07:42.281] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:42.281] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:10:0) after 1m0s
[15:08:42.300] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:10:0)
[15:08:42.300] Timer tick, asking Buildbucket for the build status
[15:08:42.374] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:42.374] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:11:0) after 1m0s
[15:09:42.389] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:11:0)
[15:09:42.389] Timer tick, asking Buildbucket for the build status
[15:09:42.581] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:42.581] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:12:0) after 1m0s
[15:10:42.603] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:12:0)
[15:10:42.603] Timer tick, asking Buildbucket for the build status
[15:10:42.643] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:42.643] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:13:0) after 1m0s
[15:11:42.661] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:13:0)
[15:11:42.661] Timer tick, asking Buildbucket for the build status
[15:11:42.727] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:42.727] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:14:0) after 1m0s
[15:12:42.754] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:14:0)
[15:12:42.754] Timer tick, asking Buildbucket for the build status
[15:12:42.870] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:42.870] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:15:0) after 1m0s
[15:13:42.894] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:15:0)
[15:13:42.894] Timer tick, asking Buildbucket for the build status
[15:13:42.940] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:42.940] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:16:0) after 1m0s
[15:14:42.958] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:16:0)
[15:14:42.958] Timer tick, asking Buildbucket for the build status
[15:14:43.022] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:43.022] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:17:0) after 1m0s
[15:15:43.041] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:17:0)
[15:15:43.041] Timer tick, asking Buildbucket for the build status
[15:15:43.214] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:43.214] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:18:0) after 1m0s
[15:16:43.337] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:18:0)
[15:16:43.337] Timer tick, asking Buildbucket for the build status
[15:16:43.378] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:43.378] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:19:0) after 1m0s
[15:17:43.397] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:19:0)
[15:17:43.397] Timer tick, asking Buildbucket for the build status
[15:17:43.719] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:43.719] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:20:0) after 1m0s
[15:18:43.739] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:20:0)
[15:18:43.739] Timer tick, asking Buildbucket for the build status
[15:18:43.826] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:43.826] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:21:0) after 1m0s
[15:19:43.846] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:21:0)
[15:19:43.846] Timer tick, asking Buildbucket for the build status
[15:19:43.930] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:43.930] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:22:0) after 1m0s
[15:20:43.947] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:22:0)
[15:20:43.947] Timer tick, asking Buildbucket for the build status
[15:20:44.052] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:44.052] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:23:0) after 1m0s
[15:21:44.069] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:23:0)
[15:21:44.069] Timer tick, asking Buildbucket for the build status
[15:21:44.195] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:44.195] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:24:0) after 1m0s
[15:22:44.214] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:24:0)
[15:22:44.214] Timer tick, asking Buildbucket for the build status
[15:22:44.263] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:44.263] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:25:0) after 1m0s
[15:23:44.280] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:25:0)
[15:23:44.280] Timer tick, asking Buildbucket for the build status
[15:23:44.417] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:44.417] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:26:0) after 1m0s
[15:24:44.449] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:26:0)
[15:24:44.449] Timer tick, asking Buildbucket for the build status
[15:24:44.504] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:44.504] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:27:0) after 1m0s
[15:25:44.524] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:27:0)
[15:25:44.524] Timer tick, asking Buildbucket for the build status
[15:25:44.605] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:44.605] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:28:0) after 1m0s
[15:26:44.626] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:28:0)
[15:26:44.626] Timer tick, asking Buildbucket for the build status
[15:26:44.691] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:44.691] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:29:0) after 1m0s
[15:27:44.709] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:29:0)
[15:27:44.709] Timer tick, asking Buildbucket for the build status
[15:27:44.792] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:44.792] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:30:0) after 1m0s
[15:28:44.818] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:30:0)
[15:28:44.818] Timer tick, asking Buildbucket for the build status
[15:28:44.987] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:44.987] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:31:0) after 1m0s
[15:29:45.039] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:31:0)
[15:29:45.039] Timer tick, asking Buildbucket for the build status
[15:29:45.116] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:45.116] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:32:0) after 1m0s
[15:30:45.137] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:32:0)
[15:30:45.137] Timer tick, asking Buildbucket for the build status
[15:30:45.198] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:45.198] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:33:0) after 1m0s
[15:31:45.230] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:33:0)
[15:31:45.230] Timer tick, asking Buildbucket for the build status
[15:31:45.274] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:45.274] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:34:0) after 1m0s
[15:32:45.305] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:34:0)
[15:32:45.305] Timer tick, asking Buildbucket for the build status
[15:32:45.367] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:45.367] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:35:0) after 1m0s
[15:33:45.438] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:35:0)
[15:33:45.438] Timer tick, asking Buildbucket for the build status
[15:33:45.477] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:45.477] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:36:0) after 1m0s
[15:34:45.494] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:36:0)
[15:34:45.494] Timer tick, asking Buildbucket for the build status
[15:34:45.552] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:45.552] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:37:0) after 1m0s
[15:35:45.570] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:37:0)
[15:35:45.570] Timer tick, asking Buildbucket for the build status
[15:35:46.002] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:46.002] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:38:0) after 1m0s
[15:36:46.022] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:38:0)
[15:36:46.022] Timer tick, asking Buildbucket for the build status
[15:36:46.140] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:46.140] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:39:0) after 1m0s
[15:37:46.255] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:39:0)
[15:37:46.255] Timer tick, asking Buildbucket for the build status
[15:37:46.414] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:46.415] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:40:0) after 1m0s
[15:38:46.437] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:40:0)
[15:38:46.437] Timer tick, asking Buildbucket for the build status
[15:38:46.500] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:46.500] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:41:0) after 1m0s
[15:39:46.518] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:41:0)
[15:39:46.518] Timer tick, asking Buildbucket for the build status
[15:39:46.674] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:46.674] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:42:0) after 1m0s
[15:40:46.714] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:42:0)
[15:40:46.714] Timer tick, asking Buildbucket for the build status
[15:40:46.757] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:46.757] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:43:0) after 1m0s
[15:41:46.852] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:43:0)
[15:41:46.852] Timer tick, asking Buildbucket for the build status
[15:41:46.977] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:46.977] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:44:0) after 1m0s
[15:42:46.997] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:44:0)
[15:42:46.997] Timer tick, asking Buildbucket for the build status
[15:42:47.066] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:47.066] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:45:0) after 1m0s
[15:43:47.083] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:45:0)
[15:43:47.083] Timer tick, asking Buildbucket for the build status
[15:43:47.184] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:47.184] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:46:0) after 1m0s
[15:44:47.203] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:46:0)
[15:44:47.203] Timer tick, asking Buildbucket for the build status
[15:44:47.282] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:47.282] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:47:0) after 1m0s
[15:45:47.306] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:47:0)
[15:45:47.306] Timer tick, asking Buildbucket for the build status
[15:45:47.354] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:47.354] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:48:0) after 1m0s
[15:46:47.373] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:48:0)
[15:46:47.373] Timer tick, asking Buildbucket for the build status
[15:46:47.449] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:47.449] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:49:0) after 1m0s
[15:47:47.469] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:49:0)
[15:47:47.469] Timer tick, asking Buildbucket for the build status
[15:47:47.517] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:47.517] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:50:0) after 1m0s
[15:48:47.538] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:50:0)
[15:48:47.538] Timer tick, asking Buildbucket for the build status
[15:48:47.611] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:47.611] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:51:0) after 1m0s
[15:49:47.692] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:51:0)
[15:49:47.692] Timer tick, asking Buildbucket for the build status
[15:49:47.743] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:47.743] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:52:0) after 1m0s
[15:50:47.857] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:52:0)
[15:50:47.857] Timer tick, asking Buildbucket for the build status
[15:50:47.945] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:47.945] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:53:0) after 1m0s
[15:51:47.975] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:53:0)
[15:51:47.975] Timer tick, asking Buildbucket for the build status
[15:51:48.067] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:48.067] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:54:0) after 1m0s
[15:52:48.088] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:54:0)
[15:52:48.088] Timer tick, asking Buildbucket for the build status
[15:52:48.299] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:48.299] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:55:0) after 1m0s
[15:53:48.387] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:55:0)
[15:53:48.387] Timer tick, asking Buildbucket for the build status
[15:53:48.493] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:48.493] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:56:0) after 1m0s
[15:54:48.514] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:56:0)
[15:54:48.514] Timer tick, asking Buildbucket for the build status
[15:54:48.760] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:48.760] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:57:0) after 1m0s
[15:55:48.780] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:57:0)
[15:55:48.780] Timer tick, asking Buildbucket for the build status
[15:55:48.907] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:48.907] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:58:0) after 1m0s
[15:56:48.926] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:58:0)
[15:56:48.926] Timer tick, asking Buildbucket for the build status
[15:56:49.005] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:49.005] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:59:0) after 1m0s
[15:57:49.044] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:59:0)
[15:57:49.044] Timer tick, asking Buildbucket for the build status
[15:57:49.203] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:49.203] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:60:0) after 1m0s
[15:58:49.253] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:60:0)
[15:58:49.253] Timer tick, asking Buildbucket for the build status
[15:58:49.570] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:49.570] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:61:0) after 1m0s
[15:59:50.923] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:61:0)
[15:59:50.923] Timer tick, asking Buildbucket for the build status
[15:59:50.982] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:50.982] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:62:0) after 1m0s
[16:00:52.240] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:62:0)
[16:00:52.240] Timer tick, asking Buildbucket for the build status
[16:00:52.328] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:52.328] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:63:0) after 1m0s
[16:01:54.746] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:63:0)
[16:01:54.746] Timer tick, asking Buildbucket for the build status
[16:01:54.907] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:54.907] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:64:0) after 1m0s
[16:02:56.341] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:64:0)
[16:02:56.341] Timer tick, asking Buildbucket for the build status
[16:02:56.413] Build 8936122988445539904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:56.413] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9101553050602413824:65:0) after 1m0s
[16:03:41.634] Received PubSub notification, asking Buildbucket for the build status
[16:03:41.675] Build 8936122988445539904: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[16:03:41.675] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1536249820544745",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536246039880049",
"failure_reason": "BUILD_FAILURE",
"id": "8936122988445539904",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"root_solution_revision\": \"9b85bf74cd368d86d9d63e7811ac2fb94f2cd19c\", \"root_solution_revision_timestamp\": 1536245722}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure sync generated files\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"failure\": {\"failure\": {\"step\": \"sync generated files\"}, \"humanReason\": \"Step('sync generated files') failed with return_code 1\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"chromium_codesearch\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8936122988445539904/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"codesearch-gen-chromium-linux\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3768-9a74523\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm1879-c4\"], \"pool\": [\"luci.infra.codesearch\"], \"caches\": [\"builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2\", \"codesearch_git_genfiles_repo\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"cb6ec4b1f91af259cbdfd1bd22bb98ed5551955e\", \"got_clang_revision\": \"340925-1\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"9b85bf74cd368d86d9d63e7811ac2fb94f2cd19c\", \"recipe\": \"chromium_codesearch\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24590}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"root_solution_revision_timestamp\": 1536245722, \"got_revision_cp\": \"refs/heads/master@{#589167}\", \"root_solution_revision\": \"9b85bf74cd368d86d9d63e7811ac2fb94f2cd19c\", \"buildername\": \"codesearch-gen-chromium-linux\", \"got_webrtc_revision\": \"b9bb9e3f6683a74acab9198359d17a3b68644338\", \"mastername\": \"chromium.infra.codesearch\", \"got_angle_revision\": \"7359954301e131a2b1f326ef391669dbd7562d0d\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1536246039880049, \"tags\": [\"builder:codesearch-gen-chromium-linux\", \"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:5624\", \"scheduler_invocation_id:9101553050602413824\", \"scheduler_job_id:infra/codesearch-gen-chromium-linux\", \"user_agent:luci-scheduler\", \"user_agent:recipe\"], \"bucket\": \"luci.infra.codesearch\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"infra\", \"id\": \"8936122988445539904\"}}, \"got_v8_revision\": \"1b63139d35984e457e9fce65b6240b5ea3fb8208\", \"got_v8_revision_cp\": \"refs/heads/7.1.37@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 3480, \"path_config\": \"generic\", \"bot_id\": \"swarm1879-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1536246062459852",
"status": "COMPLETED",
"status_changed_ts": "1536249821217602",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/3480",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5624",
"scheduler_invocation_id:9101553050602413824",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_dimension:builder:codesearch-gen-chromium-linux",
"swarming_dimension:caches:builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.infra.codesearch",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/3480",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8936122988445539904",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:codesearch-gen-chromium-linux",
"swarming_tag:caches:builder_54f8e8cb8feba6eccd56fdc0fadd094595d4925f57b55f2d9fb92e97a2de5aa9_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8936122988445539904/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5624",
"swarming_tag:pool:luci.infra.codesearch",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9101553050602413824",
"swarming_tag:scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_tag:service_account:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:c1f54e554be68337486f8ef663ba8af3d4928375",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fc837d09464a510",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1536249821218467",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/3480",
"utcnow_ts": "1536249821663986"
}
}
[16:03:41.675] Invocation finished in 1h3m3.235407513s with status FAILED