[08:00:18.322] New invocation is queued and will start shortly
[08:00:20.134] Starting the invocation (attempt 1)
[08:00:20.208] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:00:20.208] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:00:20.208] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9105565762352773424",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-linux\",\"properties\":{\"root_solution_revision\":\"e046a6ea519c0f67fdcec728c13741103db64056\",\"root_solution_revision_timestamp\":1532419104}}",
"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:9105565762352773424",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5346",
"user_agent:recipe"
]
}
[08:00:21.334] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1532419220297320",
"experimental": true,
"id": "8940135699615622432",
"lease_expiration_ts": "1532534420969350",
"lease_key": "868867163",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"root_solution_revision\": \"e046a6ea519c0f67fdcec728c13741103db64056\", \"root_solution_revision_timestamp\": 1532419104}}",
"project": "infra",
"result_details_json": "null",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1532419221174880",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/2418",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5346",
"scheduler_invocation_id:9105565762352773424",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_dimension:builder:codesearch-gen-chromium-linux",
"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/2418",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8940135699615622432",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:6d851ad604a64afe293b646c0b4f1f875a182f69",
"swarming_tag:builder:codesearch-gen-chromium-linux",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8940135699615622432/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5346",
"swarming_tag:pool:luci.infra.codesearch",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9105565762352773424",
"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:70e6fce4bd7f99bd0e93cc101178e72f72308243",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3ee41f2d2dbeb810",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1532419221175010",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/2418",
"utcnow_ts": "1532419221310150"
}
}
[08:00:21.334] Task URL: https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/2418
[08:00:21.334] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:2:0) after 1m0s
[08:00:42.247] Received PubSub notification, asking Buildbucket for the build status
[08:00:42.409] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:21.355] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:2:0)
[08:01:21.355] Timer tick, asking Buildbucket for the build status
[08:01:21.396] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:21.396] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:4:0) after 1m0s
[08:02:21.415] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:4:0)
[08:02:21.415] Timer tick, asking Buildbucket for the build status
[08:02:21.458] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:21.458] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:5:0) after 1m0s
[08:03:21.479] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:5:0)
[08:03:21.479] Timer tick, asking Buildbucket for the build status
[08:03:21.768] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:21.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:6:0) after 1m0s
[08:04:21.791] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:6:0)
[08:04:21.791] Timer tick, asking Buildbucket for the build status
[08:04:22.204] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:22.204] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:7:0) after 1m0s
[08:05:22.227] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:7:0)
[08:05:22.227] Timer tick, asking Buildbucket for the build status
[08:05:22.301] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:22.301] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:8:0) after 1m0s
[08:06:22.322] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:8:0)
[08:06:22.322] Timer tick, asking Buildbucket for the build status
[08:06:22.401] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:22.401] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:9:0) after 1m0s
[08:07:22.532] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:9:0)
[08:07:22.532] Timer tick, asking Buildbucket for the build status
[08:07:22.704] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:22.704] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:10:0) after 1m0s
[08:08:22.726] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:10:0)
[08:08:22.726] Timer tick, asking Buildbucket for the build status
[08:08:22.790] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:22.790] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:11:0) after 1m0s
[08:09:22.812] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:11:0)
[08:09:22.812] Timer tick, asking Buildbucket for the build status
[08:09:23.104] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:23.104] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:12:0) after 1m0s
[08:10:23.121] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:12:0)
[08:10:23.121] Timer tick, asking Buildbucket for the build status
[08:10:23.222] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:23.222] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:13:0) after 1m0s
[08:11:23.244] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:13:0)
[08:11:23.244] Timer tick, asking Buildbucket for the build status
[08:11:23.375] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:23.375] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:14:0) after 1m0s
[08:12:23.398] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:14:0)
[08:12:23.398] Timer tick, asking Buildbucket for the build status
[08:12:23.460] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:23.460] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:15:0) after 1m0s
[08:13:23.478] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:15:0)
[08:13:23.478] Timer tick, asking Buildbucket for the build status
[08:13:23.615] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:23.615] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:16:0) after 1m0s
[08:14:23.701] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:16:0)
[08:14:23.701] Timer tick, asking Buildbucket for the build status
[08:14:23.877] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:23.877] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:17:0) after 1m0s
[08:15:23.904] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:17:0)
[08:15:23.904] Timer tick, asking Buildbucket for the build status
[08:15:24.035] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:24.035] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:18:0) after 1m0s
[08:16:24.064] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:18:0)
[08:16:24.064] Timer tick, asking Buildbucket for the build status
[08:16:24.269] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:24.269] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:19:0) after 1m0s
[08:17:24.294] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:19:0)
[08:17:24.294] Timer tick, asking Buildbucket for the build status
[08:17:24.451] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:24.451] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:20:0) after 1m0s
[08:18:24.473] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:20:0)
[08:18:24.473] Timer tick, asking Buildbucket for the build status
[08:18:24.521] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:24.521] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:21:0) after 1m0s
[08:19:24.544] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:21:0)
[08:19:24.544] Timer tick, asking Buildbucket for the build status
[08:19:24.691] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:24.691] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:22:0) after 1m0s
[08:20:24.715] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:22:0)
[08:20:24.715] Timer tick, asking Buildbucket for the build status
[08:20:24.804] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:24.804] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:23:0) after 1m0s
[08:21:24.823] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:23:0)
[08:21:24.823] Timer tick, asking Buildbucket for the build status
[08:21:24.935] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:24.935] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:24:0) after 1m0s
[08:22:24.955] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:24:0)
[08:22:24.955] Timer tick, asking Buildbucket for the build status
[08:22:25.006] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:25.006] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:25:0) after 1m0s
[08:23:25.035] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:25:0)
[08:23:25.035] Timer tick, asking Buildbucket for the build status
[08:23:25.099] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:25.099] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:26:0) after 1m0s
[08:24:25.120] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:26:0)
[08:24:25.120] Timer tick, asking Buildbucket for the build status
[08:24:25.206] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:25.206] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:27:0) after 1m0s
[08:25:25.267] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:27:0)
[08:25:25.267] Timer tick, asking Buildbucket for the build status
[08:25:25.437] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:25.437] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:28:0) after 1m0s
[08:26:25.461] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:28:0)
[08:26:25.461] Timer tick, asking Buildbucket for the build status
[08:26:25.509] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:25.509] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:29:0) after 1m0s
[08:27:25.605] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:29:0)
[08:27:25.605] Timer tick, asking Buildbucket for the build status
[08:27:25.662] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:25.662] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:30:0) after 1m0s
[08:28:25.807] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:30:0)
[08:28:25.807] Timer tick, asking Buildbucket for the build status
[08:28:25.852] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:25.852] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:31:0) after 1m0s
[08:29:25.896] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:31:0)
[08:29:25.896] Timer tick, asking Buildbucket for the build status
[08:29:25.959] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:25.959] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:32:0) after 1m0s
[08:30:26.037] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:32:0)
[08:30:26.037] Timer tick, asking Buildbucket for the build status
[08:30:27.971] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:27.972] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:33:0) after 1m0s
[08:31:28.013] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:33:0)
[08:31:28.013] Timer tick, asking Buildbucket for the build status
[08:31:28.150] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:28.150] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:34:0) after 1m0s
[08:32:28.170] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:34:0)
[08:32:28.170] Timer tick, asking Buildbucket for the build status
[08:32:28.483] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:28.483] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:35:0) after 1m0s
[08:33:28.504] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:35:0)
[08:33:28.504] Timer tick, asking Buildbucket for the build status
[08:33:28.618] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:28.618] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:36:0) after 1m0s
[08:34:28.641] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:36:0)
[08:34:28.641] Timer tick, asking Buildbucket for the build status
[08:34:28.680] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:28.680] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:37:0) after 1m0s
[08:35:28.704] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:37:0)
[08:35:28.704] Timer tick, asking Buildbucket for the build status
[08:35:28.808] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:28.808] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:38:0) after 1m0s
[08:36:28.849] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:38:0)
[08:36:28.849] Timer tick, asking Buildbucket for the build status
[08:36:28.891] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:28.891] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:39:0) after 1m0s
[08:37:28.925] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:39:0)
[08:37:28.925] Timer tick, asking Buildbucket for the build status
[08:37:28.978] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:28.978] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:40:0) after 1m0s
[08:38:29.001] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:40:0)
[08:38:29.001] Timer tick, asking Buildbucket for the build status
[08:38:29.077] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:29.077] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:41:0) after 1m0s
[08:39:29.105] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:41:0)
[08:39:29.105] Timer tick, asking Buildbucket for the build status
[08:39:29.176] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:29.176] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:42:0) after 1m0s
[08:40:29.238] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:42:0)
[08:40:29.238] Timer tick, asking Buildbucket for the build status
[08:40:29.304] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:29.304] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:43:0) after 1m0s
[08:41:29.417] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:43:0)
[08:41:29.417] Timer tick, asking Buildbucket for the build status
[08:41:29.583] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:29.583] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:44:0) after 1m0s
[08:42:29.606] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:44:0)
[08:42:29.606] Timer tick, asking Buildbucket for the build status
[08:42:29.653] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:29.653] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:45:0) after 1m0s
[08:43:29.673] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:45:0)
[08:43:29.673] Timer tick, asking Buildbucket for the build status
[08:43:29.796] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:29.796] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:46:0) after 1m0s
[08:44:29.814] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:46:0)
[08:44:29.814] Timer tick, asking Buildbucket for the build status
[08:44:29.938] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:29.938] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:47:0) after 1m0s
[08:45:30.011] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:47:0)
[08:45:30.011] Timer tick, asking Buildbucket for the build status
[08:45:30.050] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:30.050] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:48:0) after 1m0s
[08:46:30.132] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:48:0)
[08:46:30.132] Timer tick, asking Buildbucket for the build status
[08:46:30.306] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:30.306] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:49:0) after 1m0s
[08:47:30.335] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:49:0)
[08:47:30.335] Timer tick, asking Buildbucket for the build status
[08:47:30.459] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:30.459] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:50:0) after 1m0s
[08:48:30.479] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:50:0)
[08:48:30.479] Timer tick, asking Buildbucket for the build status
[08:48:30.652] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:30.652] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:51:0) after 1m0s
[08:49:30.678] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:51:0)
[08:49:30.678] Timer tick, asking Buildbucket for the build status
[08:49:30.742] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:30.742] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:52:0) after 1m0s
[08:50:30.767] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:52:0)
[08:50:30.767] Timer tick, asking Buildbucket for the build status
[08:50:30.861] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:30.861] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:53:0) after 1m0s
[08:51:30.886] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:53:0)
[08:51:30.886] Timer tick, asking Buildbucket for the build status
[08:51:30.952] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:30.952] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:54:0) after 1m0s
[08:52:30.976] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:54:0)
[08:52:30.976] Timer tick, asking Buildbucket for the build status
[08:52:31.046] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:31.046] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:55:0) after 1m0s
[08:53:31.069] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:55:0)
[08:53:31.069] Timer tick, asking Buildbucket for the build status
[08:53:31.118] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:31.118] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:56:0) after 1m0s
[08:54:31.166] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:56:0)
[08:54:31.166] Timer tick, asking Buildbucket for the build status
[08:54:31.216] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:31.216] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:57:0) after 1m0s
[08:55:31.242] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:57:0)
[08:55:31.242] Timer tick, asking Buildbucket for the build status
[08:55:31.362] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:31.362] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:58:0) after 1m0s
[08:56:31.383] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:58:0)
[08:56:31.383] Timer tick, asking Buildbucket for the build status
[08:56:31.433] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:31.433] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:59:0) after 1m0s
[08:57:31.532] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:59:0)
[08:57:31.532] Timer tick, asking Buildbucket for the build status
[08:57:31.626] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:31.626] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:60:0) after 1m0s
[08:58:31.667] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:60:0)
[08:58:31.668] Timer tick, asking Buildbucket for the build status
[08:58:31.760] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:31.760] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:61:0) after 1m0s
[08:59:31.780] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:61:0)
[08:59:31.780] Timer tick, asking Buildbucket for the build status
[08:59:31.824] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:31.824] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:62:0) after 1m0s
[09:00:31.849] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:62:0)
[09:00:31.849] Timer tick, asking Buildbucket for the build status
[09:00:31.891] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:31.891] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:63:0) after 1m0s
[09:01:31.915] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:63:0)
[09:01:31.915] Timer tick, asking Buildbucket for the build status
[09:01:32.159] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:32.159] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:64:0) after 1m0s
[09:02:32.226] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:64:0)
[09:02:32.226] Timer tick, asking Buildbucket for the build status
[09:02:32.322] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:32.323] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:65:0) after 1m0s
[09:03:32.344] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:65:0)
[09:03:32.344] Timer tick, asking Buildbucket for the build status
[09:03:32.649] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:32.649] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:66:0) after 1m0s
[09:04:32.667] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:66:0)
[09:04:32.667] Timer tick, asking Buildbucket for the build status
[09:04:32.777] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:32.777] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:67:0) after 1m0s
[09:05:32.819] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:67:0)
[09:05:32.819] Timer tick, asking Buildbucket for the build status
[09:05:32.944] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:32.944] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:68:0) after 1m0s
[09:06:32.965] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:68:0)
[09:06:32.965] Timer tick, asking Buildbucket for the build status
[09:06:33.019] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:33.019] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:69:0) after 1m0s
[09:07:33.040] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:69:0)
[09:07:33.040] Timer tick, asking Buildbucket for the build status
[09:07:33.134] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:33.134] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:70:0) after 1m0s
[09:08:33.165] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:70:0)
[09:08:33.165] Timer tick, asking Buildbucket for the build status
[09:08:33.247] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:33.247] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:71:0) after 1m0s
[09:09:33.267] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:71:0)
[09:09:33.267] Timer tick, asking Buildbucket for the build status
[09:09:33.330] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:33.330] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:72:0) after 1m0s
[09:10:33.354] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:72:0)
[09:10:33.354] Timer tick, asking Buildbucket for the build status
[09:10:33.396] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:33.396] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:73:0) after 1m0s
[09:11:33.420] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:73:0)
[09:11:33.420] Timer tick, asking Buildbucket for the build status
[09:11:33.524] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:33.524] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:74:0) after 1m0s
[09:12:33.607] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:74:0)
[09:12:33.607] Timer tick, asking Buildbucket for the build status
[09:12:33.654] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:33.654] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:75:0) after 1m0s
[09:13:33.678] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:75:0)
[09:13:33.678] Timer tick, asking Buildbucket for the build status
[09:13:33.781] Build 8940135699615622432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:33.781] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9105565762352773424:76:0) after 1m0s
[09:13:35.008] Received PubSub notification, asking Buildbucket for the build status
[09:13:35.127] Build 8940135699615622432: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[09:13:35.127] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1532423613320150",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1532419220297320",
"experimental": true,
"failure_reason": "BUILD_FAILURE",
"id": "8940135699615622432",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"root_solution_revision\": \"e046a6ea519c0f67fdcec728c13741103db64056\", \"root_solution_revision_timestamp\": 1532419104}}",
"project": "infra",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure create kythe index pack\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"failure\": {\"failure\": {\"step\": \"create kythe index pack\"}, \"humanReason\": \"Step('create kythe index pack') 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/8940135699615622432/+/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\": [\"3684-658b5dc\"], \"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\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"aebc9e5205dcaad5d5954a18abc532316a954644\", \"got_clang_revision\": \"337439-1\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"e046a6ea519c0f67fdcec728c13741103db64056\", \"recipe\": \"chromium_codesearch\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24075}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"root_solution_revision_timestamp\": 1532419104, \"got_revision_cp\": \"refs/heads/master@{#577451}\", \"root_solution_revision\": \"e046a6ea519c0f67fdcec728c13741103db64056\", \"buildername\": \"codesearch-gen-chromium-linux\", \"got_webrtc_revision\": \"dcff0bd78e263e353b2b8f67076a2200aa5406b3\", \"mastername\": \"chromium.infra.codesearch\", \"got_angle_revision\": \"522095f7d7fe04bf1479a20a9707372d988a9da2\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1532419220297320, \"tags\": [\"builder:codesearch-gen-chromium-linux\", \"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:5346\", \"scheduler_invocation_id:9105565762352773424\", \"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\": \"8940135699615622432\"}}, \"got_v8_revision\": \"0f6c45052aee78f4daf25622dcc20ab8c8924e63\", \"got_v8_revision_cp\": \"refs/heads/7.0.7@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"buildnumber\": 2418, \"path_config\": \"generic\", \"bot_id\": \"swarm1879-c4\", \"got_buildtools_revision\": \"0dd5c6f980d22be96b728155249df2da355989d9\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1532419241292410",
"status": "COMPLETED",
"status_changed_ts": "1532423614184670",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/2418",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5346",
"scheduler_invocation_id:9105565762352773424",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"swarming_dimension:builder:codesearch-gen-chromium-linux",
"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/2418",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8940135699615622432",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:6d851ad604a64afe293b646c0b4f1f875a182f69",
"swarming_tag:builder:codesearch-gen-chromium-linux",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8940135699615622432/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5346",
"swarming_tag:pool:luci.infra.codesearch",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9105565762352773424",
"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:70e6fce4bd7f99bd0e93cc101178e72f72308243",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3ee41f2d2dbeb810",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1532423614189220",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/2418",
"utcnow_ts": "1532423615101960"
}
}
[09:13:35.127] Invocation finished in 1h13m16.822260098s with status FAILED