[12:00:22.234] New invocation is queued and will start shortly
[12:00:22.234] Triggered by user:infra-codesearch@chops-service-accounts.iam.gserviceaccount.com
[12:00:23.496] Starting the invocation (attempt 1)
[12:00:23.550] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:00:23.550] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:00:23.550] Buildbucket request:
{
"bucket": "luci.infra.codesearch",
"client_operation_id": "9072663959958592992",
"parameters_json": "{\"builder_name\":\"codesearch-gen-chromium-android\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"root_solution_revision\":\"e0d2cc79445f3d9aa5f7f50c2b74b4b0031e2542\",\"root_solution_revision_timestamp\":1563796713},\"tags\":[\"parent_buildername:codesearch-gen-chromium-initiator\",\"parent_buildnumber:8936\",\"user_agent:recipe\"]},\"id\":\"a76fceb8-7b36-4050-b417-96f6b95004bb\",\"title\":\"codesearch-gen-chromium-initiator/8936\"}]},\"root_solution_revision\":\"e0d2cc79445f3d9aa5f7f50c2b74b4b0031e2542\",\"root_solution_revision_timestamp\":1563796713}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:codesearch-gen-chromium-android",
"scheduler_invocation_id:9072663959958592992",
"scheduler_job_id:infra/codesearch-gen-chromium-android",
"user_agent:luci-scheduler",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8936",
"user_agent:recipe"
]
}
[12:00:24.610] Buildbucket response:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1563796823730365",
"id": "8907233897718315488",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-android\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"root_solution_revision\": \"e0d2cc79445f3d9aa5f7f50c2b74b4b0031e2542\", \"root_solution_revision_timestamp\": 1563796713.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:8936\", \"user_agent:recipe\"]}, \"id\": \"a76fceb8-7b36-4050-b417-96f6b95004bb\", \"title\": \"codesearch-gen-chromium-initiator/8936\"}]}, \"root_solution_revision\": \"e0d2cc79445f3d9aa5f7f50c2b74b4b0031e2542\", \"root_solution_revision_timestamp\": 1563796713.0}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1563796824440030",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-android/5683",
"builder:codesearch-gen-chromium-android",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8936",
"scheduler_invocation_id:9072663959958592992",
"scheduler_job_id:infra/codesearch-gen-chromium-android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8907233897718315488/+/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": "1563796824440202",
"url": "https://ci.chromium.org/b/8907233897718315488",
"utcnow_ts": "1563796824599129"
}
}
[12:00:24.610] Task URL: https://ci.chromium.org/b/8907233897718315488
[12:00:24.610] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:2:0) after 1m0s
[12:01:18.945] Received PubSub notification, asking Buildbucket for the build status
[12:01:19.117] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:24.664] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:2:0)
[12:01:24.664] Timer tick, asking Buildbucket for the build status
[12:01:24.820] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:24.820] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:4:0) after 1m0s
[12:02:24.862] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:4:0)
[12:02:24.862] Timer tick, asking Buildbucket for the build status
[12:02:25.011] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:25.012] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:5:0) after 1m0s
[12:03:25.055] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:5:0)
[12:03:25.055] Timer tick, asking Buildbucket for the build status
[12:03:25.191] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:25.191] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:6:0) after 1m0s
[12:04:25.266] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:6:0)
[12:04:25.266] Timer tick, asking Buildbucket for the build status
[12:04:25.475] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:25.475] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:7:0) after 1m0s
[12:05:25.484] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:7:0)
[12:05:25.484] Timer tick, asking Buildbucket for the build status
[12:05:25.744] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:25.744] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:8:0) after 1m0s
[12:06:25.740] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:8:0)
[12:06:25.740] Timer tick, asking Buildbucket for the build status
[12:06:25.923] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:25.923] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:9:0) after 1m0s
[12:07:25.951] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:9:0)
[12:07:25.951] Timer tick, asking Buildbucket for the build status
[12:07:26.113] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:26.113] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:10:0) after 1m0s
[12:08:26.184] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:10:0)
[12:08:26.184] Timer tick, asking Buildbucket for the build status
[12:08:26.351] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:26.351] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:11:0) after 1m0s
[12:09:26.469] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:11:0)
[12:09:26.469] Timer tick, asking Buildbucket for the build status
[12:09:27.095] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:27.095] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:12:0) after 1m0s
[12:10:27.274] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:12:0)
[12:10:27.274] Timer tick, asking Buildbucket for the build status
[12:10:27.462] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:27.462] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:13:0) after 1m0s
[12:11:27.895] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:13:0)
[12:11:27.895] Timer tick, asking Buildbucket for the build status
[12:11:28.155] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:28.155] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:14:0) after 1m0s
[12:12:28.337] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:14:0)
[12:12:28.337] Timer tick, asking Buildbucket for the build status
[12:12:28.606] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:28.606] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:15:0) after 1m0s
[12:13:28.619] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:15:0)
[12:13:28.619] Timer tick, asking Buildbucket for the build status
[12:13:28.909] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:28.909] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:16:0) after 1m0s
[12:14:28.930] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:16:0)
[12:14:28.930] Timer tick, asking Buildbucket for the build status
[12:14:29.084] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:29.084] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:17:0) after 1m0s
[12:15:29.114] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:17:0)
[12:15:29.114] Timer tick, asking Buildbucket for the build status
[12:15:29.264] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:29.264] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:18:0) after 1m0s
[12:16:29.289] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:18:0)
[12:16:29.289] Timer tick, asking Buildbucket for the build status
[12:16:29.547] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:29.547] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:19:0) after 1m0s
[12:17:29.572] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:19:0)
[12:17:29.573] Timer tick, asking Buildbucket for the build status
[12:17:29.711] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:29.711] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:20:0) after 1m0s
[12:18:29.746] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:20:0)
[12:18:29.746] Timer tick, asking Buildbucket for the build status
[12:18:30.029] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:30.029] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:21:0) after 1m0s
[12:19:30.048] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:21:0)
[12:19:30.048] Timer tick, asking Buildbucket for the build status
[12:19:30.187] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:30.187] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:22:0) after 1m0s
[12:20:30.266] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:22:0)
[12:20:30.266] Timer tick, asking Buildbucket for the build status
[12:20:30.404] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:30.404] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:23:0) after 1m0s
[12:21:30.515] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:23:0)
[12:21:30.515] Timer tick, asking Buildbucket for the build status
[12:21:30.665] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:30.665] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:24:0) after 1m0s
[12:22:30.728] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:24:0)
[12:22:30.728] Timer tick, asking Buildbucket for the build status
[12:22:31.147] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:31.147] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:25:0) after 1m0s
[12:23:31.199] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:25:0)
[12:23:31.200] Timer tick, asking Buildbucket for the build status
[12:23:31.507] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:31.507] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:26:0) after 1m0s
[12:24:31.538] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:26:0)
[12:24:31.538] Timer tick, asking Buildbucket for the build status
[12:24:32.143] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:32.143] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:27:0) after 1m0s
[12:25:32.188] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:27:0)
[12:25:32.188] Timer tick, asking Buildbucket for the build status
[12:25:32.519] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:32.519] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:28:0) after 1m0s
[12:26:32.548] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:28:0)
[12:26:32.548] Timer tick, asking Buildbucket for the build status
[12:26:32.650] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:32.650] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:29:0) after 1m0s
[12:27:32.638] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:29:0)
[12:27:32.638] Timer tick, asking Buildbucket for the build status
[12:27:33.742] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:33.742] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:30:0) after 1m0s
[12:28:33.846] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:30:0)
[12:28:33.846] Timer tick, asking Buildbucket for the build status
[12:28:34.008] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:34.008] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:31:0) after 1m0s
[12:29:34.168] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:31:0)
[12:29:34.168] Timer tick, asking Buildbucket for the build status
[12:29:34.383] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:34.384] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:32:0) after 1m0s
[12:30:34.573] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:32:0)
[12:30:34.573] Timer tick, asking Buildbucket for the build status
[12:30:34.822] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:34.822] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:33:0) after 1m0s
[12:31:35.021] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:33:0)
[12:31:35.021] Timer tick, asking Buildbucket for the build status
[12:31:35.407] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:35.407] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:34:0) after 1m0s
[12:32:35.440] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:34:0)
[12:32:35.440] Timer tick, asking Buildbucket for the build status
[12:32:35.734] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:35.734] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:35:0) after 1m0s
[12:33:35.777] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:35:0)
[12:33:35.777] Timer tick, asking Buildbucket for the build status
[12:33:35.990] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:35.990] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:36:0) after 1m0s
[12:34:36.048] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:36:0)
[12:34:36.048] Timer tick, asking Buildbucket for the build status
[12:34:36.188] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:36.188] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:37:0) after 1m0s
[12:35:36.422] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:37:0)
[12:35:36.422] Timer tick, asking Buildbucket for the build status
[12:35:36.527] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:36.527] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:38:0) after 1m0s
[12:36:36.687] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:38:0)
[12:36:36.687] Timer tick, asking Buildbucket for the build status
[12:36:37.057] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:37.057] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:39:0) after 1m0s
[12:37:37.393] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:39:0)
[12:37:37.393] Timer tick, asking Buildbucket for the build status
[12:37:37.549] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:37.549] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:40:0) after 1m0s
[12:38:37.731] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:40:0)
[12:38:37.731] Timer tick, asking Buildbucket for the build status
[12:38:37.882] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:37.882] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:41:0) after 1m0s
[12:39:37.984] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:41:0)
[12:39:37.984] Timer tick, asking Buildbucket for the build status
[12:39:38.385] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:38.385] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:42:0) after 1m0s
[12:40:38.374] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:42:0)
[12:40:38.374] Timer tick, asking Buildbucket for the build status
[12:40:38.464] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:38.464] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:43:0) after 1m0s
[12:41:38.538] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:43:0)
[12:41:38.538] Timer tick, asking Buildbucket for the build status
[12:41:38.709] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:38.709] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:44:0) after 1m0s
[12:42:38.799] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:44:0)
[12:42:38.799] Timer tick, asking Buildbucket for the build status
[12:42:38.929] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:38.929] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:45:0) after 1m0s
[12:43:38.950] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:45:0)
[12:43:38.950] Timer tick, asking Buildbucket for the build status
[12:43:39.087] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:39.087] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:46:0) after 1m0s
[12:44:39.179] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:46:0)
[12:44:39.179] Timer tick, asking Buildbucket for the build status
[12:44:39.284] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:39.284] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:47:0) after 1m0s
[12:45:39.309] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:47:0)
[12:45:39.309] Timer tick, asking Buildbucket for the build status
[12:45:39.428] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:39.428] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:48:0) after 1m0s
[12:46:39.477] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:48:0)
[12:46:39.477] Timer tick, asking Buildbucket for the build status
[12:46:39.715] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:39.715] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:49:0) after 1m0s
[12:47:39.744] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:49:0)
[12:47:39.744] Timer tick, asking Buildbucket for the build status
[12:47:39.913] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:39.913] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:50:0) after 1m0s
[12:48:39.975] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:50:0)
[12:48:39.975] Timer tick, asking Buildbucket for the build status
[12:48:40.143] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:40.143] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:51:0) after 1m0s
[12:49:40.199] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:51:0)
[12:49:40.199] Timer tick, asking Buildbucket for the build status
[12:49:40.333] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:40.333] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:52:0) after 1m0s
[12:50:40.353] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:52:0)
[12:50:40.353] Timer tick, asking Buildbucket for the build status
[12:50:40.476] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:40.476] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:53:0) after 1m0s
[12:51:40.525] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:53:0)
[12:51:40.525] Timer tick, asking Buildbucket for the build status
[12:51:40.704] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:40.704] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:54:0) after 1m0s
[12:52:40.720] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:54:0)
[12:52:40.720] Timer tick, asking Buildbucket for the build status
[12:52:40.861] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:40.861] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:55:0) after 1m0s
[12:53:41.053] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:55:0)
[12:53:41.053] Timer tick, asking Buildbucket for the build status
[12:53:41.905] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:41.905] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:56:0) after 1m0s
[12:54:41.934] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:56:0)
[12:54:41.934] Timer tick, asking Buildbucket for the build status
[12:54:42.056] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:42.056] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:57:0) after 1m0s
[12:55:42.097] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:57:0)
[12:55:42.097] Timer tick, asking Buildbucket for the build status
[12:55:42.216] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:42.216] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:58:0) after 1m0s
[12:56:42.241] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:58:0)
[12:56:42.241] Timer tick, asking Buildbucket for the build status
[12:56:42.366] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:42.366] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:59:0) after 1m0s
[12:57:42.443] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:59:0)
[12:57:42.443] Timer tick, asking Buildbucket for the build status
[12:57:42.822] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:42.822] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:60:0) after 1m0s
[12:58:42.857] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:60:0)
[12:58:42.857] Timer tick, asking Buildbucket for the build status
[12:58:42.952] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:42.952] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:61:0) after 1m0s
[12:59:43.050] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:61:0)
[12:59:43.050] Timer tick, asking Buildbucket for the build status
[12:59:43.172] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:43.172] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:62:0) after 1m0s
[13:00:43.185] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:62:0)
[13:00:43.185] Timer tick, asking Buildbucket for the build status
[13:00:43.327] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:43.327] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:63:0) after 1m0s
[13:01:43.362] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:63:0)
[13:01:43.362] Timer tick, asking Buildbucket for the build status
[13:01:43.891] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:43.891] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:64:0) after 1m0s
[13:02:43.955] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:64:0)
[13:02:43.955] Timer tick, asking Buildbucket for the build status
[13:02:45.190] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:45.190] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:65:0) after 1m0s
[13:03:45.220] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:65:0)
[13:03:45.220] Timer tick, asking Buildbucket for the build status
[13:03:45.374] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:45.374] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:66:0) after 1m0s
[13:04:45.461] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:66:0)
[13:04:45.461] Timer tick, asking Buildbucket for the build status
[13:04:45.579] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:45.579] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:67:0) after 1m0s
[13:05:45.704] Handling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:67:0)
[13:05:45.705] Timer tick, asking Buildbucket for the build status
[13:05:45.827] Build 8907233897718315488: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:45.827] Scheduling timer "check-buildbucket-build-status" (infra/codesearch-gen-chromium-android:9072663959958592992:68:0) after 1m0s
[13:06:02.968] Received PubSub notification, asking Buildbucket for the build status
[13:06:03.168] Build 8907233897718315488: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:06:03.168] Buildbucket build:
{
"build": {
"bucket": "luci.infra.codesearch",
"canary_preference": "PROD",
"completed_ts": "1563800761864846",
"created_by": "project:infra",
"created_ts": "1563796823730365",
"id": "8907233897718315488",
"parameters_json": "{\"builder_name\": \"codesearch-gen-chromium-android\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"root_solution_revision\": \"e0d2cc79445f3d9aa5f7f50c2b74b4b0031e2542\", \"root_solution_revision_timestamp\": 1563796713.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:8936\", \"user_agent:recipe\"]}, \"id\": \"a76fceb8-7b36-4050-b417-96f6b95004bb\", \"title\": \"codesearch-gen-chromium-initiator/8936\"}]}, \"root_solution_revision\": \"e0d2cc79445f3d9aa5f7f50c2b74b4b0031e2542\", \"root_solution_revision_timestamp\": 1563796713.0}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"root_solution_revision\": \"e0d2cc79445f3d9aa5f7f50c2b74b4b0031e2542\", \"root_solution_revision_timestamp\": 1563796713.0}, \"tags\": [\"parent_buildername:codesearch-gen-chromium-initiator\", \"parent_buildnumber:8936\", \"user_agent:recipe\"]}, \"id\": \"a76fceb8-7b36-4050-b417-96f6b95004bb\", \"title\": \"codesearch-gen-chromium-initiator/8936\"}]}, \"bot_id\": \"luci-infra-codesearch-xenial-0-nlgy\", \"buildername\": \"codesearch-gen-chromium-android\", \"buildnumber\": 5683, \"got_angle_revision\": \"9ec3f51d11d92c8b87da27811cc7ab577705ea3c\", \"got_clang_revision\": \"365097-f7e52fbd-6\", \"got_dawn_revision\": \"49aae0f3bde201d10f1b17d362b0d5b8f85dceb4\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"e0d2cc79445f3d9aa5f7f50c2b74b4b0031e2542\", \"got_revision_cp\": \"refs/heads/master@{#679516}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"77a40eb1687a0f30b3c3f4e496eea661d4b1c78b\", \"got_v8_revision_cp\": \"refs/heads/7.7.290@{#1}\", \"got_webrtc_revision\": \"ec3580361e6248bb90d3630c126d5fafbaf45c6e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28628}\", \"mastername\": \"chromium.infra.codesearch\", \"path_config\": \"generic\", \"recipe\": \"chromium_codesearch\", \"root_solution_revision\": \"e0d2cc79445f3d9aa5f7f50c2b74b4b0031e2542\", \"root_solution_revision_timestamp\": 1563796713.0}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_4d14e380d83a89b4cb58aa2f3c73d8f515800858510b279900319844ebd58b92_v2\", \"codesearch_git_genfiles_repo\", \"codesearch_update_submodules_mirror\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-codesearch-xenial-0-nlgy\"], \"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\": [\"4370-0e704a3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-a\"]}}}",
"service_account": "infra-codesearch@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1563796875545739",
"status": "COMPLETED",
"status_changed_ts": "1563800762631976",
"tags": [
"build_address:luci.infra.codesearch/codesearch-gen-chromium-android/5683",
"builder:codesearch-gen-chromium-android",
"parent_buildername:codesearch-gen-chromium-initiator",
"parent_buildnumber:8936",
"scheduler_invocation_id:9072663959958592992",
"scheduler_job_id:infra/codesearch-gen-chromium-android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8907233897718315488/+/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:46325f72cb0e9110",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1563800762670617",
"url": "https://ci.chromium.org/b/8907233897718315488",
"utcnow_ts": "1563800763140358"
}
}
[13:06:03.168] Invocation finished in 1h5m40.95718823s with status SUCCEEDED