[23:01:08.192] New invocation is queued and will start shortly
[23:01:09.618] Starting the invocation (attempt 1)
[23:01:09.663] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:01:09.663] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:01:09.663] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9104331326391292528",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-linux\",\"properties\":{\"root_solution_revision\":\"a7a753a6696b95431248846c4158f4836229f88a\",\"root_solution_revision_timestamp\":1533596280}}",
"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:9104331326391292528",
"scheduler_job_id:infra/codesearch-gen-chromium-linux",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5428",
"user_agent:recipe"
]
}
[23:01:10.927] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1533596469794190",
"experimental": true,
"id": "8938901264047084096",
"lease_expiration_ts": "1533711670763920",
"lease_key": "553976444",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"root_solution_revision\": \"a7a753a6696b95431248846c4158f4836229f88a\", \"root_solution_revision_timestamp\": 1533596280}}",
"project": "infra",
"result_details_json": "null",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1533596470841460",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/2500",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5428",
"scheduler_invocation_id:9104331326391292528",
"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/2500",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8938901264047084096",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1843d7ecb7176e182855328359db08c38323a012",
"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/8938901264047084096/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5428",
"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:9104331326391292528",
"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:32df66ef6ec5978e059bc3a43bb607b4426f75fc",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3f2a4a94ed0bb610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1533596470841590",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/2500",
"utcnow_ts": "1533596470916310"
}
}
[23:01:10.927] Task URL: https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/2500
[23:01:10.927] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:2:0) after 1m0s
[23:01:45.123] Received PubSub notification, asking Buildbucket for the build status
[23:01:45.166] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:10.997] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:2:0)
[23:02:10.997] Timer tick, asking Buildbucket for the build status
[23:02:11.097] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:11.097] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:4:0) after 1m0s
[23:03:11.117] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:4:0)
[23:03:11.117] Timer tick, asking Buildbucket for the build status
[23:03:11.198] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:11.198] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:5:0) after 1m0s
[23:04:11.229] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:5:0)
[23:04:11.229] Timer tick, asking Buildbucket for the build status
[23:04:11.269] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:11.269] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:6:0) after 1m0s
[23:05:11.287] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:6:0)
[23:05:11.287] Timer tick, asking Buildbucket for the build status
[23:05:11.399] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:11.399] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:7:0) after 1m0s
[23:06:11.443] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:7:0)
[23:06:11.443] Timer tick, asking Buildbucket for the build status
[23:06:11.661] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:11.661] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:8:0) after 1m0s
[23:07:11.678] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:8:0)
[23:07:11.678] Timer tick, asking Buildbucket for the build status
[23:07:11.714] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:11.714] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:9:0) after 1m0s
[23:08:11.734] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:9:0)
[23:08:11.734] Timer tick, asking Buildbucket for the build status
[23:08:11.999] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:11.999] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:10:0) after 1m0s
[23:09:12.052] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:10:0)
[23:09:12.052] Timer tick, asking Buildbucket for the build status
[23:09:12.153] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:12.153] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:11:0) after 1m0s
[23:10:12.170] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:11:0)
[23:10:12.170] Timer tick, asking Buildbucket for the build status
[23:10:12.282] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:12.282] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:12:0) after 1m0s
[23:11:12.302] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:12:0)
[23:11:12.302] Timer tick, asking Buildbucket for the build status
[23:11:12.391] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:12.391] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:13:0) after 1m0s
[23:12:12.428] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:13:0)
[23:12:12.428] Timer tick, asking Buildbucket for the build status
[23:12:12.466] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:12.466] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:14:0) after 1m0s
[23:13:12.482] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:14:0)
[23:13:12.482] Timer tick, asking Buildbucket for the build status
[23:13:12.624] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:12.624] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:15:0) after 1m0s
[23:14:12.641] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:15:0)
[23:14:12.641] Timer tick, asking Buildbucket for the build status
[23:14:12.739] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:12.739] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:16:0) after 1m0s
[23:15:12.761] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:16:0)
[23:15:12.761] Timer tick, asking Buildbucket for the build status
[23:15:12.799] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:12.799] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:17:0) after 1m0s
[23:16:12.830] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:17:0)
[23:16:12.830] Timer tick, asking Buildbucket for the build status
[23:16:12.901] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:12.901] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:18:0) after 1m0s
[23:17:12.967] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:18:0)
[23:17:12.967] Timer tick, asking Buildbucket for the build status
[23:17:13.045] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:13.045] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:19:0) after 1m0s
[23:18:13.063] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:19:0)
[23:18:13.063] Timer tick, asking Buildbucket for the build status
[23:18:13.231] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:13.231] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:20:0) after 1m0s
[23:19:13.250] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:20:0)
[23:19:13.250] Timer tick, asking Buildbucket for the build status
[23:19:13.291] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:13.291] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:21:0) after 1m0s
[23:20:13.310] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:21:0)
[23:20:13.310] Timer tick, asking Buildbucket for the build status
[23:20:13.460] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:13.460] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:22:0) after 1m0s
[23:21:13.481] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:22:0)
[23:21:13.481] Timer tick, asking Buildbucket for the build status
[23:21:13.648] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:13.648] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:23:0) after 1m0s
[23:22:13.668] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:23:0)
[23:22:13.668] Timer tick, asking Buildbucket for the build status
[23:22:13.705] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:13.705] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:24:0) after 1m0s
[23:23:13.723] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:24:0)
[23:23:13.723] Timer tick, asking Buildbucket for the build status
[23:23:14.037] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:14.037] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:25:0) after 1m0s
[23:24:14.172] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:25:0)
[23:24:14.172] Timer tick, asking Buildbucket for the build status
[23:24:14.299] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:14.299] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:26:0) after 1m0s
[23:25:14.323] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:26:0)
[23:25:14.323] Timer tick, asking Buildbucket for the build status
[23:25:14.481] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:14.481] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:27:0) after 1m0s
[23:26:14.502] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:27:0)
[23:26:14.502] Timer tick, asking Buildbucket for the build status
[23:26:14.538] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:14.538] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:28:0) after 1m0s
[23:27:14.562] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:28:0)
[23:27:14.562] Timer tick, asking Buildbucket for the build status
[23:27:14.603] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:14.603] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:29:0) after 1m0s
[23:28:14.643] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:29:0)
[23:28:14.643] Timer tick, asking Buildbucket for the build status
[23:28:14.802] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:14.802] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:30:0) after 1m0s
[23:29:14.826] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:30:0)
[23:29:14.826] Timer tick, asking Buildbucket for the build status
[23:29:14.893] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:14.893] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:31:0) after 1m0s
[23:30:14.922] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:31:0)
[23:30:14.922] Timer tick, asking Buildbucket for the build status
[23:30:14.980] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:14.980] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:32:0) after 1m0s
[23:31:14.998] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:32:0)
[23:31:14.998] Timer tick, asking Buildbucket for the build status
[23:31:15.291] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:15.291] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:33:0) after 1m0s
[23:32:15.367] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:33:0)
[23:32:15.367] Timer tick, asking Buildbucket for the build status
[23:32:15.477] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:15.477] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:34:0) after 1m0s
[23:33:15.496] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:34:0)
[23:33:15.496] Timer tick, asking Buildbucket for the build status
[23:33:15.593] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:15.593] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:35:0) after 1m0s
[23:34:15.713] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:35:0)
[23:34:15.713] Timer tick, asking Buildbucket for the build status
[23:34:15.891] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:15.891] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:36:0) after 1m0s
[23:35:15.917] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:36:0)
[23:35:15.918] Timer tick, asking Buildbucket for the build status
[23:35:15.954] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:15.955] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:37:0) after 1m0s
[23:36:15.978] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:37:0)
[23:36:15.978] Timer tick, asking Buildbucket for the build status
[23:36:16.046] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:16.046] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:38:0) after 1m0s
[23:37:16.067] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:38:0)
[23:37:16.067] Timer tick, asking Buildbucket for the build status
[23:37:16.104] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:16.104] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:39:0) after 1m0s
[23:38:16.122] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:39:0)
[23:38:16.123] Timer tick, asking Buildbucket for the build status
[23:38:16.270] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:16.270] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:40:0) after 1m0s
[23:39:16.289] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:40:0)
[23:39:16.289] Timer tick, asking Buildbucket for the build status
[23:39:16.385] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:16.385] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:41:0) after 1m0s
[23:40:16.408] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:41:0)
[23:40:16.408] Timer tick, asking Buildbucket for the build status
[23:40:16.684] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:16.684] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:42:0) after 1m0s
[23:41:16.783] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:42:0)
[23:41:16.783] Timer tick, asking Buildbucket for the build status
[23:41:16.843] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:16.843] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:43:0) after 1m0s
[23:42:16.861] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:43:0)
[23:42:16.861] Timer tick, asking Buildbucket for the build status
[23:42:16.923] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:16.923] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:44:0) after 1m0s
[23:43:16.944] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:44:0)
[23:43:16.944] Timer tick, asking Buildbucket for the build status
[23:43:17.012] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:17.012] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:45:0) after 1m0s
[23:44:17.034] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:45:0)
[23:44:17.034] Timer tick, asking Buildbucket for the build status
[23:44:17.154] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:17.154] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:46:0) after 1m0s
[23:45:17.177] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:46:0)
[23:45:17.177] Timer tick, asking Buildbucket for the build status
[23:45:17.226] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:17.226] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:47:0) after 1m0s
[23:46:17.250] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:47:0)
[23:46:17.250] Timer tick, asking Buildbucket for the build status
[23:46:17.356] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:17.356] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:48:0) after 1m0s
[23:47:17.430] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:48:0)
[23:47:17.430] Timer tick, asking Buildbucket for the build status
[23:47:17.481] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:17.481] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:49:0) after 1m0s
[23:48:17.532] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:49:0)
[23:48:17.532] Timer tick, asking Buildbucket for the build status
[23:48:17.593] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:17.593] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:50:0) after 1m0s
[23:49:17.730] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:50:0)
[23:49:17.730] Timer tick, asking Buildbucket for the build status
[23:49:17.783] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:17.783] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:51:0) after 1m0s
[23:50:17.804] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:51:0)
[23:50:17.804] Timer tick, asking Buildbucket for the build status
[23:50:17.861] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:17.861] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:52:0) after 1m0s
[23:51:17.967] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:52:0)
[23:51:17.967] Timer tick, asking Buildbucket for the build status
[23:51:18.001] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:18.001] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:53:0) after 1m0s
[23:52:18.157] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:53:0)
[23:52:18.157] Timer tick, asking Buildbucket for the build status
[23:52:18.242] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:18.242] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:54:0) after 1m0s
[23:53:18.325] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:54:0)
[23:53:18.325] Timer tick, asking Buildbucket for the build status
[23:53:18.375] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:18.375] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:55:0) after 1m0s
[23:54:18.395] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:55:0)
[23:54:18.395] Timer tick, asking Buildbucket for the build status
[23:54:18.444] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:18.444] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:56:0) after 1m0s
[23:55:18.470] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:56:0)
[23:55:18.470] Timer tick, asking Buildbucket for the build status
[23:55:18.529] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:18.529] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:57:0) after 1m0s
[23:56:18.546] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:57:0)
[23:56:18.546] Timer tick, asking Buildbucket for the build status
[23:56:18.595] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:18.595] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:58:0) after 1m0s
[23:57:18.616] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:58:0)
[23:57:18.616] Timer tick, asking Buildbucket for the build status
[23:57:18.913] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:18.913] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:59:0) after 1m0s
[23:58:18.941] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:59:0)
[23:58:18.942] Timer tick, asking Buildbucket for the build status
[23:58:18.982] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:18.982] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:60:0) after 1m0s
[23:59:19.002] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:60:0)
[23:59:19.003] Timer tick, asking Buildbucket for the build status
[23:59:19.225] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:19.225] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:61:0) after 1m0s
[00:00:19.285] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:61:0)
[00:00:19.285] Timer tick, asking Buildbucket for the build status
[00:00:19.351] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:19.351] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:62:0) after 1m0s
[00:01:19.388] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:62:0)
[00:01:19.388] Timer tick, asking Buildbucket for the build status
[00:01:19.503] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:19.503] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:63:0) after 1m0s
[00:02:19.522] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:63:0)
[00:02:19.522] Timer tick, asking Buildbucket for the build status
[00:02:19.624] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:19.624] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:64:0) after 1m0s
[00:03:19.647] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:64:0)
[00:03:19.647] Timer tick, asking Buildbucket for the build status
[00:03:19.733] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:19.733] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:65:0) after 1m0s
[00:04:19.755] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:65:0)
[00:04:19.755] Timer tick, asking Buildbucket for the build status
[00:04:19.828] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:19.828] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:66:0) after 1m0s
[00:05:19.847] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:66:0)
[00:05:19.847] Timer tick, asking Buildbucket for the build status
[00:05:19.964] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:19.964] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:67:0) after 1m0s
[00:06:19.990] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:67:0)
[00:06:19.990] Timer tick, asking Buildbucket for the build status
[00:06:20.022] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:20.022] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:68:0) after 1m0s
[00:07:20.098] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:68:0)
[00:07:20.098] Timer tick, asking Buildbucket for the build status
[00:07:20.183] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:20.183] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:69:0) after 1m0s
[00:08:20.208] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:69:0)
[00:08:20.208] Timer tick, asking Buildbucket for the build status
[00:08:20.295] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:20.295] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:70:0) after 1m0s
[00:09:20.315] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:70:0)
[00:09:20.315] Timer tick, asking Buildbucket for the build status
[00:09:20.398] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:20.398] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:71:0) after 1m0s
[00:10:20.419] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:71:0)
[00:10:20.419] Timer tick, asking Buildbucket for the build status
[00:10:20.483] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:20.483] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:72:0) after 1m0s
[00:11:20.508] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:72:0)
[00:11:20.508] Timer tick, asking Buildbucket for the build status
[00:11:20.586] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:20.586] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:73:0) after 1m0s
[00:12:20.613] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:73:0)
[00:12:20.613] Timer tick, asking Buildbucket for the build status
[00:12:20.691] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:20.691] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:74:0) after 1m0s
[00:13:20.714] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:74:0)
[00:13:20.714] Timer tick, asking Buildbucket for the build status
[00:13:20.751] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:20.751] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:75:0) after 1m0s
[00:14:20.784] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:75:0)
[00:14:20.784] Timer tick, asking Buildbucket for the build status
[00:14:20.817] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:20.817] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:76:0) after 1m0s
[00:15:20.837] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:76:0)
[00:15:20.837] Timer tick, asking Buildbucket for the build status
[00:15:24.630] Build 8938901264047084096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:24.630] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-linux:9104331326391292528:77:0) after 1m0s
[00:15:43.603] Received PubSub notification, asking Buildbucket for the build status
[00:15:43.657] Build 8938901264047084096: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:15:43.657] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1533600941903790",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1533596469794190",
"experimental": true,
"id": "8938901264047084096",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-linux\", \"properties\": {\"root_solution_revision\": \"a7a753a6696b95431248846c4158f4836229f88a\", \"root_solution_revision_timestamp\": 1533596280}}",
"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/8938901264047084096/+/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\": [\"3712-19aca72\"], \"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\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"64cb8d9d67fbe924ff2c48d1fd9c73437d735344\", \"got_clang_revision\": \"338452-1\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"a7a753a6696b95431248846c4158f4836229f88a\", \"recipe\": \"chromium_codesearch\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24199}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"root_solution_revision_timestamp\": 1533596280, \"got_revision_cp\": \"refs/heads/master@{#581029}\", \"root_solution_revision\": \"a7a753a6696b95431248846c4158f4836229f88a\", \"buildername\": \"codesearch-gen-chromium-linux\", \"got_webrtc_revision\": \"eb73a7bd16c725477ca2da6dc0e6fea236616d44\", \"mastername\": \"chromium.infra.codesearch\", \"got_angle_revision\": \"6ba9754f4a5668936976ca7d8f5ec69de30f9aee\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1533596469794190, \"tags\": [\"builder:codesearch-gen-chromium-linux\", \"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:5428\", \"scheduler_invocation_id:9104331326391292528\", \"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\": \"8938901264047084096\"}}, \"got_v8_revision\": \"973f34ce78a25a64567f0e12348d4114429c7342\", \"got_v8_revision_cp\": \"refs/heads/7.0.159@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"buildnumber\": 2500, \"path_config\": \"generic\", \"bot_id\": \"swarm1879-c4\", \"got_buildtools_revision\": \"9a90d9aaadeb5e04327ed05775f45132e4b3523f\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1533596503869160",
"status": "COMPLETED",
"status_changed_ts": "1533600943041190",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-linux/2500",
"builder:codesearch-gen-chromium-linux",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5428",
"scheduler_invocation_id:9104331326391292528",
"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/2500",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8938901264047084096",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1843d7ecb7176e182855328359db08c38323a012",
"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/8938901264047084096/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5428",
"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:9104331326391292528",
"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:32df66ef6ec5978e059bc3a43bb607b4426f75fc",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3f2a4a94ed0bb610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1533600943047530",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-linux/2500",
"utcnow_ts": "1533600943639870"
}
}
[00:15:43.657] Invocation finished in 1h14m35.481959445s with status SUCCEEDED