[00:00:48.569] New invocation is queued and will start shortly
[00:00:48.569] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[00:00:49.901] Starting the invocation (attempt 1)
[00:00:49.935] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:00:49.935] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:00:49.935] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9097079814863184768",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-chromiumos\",\"properties\":{\"root_solution_revision\":\"f51a68b073770244754b996f0d9e7599f1c09e99\",\"root_solution_revision_timestamp\":1540511680}}",
"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:9097079814863184768",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:6190",
"user_agent:recipe"
]
}
[00:00:51.263] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540512050005905",
"id": "8931649752611904688",
"lease_expiration_ts": "1540630850984870",
"lease_key": "1660517396",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-chromiumos\", \"properties\": {\"root_solution_revision\": \"f51a68b073770244754b996f0d9e7599f1c09e99\", \"root_solution_revision_timestamp\": 1540511680}}",
"project": "infra",
"result_details_json": "null",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1540512051166531",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3852",
"builder:codesearch-gen-chromium-chromiumos",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:6190",
"scheduler_invocation_id:9097079814863184768",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"swarming_dimension:builder:codesearch-gen-chromium-chromiumos",
"swarming_dimension:caches:builder_c53076cda07f371c1c8d6c8348c1e7630d53be9873872bdf1dfffa53553e24e4_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/3852",
"swarming_tag:buildbucket_bucket:infra/codesearch",
"swarming_tag:buildbucket_build_id:8931649752611904688",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:codesearch-gen-chromium-chromiumos",
"swarming_tag:caches:builder_c53076cda07f371c1c8d6c8348c1e7630d53be9873872bdf1dfffa53553e24e4_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8931649752611904688/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:6190",
"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:9097079814863184768",
"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:b8801edbf7543e7901d77ef59e95d9b8b0141901",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40c67df5de877410",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1540512051166616",
"url": "https://ci.chromium.org/b/8931649752611904688",
"utcnow_ts": "1540512051249266"
}
}
[00:00:51.263] Task URL: https://ci.chromium.org/b/8931649752611904688
[00:00:51.263] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:2:0) after 1m0s
[00:01:28.432] Received PubSub notification, asking Buildbucket for the build status
[00:01:28.466] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:51.302] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:2:0)
[00:01:51.302] Timer tick, asking Buildbucket for the build status
[00:01:51.337] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:51.337] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:4:0) after 1m0s
[00:02:51.358] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:4:0)
[00:02:51.358] Timer tick, asking Buildbucket for the build status
[00:02:51.455] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:51.455] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:5:0) after 1m0s
[00:03:51.482] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:5:0)
[00:03:51.482] Timer tick, asking Buildbucket for the build status
[00:03:51.539] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:51.539] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:6:0) after 1m0s
[00:04:51.558] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:6:0)
[00:04:51.558] Timer tick, asking Buildbucket for the build status
[00:04:51.621] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:51.621] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:7:0) after 1m0s
[00:05:51.646] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:7:0)
[00:05:51.647] Timer tick, asking Buildbucket for the build status
[00:05:51.689] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:51.689] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:8:0) after 1m0s
[00:06:51.704] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:8:0)
[00:06:51.704] Timer tick, asking Buildbucket for the build status
[00:06:51.813] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:51.813] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:9:0) after 1m0s
[00:07:51.898] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:9:0)
[00:07:51.898] Timer tick, asking Buildbucket for the build status
[00:07:51.970] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:51.970] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:10:0) after 1m0s
[00:08:52.000] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:10:0)
[00:08:52.000] Timer tick, asking Buildbucket for the build status
[00:08:52.179] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:52.179] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:11:0) after 1m0s
[00:09:52.504] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:11:0)
[00:09:52.504] Timer tick, asking Buildbucket for the build status
[00:09:52.578] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:52.578] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:12:0) after 1m0s
[00:10:52.700] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:12:0)
[00:10:52.700] Timer tick, asking Buildbucket for the build status
[00:10:52.800] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:52.800] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:13:0) after 1m0s
[00:11:52.899] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:13:0)
[00:11:52.899] Timer tick, asking Buildbucket for the build status
[00:11:52.942] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:52.942] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:14:0) after 1m0s
[00:12:52.968] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:14:0)
[00:12:52.968] Timer tick, asking Buildbucket for the build status
[00:12:53.096] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:53.096] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:15:0) after 1m0s
[00:13:53.230] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:15:0)
[00:13:53.230] Timer tick, asking Buildbucket for the build status
[00:13:53.275] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:53.275] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:16:0) after 1m0s
[00:14:53.289] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:16:0)
[00:14:53.289] Timer tick, asking Buildbucket for the build status
[00:14:53.394] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:53.394] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:17:0) after 1m0s
[00:15:53.413] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:17:0)
[00:15:53.413] Timer tick, asking Buildbucket for the build status
[00:15:53.465] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:53.465] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:18:0) after 1m0s
[00:16:53.485] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:18:0)
[00:16:53.485] Timer tick, asking Buildbucket for the build status
[00:16:53.599] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:53.599] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:19:0) after 1m0s
[00:17:53.633] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:19:0)
[00:17:53.633] Timer tick, asking Buildbucket for the build status
[00:17:53.880] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:53.880] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:20:0) after 1m0s
[00:18:53.909] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:20:0)
[00:18:53.909] Timer tick, asking Buildbucket for the build status
[00:18:53.973] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:53.973] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:21:0) after 1m0s
[00:19:53.992] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:21:0)
[00:19:53.992] Timer tick, asking Buildbucket for the build status
[00:19:54.066] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:54.066] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:22:0) after 1m0s
[00:20:54.103] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:22:0)
[00:20:54.103] Timer tick, asking Buildbucket for the build status
[00:20:54.177] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:54.177] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:23:0) after 1m0s
[00:21:54.199] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:23:0)
[00:21:54.199] Timer tick, asking Buildbucket for the build status
[00:21:54.263] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:54.263] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:24:0) after 1m0s
[00:22:54.286] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:24:0)
[00:22:54.286] Timer tick, asking Buildbucket for the build status
[00:22:54.325] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:54.325] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:25:0) after 1m0s
[00:23:54.393] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:25:0)
[00:23:54.393] Timer tick, asking Buildbucket for the build status
[00:23:54.524] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:54.524] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:26:0) after 1m0s
[00:24:54.545] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:26:0)
[00:24:54.545] Timer tick, asking Buildbucket for the build status
[00:24:54.585] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:54.585] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:27:0) after 1m0s
[00:25:54.604] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:27:0)
[00:25:54.604] Timer tick, asking Buildbucket for the build status
[00:25:54.677] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:54.677] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:28:0) after 1m0s
[00:26:54.729] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:28:0)
[00:26:54.729] Timer tick, asking Buildbucket for the build status
[00:26:54.758] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:54.758] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:29:0) after 1m0s
[00:27:54.781] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:29:0)
[00:27:54.781] Timer tick, asking Buildbucket for the build status
[00:27:54.950] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:54.950] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:30:0) after 1m0s
[00:28:54.974] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:30:0)
[00:28:54.974] Timer tick, asking Buildbucket for the build status
[00:28:55.036] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:55.036] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:31:0) after 1m0s
[00:29:55.056] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:31:0)
[00:29:55.056] Timer tick, asking Buildbucket for the build status
[00:29:55.196] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:55.196] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:32:0) after 1m0s
[00:30:55.216] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:32:0)
[00:30:55.216] Timer tick, asking Buildbucket for the build status
[00:30:55.279] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:55.279] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:33:0) after 1m0s
[00:31:55.301] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:33:0)
[00:31:55.301] Timer tick, asking Buildbucket for the build status
[00:31:55.411] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:55.411] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:34:0) after 1m0s
[00:32:55.433] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:34:0)
[00:32:55.433] Timer tick, asking Buildbucket for the build status
[00:32:55.545] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:55.545] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:35:0) after 1m0s
[00:33:55.596] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:35:0)
[00:33:55.596] Timer tick, asking Buildbucket for the build status
[00:33:55.743] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:55.743] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:36:0) after 1m0s
[00:34:55.760] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:36:0)
[00:34:55.760] Timer tick, asking Buildbucket for the build status
[00:34:55.821] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:55.821] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:37:0) after 1m0s
[00:35:55.847] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:37:0)
[00:35:55.847] Timer tick, asking Buildbucket for the build status
[00:35:55.915] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:55.915] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:38:0) after 1m0s
[00:36:55.981] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:38:0)
[00:36:55.981] Timer tick, asking Buildbucket for the build status
[00:36:56.073] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:56.073] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:39:0) after 1m0s
[00:37:56.104] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:39:0)
[00:37:56.104] Timer tick, asking Buildbucket for the build status
[00:37:56.143] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:56.144] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:40:0) after 1m0s
[00:38:56.209] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:40:0)
[00:38:56.209] Timer tick, asking Buildbucket for the build status
[00:38:56.333] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:56.333] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:41:0) after 1m0s
[00:39:56.373] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:41:0)
[00:39:56.373] Timer tick, asking Buildbucket for the build status
[00:39:56.415] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:56.415] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:42:0) after 1m0s
[00:40:56.486] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:42:0)
[00:40:56.486] Timer tick, asking Buildbucket for the build status
[00:40:56.826] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:56.826] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:43:0) after 1m0s
[00:41:56.884] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:43:0)
[00:41:56.884] Timer tick, asking Buildbucket for the build status
[00:41:56.975] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:56.975] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:44:0) after 1m0s
[00:42:56.996] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:44:0)
[00:42:56.996] Timer tick, asking Buildbucket for the build status
[00:42:57.082] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:57.082] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:45:0) after 1m0s
[00:43:57.101] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:45:0)
[00:43:57.101] Timer tick, asking Buildbucket for the build status
[00:43:57.165] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:57.165] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:46:0) after 1m0s
[00:44:57.187] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:46:0)
[00:44:57.187] Timer tick, asking Buildbucket for the build status
[00:44:57.252] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:57.252] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:47:0) after 1m0s
[00:45:57.272] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:47:0)
[00:45:57.272] Timer tick, asking Buildbucket for the build status
[00:45:57.338] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:57.338] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:48:0) after 1m0s
[00:46:57.375] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:48:0)
[00:46:57.375] Timer tick, asking Buildbucket for the build status
[00:46:57.429] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:57.429] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:49:0) after 1m0s
[00:49:35.636] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:49:0)
[00:49:35.636] Timer tick, asking Buildbucket for the build status
[00:49:35.799] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:35.800] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:50:0) after 1m0s
[00:50:35.822] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:50:0)
[00:50:35.822] Timer tick, asking Buildbucket for the build status
[00:50:35.879] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:35.879] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:51:0) after 1m0s
[00:51:36.131] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:51:0)
[00:51:36.131] Timer tick, asking Buildbucket for the build status
[00:51:36.213] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:36.213] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:52:0) after 1m0s
[00:52:36.235] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:52:0)
[00:52:36.235] Timer tick, asking Buildbucket for the build status
[00:52:36.322] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:36.322] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:53:0) after 1m0s
[00:53:36.341] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:53:0)
[00:53:36.341] Timer tick, asking Buildbucket for the build status
[00:53:36.402] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:36.402] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:54:0) after 1m0s
[00:54:37.187] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:54:0)
[00:54:37.187] Timer tick, asking Buildbucket for the build status
[00:54:37.229] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:37.229] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:55:0) after 1m0s
[00:55:37.312] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:55:0)
[00:55:37.312] Timer tick, asking Buildbucket for the build status
[00:55:37.427] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:37.427] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:56:0) after 1m0s
[00:56:37.736] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:56:0)
[00:56:37.736] Timer tick, asking Buildbucket for the build status
[00:56:37.781] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:37.781] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:57:0) after 1m0s
[00:57:37.800] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:57:0)
[00:57:37.800] Timer tick, asking Buildbucket for the build status
[00:57:37.867] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:37.867] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:58:0) after 1m0s
[00:58:37.986] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:58:0)
[00:58:37.986] Timer tick, asking Buildbucket for the build status
[00:58:38.055] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:38.055] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:59:0) after 1m0s
[00:59:38.191] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:59:0)
[00:59:38.191] Timer tick, asking Buildbucket for the build status
[00:59:38.241] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:38.241] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:60:0) after 1m0s
[01:00:40.119] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:60:0)
[01:00:40.119] Timer tick, asking Buildbucket for the build status
[01:00:40.232] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:40.232] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:61:0) after 1m0s
[01:01:40.663] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:61:0)
[01:01:40.663] Timer tick, asking Buildbucket for the build status
[01:01:40.710] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:40.710] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:62:0) after 1m0s
[01:02:40.748] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:62:0)
[01:02:40.748] Timer tick, asking Buildbucket for the build status
[01:02:40.978] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:40.978] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:63:0) after 1m0s
[01:03:40.998] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:63:0)
[01:03:40.998] Timer tick, asking Buildbucket for the build status
[01:03:41.066] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:41.066] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:64:0) after 1m0s
[01:04:41.109] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:64:0)
[01:04:41.109] Timer tick, asking Buildbucket for the build status
[01:04:41.158] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:41.158] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:65:0) after 1m0s
[01:05:41.199] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:65:0)
[01:05:41.199] Timer tick, asking Buildbucket for the build status
[01:05:41.297] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:41.297] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:66:0) after 1m0s
[01:06:41.316] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:66:0)
[01:06:41.316] Timer tick, asking Buildbucket for the build status
[01:06:41.463] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:41.463] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:67:0) after 1m0s
[01:07:41.485] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:67:0)
[01:07:41.485] Timer tick, asking Buildbucket for the build status
[01:07:41.554] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:41.554] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:68:0) after 1m0s
[01:08:41.622] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:68:0)
[01:08:41.622] Timer tick, asking Buildbucket for the build status
[01:08:41.681] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:41.681] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:69:0) after 1m0s
[01:09:41.715] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:69:0)
[01:09:41.715] Timer tick, asking Buildbucket for the build status
[01:09:41.782] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:41.782] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:70:0) after 1m0s
[01:10:41.809] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:70:0)
[01:10:41.809] Timer tick, asking Buildbucket for the build status
[01:10:41.931] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:41.931] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:71:0) after 1m0s
[01:11:42.037] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:71:0)
[01:11:42.037] Timer tick, asking Buildbucket for the build status
[01:11:42.102] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:42.102] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:72:0) after 1m0s
[01:12:42.126] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:72:0)
[01:12:42.126] Timer tick, asking Buildbucket for the build status
[01:12:42.184] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:42.184] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:73:0) after 1m0s
[01:13:42.203] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:73:0)
[01:13:42.203] Timer tick, asking Buildbucket for the build status
[01:13:42.370] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:42.371] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:74:0) after 1m0s
[01:14:42.423] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:74:0)
[01:14:42.423] Timer tick, asking Buildbucket for the build status
[01:14:42.461] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:42.461] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:75:0) after 1m0s
[01:15:42.478] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:75:0)
[01:15:42.478] Timer tick, asking Buildbucket for the build status
[01:15:42.621] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:42.621] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:76:0) after 1m0s
[01:16:42.661] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:76:0)
[01:16:42.661] Timer tick, asking Buildbucket for the build status
[01:16:42.718] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:42.718] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:77:0) after 1m0s
[01:17:42.768] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:77:0)
[01:17:42.768] Timer tick, asking Buildbucket for the build status
[01:17:42.833] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:42.833] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:78:0) after 1m0s
[01:18:42.862] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:78:0)
[01:18:42.862] Timer tick, asking Buildbucket for the build status
[01:18:43.065] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:43.065] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:79:0) after 1m0s
[01:19:43.092] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:79:0)
[01:19:43.092] Timer tick, asking Buildbucket for the build status
[01:19:43.169] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:43.170] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:80:0) after 1m0s
[01:20:43.200] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:80:0)
[01:20:43.201] Timer tick, asking Buildbucket for the build status
[01:20:43.399] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:43.399] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:81:0) after 1m0s
[01:21:43.415] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:81:0)
[01:21:43.415] Timer tick, asking Buildbucket for the build status
[01:21:43.453] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:43.453] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:82:0) after 1m0s
[01:22:43.492] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:82:0)
[01:22:43.492] Timer tick, asking Buildbucket for the build status
[01:22:43.736] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:43.736] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:83:0) after 1m0s
[01:23:43.772] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:83:0)
[01:23:43.772] Timer tick, asking Buildbucket for the build status
[01:23:43.818] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:43.818] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:84:0) after 1m0s
[01:24:43.833] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:84:0)
[01:24:43.833] Timer tick, asking Buildbucket for the build status
[01:24:43.969] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:43.969] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:85:0) after 1m0s
[01:25:44.040] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:85:0)
[01:25:44.040] Timer tick, asking Buildbucket for the build status
[01:25:44.083] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:44.083] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:86:0) after 1m0s
[01:26:44.108] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:86:0)
[01:26:44.109] Timer tick, asking Buildbucket for the build status
[01:26:44.170] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:44.170] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:87:0) after 1m0s
[01:27:44.248] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:87:0)
[01:27:44.248] Timer tick, asking Buildbucket for the build status
[01:27:44.340] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:44.340] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:88:0) after 1m0s
[01:28:44.366] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:88:0)
[01:28:44.367] Timer tick, asking Buildbucket for the build status
[01:28:44.679] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:44.679] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:89:0) after 1m0s
[01:29:44.790] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:89:0)
[01:29:44.790] Timer tick, asking Buildbucket for the build status
[01:29:44.864] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:44.864] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:90:0) after 1m0s
[01:30:44.888] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:90:0)
[01:30:44.888] Timer tick, asking Buildbucket for the build status
[01:30:44.958] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:44.958] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:91:0) after 1m0s
[01:31:45.066] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:91:0)
[01:31:45.067] Timer tick, asking Buildbucket for the build status
[01:31:45.144] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:45.144] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:92:0) after 1m0s
[01:32:45.167] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:92:0)
[01:32:45.167] Timer tick, asking Buildbucket for the build status
[01:32:45.250] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:45.250] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:93:0) after 1m0s
[01:33:45.269] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:93:0)
[01:33:45.269] Timer tick, asking Buildbucket for the build status
[01:33:45.472] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:45.472] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:94:0) after 1m0s
[01:34:45.585] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:94:0)
[01:34:45.585] Timer tick, asking Buildbucket for the build status
[01:34:45.635] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:45.635] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:95:0) after 1m0s
[01:35:45.655] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:95:0)
[01:35:45.655] Timer tick, asking Buildbucket for the build status
[01:35:45.699] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:45.699] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:96:0) after 1m0s
[01:36:45.734] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:96:0)
[01:36:45.734] Timer tick, asking Buildbucket for the build status
[01:36:45.804] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:45.804] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:97:0) after 1m0s
[01:37:45.825] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:97:0)
[01:37:45.825] Timer tick, asking Buildbucket for the build status
[01:37:45.897] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:45.897] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:98:0) after 1m0s
[01:38:45.927] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:98:0)
[01:38:45.928] Timer tick, asking Buildbucket for the build status
[01:38:45.981] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:45.981] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:99:0) after 1m0s
[01:39:46.000] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:99:0)
[01:39:46.000] Timer tick, asking Buildbucket for the build status
[01:39:46.071] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:46.071] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:100:0) after 1m0s
[01:40:46.146] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:100:0)
[01:40:46.146] Timer tick, asking Buildbucket for the build status
[01:40:46.211] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:46.211] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:101:0) after 1m0s
[01:41:46.245] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:101:0)
[01:41:46.245] Timer tick, asking Buildbucket for the build status
[01:41:46.314] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:46.314] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:102:0) after 1m0s
[01:42:46.407] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:102:0)
[01:42:46.407] Timer tick, asking Buildbucket for the build status
[01:42:46.482] Build 8931649752611904688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:46.482] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9097079814863184768:103:0) after 1m0s
[01:43:03.536] Received PubSub notification, asking Buildbucket for the build status
[01:43:03.576] Build 8931649752611904688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:43:03.576] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "AUTO",
"completed_ts": "1540518182114379",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540512050005905",
"id": "8931649752611904688",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-chromiumos\", \"properties\": {\"root_solution_revision\": \"f51a68b073770244754b996f0d9e7599f1c09e99\", \"root_solution_revision_timestamp\": 1540511680}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"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\": [\"3817-6aedaff\"], \"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_c53076cda07f371c1c8d6c8348c1e7630d53be9873872bdf1dfffa53553e24e4_v2\", \"builder_fc2e8e4adaad07c0fdb9097d17739372515345c2d70921a64548f07bb9e4954b_v2\", \"codesearch_git_genfiles_repo\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_clang_revision\": \"344066-1\", \"got_swarming_client_revision\": \"f78187ab77127de42555afe0ad410bebde6ac6a5\", \"got_revision\": \"f51a68b073770244754b996f0d9e7599f1c09e99\", \"recipe\": \"chromium_codesearch\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25375}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"root_solution_revision_timestamp\": 1540511680, \"got_revision_cp\": \"refs/heads/master@{#602935}\", \"root_solution_revision\": \"f51a68b073770244754b996f0d9e7599f1c09e99\", \"buildername\": \"codesearch-gen-chromium-chromiumos\", \"got_webrtc_revision\": \"8c27ccac75975f38fe030b83582941604e49ec58\", \"mastername\": \"chromium.infra.codesearch\", \"got_angle_revision\": \"683bb0130ca2c9a06fd02141861ac97ca859b9c1\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1540512050005905, \"tags\": [\"builder:codesearch-gen-chromium-chromiumos\", \"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:6190\", \"scheduler_invocation_id:9097079814863184768\", \"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\": \"8931649752611904688\"}}, \"got_v8_revision\": \"14d9c29330036d87823b15706a4ebcf076b3df83\", \"got_v8_revision_cp\": \"refs/heads/7.2.125@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 3852, \"path_config\": \"generic\", \"bot_id\": \"swarm1881-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1540512087469560",
"status": "COMPLETED",
"status_changed_ts": "1540518183000554",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-chromiumos/3852",
"builder:codesearch-gen-chromium-chromiumos",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:6190",
"scheduler_invocation_id:9097079814863184768",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"swarming_dimension:builder:codesearch-gen-chromium-chromiumos",
"swarming_dimension:caches:builder_c53076cda07f371c1c8d6c8348c1e7630d53be9873872bdf1dfffa53553e24e4_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/3852",
"swarming_tag:buildbucket_bucket:infra/codesearch",
"swarming_tag:buildbucket_build_id:8931649752611904688",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:codesearch-gen-chromium-chromiumos",
"swarming_tag:caches:builder_c53076cda07f371c1c8d6c8348c1e7630d53be9873872bdf1dfffa53553e24e4_v2",
"swarming_tag:cpu:x86-64",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8931649752611904688/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:parent_buildername:codesearch-gen-chromium-initiator",
"swarming_tag:parent_buildnumber:6190",
"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:9097079814863184768",
"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:b8801edbf7543e7901d77ef59e95d9b8b0141901",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:user_agent:recipe",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40c67df5de877410",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1540518183003219",
"url": "https://ci.chromium.org/b/8931649752611904688",
"utcnow_ts": "1540518183564699"
}
}
[01:43:03.576] Invocation finished in 1h42m15.10114633s with status SUCCEEDED