[20:01:00.316] New invocation is queued and will start shortly
[20:01:00.316] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[20:01:01.501] Starting the invocation (attempt 1)
[20:01:01.547] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:01:01.547] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:01:01.547] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9100265795780456992",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-chromiumos\",\"properties\":{\"root_solution_revision\":\"f38ce4ea9af6e8a457609ec083f285032ef28ca8\",\"root_solution_revision_timestamp\":1537473336}}",
"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:9100265795780456992",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5768",
"user_agent:recipe"
]
}
[20:01:03.010] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537473661647296",
"id": "8934835733723505040",
"lease_expiration_ts": "1537592462617623",
"lease_key": "759514283",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-chromiumos\", \"properties\": {\"root_solution_revision\": \"f38ce4ea9af6e8a457609ec083f285032ef28ca8\", \"root_solution_revision_timestamp\": 1537473336}}",
"project": "infra",
"result_details_json": "null",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1537473662778624",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3430",
"builder:codesearch-gen-chromium-chromiumos",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5768",
"scheduler_invocation_id:9100265795780456992",
"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/3430",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8934835733723505040",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1630ff158d8d4118027817e4d74c356b46464ed9",
"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/8934835733723505040/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5768",
"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:9100265795780456992",
"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:a636fa546b9b663cc0d60eefebb84621a4dfa011",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:401163d58aeb9e10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1537473662778799",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3430",
"utcnow_ts": "1537473662929477"
}
}
[20:01:03.010] Task URL: https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3430
[20:01:03.010] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:2:0) after 1m0s
[20:01:47.886] Received PubSub notification, asking Buildbucket for the build status
[20:01:47.946] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:03.029] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:2:0)
[20:02:03.029] Timer tick, asking Buildbucket for the build status
[20:02:03.109] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:03.109] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:4:0) after 1m0s
[20:03:03.141] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:4:0)
[20:03:03.141] Timer tick, asking Buildbucket for the build status
[20:03:03.177] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:03.177] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:5:0) after 1m0s
[20:04:03.221] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:5:0)
[20:04:03.221] Timer tick, asking Buildbucket for the build status
[20:04:03.422] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:03.422] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:6:0) after 1m0s
[20:05:03.446] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:6:0)
[20:05:03.446] Timer tick, asking Buildbucket for the build status
[20:05:03.527] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:03.528] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:7:0) after 1m0s
[20:06:03.559] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:7:0)
[20:06:03.559] Timer tick, asking Buildbucket for the build status
[20:06:03.623] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:03.623] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:8:0) after 1m0s
[20:07:03.645] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:8:0)
[20:07:03.645] Timer tick, asking Buildbucket for the build status
[20:07:03.713] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:03.713] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:9:0) after 1m0s
[20:08:03.732] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:9:0)
[20:08:03.732] Timer tick, asking Buildbucket for the build status
[20:08:03.828] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:03.828] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:10:0) after 1m0s
[20:09:03.848] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:10:0)
[20:09:03.848] Timer tick, asking Buildbucket for the build status
[20:09:06.939] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:06.939] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:11:0) after 1m0s
[20:10:06.954] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:11:0)
[20:10:06.954] Timer tick, asking Buildbucket for the build status
[20:10:06.994] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:06.994] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:12:0) after 1m0s
[20:11:07.015] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:12:0)
[20:11:07.015] Timer tick, asking Buildbucket for the build status
[20:11:07.105] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:07.105] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:13:0) after 1m0s
[20:12:07.127] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:13:0)
[20:12:07.127] Timer tick, asking Buildbucket for the build status
[20:12:07.254] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:07.254] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:14:0) after 1m0s
[20:13:07.270] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:14:0)
[20:13:07.270] Timer tick, asking Buildbucket for the build status
[20:13:07.310] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:07.310] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:15:0) after 1m0s
[20:14:07.335] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:15:0)
[20:14:07.335] Timer tick, asking Buildbucket for the build status
[20:14:07.378] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:07.378] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:16:0) after 1m0s
[20:15:07.393] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:16:0)
[20:15:07.393] Timer tick, asking Buildbucket for the build status
[20:15:07.584] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:07.584] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:17:0) after 1m0s
[20:16:07.609] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:17:0)
[20:16:07.609] Timer tick, asking Buildbucket for the build status
[20:16:07.670] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:07.670] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:18:0) after 1m0s
[20:17:07.705] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:18:0)
[20:17:07.705] Timer tick, asking Buildbucket for the build status
[20:17:07.742] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:07.742] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:19:0) after 1m0s
[20:18:07.758] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:19:0)
[20:18:07.758] Timer tick, asking Buildbucket for the build status
[20:18:07.915] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:07.915] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:20:0) after 1m0s
[20:19:07.932] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:20:0)
[20:19:07.932] Timer tick, asking Buildbucket for the build status
[20:19:08.143] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:08.143] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:21:0) after 1m0s
[20:20:08.165] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:21:0)
[20:20:08.165] Timer tick, asking Buildbucket for the build status
[20:20:08.258] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:08.258] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:22:0) after 1m0s
[20:21:08.292] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:22:0)
[20:21:08.292] Timer tick, asking Buildbucket for the build status
[20:21:08.515] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:08.515] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:23:0) after 1m0s
[20:22:08.542] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:23:0)
[20:22:08.542] Timer tick, asking Buildbucket for the build status
[20:22:08.820] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:08.820] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:24:0) after 1m0s
[20:23:08.837] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:24:0)
[20:23:08.837] Timer tick, asking Buildbucket for the build status
[20:23:08.983] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:08.983] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:25:0) after 1m0s
[20:24:09.006] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:25:0)
[20:24:09.006] Timer tick, asking Buildbucket for the build status
[20:24:09.044] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:09.044] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:26:0) after 1m0s
[20:25:09.079] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:26:0)
[20:25:09.079] Timer tick, asking Buildbucket for the build status
[20:25:09.144] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:09.144] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:27:0) after 1m0s
[20:26:09.162] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:27:0)
[20:26:09.162] Timer tick, asking Buildbucket for the build status
[20:26:09.208] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:09.208] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:28:0) after 1m0s
[20:27:09.225] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:28:0)
[20:27:09.225] Timer tick, asking Buildbucket for the build status
[20:27:09.314] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:09.314] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:29:0) after 1m0s
[20:28:09.329] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:29:0)
[20:28:09.329] Timer tick, asking Buildbucket for the build status
[20:28:09.390] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:09.390] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:30:0) after 1m0s
[20:29:09.407] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:30:0)
[20:29:09.407] Timer tick, asking Buildbucket for the build status
[20:29:09.501] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:09.501] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:31:0) after 1m0s
[20:30:09.519] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:31:0)
[20:30:09.519] Timer tick, asking Buildbucket for the build status
[20:30:09.595] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:09.595] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:32:0) after 1m0s
[20:31:09.613] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:32:0)
[20:31:09.613] Timer tick, asking Buildbucket for the build status
[20:31:09.673] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:09.673] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:33:0) after 1m0s
[20:32:09.695] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:33:0)
[20:32:09.695] Timer tick, asking Buildbucket for the build status
[20:32:09.792] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:09.792] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:34:0) after 1m0s
[20:33:09.814] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:34:0)
[20:33:09.814] Timer tick, asking Buildbucket for the build status
[20:33:10.000] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:10.000] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:35:0) after 1m0s
[20:34:10.025] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:35:0)
[20:34:10.026] Timer tick, asking Buildbucket for the build status
[20:34:10.116] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:10.116] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:36:0) after 1m0s
[20:35:10.138] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:36:0)
[20:35:10.138] Timer tick, asking Buildbucket for the build status
[20:35:10.217] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:10.217] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:37:0) after 1m0s
[20:36:10.255] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:37:0)
[20:36:10.255] Timer tick, asking Buildbucket for the build status
[20:36:10.321] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:10.321] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:38:0) after 1m0s
[20:37:10.346] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:38:0)
[20:37:10.346] Timer tick, asking Buildbucket for the build status
[20:37:10.528] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:10.528] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:39:0) after 1m0s
[20:38:10.548] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:39:0)
[20:38:10.548] Timer tick, asking Buildbucket for the build status
[20:38:10.609] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:10.609] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:40:0) after 1m0s
[20:39:10.629] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:40:0)
[20:39:10.629] Timer tick, asking Buildbucket for the build status
[20:39:10.790] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:10.790] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:41:0) after 1m0s
[20:40:10.812] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:41:0)
[20:40:10.812] Timer tick, asking Buildbucket for the build status
[20:40:10.863] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:10.863] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:42:0) after 1m0s
[20:41:10.888] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:42:0)
[20:41:10.888] Timer tick, asking Buildbucket for the build status
[20:41:11.030] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:11.030] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:43:0) after 1m0s
[20:42:11.050] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:43:0)
[20:42:11.050] Timer tick, asking Buildbucket for the build status
[20:42:11.090] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:11.090] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:44:0) after 1m0s
[20:43:11.120] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:44:0)
[20:43:11.120] Timer tick, asking Buildbucket for the build status
[20:43:11.185] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:11.185] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:45:0) after 1m0s
[20:44:11.209] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:45:0)
[20:44:11.209] Timer tick, asking Buildbucket for the build status
[20:44:11.250] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:11.250] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:46:0) after 1m0s
[20:45:11.270] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:46:0)
[20:45:11.270] Timer tick, asking Buildbucket for the build status
[20:45:11.378] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:11.378] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:47:0) after 1m0s
[20:46:11.449] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:47:0)
[20:46:11.449] Timer tick, asking Buildbucket for the build status
[20:46:11.489] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:11.489] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:48:0) after 1m0s
[20:47:11.530] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:48:0)
[20:47:11.530] Timer tick, asking Buildbucket for the build status
[20:47:11.605] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:11.605] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:49:0) after 1m0s
[20:48:11.622] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:49:0)
[20:48:11.622] Timer tick, asking Buildbucket for the build status
[20:48:11.716] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:11.716] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:50:0) after 1m0s
[20:49:11.733] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:50:0)
[20:49:11.733] Timer tick, asking Buildbucket for the build status
[20:49:11.772] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:11.772] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:51:0) after 1m0s
[20:50:11.789] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:51:0)
[20:50:11.789] Timer tick, asking Buildbucket for the build status
[20:50:11.879] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:11.879] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:52:0) after 1m0s
[20:51:12.016] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:52:0)
[20:51:12.016] Timer tick, asking Buildbucket for the build status
[20:51:12.241] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:12.241] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:53:0) after 1m0s
[20:52:12.311] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:53:0)
[20:52:12.311] Timer tick, asking Buildbucket for the build status
[20:52:12.417] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:12.417] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:54:0) after 1m0s
[20:53:12.519] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:54:0)
[20:53:12.519] Timer tick, asking Buildbucket for the build status
[20:53:12.568] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:12.568] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:55:0) after 1m0s
[20:54:12.634] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:55:0)
[20:54:12.634] Timer tick, asking Buildbucket for the build status
[20:54:12.722] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:12.722] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:56:0) after 1m0s
[20:55:12.742] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:56:0)
[20:55:12.742] Timer tick, asking Buildbucket for the build status
[20:55:12.811] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:12.811] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:57:0) after 1m0s
[20:56:12.829] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:57:0)
[20:56:12.829] Timer tick, asking Buildbucket for the build status
[20:56:13.162] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:13.162] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:58:0) after 1m0s
[20:57:13.186] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:58:0)
[20:57:13.186] Timer tick, asking Buildbucket for the build status
[20:57:13.297] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:13.297] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:59:0) after 1m0s
[20:58:13.318] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:59:0)
[20:58:13.318] Timer tick, asking Buildbucket for the build status
[20:58:13.387] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:13.387] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:60:0) after 1m0s
[20:59:13.407] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:60:0)
[20:59:13.407] Timer tick, asking Buildbucket for the build status
[20:59:13.445] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:13.445] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:61:0) after 1m0s
[21:00:13.466] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:61:0)
[21:00:13.466] Timer tick, asking Buildbucket for the build status
[21:00:13.540] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:13.540] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:62:0) after 1m0s
[21:01:13.563] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:62:0)
[21:01:13.563] Timer tick, asking Buildbucket for the build status
[21:01:13.603] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:13.603] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:63:0) after 1m0s
[21:02:13.626] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:63:0)
[21:02:13.626] Timer tick, asking Buildbucket for the build status
[21:02:13.691] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:13.691] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:64:0) after 1m0s
[21:03:13.721] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:64:0)
[21:03:13.721] Timer tick, asking Buildbucket for the build status
[21:03:13.772] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:13.772] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:65:0) after 1m0s
[21:04:13.790] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:65:0)
[21:04:13.790] Timer tick, asking Buildbucket for the build status
[21:04:13.981] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:13.981] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:66:0) after 1m0s
[21:05:14.000] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:66:0)
[21:05:14.000] Timer tick, asking Buildbucket for the build status
[21:05:14.036] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:14.036] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:67:0) after 1m0s
[21:06:14.063] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:67:0)
[21:06:14.063] Timer tick, asking Buildbucket for the build status
[21:06:14.182] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:14.182] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:68:0) after 1m0s
[21:07:14.209] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:68:0)
[21:07:14.209] Timer tick, asking Buildbucket for the build status
[21:07:14.329] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:14.329] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:69:0) after 1m0s
[21:08:14.376] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:69:0)
[21:08:14.376] Timer tick, asking Buildbucket for the build status
[21:08:14.450] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:14.450] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:70:0) after 1m0s
[21:09:14.534] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:70:0)
[21:09:14.534] Timer tick, asking Buildbucket for the build status
[21:09:14.585] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:14.585] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:71:0) after 1m0s
[21:10:14.606] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:71:0)
[21:10:14.606] Timer tick, asking Buildbucket for the build status
[21:10:14.742] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:14.742] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:72:0) after 1m0s
[21:11:14.810] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:72:0)
[21:11:14.810] Timer tick, asking Buildbucket for the build status
[21:11:14.891] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:14.891] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:73:0) after 1m0s
[21:12:14.934] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:73:0)
[21:12:14.934] Timer tick, asking Buildbucket for the build status
[21:12:14.994] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:14.994] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:74:0) after 1m0s
[21:13:15.015] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:74:0)
[21:13:15.015] Timer tick, asking Buildbucket for the build status
[21:13:15.077] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:15.077] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:75:0) after 1m0s
[21:14:15.112] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:75:0)
[21:14:15.112] Timer tick, asking Buildbucket for the build status
[21:14:15.205] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:15.206] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:76:0) after 1m0s
[21:15:15.228] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:76:0)
[21:15:15.228] Timer tick, asking Buildbucket for the build status
[21:15:15.307] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:15.307] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:77:0) after 1m0s
[21:16:15.328] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:77:0)
[21:16:15.328] Timer tick, asking Buildbucket for the build status
[21:16:15.359] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:15.359] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:78:0) after 1m0s
[21:17:15.449] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:78:0)
[21:17:15.449] Timer tick, asking Buildbucket for the build status
[21:17:16.852] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:16.852] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:79:0) after 1m0s
[21:18:16.871] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:79:0)
[21:18:16.871] Timer tick, asking Buildbucket for the build status
[21:18:17.036] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:17.036] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:80:0) after 1m0s
[21:19:17.055] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:80:0)
[21:19:17.055] Timer tick, asking Buildbucket for the build status
[21:19:17.116] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:17.116] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:81:0) after 1m0s
[21:20:17.189] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:81:0)
[21:20:17.189] Timer tick, asking Buildbucket for the build status
[21:20:17.274] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:17.274] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:82:0) after 1m0s
[21:21:17.293] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:82:0)
[21:21:17.293] Timer tick, asking Buildbucket for the build status
[21:21:17.342] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:17.342] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:83:0) after 1m0s
[21:22:17.363] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:83:0)
[21:22:17.363] Timer tick, asking Buildbucket for the build status
[21:22:17.406] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:17.406] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:84:0) after 1m0s
[21:23:17.427] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:84:0)
[21:23:17.427] Timer tick, asking Buildbucket for the build status
[21:23:17.487] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:17.487] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:85:0) after 1m0s
[21:24:17.515] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:85:0)
[21:24:17.515] Timer tick, asking Buildbucket for the build status
[21:24:17.565] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:17.565] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:86:0) after 1m0s
[21:25:17.594] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:86:0)
[21:25:17.594] Timer tick, asking Buildbucket for the build status
[21:25:17.725] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:17.725] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:87:0) after 1m0s
[21:26:17.807] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:87:0)
[21:26:17.807] Timer tick, asking Buildbucket for the build status
[21:26:17.851] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:17.851] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:88:0) after 1m0s
[21:27:17.946] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:88:0)
[21:27:17.946] Timer tick, asking Buildbucket for the build status
[21:27:18.007] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:18.007] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:89:0) after 1m0s
[21:28:18.042] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:89:0)
[21:28:18.042] Timer tick, asking Buildbucket for the build status
[21:28:18.190] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:18.190] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:90:0) after 1m0s
[21:29:18.223] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:90:0)
[21:29:18.223] Timer tick, asking Buildbucket for the build status
[21:29:18.359] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:18.359] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:91:0) after 1m0s
[21:30:18.455] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:91:0)
[21:30:18.455] Timer tick, asking Buildbucket for the build status
[21:30:18.670] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:18.670] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:92:0) after 1m0s
[21:31:18.695] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:92:0)
[21:31:18.695] Timer tick, asking Buildbucket for the build status
[21:31:18.754] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:18.754] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:93:0) after 1m0s
[21:32:18.816] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:93:0)
[21:32:18.816] Timer tick, asking Buildbucket for the build status
[21:32:18.858] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:18.858] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:94:0) after 1m0s
[21:33:18.876] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:94:0)
[21:33:18.876] Timer tick, asking Buildbucket for the build status
[21:33:18.973] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:18.973] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:95:0) after 1m0s
[21:34:18.997] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:95:0)
[21:34:18.997] Timer tick, asking Buildbucket for the build status
[21:34:19.079] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:19.079] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:96:0) after 1m0s
[21:35:19.099] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:96:0)
[21:35:19.099] Timer tick, asking Buildbucket for the build status
[21:35:19.158] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:19.158] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:97:0) after 1m0s
[21:36:19.180] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:97:0)
[21:36:19.180] Timer tick, asking Buildbucket for the build status
[21:36:19.272] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:19.272] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:98:0) after 1m0s
[21:37:19.295] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:98:0)
[21:37:19.295] Timer tick, asking Buildbucket for the build status
[21:37:19.360] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:19.360] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:99:0) after 1m0s
[21:38:19.409] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:99:0)
[21:38:19.409] Timer tick, asking Buildbucket for the build status
[21:38:19.550] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:19.550] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:100:0) after 1m0s
[21:39:19.573] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:100:0)
[21:39:19.573] Timer tick, asking Buildbucket for the build status
[21:39:19.622] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:19.622] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:101:0) after 1m0s
[21:40:19.646] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:101:0)
[21:40:19.646] Timer tick, asking Buildbucket for the build status
[21:40:19.683] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:19.683] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:102:0) after 1m0s
[21:41:19.703] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:102:0)
[21:41:19.703] Timer tick, asking Buildbucket for the build status
[21:41:19.763] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:19.763] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:103:0) after 1m0s
[21:42:19.786] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:103:0)
[21:42:19.786] Timer tick, asking Buildbucket for the build status
[21:42:19.841] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:19.841] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:104:0) after 1m0s
[21:43:19.864] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:104:0)
[21:43:19.864] Timer tick, asking Buildbucket for the build status
[21:43:19.959] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:19.959] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:105:0) after 1m0s
[21:44:19.978] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:105:0)
[21:44:19.978] Timer tick, asking Buildbucket for the build status
[21:44:20.046] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:20.046] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:106:0) after 1m0s
[21:45:20.069] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:106:0)
[21:45:20.069] Timer tick, asking Buildbucket for the build status
[21:45:20.195] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:20.195] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:107:0) after 1m0s
[21:46:20.219] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:107:0)
[21:46:20.219] Timer tick, asking Buildbucket for the build status
[21:46:20.287] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:20.287] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:108:0) after 1m0s
[21:47:20.308] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:108:0)
[21:47:20.308] Timer tick, asking Buildbucket for the build status
[21:47:20.352] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:20.352] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:109:0) after 1m0s
[21:48:20.374] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:109:0)
[21:48:20.374] Timer tick, asking Buildbucket for the build status
[21:48:20.420] Build 8934835733723505040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:20.420] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9100265795780456992:110:0) after 1m0s
[21:49:17.313] Received PubSub notification, asking Buildbucket for the build status
[21:49:17.346] Build 8934835733723505040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:49:17.346] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1537480156091305",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537473661647296",
"id": "8934835733723505040",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-chromiumos\", \"properties\": {\"root_solution_revision\": \"f38ce4ea9af6e8a457609ec083f285032ef28ca8\", \"root_solution_revision_timestamp\": 1537473336}}",
"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/8934835733723505040/+/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\": [\"3779-c5c026e\"], \"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\": \"b64cb7b68093f06952a5966c97e6f49dae5f455e\", \"got_clang_revision\": \"342523-1\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"f38ce4ea9af6e8a457609ec083f285032ef28ca8\", \"recipe\": \"chromium_codesearch\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24780}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"root_solution_revision_timestamp\": 1537473336, \"got_revision_cp\": \"refs/heads/master@{#592918}\", \"root_solution_revision\": \"f38ce4ea9af6e8a457609ec083f285032ef28ca8\", \"buildername\": \"codesearch-gen-chromium-chromiumos\", \"got_webrtc_revision\": \"0ad0c27a0bcee24ec9dc5c27df090034e152bd65\", \"mastername\": \"chromium.infra.codesearch\", \"got_angle_revision\": \"52ea49706fd701108b4ce5e6062160fbb0b98724\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1537473661647296, \"tags\": [\"builder:codesearch-gen-chromium-chromiumos\", \"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:5768\", \"scheduler_invocation_id:9100265795780456992\", \"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\": \"8934835733723505040\"}}, \"got_v8_revision\": \"08b9e3767fb200bec683f9d382f4f72b3d16a765\", \"got_v8_revision_cp\": \"refs/heads/7.1.148@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 3430, \"path_config\": \"generic\", \"bot_id\": \"swarm1881-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1537473706750387",
"status": "COMPLETED",
"status_changed_ts": "1537480156694305",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3430",
"builder:codesearch-gen-chromium-chromiumos",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:5768",
"scheduler_invocation_id:9100265795780456992",
"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/3430",
"swarming_tag:buildbucket_bucket:luci.infra.codesearch",
"swarming_tag:buildbucket_build_id:8934835733723505040",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1630ff158d8d4118027817e4d74c356b46464ed9",
"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/8934835733723505040/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:5768",
"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:9100265795780456992",
"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:a636fa546b9b663cc0d60eefebb84621a4dfa011",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:401163d58aeb9e10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1537480156695572",
"url": "https://ci.chromium.org/p/infra/builders/luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3430",
"utcnow_ts": "1537480157337607"
}
}
[21:49:17.346] Invocation finished in 1h48m17.044630082s with status SUCCEEDED