[00:00:42.834] New invocation is queued and will start shortly
[00:00:42.834] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[00:00:44.736] Starting the invocation (attempt 1)
[00:00:44.773] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:00:44.773] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:00:44.773] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9071893864138772512",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-chromiumos\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"root_solution_revision\":\"3cdf07bd23be04fbaacf2a76add5b838aca3de8e\",\"root_solution_revision_timestamp\":1564531234},\"tags\":[\"parent_buildername:codesearch-gen-chromium-initiator\",\"parent_buildnumber:8987\",\"user_agent:recipe\"]},\"id\":\"a35f7a1b-3ab7-4f99-880f-037ac0c0e718\",\"title\":\"codesearch-gen-chromium-initiator/8987\"}]},\"root_solution_revision\":\"3cdf07bd23be04fbaacf2a76add5b838aca3de8e\",\"root_solution_revision_timestamp\":1564531234}}",
"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:9071893864138772512",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8987",
"user_agent:recipe"
]
}
[00:00:45.897] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1564531244877224",
"id": "8906463801330380688",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-chromiumos\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"root_solution_revision\": \"3cdf07bd23be04fbaacf2a76add5b838aca3de8e\", \"root_solution_revision_timestamp\": 1564531234.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:8987\", \"user_agent:recipe\"]}, \"id\": \"a35f7a1b-3ab7-4f99-880f-037ac0c0e718\", \"title\": \"codesearch-gen-chromium-initiator/8987\"}]}, \"root_solution_revision\": \"3cdf07bd23be04fbaacf2a76add5b838aca3de8e\", \"root_solution_revision_timestamp\": 1564531234.0}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1564531245459965",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-chromiumos/6395",
"builder:codesearch-gen-chromium-chromiumos",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8987",
"scheduler_invocation_id:9071893864138772512",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8906463801330380688/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1564531245460070",
"url": "https://ci.chromium.org/b/8906463801330380688",
"utcnow_ts": "1564531245874454"
}
}
[00:00:45.897] Task URL: https://ci.chromium.org/b/8906463801330380688
[00:00:45.897] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:2:0) after 1m0s
[00:00:49.671] Received PubSub notification, asking Buildbucket for the build status
[00:00:49.742] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:45.965] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:2:0)
[00:01:45.965] Timer tick, asking Buildbucket for the build status
[00:01:46.089] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:46.089] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:4:0) after 1m0s
[00:02:46.075] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:4:0)
[00:02:46.075] Timer tick, asking Buildbucket for the build status
[00:02:46.288] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:46.288] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:5:0) after 1m0s
[00:03:46.337] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:5:0)
[00:03:46.337] Timer tick, asking Buildbucket for the build status
[00:03:46.457] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:46.457] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:6:0) after 1m0s
[00:04:46.497] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:6:0)
[00:04:46.497] Timer tick, asking Buildbucket for the build status
[00:04:46.811] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:46.811] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:7:0) after 1m0s
[00:05:46.866] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:7:0)
[00:05:46.866] Timer tick, asking Buildbucket for the build status
[00:05:47.125] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:47.125] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:8:0) after 1m0s
[00:06:47.191] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:8:0)
[00:06:47.191] Timer tick, asking Buildbucket for the build status
[00:06:47.325] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:47.325] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:9:0) after 1m0s
[00:07:47.351] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:9:0)
[00:07:47.351] Timer tick, asking Buildbucket for the build status
[00:07:48.095] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:48.095] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:10:0) after 1m0s
[00:08:48.127] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:10:0)
[00:08:48.127] Timer tick, asking Buildbucket for the build status
[00:08:48.266] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:48.266] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:11:0) after 1m0s
[00:09:48.291] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:11:0)
[00:09:48.291] Timer tick, asking Buildbucket for the build status
[00:09:49.362] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:49.362] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:12:0) after 1m0s
[00:10:49.391] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:12:0)
[00:10:49.391] Timer tick, asking Buildbucket for the build status
[00:10:49.659] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:49.659] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:13:0) after 1m0s
[00:11:49.727] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:13:0)
[00:11:49.727] Timer tick, asking Buildbucket for the build status
[00:11:50.398] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:50.398] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:14:0) after 1m0s
[00:12:50.384] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:14:0)
[00:12:50.384] Timer tick, asking Buildbucket for the build status
[00:12:50.661] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:50.661] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:15:0) after 1m0s
[00:13:50.700] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:15:0)
[00:13:50.700] Timer tick, asking Buildbucket for the build status
[00:13:51.092] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:51.092] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:16:0) after 1m0s
[00:14:51.126] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:16:0)
[00:14:51.126] Timer tick, asking Buildbucket for the build status
[00:14:51.536] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:51.536] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:17:0) after 1m0s
[00:15:51.559] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:17:0)
[00:15:51.559] Timer tick, asking Buildbucket for the build status
[00:15:52.197] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:52.197] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:18:0) after 1m0s
[00:16:52.260] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:18:0)
[00:16:52.260] Timer tick, asking Buildbucket for the build status
[00:16:52.399] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:52.399] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:19:0) after 1m0s
[00:17:52.455] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:19:0)
[00:17:52.455] Timer tick, asking Buildbucket for the build status
[00:17:52.701] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:52.701] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:20:0) after 1m0s
[00:18:52.747] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:20:0)
[00:18:52.747] Timer tick, asking Buildbucket for the build status
[00:18:53.316] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:53.316] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:21:0) after 1m0s
[00:19:53.360] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:21:0)
[00:19:53.360] Timer tick, asking Buildbucket for the build status
[00:19:53.731] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:53.731] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:22:0) after 1m0s
[00:20:53.799] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:22:0)
[00:20:53.799] Timer tick, asking Buildbucket for the build status
[00:20:54.522] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:54.522] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:23:0) after 1m0s
[00:21:54.570] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:23:0)
[00:21:54.570] Timer tick, asking Buildbucket for the build status
[00:21:54.685] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:54.685] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:24:0) after 1m0s
[00:22:54.736] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:24:0)
[00:22:54.736] Timer tick, asking Buildbucket for the build status
[00:22:54.951] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:54.951] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:25:0) after 1m0s
[00:23:55.055] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:25:0)
[00:23:55.055] Timer tick, asking Buildbucket for the build status
[00:23:56.616] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:56.616] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:26:0) after 1m0s
[00:24:56.698] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:26:0)
[00:24:56.698] Timer tick, asking Buildbucket for the build status
[00:24:58.813] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:58.813] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:27:0) after 1m0s
[00:25:58.874] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:27:0)
[00:25:58.874] Timer tick, asking Buildbucket for the build status
[00:25:59.281] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:59.281] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:28:0) after 1m0s
[00:26:59.301] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:28:0)
[00:26:59.301] Timer tick, asking Buildbucket for the build status
[00:26:59.478] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:59.478] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:29:0) after 1m0s
[00:27:59.513] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:29:0)
[00:27:59.513] Timer tick, asking Buildbucket for the build status
[00:27:59.611] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:59.611] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:30:0) after 1m0s
[00:28:59.628] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:30:0)
[00:28:59.628] Timer tick, asking Buildbucket for the build status
[00:28:59.769] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:59.769] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:31:0) after 1m0s
[00:29:59.792] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:31:0)
[00:29:59.792] Timer tick, asking Buildbucket for the build status
[00:29:59.942] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:59.942] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:32:0) after 1m0s
[00:30:59.999] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:32:0)
[00:30:59.999] Timer tick, asking Buildbucket for the build status
[00:31:00.102] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:00.102] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:33:0) after 1m0s
[00:32:00.230] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:33:0)
[00:32:00.230] Timer tick, asking Buildbucket for the build status
[00:32:00.360] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:00.360] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:34:0) after 1m0s
[00:33:00.388] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:34:0)
[00:33:00.388] Timer tick, asking Buildbucket for the build status
[00:33:00.566] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:00.566] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:35:0) after 1m0s
[00:34:00.630] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:35:0)
[00:34:00.630] Timer tick, asking Buildbucket for the build status
[00:34:00.841] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:00.841] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:36:0) after 1m0s
[00:35:00.869] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:36:0)
[00:35:00.869] Timer tick, asking Buildbucket for the build status
[00:35:01.261] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:01.261] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:37:0) after 1m0s
[00:36:01.290] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:37:0)
[00:36:01.290] Timer tick, asking Buildbucket for the build status
[00:36:01.461] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:01.461] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:38:0) after 1m0s
[00:37:01.521] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:38:0)
[00:37:01.521] Timer tick, asking Buildbucket for the build status
[00:37:02.032] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:02.032] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:39:0) after 1m0s
[00:38:02.052] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:39:0)
[00:38:02.052] Timer tick, asking Buildbucket for the build status
[00:38:02.158] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:02.158] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:40:0) after 1m0s
[00:39:02.170] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:40:0)
[00:39:02.170] Timer tick, asking Buildbucket for the build status
[00:39:02.375] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:02.375] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:41:0) after 1m0s
[00:40:02.449] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:41:0)
[00:40:02.449] Timer tick, asking Buildbucket for the build status
[00:40:02.602] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:02.602] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:42:0) after 1m0s
[00:41:02.654] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:42:0)
[00:41:02.654] Timer tick, asking Buildbucket for the build status
[00:41:02.805] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:02.805] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:43:0) after 1m0s
[00:42:02.843] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:43:0)
[00:42:02.843] Timer tick, asking Buildbucket for the build status
[00:42:03.184] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:03.184] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:44:0) after 1m0s
[00:43:03.218] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:44:0)
[00:43:03.218] Timer tick, asking Buildbucket for the build status
[00:43:03.370] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:03.370] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:45:0) after 1m0s
[00:44:03.869] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:45:0)
[00:44:03.869] Timer tick, asking Buildbucket for the build status
[00:44:04.165] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:04.165] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:46:0) after 1m0s
[00:45:04.294] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:46:0)
[00:45:04.294] Timer tick, asking Buildbucket for the build status
[00:45:05.127] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:05.127] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:47:0) after 1m0s
[00:46:05.170] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:47:0)
[00:46:05.170] Timer tick, asking Buildbucket for the build status
[00:46:05.565] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:05.565] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:48:0) after 1m0s
[00:47:06.020] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:48:0)
[00:47:06.020] Timer tick, asking Buildbucket for the build status
[00:47:06.366] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:06.366] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:49:0) after 1m0s
[00:48:06.600] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:49:0)
[00:48:06.600] Timer tick, asking Buildbucket for the build status
[00:48:06.742] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:06.742] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:50:0) after 1m0s
[00:49:06.784] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:50:0)
[00:49:06.784] Timer tick, asking Buildbucket for the build status
[00:49:07.119] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:07.119] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:51:0) after 1m0s
[00:50:07.143] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:51:0)
[00:50:07.143] Timer tick, asking Buildbucket for the build status
[00:50:07.277] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:07.277] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:52:0) after 1m0s
[00:51:07.314] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:52:0)
[00:51:07.314] Timer tick, asking Buildbucket for the build status
[00:51:07.426] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:07.426] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:53:0) after 1m0s
[00:52:07.469] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:53:0)
[00:52:07.469] Timer tick, asking Buildbucket for the build status
[00:52:08.461] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:08.461] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:54:0) after 1m0s
[00:53:08.529] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:54:0)
[00:53:08.529] Timer tick, asking Buildbucket for the build status
[00:53:08.870] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:08.870] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:55:0) after 1m0s
[00:54:09.011] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:55:0)
[00:54:09.011] Timer tick, asking Buildbucket for the build status
[00:54:09.432] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:09.432] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:56:0) after 1m0s
[00:55:09.465] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:56:0)
[00:55:09.465] Timer tick, asking Buildbucket for the build status
[00:55:09.571] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:09.571] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:57:0) after 1m0s
[00:56:09.617] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:57:0)
[00:56:09.617] Timer tick, asking Buildbucket for the build status
[00:56:09.773] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:09.773] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:58:0) after 1m0s
[00:57:09.833] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:58:0)
[00:57:09.833] Timer tick, asking Buildbucket for the build status
[00:57:09.954] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:09.954] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:59:0) after 1m0s
[00:58:10.028] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:59:0)
[00:58:10.028] Timer tick, asking Buildbucket for the build status
[00:58:11.702] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:11.702] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:60:0) after 1m0s
[00:59:11.836] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:60:0)
[00:59:11.836] Timer tick, asking Buildbucket for the build status
[00:59:11.950] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:11.950] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:61:0) after 1m0s
[01:00:12.103] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:61:0)
[01:00:12.103] Timer tick, asking Buildbucket for the build status
[01:00:12.247] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:12.247] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:62:0) after 1m0s
[01:01:12.431] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:62:0)
[01:01:12.431] Timer tick, asking Buildbucket for the build status
[01:01:12.754] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:12.754] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:63:0) after 1m0s
[01:02:12.801] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:63:0)
[01:02:12.801] Timer tick, asking Buildbucket for the build status
[01:02:13.737] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:13.737] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:64:0) after 1m0s
[01:03:13.773] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:64:0)
[01:03:13.773] Timer tick, asking Buildbucket for the build status
[01:03:14.019] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:14.019] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:65:0) after 1m0s
[01:04:14.106] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:65:0)
[01:04:14.106] Timer tick, asking Buildbucket for the build status
[01:04:14.426] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:14.426] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:66:0) after 1m0s
[01:05:14.535] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:66:0)
[01:05:14.535] Timer tick, asking Buildbucket for the build status
[01:05:14.661] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:14.661] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:67:0) after 1m0s
[01:06:14.741] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:67:0)
[01:06:14.741] Timer tick, asking Buildbucket for the build status
[01:06:14.980] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:14.980] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:68:0) after 1m0s
[01:07:15.303] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:68:0)
[01:07:15.303] Timer tick, asking Buildbucket for the build status
[01:07:15.723] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:15.723] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:69:0) after 1m0s
[01:08:15.884] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:69:0)
[01:08:15.884] Timer tick, asking Buildbucket for the build status
[01:08:16.198] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:16.198] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:70:0) after 1m0s
[01:09:16.516] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:70:0)
[01:09:16.516] Timer tick, asking Buildbucket for the build status
[01:09:16.644] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:16.644] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:71:0) after 1m0s
[01:10:16.852] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:71:0)
[01:10:16.852] Timer tick, asking Buildbucket for the build status
[01:10:17.270] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:17.271] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:72:0) after 1m0s
[01:11:17.437] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:72:0)
[01:11:17.437] Timer tick, asking Buildbucket for the build status
[01:11:17.580] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:17.580] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:73:0) after 1m0s
[01:12:17.700] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:73:0)
[01:12:17.700] Timer tick, asking Buildbucket for the build status
[01:12:17.834] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:17.834] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:74:0) after 1m0s
[01:13:17.861] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:74:0)
[01:13:17.861] Timer tick, asking Buildbucket for the build status
[01:13:18.362] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:18.362] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:75:0) after 1m0s
[01:14:18.373] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:75:0)
[01:14:18.373] Timer tick, asking Buildbucket for the build status
[01:14:18.497] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:18.497] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:76:0) after 1m0s
[01:15:18.785] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:76:0)
[01:15:18.785] Timer tick, asking Buildbucket for the build status
[01:15:19.129] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:19.129] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:77:0) after 1m0s
[01:16:19.275] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:77:0)
[01:16:19.275] Timer tick, asking Buildbucket for the build status
[01:16:20.681] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:20.681] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:78:0) after 1m0s
[01:17:20.776] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:78:0)
[01:17:20.776] Timer tick, asking Buildbucket for the build status
[01:17:20.923] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:20.923] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:79:0) after 1m0s
[01:18:20.942] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:79:0)
[01:18:20.942] Timer tick, asking Buildbucket for the build status
[01:18:21.229] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:21.229] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:80:0) after 1m0s
[01:19:21.354] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:80:0)
[01:19:21.354] Timer tick, asking Buildbucket for the build status
[01:19:22.382] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:22.382] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:81:0) after 1m0s
[01:20:22.680] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:81:0)
[01:20:22.680] Timer tick, asking Buildbucket for the build status
[01:20:22.990] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:22.990] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:82:0) after 1m0s
[01:21:23.057] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:82:0)
[01:21:23.057] Timer tick, asking Buildbucket for the build status
[01:21:23.248] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:23.248] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:83:0) after 1m0s
[01:22:23.426] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:83:0)
[01:22:23.426] Timer tick, asking Buildbucket for the build status
[01:22:23.656] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:23.656] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:84:0) after 1m0s
[01:23:23.802] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:84:0)
[01:23:23.802] Timer tick, asking Buildbucket for the build status
[01:23:23.943] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:23.943] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:85:0) after 1m0s
[01:24:24.102] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:85:0)
[01:24:24.103] Timer tick, asking Buildbucket for the build status
[01:24:25.044] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:25.044] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:86:0) after 1m0s
[01:25:27.337] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:86:0)
[01:25:27.337] Timer tick, asking Buildbucket for the build status
[01:25:27.936] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:27.936] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:87:0) after 1m0s
[01:26:28.277] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:87:0)
[01:26:28.277] Timer tick, asking Buildbucket for the build status
[01:26:28.414] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:28.414] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:88:0) after 1m0s
[01:27:28.829] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:88:0)
[01:27:28.829] Timer tick, asking Buildbucket for the build status
[01:27:29.316] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:29.316] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:89:0) after 1m0s
[01:28:29.440] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:89:0)
[01:28:29.440] Timer tick, asking Buildbucket for the build status
[01:28:29.883] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:29.883] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:90:0) after 1m0s
[01:29:30.008] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:90:0)
[01:29:30.008] Timer tick, asking Buildbucket for the build status
[01:29:30.248] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:30.248] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:91:0) after 1m0s
[01:30:30.302] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:91:0)
[01:30:30.302] Timer tick, asking Buildbucket for the build status
[01:30:30.900] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:30.900] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:92:0) after 1m0s
[01:31:31.012] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:92:0)
[01:31:31.012] Timer tick, asking Buildbucket for the build status
[01:31:31.385] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:31.385] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:93:0) after 1m0s
[01:32:31.371] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:93:0)
[01:32:31.371] Timer tick, asking Buildbucket for the build status
[01:32:31.476] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:31.476] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:94:0) after 1m0s
[01:33:31.533] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:94:0)
[01:33:31.533] Timer tick, asking Buildbucket for the build status
[01:33:31.759] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:31.759] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:95:0) after 1m0s
[01:34:31.757] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:95:0)
[01:34:31.757] Timer tick, asking Buildbucket for the build status
[01:34:32.480] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:32.480] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:96:0) after 1m0s
[01:35:32.710] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:96:0)
[01:35:32.710] Timer tick, asking Buildbucket for the build status
[01:35:33.017] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:33.017] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:97:0) after 1m0s
[01:36:33.019] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:97:0)
[01:36:33.019] Timer tick, asking Buildbucket for the build status
[01:36:33.266] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:33.266] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:98:0) after 1m0s
[01:37:33.519] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:98:0)
[01:37:33.519] Timer tick, asking Buildbucket for the build status
[01:37:33.642] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:33.642] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:99:0) after 1m0s
[01:38:33.875] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:99:0)
[01:38:33.875] Timer tick, asking Buildbucket for the build status
[01:38:35.448] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:35.448] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:100:0) after 1m0s
[01:39:35.527] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:100:0)
[01:39:35.527] Timer tick, asking Buildbucket for the build status
[01:39:35.831] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:35.831] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:101:0) after 1m0s
[01:40:36.596] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:101:0)
[01:40:36.596] Timer tick, asking Buildbucket for the build status
[01:40:36.701] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:36.701] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:102:0) after 1m0s
[01:41:37.460] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:102:0)
[01:41:37.460] Timer tick, asking Buildbucket for the build status
[01:41:37.612] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:37.612] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:103:0) after 1m0s
[01:42:37.932] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:103:0)
[01:42:37.932] Timer tick, asking Buildbucket for the build status
[01:42:38.214] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:38.214] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:104:0) after 1m0s
[01:43:38.261] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:104:0)
[01:43:38.261] Timer tick, asking Buildbucket for the build status
[01:43:38.382] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:38.382] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:105:0) after 1m0s
[01:44:38.371] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:105:0)
[01:44:38.371] Timer tick, asking Buildbucket for the build status
[01:44:39.045] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:39.046] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:106:0) after 1m0s
[01:45:39.075] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:106:0)
[01:45:39.075] Timer tick, asking Buildbucket for the build status
[01:45:39.727] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:39.727] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:107:0) after 1m0s
[01:46:39.768] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:107:0)
[01:46:39.768] Timer tick, asking Buildbucket for the build status
[01:46:39.904] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:39.904] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:108:0) after 1m0s
[01:47:40.051] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:108:0)
[01:47:40.051] Timer tick, asking Buildbucket for the build status
[01:47:40.400] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:40.400] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:109:0) after 1m0s
[01:48:40.891] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:109:0)
[01:48:40.891] Timer tick, asking Buildbucket for the build status
[01:48:41.287] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:41.287] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:110:0) after 1m0s
[01:49:42.926] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:110:0)
[01:49:42.926] Timer tick, asking Buildbucket for the build status
[01:49:43.037] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:43.037] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:111:0) after 1m0s
[01:50:43.037] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:111:0)
[01:50:43.037] Timer tick, asking Buildbucket for the build status
[01:50:43.244] Build 8906463801330380688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:43.244] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-chromiumos:9071893864138772512:112:0) after 1m0s
[01:51:28.280] Received PubSub notification, asking Buildbucket for the build status
[01:51:28.397] Build 8906463801330380688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:51:28.397] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"completed_ts": "1564537887384367",
"created_by": "project:infra",
"created_ts": "1564531244877224",
"id": "8906463801330380688",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-chromiumos\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"root_solution_revision\": \"3cdf07bd23be04fbaacf2a76add5b838aca3de8e\", \"root_solution_revision_timestamp\": 1564531234.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:8987\", \"user_agent:recipe\"]}, \"id\": \"a35f7a1b-3ab7-4f99-880f-037ac0c0e718\", \"title\": \"codesearch-gen-chromium-initiator/8987\"}]}, \"root_solution_revision\": \"3cdf07bd23be04fbaacf2a76add5b838aca3de8e\", \"root_solution_revision_timestamp\": 1564531234.0}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"root_solution_revision\": \"3cdf07bd23be04fbaacf2a76add5b838aca3de8e\", \"root_solution_revision_timestamp\": 1564531234.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:8987\", \"user_agent:recipe\"]}, \"id\": \"a35f7a1b-3ab7-4f99-880f-037ac0c0e718\", \"title\": \"codesearch-gen-chromium-initiator/8987\"}]}, \"bot_id\": \"luci-infra-codesearch-xenial-8-n30y\", \"buildername\": \"codesearch-gen-chromium-chromiumos\", \"buildnumber\": 6395, \"got_angle_revision\": \"1ebe6014389e022dfb1d89ae47cb8b4c7593a733\", \"got_clang_revision\": \"365097-f7e52fbd-8\", \"got_dawn_revision\": \"35ad5221fb556c7aa80961d42537e4d9c825bf49\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"3cdf07bd23be04fbaacf2a76add5b838aca3de8e\", \"got_revision_cp\": \"refs/heads/master@{#682520}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"2ddb2cc31c4ab5b2d15ab4d99d2278f43dec0c45\", \"got_v8_revision_cp\": \"refs/heads/7.8.30@{#1}\", \"got_webrtc_revision\": \"4ed5b087f57fe8b116966ee2e60be2d3785975be\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28709}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"3cdf07bd23be04fbaacf2a76add5b838aca3de8e\", \"root_solution_revision_timestamp\": 1564531234.0}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_c53076cda07f371c1c8d6c8348c1e7630d53be9873872bdf1dfffa53553e24e4_v2\", \"codesearch_git_genfiles_repo\", \"codesearch_update_submodules_mirror\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-codesearch-xenial-8-n30y\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.codesearch\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4382-5929880\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-a\"]}}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1564531247622270",
"status": "COMPLETED",
"status_changed_ts": "1564537887729023",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-chromiumos/6395",
"builder:codesearch-gen-chromium-chromiumos",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8987",
"scheduler_invocation_id:9071893864138772512",
"scheduler_job_id:infra/codesearch-gen-chromium-chromiumos",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8906463801330380688/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium_codesearch",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:465e25cb64b8d310",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1564537887744575",
"url": "https://ci.chromium.org/b/8906463801330380688",
"utcnow_ts": "1564537888384510"
}
}
[01:51:28.397] Invocation finished in 1h50m45.581705728s with status SUCCEEDED