[16:01:32.821] New invocation is queued and will start shortly
[16:01:32.821] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[16:01:34.059] Starting the invocation (attempt 1)
[16:01:34.149] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:01:34.149] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:01:34.149] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9061686553538210928",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-fuchsia\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"codesearch_mirror_revision\":\"dd0cc624d76e15ebb641f28d9f479d3210600b6a\",\"codesearch_mirror_revision_timestamp\":1574265265,\"root_solution_revision\":\"7c82c0247e70237690b883fb5e6b5fe41472b700\",\"root_solution_revision_timestamp\":1574265196},\"tags\":[\"parent_buildername:codesearch-gen-chromium-initiator\",\"parent_buildnumber:9663\",\"user_agent:recipe\"]},\"id\":\"208d246c-49c3-4ff7-939e-885e25b1f00a\",\"title\":\"codesearch-gen-chromium-initiator/9663\"}]},\"codesearch_mirror_revision\":\"dd0cc624d76e15ebb641f28d9f479d3210600b6a\",\"codesearch_mirror_revision_timestamp\":1574265265,\"root_solution_revision\":\"7c82c0247e70237690b883fb5e6b5fe41472b700\",\"root_solution_revision_timestamp\":1574265196}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-fuchsia",
"scheduler_invocation_id:9061686553538210928",
"scheduler_job_id:infra/codesearch-gen-chromium-fuchsia",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:9663",
"user_agent:recipe"
]
}
[16:01:35.858] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:infra",
"created_ts": "1574265694345440",
"id": "8896256491244788096",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-fuchsia\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"dd0cc624d76e15ebb641f28d9f479d3210600b6a\", \"codesearch_mirror_revision_timestamp\": 1574265265.0, \"root_solution_revision\": \"7c82c0247e70237690b883fb5e6b5fe41472b700\", \"root_solution_revision_timestamp\": 1574265196.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:9663\", \"user_agent:recipe\"]}, \"id\": \"208d246c-49c3-4ff7-939e-885e25b1f00a\", \"title\": \"codesearch-gen-chromium-initiator/9663\"}]}, \"codesearch_mirror_revision\": \"dd0cc624d76e15ebb641f28d9f479d3210600b6a\", \"codesearch_mirror_revision_timestamp\": 1574265265.0, \"root_solution_revision\": \"7c82c0247e70237690b883fb5e6b5fe41472b700\", \"root_solution_revision_timestamp\": 1574265196.0}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574265695183933",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-fuchsia/2422",
"builder:codesearch-gen-chromium-fuchsia",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:9663",
"scheduler_invocation_id:9061686553538210928",
"scheduler_job_id:infra/codesearch-gen-chromium-fuchsia",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8896256491244788096/+/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": "1574265695184045",
"url": "https://ci.chromium.org/b/8896256491244788096",
"utcnow_ts": "1574265695848033"
}
}
[16:01:35.858] Task URL: https://ci.chromium.org/b/8896256491244788096
[16:01:35.858] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:2:0) after 1m0s
[16:01:40.659] Received PubSub notification, asking Buildbucket for the build status
[16:01:40.839] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:35.891] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:2:0)
[16:02:35.891] Timer tick, asking Buildbucket for the build status
[16:02:36.152] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:36.152] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:4:0) after 1m0s
[16:03:36.295] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:4:0)
[16:03:36.295] Timer tick, asking Buildbucket for the build status
[16:03:36.694] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:36.694] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:5:0) after 1m0s
[16:04:36.765] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:5:0)
[16:04:36.765] Timer tick, asking Buildbucket for the build status
[16:04:36.922] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:36.922] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:6:0) after 1m0s
[16:05:37.012] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:6:0)
[16:05:37.012] Timer tick, asking Buildbucket for the build status
[16:05:37.394] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:37.394] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:7:0) after 1m0s
[16:06:37.409] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:7:0)
[16:06:37.409] Timer tick, asking Buildbucket for the build status
[16:06:38.015] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:38.015] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:8:0) after 1m0s
[16:07:38.117] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:8:0)
[16:07:38.117] Timer tick, asking Buildbucket for the build status
[16:07:38.212] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:38.212] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:9:0) after 1m0s
[16:08:38.289] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:9:0)
[16:08:38.289] Timer tick, asking Buildbucket for the build status
[16:08:38.517] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:38.517] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:10:0) after 1m0s
[16:09:38.549] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:10:0)
[16:09:38.549] Timer tick, asking Buildbucket for the build status
[16:09:39.013] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:39.013] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:11:0) after 1m0s
[16:10:39.133] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:11:0)
[16:10:39.133] Timer tick, asking Buildbucket for the build status
[16:10:39.282] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:39.282] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:12:0) after 1m0s
[16:11:39.347] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:12:0)
[16:11:39.347] Timer tick, asking Buildbucket for the build status
[16:11:40.640] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:40.640] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:13:0) after 1m0s
[16:12:40.850] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:13:0)
[16:12:40.850] Timer tick, asking Buildbucket for the build status
[16:12:41.173] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:41.174] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:14:0) after 1m0s
[16:13:41.216] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:14:0)
[16:13:41.216] Timer tick, asking Buildbucket for the build status
[16:13:41.506] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:41.506] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:15:0) after 1m0s
[16:14:41.578] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:15:0)
[16:14:41.578] Timer tick, asking Buildbucket for the build status
[16:14:41.741] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:41.741] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:16:0) after 1m0s
[16:15:41.795] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:16:0)
[16:15:41.795] Timer tick, asking Buildbucket for the build status
[16:15:42.151] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:42.152] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:17:0) after 1m0s
[16:16:42.182] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:17:0)
[16:16:42.182] Timer tick, asking Buildbucket for the build status
[16:16:42.303] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:42.303] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:18:0) after 1m0s
[16:17:42.360] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:18:0)
[16:17:42.360] Timer tick, asking Buildbucket for the build status
[16:17:42.507] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:42.507] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:19:0) after 1m0s
[16:18:42.579] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:19:0)
[16:18:42.579] Timer tick, asking Buildbucket for the build status
[16:18:43.502] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:43.502] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:20:0) after 1m0s
[16:19:43.614] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:20:0)
[16:19:43.614] Timer tick, asking Buildbucket for the build status
[16:19:43.752] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:43.752] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:21:0) after 1m0s
[16:20:43.788] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:21:0)
[16:20:43.788] Timer tick, asking Buildbucket for the build status
[16:20:44.354] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:44.354] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:22:0) after 1m0s
[16:21:44.483] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:22:0)
[16:21:44.483] Timer tick, asking Buildbucket for the build status
[16:21:44.636] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:44.636] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:23:0) after 1m0s
[16:22:44.723] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:23:0)
[16:22:44.723] Timer tick, asking Buildbucket for the build status
[16:22:44.879] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:44.879] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:24:0) after 1m0s
[16:23:45.218] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:24:0)
[16:23:45.218] Timer tick, asking Buildbucket for the build status
[16:23:45.436] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:45.436] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:25:0) after 1m0s
[16:24:45.613] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:25:0)
[16:24:45.613] Timer tick, asking Buildbucket for the build status
[16:24:45.772] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:45.772] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:26:0) after 1m0s
[16:25:45.949] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:26:0)
[16:25:45.949] Timer tick, asking Buildbucket for the build status
[16:25:46.110] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:46.110] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:27:0) after 1m0s
[16:26:46.194] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:27:0)
[16:26:46.194] Timer tick, asking Buildbucket for the build status
[16:26:46.384] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:46.384] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:28:0) after 1m0s
[16:27:46.485] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:28:0)
[16:27:46.485] Timer tick, asking Buildbucket for the build status
[16:27:46.699] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:46.699] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:29:0) after 1m0s
[16:28:46.900] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:29:0)
[16:28:46.900] Timer tick, asking Buildbucket for the build status
[16:28:47.089] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:47.089] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:30:0) after 1m0s
[16:29:47.364] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:30:0)
[16:29:47.364] Timer tick, asking Buildbucket for the build status
[16:29:47.818] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:47.818] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:31:0) after 1m0s
[16:30:47.915] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:31:0)
[16:30:47.915] Timer tick, asking Buildbucket for the build status
[16:30:48.126] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:48.126] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:32:0) after 1m0s
[16:31:48.153] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:32:0)
[16:31:48.153] Timer tick, asking Buildbucket for the build status
[16:31:48.496] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:48.496] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:33:0) after 1m0s
[16:32:48.535] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:33:0)
[16:32:48.535] Timer tick, asking Buildbucket for the build status
[16:32:48.794] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:48.794] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:34:0) after 1m0s
[16:33:49.010] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:34:0)
[16:33:49.010] Timer tick, asking Buildbucket for the build status
[16:33:49.252] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:49.252] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:35:0) after 1m0s
[16:34:49.315] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:35:0)
[16:34:49.315] Timer tick, asking Buildbucket for the build status
[16:34:51.196] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:51.196] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:36:0) after 1m0s
[16:35:51.350] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:36:0)
[16:35:51.350] Timer tick, asking Buildbucket for the build status
[16:35:51.535] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:51.535] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:37:0) after 1m0s
[16:36:51.597] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:37:0)
[16:36:51.597] Timer tick, asking Buildbucket for the build status
[16:36:52.060] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:52.060] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:38:0) after 1m0s
[16:37:52.105] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:38:0)
[16:37:52.105] Timer tick, asking Buildbucket for the build status
[16:37:52.257] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:52.258] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:39:0) after 1m0s
[16:38:52.356] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:39:0)
[16:38:52.356] Timer tick, asking Buildbucket for the build status
[16:38:52.637] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:52.637] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:40:0) after 1m0s
[16:39:52.755] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:40:0)
[16:39:52.756] Timer tick, asking Buildbucket for the build status
[16:39:52.973] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:52.973] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:41:0) after 1m0s
[16:40:53.102] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:41:0)
[16:40:53.102] Timer tick, asking Buildbucket for the build status
[16:40:53.306] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:53.306] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:42:0) after 1m0s
[16:41:53.344] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:42:0)
[16:41:53.344] Timer tick, asking Buildbucket for the build status
[16:41:53.597] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:53.597] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:43:0) after 1m0s
[16:42:53.706] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:43:0)
[16:42:53.706] Timer tick, asking Buildbucket for the build status
[16:42:54.299] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:54.299] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:44:0) after 1m0s
[16:43:54.414] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:44:0)
[16:43:54.414] Timer tick, asking Buildbucket for the build status
[16:43:54.557] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:54.557] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:45:0) after 1m0s
[16:44:54.748] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:45:0)
[16:44:54.748] Timer tick, asking Buildbucket for the build status
[16:44:54.951] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:54.952] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:46:0) after 1m0s
[16:45:55.016] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:46:0)
[16:45:55.016] Timer tick, asking Buildbucket for the build status
[16:45:55.329] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:55.329] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:47:0) after 1m0s
[16:46:55.399] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:47:0)
[16:46:55.399] Timer tick, asking Buildbucket for the build status
[16:46:55.716] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:55.716] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:48:0) after 1m0s
[16:47:55.827] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:48:0)
[16:47:55.827] Timer tick, asking Buildbucket for the build status
[16:47:56.171] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:56.171] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:49:0) after 1m0s
[16:48:56.287] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:49:0)
[16:48:56.287] Timer tick, asking Buildbucket for the build status
[16:48:56.493] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:56.493] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:50:0) after 1m0s
[16:49:56.553] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:50:0)
[16:49:56.553] Timer tick, asking Buildbucket for the build status
[16:49:56.801] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:56.801] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:51:0) after 1m0s
[16:50:56.960] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:51:0)
[16:50:56.960] Timer tick, asking Buildbucket for the build status
[16:50:57.089] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:57.089] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:52:0) after 1m0s
[16:51:57.407] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:52:0)
[16:51:57.407] Timer tick, asking Buildbucket for the build status
[16:51:57.650] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:57.650] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:53:0) after 1m0s
[16:52:57.951] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:53:0)
[16:52:57.951] Timer tick, asking Buildbucket for the build status
[16:52:59.134] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:59.134] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:54:0) after 1m0s
[16:53:59.454] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:54:0)
[16:53:59.454] Timer tick, asking Buildbucket for the build status
[16:53:59.652] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:59.652] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:55:0) after 1m0s
[16:54:59.770] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:55:0)
[16:54:59.770] Timer tick, asking Buildbucket for the build status
[16:55:00.131] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:00.131] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:56:0) after 1m0s
[16:56:00.342] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:56:0)
[16:56:00.342] Timer tick, asking Buildbucket for the build status
[16:56:00.517] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:00.517] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:57:0) after 1m0s
[16:57:00.817] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:57:0)
[16:57:00.817] Timer tick, asking Buildbucket for the build status
[16:57:00.989] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:00.989] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:58:0) after 1m0s
[16:58:01.162] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:58:0)
[16:58:01.162] Timer tick, asking Buildbucket for the build status
[16:58:01.391] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:01.391] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:59:0) after 1m0s
[16:59:01.569] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:59:0)
[16:59:01.569] Timer tick, asking Buildbucket for the build status
[16:59:01.903] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:01.903] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:60:0) after 1m0s
[17:00:01.955] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:60:0)
[17:00:01.955] Timer tick, asking Buildbucket for the build status
[17:00:02.205] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:02.205] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:61:0) after 1m0s
[17:01:02.261] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:61:0)
[17:01:02.261] Timer tick, asking Buildbucket for the build status
[17:01:02.503] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:02.503] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:62:0) after 1m0s
[17:02:02.630] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:62:0)
[17:02:02.630] Timer tick, asking Buildbucket for the build status
[17:02:02.966] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:02.966] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:63:0) after 1m0s
[17:03:03.246] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:63:0)
[17:03:03.246] Timer tick, asking Buildbucket for the build status
[17:03:03.413] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:03.413] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:64:0) after 1m0s
[17:04:03.496] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:64:0)
[17:04:03.496] Timer tick, asking Buildbucket for the build status
[17:04:03.751] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:03.751] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:65:0) after 1m0s
[17:05:03.804] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:65:0)
[17:05:03.804] Timer tick, asking Buildbucket for the build status
[17:05:04.175] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:04.176] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:66:0) after 1m0s
[17:06:04.285] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:66:0)
[17:06:04.285] Timer tick, asking Buildbucket for the build status
[17:06:04.471] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:04.471] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:67:0) after 1m0s
[17:07:04.533] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:67:0)
[17:07:04.533] Timer tick, asking Buildbucket for the build status
[17:07:04.677] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:04.677] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:68:0) after 1m0s
[17:08:04.753] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:68:0)
[17:08:04.753] Timer tick, asking Buildbucket for the build status
[17:08:04.871] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:04.871] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:69:0) after 1m0s
[17:09:05.134] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:69:0)
[17:09:05.134] Timer tick, asking Buildbucket for the build status
[17:09:05.460] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:05.460] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:70:0) after 1m0s
[17:10:05.622] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:70:0)
[17:10:05.622] Timer tick, asking Buildbucket for the build status
[17:10:05.785] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:05.785] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:71:0) after 1m0s
[17:11:05.949] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:71:0)
[17:11:05.949] Timer tick, asking Buildbucket for the build status
[17:11:06.402] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:06.402] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:72:0) after 1m0s
[17:12:06.512] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:72:0)
[17:12:06.512] Timer tick, asking Buildbucket for the build status
[17:12:06.851] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:06.851] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:73:0) after 1m0s
[17:13:06.957] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:73:0)
[17:13:06.957] Timer tick, asking Buildbucket for the build status
[17:13:07.205] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:07.205] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:74:0) after 1m0s
[17:14:07.277] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:74:0)
[17:14:07.277] Timer tick, asking Buildbucket for the build status
[17:14:07.435] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:07.435] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:75:0) after 1m0s
[17:15:07.560] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:75:0)
[17:15:07.560] Timer tick, asking Buildbucket for the build status
[17:15:07.824] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:07.824] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:76:0) after 1m0s
[17:16:07.831] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:76:0)
[17:16:07.831] Timer tick, asking Buildbucket for the build status
[17:16:08.198] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:08.198] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:77:0) after 1m0s
[17:17:08.281] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:77:0)
[17:17:08.281] Timer tick, asking Buildbucket for the build status
[17:17:08.544] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:08.544] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:78:0) after 1m0s
[17:18:08.716] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:78:0)
[17:18:08.716] Timer tick, asking Buildbucket for the build status
[17:18:08.854] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:08.854] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:79:0) after 1m0s
[17:19:09.037] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:79:0)
[17:19:09.037] Timer tick, asking Buildbucket for the build status
[17:19:09.141] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:09.141] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:80:0) after 1m0s
[17:20:09.225] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:80:0)
[17:20:09.225] Timer tick, asking Buildbucket for the build status
[17:20:09.352] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:09.352] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:81:0) after 1m0s
[17:21:09.487] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:81:0)
[17:21:09.487] Timer tick, asking Buildbucket for the build status
[17:21:09.677] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:09.677] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:82:0) after 1m0s
[17:22:09.717] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:82:0)
[17:22:09.717] Timer tick, asking Buildbucket for the build status
[17:22:09.887] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:09.887] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:83:0) after 1m0s
[17:23:09.953] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:83:0)
[17:23:09.953] Timer tick, asking Buildbucket for the build status
[17:23:10.121] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:10.121] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:84:0) after 1m0s
[17:24:10.342] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:84:0)
[17:24:10.342] Timer tick, asking Buildbucket for the build status
[17:24:10.513] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:10.513] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:85:0) after 1m0s
[17:25:10.666] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:85:0)
[17:25:10.666] Timer tick, asking Buildbucket for the build status
[17:25:10.776] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:10.776] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:86:0) after 1m0s
[17:26:10.906] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:86:0)
[17:26:10.906] Timer tick, asking Buildbucket for the build status
[17:26:11.122] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:11.122] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:87:0) after 1m0s
[17:27:11.265] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:87:0)
[17:27:11.266] Timer tick, asking Buildbucket for the build status
[17:27:11.417] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:11.417] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:88:0) after 1m0s
[17:28:11.517] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:88:0)
[17:28:11.517] Timer tick, asking Buildbucket for the build status
[17:28:11.739] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:11.739] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:89:0) after 1m0s
[17:29:11.829] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:89:0)
[17:29:11.829] Timer tick, asking Buildbucket for the build status
[17:29:11.951] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:11.951] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:90:0) after 1m0s
[17:30:12.002] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:90:0)
[17:30:12.002] Timer tick, asking Buildbucket for the build status
[17:30:12.123] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:12.123] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:91:0) after 1m0s
[17:31:12.167] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:91:0)
[17:31:12.167] Timer tick, asking Buildbucket for the build status
[17:31:12.609] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:12.609] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:92:0) after 1m0s
[17:32:12.725] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:92:0)
[17:32:12.725] Timer tick, asking Buildbucket for the build status
[17:32:13.209] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:13.209] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:93:0) after 1m0s
[17:33:13.332] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:93:0)
[17:33:13.332] Timer tick, asking Buildbucket for the build status
[17:33:13.712] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:13.712] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:94:0) after 1m0s
[17:34:13.835] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:94:0)
[17:34:13.835] Timer tick, asking Buildbucket for the build status
[17:34:14.153] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:14.153] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:95:0) after 1m0s
[17:35:14.295] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:95:0)
[17:35:14.295] Timer tick, asking Buildbucket for the build status
[17:35:14.635] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:14.635] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:96:0) after 1m0s
[17:36:14.834] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:96:0)
[17:36:14.834] Timer tick, asking Buildbucket for the build status
[17:36:15.191] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:15.191] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:97:0) after 1m0s
[17:37:15.248] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:97:0)
[17:37:15.248] Timer tick, asking Buildbucket for the build status
[17:37:15.434] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:15.434] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:98:0) after 1m0s
[17:38:15.580] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:98:0)
[17:38:15.580] Timer tick, asking Buildbucket for the build status
[17:38:15.694] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:15.694] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:99:0) after 1m0s
[17:39:15.875] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:99:0)
[17:39:15.875] Timer tick, asking Buildbucket for the build status
[17:39:16.558] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:16.558] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:100:0) after 1m0s
[17:40:16.630] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:100:0)
[17:40:16.630] Timer tick, asking Buildbucket for the build status
[17:40:16.793] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:16.793] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:101:0) after 1m0s
[17:41:16.952] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:101:0)
[17:41:16.952] Timer tick, asking Buildbucket for the build status
[17:41:17.124] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:17.124] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:102:0) after 1m0s
[17:42:17.234] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:102:0)
[17:42:17.234] Timer tick, asking Buildbucket for the build status
[17:42:17.566] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:17.566] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:103:0) after 1m0s
[17:43:17.712] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:103:0)
[17:43:17.712] Timer tick, asking Buildbucket for the build status
[17:43:18.261] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:18.261] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:104:0) after 1m0s
[17:44:18.553] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:104:0)
[17:44:18.553] Timer tick, asking Buildbucket for the build status
[17:44:18.942] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:18.942] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:105:0) after 1m0s
[17:45:18.999] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:105:0)
[17:45:18.999] Timer tick, asking Buildbucket for the build status
[17:45:19.937] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:19.937] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:106:0) after 1m0s
[17:46:20.178] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:106:0)
[17:46:20.178] Timer tick, asking Buildbucket for the build status
[17:46:20.502] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:20.502] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:107:0) after 1m0s
[17:47:20.561] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:107:0)
[17:47:20.561] Timer tick, asking Buildbucket for the build status
[17:47:20.950] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:20.950] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:108:0) after 1m0s
[17:48:21.094] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:108:0)
[17:48:21.094] Timer tick, asking Buildbucket for the build status
[17:48:21.313] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:21.313] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:109:0) after 1m0s
[17:49:21.434] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:109:0)
[17:49:21.434] Timer tick, asking Buildbucket for the build status
[17:49:21.602] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:21.602] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:110:0) after 1m0s
[17:50:21.744] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:110:0)
[17:50:21.744] Timer tick, asking Buildbucket for the build status
[17:50:21.891] Build 8896256491244788096: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:21.891] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9061686553538210928:111:0) after 1m0s
[17:50:32.015] Received PubSub notification, asking Buildbucket for the build status
[17:50:32.120] Build 8896256491244788096: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:50:32.120] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1574272231391458",
"created_by": "project:infra",
"created_ts": "1574265694345440",
"id": "8896256491244788096",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-fuchsia\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"dd0cc624d76e15ebb641f28d9f479d3210600b6a\", \"codesearch_mirror_revision_timestamp\": 1574265265.0, \"root_solution_revision\": \"7c82c0247e70237690b883fb5e6b5fe41472b700\", \"root_solution_revision_timestamp\": 1574265196.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:9663\", \"user_agent:recipe\"]}, \"id\": \"208d246c-49c3-4ff7-939e-885e25b1f00a\", \"title\": \"codesearch-gen-chromium-initiator/9663\"}]}, \"codesearch_mirror_revision\": \"dd0cc624d76e15ebb641f28d9f479d3210600b6a\", \"codesearch_mirror_revision_timestamp\": 1574265265.0, \"root_solution_revision\": \"7c82c0247e70237690b883fb5e6b5fe41472b700\", \"root_solution_revision_timestamp\": 1574265196.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\": {\"codesearch_mirror_revision\": \"dd0cc624d76e15ebb641f28d9f479d3210600b6a\", \"codesearch_mirror_revision_timestamp\": 1574265265.0, \"root_solution_revision\": \"7c82c0247e70237690b883fb5e6b5fe41472b700\", \"root_solution_revision_timestamp\": 1574265196.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:9663\", \"user_agent:recipe\"]}, \"id\": \"208d246c-49c3-4ff7-939e-885e25b1f00a\", \"title\": \"codesearch-gen-chromium-initiator/9663\"}]}, \"bot_id\": \"luci-infra-codesearch-xenial-9-l5f5\", \"buildername\": \"codesearch-gen-chromium-fuchsia\", \"buildnumber\": 2422, \"codesearch_mirror_revision\": \"dd0cc624d76e15ebb641f28d9f479d3210600b6a\", \"codesearch_mirror_revision_timestamp\": 1574265265.0, \"got_angle_revision\": \"8d94b5e9339ac425afdb9ffe5185b4c1a87b8db9\", \"got_clang_revision\": \"n331734-e84b7a5f-1\", \"got_dawn_revision\": \"9e5b9edb43f2f2b94e88dbde517d8aff144f6278\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"7c82c0247e70237690b883fb5e6b5fe41472b700\", \"got_revision_cp\": \"refs/heads/master@{#717025}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"2377845dd216b8288a763f7f1417d75bb7c8ce23\", \"got_v8_revision\": \"d721864f4590d9e922b227abd74a19199f312fe3\", \"got_v8_revision_cp\": \"refs/heads/8.0.323@{#1}\", \"got_webrtc_revision\": \"fa7a8ca21cd46c9bd419b754056f5eff4b96645d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29836}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"7c82c0247e70237690b883fb5e6b5fe41472b700\", \"root_solution_revision_timestamp\": 1574265196.0}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_b5ea7bb4091186e872937c4042f52c0c1d84281f1bc29c547e93e8efc0fd27bb_v2\", \"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-9-l5f5\"], \"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\": [\"4645-7f6a85d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-a\"]}}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574265698612522",
"status": "COMPLETED",
"status_changed_ts": "1574272231668647",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-fuchsia/2422",
"builder:codesearch-gen-chromium-fuchsia",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:9663",
"scheduler_invocation_id:9061686553538210928",
"scheduler_job_id:infra/codesearch-gen-chromium-fuchsia",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8896256491244788096/+/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:48a25db582863010",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1574272231683490",
"url": "https://ci.chromium.org/b/8896256491244788096",
"utcnow_ts": "1574272232097053"
}
}
[17:50:32.120] Invocation finished in 1h48m59.34662264s with status SUCCEEDED