[21:00:56.508] New invocation is queued and will start shortly
[21:00:57.800] Starting the invocation (attempt 1)
[21:00:57.952] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:00:57.952] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:00:57.954] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029324600225859968",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9029324600225859968",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b",
"gitiles_ref:refs/heads/master"
]
}
[21:01:00.256] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605128458335101",
"id": "8863894537631668384",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605128459888284",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/6085",
"builder:android-bfcache-rel",
"buildset:commit/git/e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029324600225859968",
"scheduler_job_id:chromium/android-bfcache-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863894537631668384/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1605128459888459",
"url": "https://ci.chromium.org/b/8863894537631668384",
"utcnow_ts": "1605128460228671"
}
}
[21:01:00.259] Task URL: https://ci.chromium.org/b/8863894537631668384
[21:01:00.259] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:2:0) after 1m0s
[21:01:08.170] Received PubSub notification, asking Buildbucket for the build status
[21:01:08.314] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:00.356] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:2:0)
[21:02:00.356] Timer tick, asking Buildbucket for the build status
[21:02:00.565] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:00.566] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:4:0) after 1m0s
[21:03:04.181] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:4:0)
[21:03:04.181] Timer tick, asking Buildbucket for the build status
[21:03:04.270] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:04.270] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:5:0) after 1m0s
[21:04:04.306] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:5:0)
[21:04:04.306] Timer tick, asking Buildbucket for the build status
[21:04:04.596] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:04.596] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:6:0) after 1m0s
[21:05:04.806] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:6:0)
[21:05:04.806] Timer tick, asking Buildbucket for the build status
[21:05:05.634] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:05.634] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:7:0) after 1m0s
[21:06:05.930] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:7:0)
[21:06:05.930] Timer tick, asking Buildbucket for the build status
[21:06:06.463] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:06.463] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:8:0) after 1m0s
[21:07:06.587] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:8:0)
[21:07:06.587] Timer tick, asking Buildbucket for the build status
[21:07:06.831] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:06.831] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:9:0) after 1m0s
[21:08:06.871] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:9:0)
[21:08:06.871] Timer tick, asking Buildbucket for the build status
[21:08:07.218] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:07.218] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:10:0) after 1m0s
[21:09:07.282] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:10:0)
[21:09:07.282] Timer tick, asking Buildbucket for the build status
[21:09:07.443] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:07.443] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:11:0) after 1m0s
[21:10:07.469] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:11:0)
[21:10:07.469] Timer tick, asking Buildbucket for the build status
[21:10:07.616] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:07.616] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:12:0) after 1m0s
[21:11:07.620] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:12:0)
[21:11:07.620] Timer tick, asking Buildbucket for the build status
[21:11:07.906] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:07.906] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:13:0) after 1m0s
[21:12:07.927] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:13:0)
[21:12:07.927] Timer tick, asking Buildbucket for the build status
[21:12:08.079] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:08.079] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:14:0) after 1m0s
[21:13:08.578] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:14:0)
[21:13:08.578] Timer tick, asking Buildbucket for the build status
[21:13:08.650] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:08.650] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:15:0) after 1m0s
[21:14:08.763] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:15:0)
[21:14:08.763] Timer tick, asking Buildbucket for the build status
[21:14:08.842] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:08.842] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:16:0) after 1m0s
[21:15:08.913] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:16:0)
[21:15:08.913] Timer tick, asking Buildbucket for the build status
[21:15:09.020] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:09.021] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:17:0) after 1m0s
[21:16:09.048] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:17:0)
[21:16:09.048] Timer tick, asking Buildbucket for the build status
[21:16:09.443] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:09.444] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:18:0) after 1m0s
[21:17:09.455] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:18:0)
[21:17:09.455] Timer tick, asking Buildbucket for the build status
[21:17:09.717] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:09.717] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:19:0) after 1m0s
[21:18:09.800] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:19:0)
[21:18:09.800] Timer tick, asking Buildbucket for the build status
[21:18:09.928] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:09.928] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:20:0) after 1m0s
[21:19:10.008] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:20:0)
[21:19:10.008] Timer tick, asking Buildbucket for the build status
[21:19:10.147] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:10.147] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:21:0) after 1m0s
[21:20:10.179] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:21:0)
[21:20:10.179] Timer tick, asking Buildbucket for the build status
[21:20:10.255] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:10.255] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:22:0) after 1m0s
[21:21:10.295] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:22:0)
[21:21:10.296] Timer tick, asking Buildbucket for the build status
[21:21:10.803] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:10.803] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:23:0) after 1m0s
[21:22:10.851] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:23:0)
[21:22:10.851] Timer tick, asking Buildbucket for the build status
[21:22:10.955] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:10.955] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:24:0) after 1m0s
[21:23:11.034] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:24:0)
[21:23:11.034] Timer tick, asking Buildbucket for the build status
[21:23:11.164] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:11.164] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:25:0) after 1m0s
[21:24:11.220] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:25:0)
[21:24:11.220] Timer tick, asking Buildbucket for the build status
[21:24:11.484] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:11.484] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:26:0) after 1m0s
[21:25:11.578] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:26:0)
[21:25:11.578] Timer tick, asking Buildbucket for the build status
[21:25:11.837] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:11.837] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:27:0) after 1m0s
[21:26:11.917] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:27:0)
[21:26:11.917] Timer tick, asking Buildbucket for the build status
[21:26:12.059] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:12.059] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:28:0) after 1m0s
[21:27:12.149] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:28:0)
[21:27:12.149] Timer tick, asking Buildbucket for the build status
[21:27:12.282] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:12.282] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:29:0) after 1m0s
[21:28:12.350] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:29:0)
[21:28:12.350] Timer tick, asking Buildbucket for the build status
[21:28:12.554] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:12.554] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:30:0) after 1m0s
[21:29:12.593] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:30:0)
[21:29:12.593] Timer tick, asking Buildbucket for the build status
[21:29:12.667] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:12.667] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:31:0) after 1m0s
[21:30:12.707] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:31:0)
[21:30:12.707] Timer tick, asking Buildbucket for the build status
[21:30:12.934] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:12.934] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:32:0) after 1m0s
[21:31:12.954] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:32:0)
[21:31:12.954] Timer tick, asking Buildbucket for the build status
[21:31:13.384] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:13.384] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:33:0) after 1m0s
[21:32:13.451] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:33:0)
[21:32:13.451] Timer tick, asking Buildbucket for the build status
[21:32:13.613] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:13.613] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:34:0) after 1m0s
[21:33:13.665] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:34:0)
[21:33:13.665] Timer tick, asking Buildbucket for the build status
[21:33:13.742] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:13.742] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:35:0) after 1m0s
[21:34:13.745] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:35:0)
[21:34:13.745] Timer tick, asking Buildbucket for the build status
[21:34:13.902] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:13.902] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:36:0) after 1m0s
[21:35:13.961] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:36:0)
[21:35:13.961] Timer tick, asking Buildbucket for the build status
[21:35:14.084] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:14.084] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:37:0) after 1m0s
[21:36:14.264] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:37:0)
[21:36:14.264] Timer tick, asking Buildbucket for the build status
[21:36:14.467] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:14.467] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:38:0) after 1m0s
[21:37:15.007] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:38:0)
[21:37:15.007] Timer tick, asking Buildbucket for the build status
[21:37:15.080] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:15.080] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:39:0) after 1m0s
[21:38:15.178] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:39:0)
[21:38:15.178] Timer tick, asking Buildbucket for the build status
[21:38:15.355] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:15.355] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:40:0) after 1m0s
[21:39:15.522] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:40:0)
[21:39:15.522] Timer tick, asking Buildbucket for the build status
[21:39:15.873] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:15.873] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:41:0) after 1m0s
[21:40:16.127] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:41:0)
[21:40:16.127] Timer tick, asking Buildbucket for the build status
[21:40:16.206] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:16.206] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:42:0) after 1m0s
[21:41:16.257] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:42:0)
[21:41:16.257] Timer tick, asking Buildbucket for the build status
[21:41:16.429] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:16.429] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:43:0) after 1m0s
[21:42:16.458] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:43:0)
[21:42:16.458] Timer tick, asking Buildbucket for the build status
[21:42:16.556] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:16.556] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:44:0) after 1m0s
[21:43:16.732] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:44:0)
[21:43:16.732] Timer tick, asking Buildbucket for the build status
[21:43:16.858] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:16.858] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:45:0) after 1m0s
[21:44:16.886] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:45:0)
[21:44:16.886] Timer tick, asking Buildbucket for the build status
[21:44:16.950] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:16.950] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:46:0) after 1m0s
[21:45:16.935] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:46:0)
[21:45:16.935] Timer tick, asking Buildbucket for the build status
[21:45:17.066] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:17.066] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:47:0) after 1m0s
[21:46:17.136] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:47:0)
[21:46:17.136] Timer tick, asking Buildbucket for the build status
[21:46:17.320] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:17.320] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:48:0) after 1m0s
[21:47:17.370] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:48:0)
[21:47:17.370] Timer tick, asking Buildbucket for the build status
[21:47:17.439] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:17.439] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:49:0) after 1m0s
[21:48:17.468] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:49:0)
[21:48:17.468] Timer tick, asking Buildbucket for the build status
[21:48:17.786] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:17.786] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:50:0) after 1m0s
[21:49:17.817] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:50:0)
[21:49:17.817] Timer tick, asking Buildbucket for the build status
[21:49:17.906] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:17.906] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:51:0) after 1m0s
[21:50:18.017] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:51:0)
[21:50:18.017] Timer tick, asking Buildbucket for the build status
[21:50:18.607] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:18.607] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:52:0) after 1m0s
[21:51:18.638] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:52:0)
[21:51:18.638] Timer tick, asking Buildbucket for the build status
[21:51:18.796] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:18.796] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:53:0) after 1m0s
[21:52:18.842] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:53:0)
[21:52:18.842] Timer tick, asking Buildbucket for the build status
[21:52:18.910] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:18.910] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:54:0) after 1m0s
[21:53:18.950] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:54:0)
[21:53:18.950] Timer tick, asking Buildbucket for the build status
[21:53:19.203] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:19.203] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:55:0) after 1m0s
[21:54:19.253] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:55:0)
[21:54:19.253] Timer tick, asking Buildbucket for the build status
[21:54:19.339] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:19.339] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:56:0) after 1m0s
[21:55:19.423] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:56:0)
[21:55:19.423] Timer tick, asking Buildbucket for the build status
[21:55:19.621] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:19.621] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:57:0) after 1m0s
[21:56:19.609] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:57:0)
[21:56:19.609] Timer tick, asking Buildbucket for the build status
[21:56:19.731] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:19.731] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:58:0) after 1m0s
[21:57:19.758] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:58:0)
[21:57:19.758] Timer tick, asking Buildbucket for the build status
[21:57:19.832] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:19.832] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:59:0) after 1m0s
[21:58:19.994] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:59:0)
[21:58:19.994] Timer tick, asking Buildbucket for the build status
[21:58:20.341] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:20.341] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:60:0) after 1m0s
[21:59:20.400] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:60:0)
[21:59:20.400] Timer tick, asking Buildbucket for the build status
[21:59:20.813] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:20.813] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:61:0) after 1m0s
[22:00:21.152] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:61:0)
[22:00:21.152] Timer tick, asking Buildbucket for the build status
[22:00:21.294] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:21.294] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:62:0) after 1m0s
[22:01:21.368] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:62:0)
[22:01:21.368] Timer tick, asking Buildbucket for the build status
[22:01:21.536] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:21.536] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:63:0) after 1m0s
[22:02:21.953] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:63:0)
[22:02:21.953] Timer tick, asking Buildbucket for the build status
[22:02:22.046] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:22.046] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:64:0) after 1m0s
[22:03:22.243] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:64:0)
[22:03:22.243] Timer tick, asking Buildbucket for the build status
[22:03:22.331] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:22.331] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:65:0) after 1m0s
[22:04:22.381] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:65:0)
[22:04:22.381] Timer tick, asking Buildbucket for the build status
[22:04:22.453] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:22.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:66:0) after 1m0s
[22:05:22.738] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:66:0)
[22:05:22.738] Timer tick, asking Buildbucket for the build status
[22:05:22.857] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:22.857] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:67:0) after 1m0s
[22:06:22.959] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:67:0)
[22:06:22.959] Timer tick, asking Buildbucket for the build status
[22:06:23.131] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:23.132] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:68:0) after 1m0s
[22:07:23.198] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:68:0)
[22:07:23.198] Timer tick, asking Buildbucket for the build status
[22:07:23.265] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:23.265] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:69:0) after 1m0s
[22:08:23.424] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:69:0)
[22:08:23.424] Timer tick, asking Buildbucket for the build status
[22:08:23.505] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:23.505] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:70:0) after 1m0s
[22:09:23.530] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:70:0)
[22:09:23.530] Timer tick, asking Buildbucket for the build status
[22:09:23.668] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:23.668] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:71:0) after 1m0s
[22:10:23.756] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:71:0)
[22:10:23.756] Timer tick, asking Buildbucket for the build status
[22:10:23.829] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:23.829] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:72:0) after 1m0s
[22:11:23.921] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:72:0)
[22:11:23.921] Timer tick, asking Buildbucket for the build status
[22:11:24.270] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:24.270] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:73:0) after 1m0s
[22:12:24.614] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:73:0)
[22:12:24.614] Timer tick, asking Buildbucket for the build status
[22:12:26.460] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:26.460] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:74:0) after 1m0s
[22:13:26.490] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:74:0)
[22:13:26.490] Timer tick, asking Buildbucket for the build status
[22:13:26.790] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:26.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:75:0) after 1m0s
[22:14:27.019] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:75:0)
[22:14:27.019] Timer tick, asking Buildbucket for the build status
[22:14:27.353] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:27.353] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:76:0) after 1m0s
[22:15:27.609] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:76:0)
[22:15:27.609] Timer tick, asking Buildbucket for the build status
[22:15:27.727] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:27.727] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:77:0) after 1m0s
[22:16:27.934] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:77:0)
[22:16:27.934] Timer tick, asking Buildbucket for the build status
[22:16:28.366] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:28.366] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:78:0) after 1m0s
[22:17:28.470] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:78:0)
[22:17:28.470] Timer tick, asking Buildbucket for the build status
[22:17:28.654] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:28.654] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:79:0) after 1m0s
[22:18:28.667] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:79:0)
[22:18:28.667] Timer tick, asking Buildbucket for the build status
[22:18:28.751] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:28.751] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:80:0) after 1m0s
[22:19:28.743] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:80:0)
[22:19:28.743] Timer tick, asking Buildbucket for the build status
[22:19:28.853] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:28.853] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:81:0) after 1m0s
[22:20:28.953] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:81:0)
[22:20:28.953] Timer tick, asking Buildbucket for the build status
[22:20:29.110] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:29.110] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:82:0) after 1m0s
[22:21:29.209] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:82:0)
[22:21:29.209] Timer tick, asking Buildbucket for the build status
[22:21:29.405] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:29.405] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:83:0) after 1m0s
[22:22:29.467] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:83:0)
[22:22:29.467] Timer tick, asking Buildbucket for the build status
[22:22:29.839] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:29.839] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:84:0) after 1m0s
[22:23:29.923] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:84:0)
[22:23:29.923] Timer tick, asking Buildbucket for the build status
[22:23:30.732] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:30.732] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:85:0) after 1m0s
[22:24:30.782] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:85:0)
[22:24:30.782] Timer tick, asking Buildbucket for the build status
[22:24:30.840] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:30.840] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:86:0) after 1m0s
[22:25:30.850] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:86:0)
[22:25:30.850] Timer tick, asking Buildbucket for the build status
[22:25:31.033] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:31.033] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:87:0) after 1m0s
[22:26:31.097] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:87:0)
[22:26:31.097] Timer tick, asking Buildbucket for the build status
[22:26:31.601] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:31.601] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:88:0) after 1m0s
[22:27:31.665] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:88:0)
[22:27:31.665] Timer tick, asking Buildbucket for the build status
[22:27:31.917] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:31.917] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:89:0) after 1m0s
[22:28:31.964] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:89:0)
[22:28:31.964] Timer tick, asking Buildbucket for the build status
[22:28:32.223] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:32.223] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:90:0) after 1m0s
[22:29:32.253] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:90:0)
[22:29:32.253] Timer tick, asking Buildbucket for the build status
[22:29:32.382] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:32.382] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:91:0) after 1m0s
[22:30:32.474] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:91:0)
[22:30:32.474] Timer tick, asking Buildbucket for the build status
[22:30:32.790] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:32.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:92:0) after 1m0s
[22:31:32.853] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:92:0)
[22:31:32.853] Timer tick, asking Buildbucket for the build status
[22:31:33.714] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:33.714] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:93:0) after 1m0s
[22:32:33.807] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:93:0)
[22:32:33.807] Timer tick, asking Buildbucket for the build status
[22:32:34.070] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:34.070] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:94:0) after 1m0s
[22:33:34.123] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:94:0)
[22:33:34.123] Timer tick, asking Buildbucket for the build status
[22:33:34.199] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:34.199] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:95:0) after 1m0s
[22:34:34.338] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:95:0)
[22:34:34.338] Timer tick, asking Buildbucket for the build status
[22:34:34.471] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:34.471] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:96:0) after 1m0s
[22:35:34.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:96:0)
[22:35:34.525] Timer tick, asking Buildbucket for the build status
[22:35:34.637] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:34.637] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:97:0) after 1m0s
[22:36:34.717] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:97:0)
[22:36:34.717] Timer tick, asking Buildbucket for the build status
[22:36:34.831] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:34.831] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:98:0) after 1m0s
[22:37:34.860] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:98:0)
[22:37:34.860] Timer tick, asking Buildbucket for the build status
[22:37:34.925] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:34.925] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:99:0) after 1m0s
[22:38:34.977] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:99:0)
[22:38:34.977] Timer tick, asking Buildbucket for the build status
[22:38:35.104] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:35.104] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:100:0) after 1m0s
[22:39:35.092] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:100:0)
[22:39:35.092] Timer tick, asking Buildbucket for the build status
[22:39:35.304] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:35.304] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:101:0) after 1m0s
[22:40:35.331] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:101:0)
[22:40:35.331] Timer tick, asking Buildbucket for the build status
[22:40:35.420] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:35.420] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:102:0) after 1m0s
[22:41:35.671] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:102:0)
[22:41:35.671] Timer tick, asking Buildbucket for the build status
[22:41:35.773] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:35.773] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:103:0) after 1m0s
[22:42:35.815] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:103:0)
[22:42:35.815] Timer tick, asking Buildbucket for the build status
[22:42:36.374] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:36.374] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:104:0) after 1m0s
[22:43:36.734] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:104:0)
[22:43:36.734] Timer tick, asking Buildbucket for the build status
[22:43:36.832] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:36.832] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:105:0) after 1m0s
[22:44:36.951] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:105:0)
[22:44:36.951] Timer tick, asking Buildbucket for the build status
[22:44:37.236] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:37.236] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:106:0) after 1m0s
[22:45:37.272] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:106:0)
[22:45:37.272] Timer tick, asking Buildbucket for the build status
[22:45:37.590] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:37.590] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:107:0) after 1m0s
[22:46:37.616] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:107:0)
[22:46:37.616] Timer tick, asking Buildbucket for the build status
[22:46:38.034] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:38.034] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:108:0) after 1m0s
[22:47:38.101] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:108:0)
[22:47:38.101] Timer tick, asking Buildbucket for the build status
[22:47:38.176] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:38.177] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:109:0) after 1m0s
[22:48:38.189] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:109:0)
[22:48:38.189] Timer tick, asking Buildbucket for the build status
[22:48:38.261] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:38.261] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:110:0) after 1m0s
[22:49:38.300] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:110:0)
[22:49:38.300] Timer tick, asking Buildbucket for the build status
[22:49:38.363] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:38.363] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:111:0) after 1m0s
[22:50:38.459] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:111:0)
[22:50:38.459] Timer tick, asking Buildbucket for the build status
[22:50:38.545] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:38.545] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:112:0) after 1m0s
[22:51:38.638] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:112:0)
[22:51:38.638] Timer tick, asking Buildbucket for the build status
[22:51:38.746] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:38.746] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:113:0) after 1m0s
[22:52:38.833] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:113:0)
[22:52:38.833] Timer tick, asking Buildbucket for the build status
[22:52:38.893] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:38.893] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:114:0) after 1m0s
[22:53:38.982] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:114:0)
[22:53:38.982] Timer tick, asking Buildbucket for the build status
[22:53:39.051] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:39.051] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:115:0) after 1m0s
[22:54:39.086] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:115:0)
[22:54:39.086] Timer tick, asking Buildbucket for the build status
[22:54:39.199] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:39.199] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:116:0) after 1m0s
[22:55:39.229] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:116:0)
[22:55:39.229] Timer tick, asking Buildbucket for the build status
[22:55:39.539] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:39.539] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:117:0) after 1m0s
[22:56:39.693] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:117:0)
[22:56:39.693] Timer tick, asking Buildbucket for the build status
[22:56:39.842] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:39.842] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:118:0) after 1m0s
[22:57:39.992] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:118:0)
[22:57:39.992] Timer tick, asking Buildbucket for the build status
[22:57:40.088] Build 8863894537631668384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:40.088] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9029324600225859968:119:0) after 1m0s
[22:57:57.189] Received PubSub notification, asking Buildbucket for the build status
[22:57:57.450] Build 8863894537631668384: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:57:57.450] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605135475657957",
"created_by": "project:chromium",
"created_ts": "1605128458335101",
"id": "8863894537631668384",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b\", \"project\": \"chromium/src\"}], \"$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}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-45-dodu\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 6085, \"got_angle_revision\": \"c360709829e16ddfbc97070219cdc414e5e59fb3\", \"got_dawn_revision\": \"f3c829047220ec1305c6a3202ee3e067e10512c9\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b\", \"got_revision_cp\": \"refs/heads/master@{#826455}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"4ed9d3498dcffa987acba1a8007ff8dec336f263\", \"got_v8_revision\": \"48a46dd6ca17622005303c3c0f505485e4846405\", \"got_v8_revision_cp\": \"refs/heads/8.8.281@{#1}\", \"got_webrtc_revision\": \"06bbeb3398afa8651ca76ea7eb56b7d046edfca8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32588}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.android:android-bfcache-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b\", \"swarm_hashes_refs/heads/master(at){#826455}_without_patch\": {\"android_browsertests\": \"c5c4d4a7ad32fff8221940c7a8e7f11ac62f086a\", \"chrome_public_test_apk\": \"a018076d1ba0378df57abe4af3d2f8ed15fdd427\", \"content_browsertests\": \"a0c7aa0caf01d4bed8357264dd5e8cbcae12ed9a\", \"content_shell_test_apk\": \"aa96ee7d4cc63db6ceb6dc502a1acd17f5962dd9\", \"content_unittests\": \"1f15e9502c7c93b6d3f336e0a384a788141e5e6e\", \"unit_tests\": \"6587a559a2fc96a5757f2853b4f2ecc11fdd0141\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_6887d226fea03ae8e203d0a1d4c9e197b929dd99abf2bafb38063e06e39bc1ba_v2\", \"builder_9b311965bcdd39b39aa4e18428ed38a374d2d5d9f2ab24593845b266390676f3_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"builder_de45c485d8a81e16b8ff53eb76d94467eed5e11e118465311a13e72e2b141cb1_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-45-dodu\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605128466584666",
"status": "COMPLETED",
"status_changed_ts": "1605135476300294",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/6085",
"builder:android-bfcache-rel",
"buildset:commit/git/e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e5b1d3a1bdbc2829f34614b730ad3fdef7c08a4b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029324600225859968",
"scheduler_job_id:chromium/android-bfcache-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8863894537631668384/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4fd1ee21f5b7b510",
"user_agent:luci-scheduler"
],
"updated_ts": "1605135476348717",
"url": "https://ci.chromium.org/b/8863894537631668384",
"utcnow_ts": "1605135477435325"
}
}
[22:57:57.450] Invocation finished in 1h57m0.973297383s with status SUCCEEDED