[16:00:56.144] New invocation is queued and will start shortly
[16:00:56.144] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[16:00:57.374] Starting the invocation (attempt 1)
[16:00:57.408] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:00:57.408] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:00:57.408] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9098740751226317232",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-chromiumos\",\"properties\":{\"root_solution_revision\":\"50326d70bed86d08b6d1095831267cb37519a57e\",\"root_solution_revision_timestamp\":1538924514}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-chromiumos",
"scheduler_invocation_id:9098740751226317232",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5970",
"user_agent:recipe"
]
}
[16:00:58.869] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538928057490307",
"id": "8933310689147441728",
"lease_expiration_ts": "1539046858589353",
"lease_key": "1547725211",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-chromiumos\", \"properties\": {\"root_solution_revision\": \"50326d70bed86d08b6d1095831267cb37519a57e\", \"root_solution_revision_timestamp\": 1538924514}}",
"project": "infra",
"result_details_json": "null",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1538928058755049",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3632",
"builder:codesearch-gen-chromium-chromiumos",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5970",
"scheduler_invocation_id:9098740751226317232",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"swarming_dimension:builder:codesearch-gen-chromium-chromiumos",
"swarming_dimension:caches:builder_fc2e8e4adaad07c0fdb9097d17739372515345c2d70921a64548f07bb9e4954b_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-chromiumos/3632",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8933310689147441728",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:codesearch-gen-chromium-chromiumos",
"swarming_tag:caches:builder_fc2e8e4adaad07c0fdb9097d17739372515345c2d70921a64548f07bb9e4954b_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8933310689147441728/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5970",
"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:9098740751226317232",
"swarming_tag:scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"swarming_tag:service_account:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:7a2c6a280a68ea7a8c9976d934a89c38009336b9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4068142755ca6a10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1538928058755142",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3632",
"utcnow_ts": "1538928058851784"
}
}
[16:00:58.869] Task URL: https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3632
[16:00:58.869] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:2:0) after 1m0s
[16:01:12.217] Received PubSub notification, asking Buildbucket for the build status
[16:01:12.309] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:58.931] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:2:0)
[16:01:58.931] Timer tick, asking Buildbucket for the build status
[16:01:58.986] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:58.986] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:4:0) after 1m0s
[16:02:59.469] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:4:0)
[16:02:59.469] Timer tick, asking Buildbucket for the build status
[16:02:59.530] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:59.530] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:5:0) after 1m0s
[16:04:00.145] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:5:0)
[16:04:00.145] Timer tick, asking Buildbucket for the build status
[16:04:00.208] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:00.208] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:6:0) after 1m0s
[16:05:00.696] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:6:0)
[16:05:00.696] Timer tick, asking Buildbucket for the build status
[16:05:00.768] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:00.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:7:0) after 1m0s
[16:06:00.800] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:7:0)
[16:06:00.800] Timer tick, asking Buildbucket for the build status
[16:06:01.069] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:01.070] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:8:0) after 1m0s
[16:07:01.303] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:8:0)
[16:07:01.303] Timer tick, asking Buildbucket for the build status
[16:07:01.388] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:01.388] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:9:0) after 1m0s
[16:08:01.927] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:9:0)
[16:08:01.927] Timer tick, asking Buildbucket for the build status
[16:08:02.658] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:02.658] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:10:0) after 1m0s
[16:09:02.960] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:10:0)
[16:09:02.960] Timer tick, asking Buildbucket for the build status
[16:09:03.135] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:03.135] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:11:0) after 1m0s
[16:10:03.510] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:11:0)
[16:10:03.510] Timer tick, asking Buildbucket for the build status
[16:10:03.590] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:03.590] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:12:0) after 1m0s
[16:11:04.105] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:12:0)
[16:11:04.105] Timer tick, asking Buildbucket for the build status
[16:11:04.201] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:04.201] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:13:0) after 1m0s
[16:12:04.781] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:13:0)
[16:12:04.781] Timer tick, asking Buildbucket for the build status
[16:12:04.887] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:04.887] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:14:0) after 1m0s
[16:13:05.459] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:14:0)
[16:13:05.459] Timer tick, asking Buildbucket for the build status
[16:13:05.732] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:05.732] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:15:0) after 1m0s
[16:14:05.846] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:15:0)
[16:14:05.846] Timer tick, asking Buildbucket for the build status
[16:14:05.971] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:05.971] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:16:0) after 1m0s
[16:15:05.992] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:16:0)
[16:15:05.992] Timer tick, asking Buildbucket for the build status
[16:15:06.117] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:06.117] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:17:0) after 1m0s
[16:16:06.144] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:17:0)
[16:16:06.145] Timer tick, asking Buildbucket for the build status
[16:16:06.311] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:06.311] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:18:0) after 1m0s
[16:17:06.474] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:18:0)
[16:17:06.474] Timer tick, asking Buildbucket for the build status
[16:17:06.601] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:06.601] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:19:0) after 1m0s
[16:18:06.643] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:19:0)
[16:18:06.643] Timer tick, asking Buildbucket for the build status
[16:18:06.721] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:06.721] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:20:0) after 1m0s
[16:19:07.174] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:20:0)
[16:19:07.174] Timer tick, asking Buildbucket for the build status
[16:19:07.550] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:07.550] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:21:0) after 1m0s
[16:20:08.080] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:21:0)
[16:20:08.080] Timer tick, asking Buildbucket for the build status
[16:20:08.353] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:08.353] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:22:0) after 1m0s
[16:21:08.772] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:22:0)
[16:21:08.772] Timer tick, asking Buildbucket for the build status
[16:21:08.850] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:08.850] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:23:0) after 1m0s
[16:22:09.262] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:23:0)
[16:22:09.262] Timer tick, asking Buildbucket for the build status
[16:22:09.330] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:09.331] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:24:0) after 1m0s
[16:23:09.705] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:24:0)
[16:23:09.705] Timer tick, asking Buildbucket for the build status
[16:23:09.966] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:09.966] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:25:0) after 1m0s
[16:24:10.589] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:25:0)
[16:24:10.589] Timer tick, asking Buildbucket for the build status
[16:24:10.672] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:10.672] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:26:0) after 1m0s
[16:25:10.698] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:26:0)
[16:25:10.698] Timer tick, asking Buildbucket for the build status
[16:25:10.761] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:10.762] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:27:0) after 1m0s
[16:26:11.244] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:27:0)
[16:26:11.244] Timer tick, asking Buildbucket for the build status
[16:26:11.472] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:11.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:28:0) after 1m0s
[16:27:11.918] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:28:0)
[16:27:11.918] Timer tick, asking Buildbucket for the build status
[16:27:12.050] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:12.050] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:29:0) after 1m0s
[16:28:12.728] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:29:0)
[16:28:12.728] Timer tick, asking Buildbucket for the build status
[16:28:12.835] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:12.835] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:30:0) after 1m0s
[16:29:13.315] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:30:0)
[16:29:13.315] Timer tick, asking Buildbucket for the build status
[16:29:13.452] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:13.452] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:31:0) after 1m0s
[16:30:13.963] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:31:0)
[16:30:13.963] Timer tick, asking Buildbucket for the build status
[16:30:14.124] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:14.124] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:32:0) after 1m0s
[16:31:14.566] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:32:0)
[16:31:14.566] Timer tick, asking Buildbucket for the build status
[16:31:14.706] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:14.706] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:33:0) after 1m0s
[16:32:15.154] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:33:0)
[16:32:15.154] Timer tick, asking Buildbucket for the build status
[16:32:15.300] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:15.300] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:34:0) after 1m0s
[16:33:15.872] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:34:0)
[16:33:15.872] Timer tick, asking Buildbucket for the build status
[16:33:15.956] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:15.956] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:35:0) after 1m0s
[16:34:16.446] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:35:0)
[16:34:16.446] Timer tick, asking Buildbucket for the build status
[16:34:16.514] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:16.514] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:36:0) after 1m0s
[16:35:17.025] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:36:0)
[16:35:17.025] Timer tick, asking Buildbucket for the build status
[16:35:17.112] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:17.112] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:37:0) after 1m0s
[16:36:17.666] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:37:0)
[16:36:17.666] Timer tick, asking Buildbucket for the build status
[16:36:17.768] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:17.768] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:38:0) after 1m0s
[16:37:18.058] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:38:0)
[16:37:18.058] Timer tick, asking Buildbucket for the build status
[16:37:18.105] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:18.105] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:39:0) after 1m0s
[16:38:18.657] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:39:0)
[16:38:18.657] Timer tick, asking Buildbucket for the build status
[16:38:19.035] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:19.035] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:40:0) after 1m0s
[16:39:19.630] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:40:0)
[16:39:19.630] Timer tick, asking Buildbucket for the build status
[16:39:19.905] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:19.905] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:41:0) after 1m0s
[16:40:20.413] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:41:0)
[16:40:20.413] Timer tick, asking Buildbucket for the build status
[16:40:20.454] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:20.454] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:42:0) after 1m0s
[16:41:20.961] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:42:0)
[16:41:20.961] Timer tick, asking Buildbucket for the build status
[16:41:21.141] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:21.141] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:43:0) after 1m0s
[16:42:21.404] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:43:0)
[16:42:21.404] Timer tick, asking Buildbucket for the build status
[16:42:21.613] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:21.613] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:44:0) after 1m0s
[16:43:21.631] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:44:0)
[16:43:21.631] Timer tick, asking Buildbucket for the build status
[16:43:21.769] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:21.769] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:45:0) after 1m0s
[16:44:21.863] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:45:0)
[16:44:21.863] Timer tick, asking Buildbucket for the build status
[16:44:21.963] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:21.963] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:46:0) after 1m0s
[16:45:22.566] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:46:0)
[16:45:22.566] Timer tick, asking Buildbucket for the build status
[16:45:22.602] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:22.602] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:47:0) after 1m0s
[16:46:22.989] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:47:0)
[16:46:22.989] Timer tick, asking Buildbucket for the build status
[16:46:23.243] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:23.243] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:48:0) after 1m0s
[16:47:23.631] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:48:0)
[16:47:23.632] Timer tick, asking Buildbucket for the build status
[16:47:23.812] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:23.812] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:49:0) after 1m0s
[16:48:24.252] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:49:0)
[16:48:24.252] Timer tick, asking Buildbucket for the build status
[16:48:24.365] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:24.365] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:50:0) after 1m0s
[16:49:24.779] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:50:0)
[16:49:24.779] Timer tick, asking Buildbucket for the build status
[16:49:24.888] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:24.888] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:51:0) after 1m0s
[16:50:24.909] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:51:0)
[16:50:24.909] Timer tick, asking Buildbucket for the build status
[16:50:24.995] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:24.995] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:52:0) after 1m0s
[16:51:25.304] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:52:0)
[16:51:25.304] Timer tick, asking Buildbucket for the build status
[16:51:25.387] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:25.387] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:53:0) after 1m0s
[16:52:25.408] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:53:0)
[16:52:25.408] Timer tick, asking Buildbucket for the build status
[16:52:25.646] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:25.646] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:54:0) after 1m0s
[16:53:25.667] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:54:0)
[16:53:25.667] Timer tick, asking Buildbucket for the build status
[16:53:25.738] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:25.738] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:55:0) after 1m0s
[16:54:25.757] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:55:0)
[16:54:25.758] Timer tick, asking Buildbucket for the build status
[16:54:25.913] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:25.913] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:56:0) after 1m0s
[16:55:26.062] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:56:0)
[16:55:26.062] Timer tick, asking Buildbucket for the build status
[16:55:26.162] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:26.162] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:57:0) after 1m0s
[16:56:26.184] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:57:0)
[16:56:26.184] Timer tick, asking Buildbucket for the build status
[16:56:26.310] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:26.310] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:58:0) after 1m0s
[16:57:26.332] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:58:0)
[16:57:26.332] Timer tick, asking Buildbucket for the build status
[16:57:26.429] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:26.429] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:59:0) after 1m0s
[16:58:26.472] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:59:0)
[16:58:26.472] Timer tick, asking Buildbucket for the build status
[16:58:26.546] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:26.546] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:60:0) after 1m0s
[16:59:26.566] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:60:0)
[16:59:26.566] Timer tick, asking Buildbucket for the build status
[16:59:26.699] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:26.699] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:61:0) after 1m0s
[17:00:26.729] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:61:0)
[17:00:26.729] Timer tick, asking Buildbucket for the build status
[17:00:26.935] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:26.935] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:62:0) after 1m0s
[17:01:26.955] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:62:0)
[17:01:26.955] Timer tick, asking Buildbucket for the build status
[17:01:27.055] Build 8933310689147441728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:27.055] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9098740751226317232:63:0) after 1m0s
[17:01:53.359] Received PubSub notification, asking Buildbucket for the build status
[17:01:53.410] Build 8933310689147441728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:01:53.410] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1538931703734424",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538928057490307",
"id": "8933310689147441728",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-chromiumos\", \"properties\": {\"root_solution_revision\": \"50326d70bed86d08b6d1095831267cb37519a57e\", \"root_solution_revision_timestamp\": 1538924514}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"chromium_codesearch\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8933310689147441728/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"codesearch-gen-chromium-chromiumos\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3801-8761768\"], \"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\": [\"swarm1881-c4\"], \"pool\": [\"luci.infra.codesearch\"], \"caches\": [\"builder_fc2e8e4adaad07c0fdb9097d17739372515345c2d70921a64548f07bb9e4954b_v2\", \"codesearch_git_genfiles_repo\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"2ebbdab4bfb1ed9dfe52ce756b34829207dbe25f\", \"got_clang_revision\": \"343342-1\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"50326d70bed86d08b6d1095831267cb37519a57e\", \"recipe\": \"chromium_codesearch\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25031}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"root_solution_revision_timestamp\": 1538924514, \"got_revision_cp\": \"refs/heads/master@{#597462}\", \"root_solution_revision\": \"50326d70bed86d08b6d1095831267cb37519a57e\", \"buildername\": \"codesearch-gen-chromium-chromiumos\", \"got_webrtc_revision\": \"343f4144bee5ddde5efec1e1217403b444386cb4\", \"mastername\": \"chromium.infra.codesearch\", \"got_angle_revision\": \"450bf36f7918d18f3186be8ce570d9eac63b309d\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1538928057490307, \"tags\": [\"builder:codesearch-gen-chromium-chromiumos\", \"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:5970\", \"scheduler_invocation_id:9098740751226317232\", \"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos\", \"user_agent:luci-scheduler\", \"user_agent:recipe\"], \"bucket\": \"luci.infra.codesearch\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"infra\", \"id\": \"8933310689147441728\"}}, \"got_v8_revision\": \"a3d2be45f6c668c582f09cd5e0143d6fb1f2ae80\", \"got_v8_revision_cp\": \"refs/heads/7.1.280@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 3632, \"path_config\": \"generic\", \"bot_id\": \"swarm1881-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1538928071055192",
"status": "COMPLETED",
"status_changed_ts": "1538931712847692",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3632",
"builder:codesearch-gen-chromium-chromiumos",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5970",
"scheduler_invocation_id:9098740751226317232",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"swarming_dimension:builder:codesearch-gen-chromium-chromiumos",
"swarming_dimension:caches:builder_fc2e8e4adaad07c0fdb9097d17739372515345c2d70921a64548f07bb9e4954b_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-chromiumos/3632",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8933310689147441728",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:codesearch-gen-chromium-chromiumos",
"swarming_tag:caches:builder_fc2e8e4adaad07c0fdb9097d17739372515345c2d70921a64548f07bb9e4954b_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8933310689147441728/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5970",
"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:9098740751226317232",
"swarming_tag:scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"swarming_tag:service_account:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:7a2c6a280a68ea7a8c9976d934a89c38009336b9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4068142755ca6a10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1538931712848598",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3632",
"utcnow_ts": "1538931713392444"
}
}
[17:01:53.410] Invocation finished in 1h0m57.285973032s with status SUCCEEDED