[16:00:38.189] New invocation is queued and will start shortly
[16:00:38.189] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[16:00:39.255] Starting the invocation (attempt 1)
[16:00:39.293] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:00:39.293] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:00:39.294] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9028437524122456048",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-fuchsia\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"codesearch_mirror_revision\":\"a7029b8b60fd7cb30661843617971f3e10c151fa\",\"codesearch_mirror_revision_timestamp\":1605973086,\"root_solution_revision\":\"f0e03306e587863247d807f8a5a64a68a0be93b3\",\"root_solution_revision_timestamp\":1605972872},\"tags\":[\"parent_buildername:codesearch-gen-chromium-initiator\",\"parent_buildnumber:11866\",\"user_agent:recipe\"]},\"id\":\"4a65d005-bbc7-45f8-9652-2b4f68ae588f\",\"title\":\"codesearch-gen-chromium-initiator/11866\"}]},\"codesearch_mirror_revision\":\"a7029b8b60fd7cb30661843617971f3e10c151fa\",\"codesearch_mirror_revision_timestamp\":1605973086,\"root_solution_revision\":\"f0e03306e587863247d807f8a5a64a68a0be93b3\",\"root_solution_revision_timestamp\":1605972872}}",
"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:9028437524122456048",
"scheduler_job_id:infra/codesearch-gen-chromium-fuchsia",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:11866",
"user_agent:recipe"
]
}
[16:00:40.254] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1605974439389274",
"id": "8863007462201894240",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-fuchsia\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"a7029b8b60fd7cb30661843617971f3e10c151fa\", \"codesearch_mirror_revision_timestamp\": 1605973086.0, \"root_solution_revision\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\", \"root_solution_revision_timestamp\": 1605972872.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:11866\", \"user_agent:recipe\"]}, \"id\": \"4a65d005-bbc7-45f8-9652-2b4f68ae588f\", \"title\": \"codesearch-gen-chromium-initiator/11866\"}]}, \"codesearch_mirror_revision\": \"a7029b8b60fd7cb30661843617971f3e10c151fa\", \"codesearch_mirror_revision_timestamp\": 1605973086.0, \"root_solution_revision\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\", \"root_solution_revision_timestamp\": 1605972872.0}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605974439896759",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-fuchsia/4620",
"builder:codesearch-gen-chromium-fuchsia",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:11866",
"scheduler_invocation_id:9028437524122456048",
"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/8863007462201894240/+/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": "1605974439896922",
"url": "https://ci.chromium.org/b/8863007462201894240",
"utcnow_ts": "1605974440226453"
}
}
[16:00:40.254] Task URL: https://ci.chromium.org/b/8863007462201894240
[16:00:40.254] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:2:0) after 1m0s
[16:00:47.289] Received PubSub notification, asking Buildbucket for the build status
[16:00:47.702] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:40.404] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:2:0)
[16:01:40.404] Timer tick, asking Buildbucket for the build status
[16:01:40.532] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:40.532] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:4:0) after 1m0s
[16:02:40.617] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:4:0)
[16:02:40.617] Timer tick, asking Buildbucket for the build status
[16:02:40.707] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:40.707] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:5:0) after 1m0s
[16:03:40.726] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:5:0)
[16:03:40.726] Timer tick, asking Buildbucket for the build status
[16:03:40.786] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:40.786] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:6:0) after 1m0s
[16:04:40.805] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:6:0)
[16:04:40.805] Timer tick, asking Buildbucket for the build status
[16:04:40.916] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:40.916] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:7:0) after 1m0s
[16:05:41.029] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:7:0)
[16:05:41.029] Timer tick, asking Buildbucket for the build status
[16:05:41.120] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:41.120] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:8:0) after 1m0s
[16:06:41.349] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:8:0)
[16:06:41.349] Timer tick, asking Buildbucket for the build status
[16:06:41.628] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:41.628] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:9:0) after 1m0s
[16:07:41.809] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:9:0)
[16:07:41.809] Timer tick, asking Buildbucket for the build status
[16:07:41.945] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:41.945] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:10:0) after 1m0s
[16:08:42.178] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:10:0)
[16:08:42.178] Timer tick, asking Buildbucket for the build status
[16:08:42.528] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:42.528] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:11:0) after 1m0s
[16:09:42.600] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:11:0)
[16:09:42.600] Timer tick, asking Buildbucket for the build status
[16:09:42.681] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:42.681] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:12:0) after 1m0s
[16:10:42.782] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:12:0)
[16:10:42.782] Timer tick, asking Buildbucket for the build status
[16:10:42.952] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:42.952] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:13:0) after 1m0s
[16:11:42.930] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:13:0)
[16:11:42.930] Timer tick, asking Buildbucket for the build status
[16:11:42.996] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:42.996] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:14:0) after 1m0s
[16:12:43.033] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:14:0)
[16:12:43.033] Timer tick, asking Buildbucket for the build status
[16:12:43.125] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:43.125] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:15:0) after 1m0s
[16:13:43.263] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:15:0)
[16:13:43.263] Timer tick, asking Buildbucket for the build status
[16:13:43.327] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:43.327] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:16:0) after 1m0s
[16:14:43.500] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:16:0)
[16:14:43.500] Timer tick, asking Buildbucket for the build status
[16:14:44.246] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:44.246] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:17:0) after 1m0s
[16:15:44.283] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:17:0)
[16:15:44.283] Timer tick, asking Buildbucket for the build status
[16:15:44.394] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:44.394] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:18:0) after 1m0s
[16:16:47.788] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:18:0)
[16:16:47.788] Timer tick, asking Buildbucket for the build status
[16:16:47.861] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:47.861] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:19:0) after 1m0s
[16:17:47.914] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:19:0)
[16:17:47.914] Timer tick, asking Buildbucket for the build status
[16:17:48.017] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:48.017] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:20:0) after 1m0s
[16:18:48.048] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:20:0)
[16:18:48.048] Timer tick, asking Buildbucket for the build status
[16:18:48.394] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:48.394] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:21:0) after 1m0s
[16:19:48.449] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:21:0)
[16:19:48.449] Timer tick, asking Buildbucket for the build status
[16:19:48.914] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:48.914] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:22:0) after 1m0s
[16:20:48.894] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:22:0)
[16:20:48.894] Timer tick, asking Buildbucket for the build status
[16:20:49.390] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:49.390] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:23:0) after 1m0s
[16:21:49.414] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:23:0)
[16:21:49.414] Timer tick, asking Buildbucket for the build status
[16:21:49.476] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:49.476] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:24:0) after 1m0s
[16:22:49.500] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:24:0)
[16:22:49.500] Timer tick, asking Buildbucket for the build status
[16:22:49.567] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:49.567] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:25:0) after 1m0s
[16:23:49.605] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:25:0)
[16:23:49.606] Timer tick, asking Buildbucket for the build status
[16:23:49.812] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:49.812] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:26:0) after 1m0s
[16:24:49.836] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:26:0)
[16:24:49.836] Timer tick, asking Buildbucket for the build status
[16:24:49.921] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:49.921] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:27:0) after 1m0s
[16:25:49.945] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:27:0)
[16:25:49.945] Timer tick, asking Buildbucket for the build status
[16:25:50.104] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:50.104] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:28:0) after 1m0s
[16:26:50.127] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:28:0)
[16:26:50.127] Timer tick, asking Buildbucket for the build status
[16:26:50.258] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:50.258] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:29:0) after 1m0s
[16:27:50.313] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:29:0)
[16:27:50.313] Timer tick, asking Buildbucket for the build status
[16:27:50.442] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:50.442] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:30:0) after 1m0s
[16:28:50.456] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:30:0)
[16:28:50.456] Timer tick, asking Buildbucket for the build status
[16:28:50.549] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:50.549] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:31:0) after 1m0s
[16:29:50.574] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:31:0)
[16:29:50.574] Timer tick, asking Buildbucket for the build status
[16:29:50.672] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:50.672] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:32:0) after 1m0s
[16:30:50.700] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:32:0)
[16:30:50.700] Timer tick, asking Buildbucket for the build status
[16:30:50.826] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:50.826] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:33:0) after 1m0s
[16:31:51.790] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:33:0)
[16:31:51.790] Timer tick, asking Buildbucket for the build status
[16:31:51.945] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:51.945] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:34:0) after 1m0s
[16:32:52.161] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:34:0)
[16:32:52.169] Timer tick, asking Buildbucket for the build status
[16:32:52.243] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:52.243] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:35:0) after 1m0s
[16:33:52.511] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:35:0)
[16:33:52.511] Timer tick, asking Buildbucket for the build status
[16:33:52.634] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:52.634] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:36:0) after 1m0s
[16:34:52.730] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:36:0)
[16:34:52.730] Timer tick, asking Buildbucket for the build status
[16:34:52.807] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:52.807] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:37:0) after 1m0s
[16:35:52.983] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:37:0)
[16:35:52.983] Timer tick, asking Buildbucket for the build status
[16:35:53.377] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:53.377] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:38:0) after 1m0s
[16:36:53.611] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:38:0)
[16:36:53.611] Timer tick, asking Buildbucket for the build status
[16:36:53.672] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:53.672] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:39:0) after 1m0s
[16:37:53.693] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:39:0)
[16:37:53.693] Timer tick, asking Buildbucket for the build status
[16:37:53.751] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:53.751] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:40:0) after 1m0s
[16:38:53.808] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:40:0)
[16:38:53.808] Timer tick, asking Buildbucket for the build status
[16:38:54.018] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:54.018] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:41:0) after 1m0s
[16:39:54.038] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:41:0)
[16:39:54.038] Timer tick, asking Buildbucket for the build status
[16:39:54.145] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:54.145] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:42:0) after 1m0s
[16:40:54.174] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:42:0)
[16:40:54.174] Timer tick, asking Buildbucket for the build status
[16:40:54.619] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:54.619] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:43:0) after 1m0s
[16:41:54.671] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:43:0)
[16:41:54.671] Timer tick, asking Buildbucket for the build status
[16:41:54.858] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:54.858] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:44:0) after 1m0s
[16:42:54.909] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:44:0)
[16:42:54.909] Timer tick, asking Buildbucket for the build status
[16:42:55.312] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:55.312] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:45:0) after 1m0s
[16:43:55.388] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:45:0)
[16:43:55.388] Timer tick, asking Buildbucket for the build status
[16:43:55.603] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:55.603] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:46:0) after 1m0s
[16:44:55.574] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:46:0)
[16:44:55.574] Timer tick, asking Buildbucket for the build status
[16:44:55.645] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:55.645] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:47:0) after 1m0s
[16:45:55.701] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:47:0)
[16:45:55.701] Timer tick, asking Buildbucket for the build status
[16:45:56.248] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:56.248] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:48:0) after 1m0s
[16:46:56.305] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:48:0)
[16:46:56.305] Timer tick, asking Buildbucket for the build status
[16:46:56.403] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:56.403] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:49:0) after 1m0s
[16:47:56.402] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:49:0)
[16:47:56.402] Timer tick, asking Buildbucket for the build status
[16:47:56.466] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:56.466] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:50:0) after 1m0s
[16:48:56.506] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:50:0)
[16:48:56.506] Timer tick, asking Buildbucket for the build status
[16:48:56.567] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:56.567] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:51:0) after 1m0s
[16:49:56.595] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:51:0)
[16:49:56.595] Timer tick, asking Buildbucket for the build status
[16:49:56.657] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:56.657] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:52:0) after 1m0s
[16:50:56.667] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:52:0)
[16:50:56.667] Timer tick, asking Buildbucket for the build status
[16:50:56.792] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:56.792] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:53:0) after 1m0s
[16:51:56.812] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:53:0)
[16:51:56.812] Timer tick, asking Buildbucket for the build status
[16:51:56.921] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:56.921] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:54:0) after 1m0s
[16:52:56.944] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:54:0)
[16:52:56.944] Timer tick, asking Buildbucket for the build status
[16:52:57.326] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:57.326] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:55:0) after 1m0s
[16:53:57.422] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:55:0)
[16:53:57.422] Timer tick, asking Buildbucket for the build status
[16:53:57.671] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:57.671] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:56:0) after 1m0s
[16:54:57.692] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:56:0)
[16:54:57.692] Timer tick, asking Buildbucket for the build status
[16:54:58.114] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:58.114] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:57:0) after 1m0s
[16:55:58.129] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:57:0)
[16:55:58.129] Timer tick, asking Buildbucket for the build status
[16:55:58.550] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:58.550] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:58:0) after 1m0s
[16:56:58.593] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:58:0)
[16:56:58.593] Timer tick, asking Buildbucket for the build status
[16:56:58.662] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:58.662] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:59:0) after 1m0s
[16:57:58.695] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:59:0)
[16:57:58.695] Timer tick, asking Buildbucket for the build status
[16:57:59.429] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:59.429] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:60:0) after 1m0s
[16:58:59.450] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:60:0)
[16:58:59.450] Timer tick, asking Buildbucket for the build status
[16:58:59.540] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:59.540] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:61:0) after 1m0s
[16:59:59.561] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:61:0)
[16:59:59.561] Timer tick, asking Buildbucket for the build status
[16:59:59.623] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:59.623] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:62:0) after 1m0s
[17:00:59.650] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:62:0)
[17:00:59.650] Timer tick, asking Buildbucket for the build status
[17:00:59.792] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:59.792] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:63:0) after 1m0s
[17:01:59.814] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:63:0)
[17:01:59.814] Timer tick, asking Buildbucket for the build status
[17:01:59.895] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:59.895] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:64:0) after 1m0s
[17:02:59.925] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:64:0)
[17:02:59.925] Timer tick, asking Buildbucket for the build status
[17:03:01.346] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:01.346] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:65:0) after 1m0s
[17:04:01.391] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:65:0)
[17:04:01.391] Timer tick, asking Buildbucket for the build status
[17:04:01.496] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:01.496] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:66:0) after 1m0s
[17:05:01.552] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:66:0)
[17:05:01.552] Timer tick, asking Buildbucket for the build status
[17:05:02.606] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:02.606] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:67:0) after 1m0s
[17:06:02.623] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:67:0)
[17:06:02.623] Timer tick, asking Buildbucket for the build status
[17:06:02.731] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:02.731] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:68:0) after 1m0s
[17:07:02.756] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:68:0)
[17:07:02.756] Timer tick, asking Buildbucket for the build status
[17:07:03.030] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:03.030] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:69:0) after 1m0s
[17:08:03.129] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:69:0)
[17:08:03.129] Timer tick, asking Buildbucket for the build status
[17:08:03.381] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:03.381] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:70:0) after 1m0s
[17:09:03.370] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:70:0)
[17:09:03.370] Timer tick, asking Buildbucket for the build status
[17:09:03.493] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:03.493] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:71:0) after 1m0s
[17:10:03.517] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:71:0)
[17:10:03.517] Timer tick, asking Buildbucket for the build status
[17:10:03.650] Build 8863007462201894240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:03.650] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-fuchsia:9028437524122456048:72:0) after 1m0s
[17:10:34.473] Received PubSub notification, asking Buildbucket for the build status
[17:10:34.526] Build 8863007462201894240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:10:34.526] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"completed_ts": "1605978633581885",
"created_by": "project:infra",
"created_ts": "1605974439389274",
"id": "8863007462201894240",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-fuchsia\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"codesearch_mirror_revision\": \"a7029b8b60fd7cb30661843617971f3e10c151fa\", \"codesearch_mirror_revision_timestamp\": 1605973086.0, \"root_solution_revision\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\", \"root_solution_revision_timestamp\": 1605972872.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:11866\", \"user_agent:recipe\"]}, \"id\": \"4a65d005-bbc7-45f8-9652-2b4f68ae588f\", \"title\": \"codesearch-gen-chromium-initiator/11866\"}]}, \"codesearch_mirror_revision\": \"a7029b8b60fd7cb30661843617971f3e10c151fa\", \"codesearch_mirror_revision_timestamp\": 1605973086.0, \"root_solution_revision\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\", \"root_solution_revision_timestamp\": 1605972872.0}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"clang_revision\": \"llvmorg-12-init-12083-g94e4ec64-1\", \"got_angle_revision\": \"e51c9068a84f14e42157c097eb764ec3009e0e54\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"f0e03306e587863247d807f8a5a64a68a0be93b3\", \"got_revision_cp\": \"refs/heads/master@{#829993}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"22f2e5ef66ed5c820532f27b141096d3ddb1966e\", \"got_v8_revision_cp\": \"refs/heads/8.9.31@{#1}\", \"got_webrtc_revision\": \"7d75f2ca782f38006bb65bc67533e582190454e8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32659}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_14b4f73c8b95a6615516bba597f721e10c68093aeabbb388e9a5697d2f7f84cc_v2\", \"builder_b5ea7bb4091186e872937c4042f52c0c1d84281f1bc29c547e93e8efc0fd27bb_v2\", \"builder_c53076cda07f371c1c8d6c8348c1e7630d53be9873872bdf1dfffa53553e24e4_v2\", \"codesearch_git_genfiles_repo\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-codesearch-xenial-7-8mjf\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.codesearch\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-a\"]}}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605974446045419",
"status": "COMPLETED",
"status_changed_ts": "1605978633914062",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-fuchsia/4620",
"builder:codesearch-gen-chromium-fuchsia",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:11866",
"scheduler_invocation_id:9028437524122456048",
"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/8863007462201894240/+/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:50045ac145a00e10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1605978633937064",
"url": "https://ci.chromium.org/b/8863007462201894240",
"utcnow_ts": "1605978634519114"
}
}
[17:10:34.526] Invocation finished in 1h9m56.353418858s with status SUCCEEDED