[19:26:06.972] New invocation is queued and will start shortly
[19:26:09.088] Starting the invocation (attempt 1)
[19:26:09.138] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:26:09.138] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:26:09.138] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034403996244700672",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b2ae430dd485020af3cd3caa47222b5c7eb3672b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9034403996244700672",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/b2ae430dd485020af3cd3caa47222b5c7eb3672b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2ae430dd485020af3cd3caa47222b5c7eb3672b",
"gitiles_ref:refs/heads/master"
]
}
[19:26:10.221] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1600284369267820",
"id": "8868973933170008880",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b2ae430dd485020af3cd3caa47222b5c7eb3672b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600284370028196",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/5067",
"builder:android-bfcache-rel",
"buildset:commit/git/b2ae430dd485020af3cd3caa47222b5c7eb3672b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2ae430dd485020af3cd3caa47222b5c7eb3672b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034403996244700672",
"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/8868973933170008880/+/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": "1600284370028313",
"url": "https://ci.chromium.org/b/8868973933170008880",
"utcnow_ts": "1600284370210766"
}
}
[19:26:10.221] Task URL: https://ci.chromium.org/b/8868973933170008880
[19:26:10.221] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:2:0) after 1m0s
[19:26:35.572] Received PubSub notification, asking Buildbucket for the build status
[19:26:35.713] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:10.547] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:2:0)
[19:27:10.547] Timer tick, asking Buildbucket for the build status
[19:27:11.350] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:11.350] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:4:0) after 1m0s
[19:28:11.625] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:4:0)
[19:28:11.625] Timer tick, asking Buildbucket for the build status
[19:28:11.716] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:11.716] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:5:0) after 1m0s
[19:29:11.739] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:5:0)
[19:29:11.739] Timer tick, asking Buildbucket for the build status
[19:29:11.795] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:11.795] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:6:0) after 1m0s
[19:30:11.837] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:6:0)
[19:30:11.837] Timer tick, asking Buildbucket for the build status
[19:30:11.914] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:11.914] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:7:0) after 1m0s
[19:31:12.019] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:7:0)
[19:31:12.019] Timer tick, asking Buildbucket for the build status
[19:31:12.139] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:12.139] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:8:0) after 1m0s
[19:32:12.202] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:8:0)
[19:32:12.202] Timer tick, asking Buildbucket for the build status
[19:32:12.393] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:12.393] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:9:0) after 1m0s
[19:33:12.485] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:9:0)
[19:33:12.485] Timer tick, asking Buildbucket for the build status
[19:33:12.564] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:12.564] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:10:0) after 1m0s
[19:34:12.598] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:10:0)
[19:34:12.598] Timer tick, asking Buildbucket for the build status
[19:34:12.774] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:12.776] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:11:0) after 1m0s
[19:35:12.882] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:11:0)
[19:35:12.882] Timer tick, asking Buildbucket for the build status
[19:35:13.011] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:13.011] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:12:0) after 1m0s
[19:36:13.114] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:12:0)
[19:36:13.114] Timer tick, asking Buildbucket for the build status
[19:36:13.255] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:13.255] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:13:0) after 1m0s
[19:37:13.391] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:13:0)
[19:37:13.391] Timer tick, asking Buildbucket for the build status
[19:37:13.461] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:13.461] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:14:0) after 1m0s
[19:38:13.480] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:14:0)
[19:38:13.480] Timer tick, asking Buildbucket for the build status
[19:38:13.619] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:13.619] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:15:0) after 1m0s
[19:39:13.687] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:15:0)
[19:39:13.687] Timer tick, asking Buildbucket for the build status
[19:39:17.730] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:17.730] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:16:0) after 1m0s
[19:40:17.821] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:16:0)
[19:40:17.821] Timer tick, asking Buildbucket for the build status
[19:40:19.432] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:19.432] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:17:0) after 1m0s
[19:41:19.437] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:17:0)
[19:41:19.437] Timer tick, asking Buildbucket for the build status
[19:41:22.474] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:22.474] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:18:0) after 1m0s
[19:42:22.498] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:18:0)
[19:42:22.498] Timer tick, asking Buildbucket for the build status
[19:42:22.580] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:22.580] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:19:0) after 1m0s
[19:43:22.647] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:19:0)
[19:43:22.647] Timer tick, asking Buildbucket for the build status
[19:43:22.941] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:22.941] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:20:0) after 1m0s
[19:44:22.946] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:20:0)
[19:44:22.946] Timer tick, asking Buildbucket for the build status
[19:44:23.028] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:23.028] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:21:0) after 1m0s
[19:45:23.076] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:21:0)
[19:45:23.076] Timer tick, asking Buildbucket for the build status
[19:45:23.234] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:23.234] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:22:0) after 1m0s
[19:46:23.309] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:22:0)
[19:46:23.309] Timer tick, asking Buildbucket for the build status
[19:46:23.454] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:23.454] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:23:0) after 1m0s
[19:47:23.479] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:23:0)
[19:47:23.479] Timer tick, asking Buildbucket for the build status
[19:47:23.550] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:23.550] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:24:0) after 1m0s
[19:48:23.693] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:24:0)
[19:48:23.693] Timer tick, asking Buildbucket for the build status
[19:48:23.767] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:23.767] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:25:0) after 1m0s
[19:49:23.870] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:25:0)
[19:49:23.870] Timer tick, asking Buildbucket for the build status
[19:49:23.945] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:23.945] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:26:0) after 1m0s
[19:50:24.016] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:26:0)
[19:50:24.016] Timer tick, asking Buildbucket for the build status
[19:50:24.093] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:24.093] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:27:0) after 1m0s
[19:51:24.127] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:27:0)
[19:51:24.127] Timer tick, asking Buildbucket for the build status
[19:51:24.243] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:24.243] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:28:0) after 1m0s
[19:52:24.328] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:28:0)
[19:52:24.328] Timer tick, asking Buildbucket for the build status
[19:52:24.446] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:24.447] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:29:0) after 1m0s
[19:53:24.644] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:29:0)
[19:53:24.644] Timer tick, asking Buildbucket for the build status
[19:53:24.728] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:24.728] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:30:0) after 1m0s
[19:54:24.786] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:30:0)
[19:54:24.786] Timer tick, asking Buildbucket for the build status
[19:54:24.935] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:24.936] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:31:0) after 1m0s
[19:55:24.975] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:31:0)
[19:55:24.975] Timer tick, asking Buildbucket for the build status
[19:55:25.094] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:25.094] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:32:0) after 1m0s
[19:56:25.143] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:32:0)
[19:56:25.143] Timer tick, asking Buildbucket for the build status
[19:56:25.262] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:25.262] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:33:0) after 1m0s
[19:57:25.431] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:33:0)
[19:57:25.432] Timer tick, asking Buildbucket for the build status
[19:57:25.683] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:25.683] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:34:0) after 1m0s
[19:58:25.970] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:34:0)
[19:58:25.970] Timer tick, asking Buildbucket for the build status
[19:58:26.072] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:26.072] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:35:0) after 1m0s
[19:59:26.135] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:35:0)
[19:59:26.135] Timer tick, asking Buildbucket for the build status
[19:59:26.239] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:26.239] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:36:0) after 1m0s
[20:00:26.285] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:36:0)
[20:00:26.285] Timer tick, asking Buildbucket for the build status
[20:00:26.376] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:26.376] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:37:0) after 1m0s
[20:01:26.501] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:37:0)
[20:01:26.501] Timer tick, asking Buildbucket for the build status
[20:01:27.991] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:27.991] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:38:0) after 1m0s
[20:02:28.108] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:38:0)
[20:02:28.108] Timer tick, asking Buildbucket for the build status
[20:02:28.351] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:28.352] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:39:0) after 1m0s
[20:03:28.458] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:39:0)
[20:03:28.458] Timer tick, asking Buildbucket for the build status
[20:03:28.608] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:28.608] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:40:0) after 1m0s
[20:04:28.649] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:40:0)
[20:04:28.649] Timer tick, asking Buildbucket for the build status
[20:04:28.736] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:28.736] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:41:0) after 1m0s
[20:05:28.893] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:41:0)
[20:05:28.893] Timer tick, asking Buildbucket for the build status
[20:05:29.165] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:29.165] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:42:0) after 1m0s
[20:06:29.201] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:42:0)
[20:06:29.201] Timer tick, asking Buildbucket for the build status
[20:06:30.404] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:30.404] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:43:0) after 1m0s
[20:07:30.568] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:43:0)
[20:07:30.568] Timer tick, asking Buildbucket for the build status
[20:07:31.230] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:31.230] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:44:0) after 1m0s
[20:08:31.294] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:44:0)
[20:08:31.294] Timer tick, asking Buildbucket for the build status
[20:08:31.396] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:31.396] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:45:0) after 1m0s
[20:09:31.489] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:45:0)
[20:09:31.489] Timer tick, asking Buildbucket for the build status
[20:09:31.667] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:31.667] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:46:0) after 1m0s
[20:10:31.722] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:46:0)
[20:10:31.722] Timer tick, asking Buildbucket for the build status
[20:10:33.761] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:33.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:47:0) after 1m0s
[20:11:33.852] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:47:0)
[20:11:33.852] Timer tick, asking Buildbucket for the build status
[20:11:33.979] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:33.979] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:48:0) after 1m0s
[20:12:34.250] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:48:0)
[20:12:34.250] Timer tick, asking Buildbucket for the build status
[20:12:34.338] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:34.338] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:49:0) after 1m0s
[20:13:34.372] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:49:0)
[20:13:34.372] Timer tick, asking Buildbucket for the build status
[20:13:34.465] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:34.465] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:50:0) after 1m0s
[20:14:34.523] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:50:0)
[20:14:34.523] Timer tick, asking Buildbucket for the build status
[20:14:34.586] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:34.586] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:51:0) after 1m0s
[20:15:34.686] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:51:0)
[20:15:34.686] Timer tick, asking Buildbucket for the build status
[20:15:34.827] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:34.827] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:52:0) after 1m0s
[20:16:34.874] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:52:0)
[20:16:34.874] Timer tick, asking Buildbucket for the build status
[20:16:35.048] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:35.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:53:0) after 1m0s
[20:17:35.113] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:53:0)
[20:17:35.113] Timer tick, asking Buildbucket for the build status
[20:17:35.218] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:35.218] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:54:0) after 1m0s
[20:18:35.339] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:54:0)
[20:18:35.339] Timer tick, asking Buildbucket for the build status
[20:18:35.453] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:35.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:55:0) after 1m0s
[20:19:35.555] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:55:0)
[20:19:35.555] Timer tick, asking Buildbucket for the build status
[20:19:35.806] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:35.806] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:56:0) after 1m0s
[20:20:35.871] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:56:0)
[20:20:35.871] Timer tick, asking Buildbucket for the build status
[20:20:36.017] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:36.017] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:57:0) after 1m0s
[20:21:36.095] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:57:0)
[20:21:36.095] Timer tick, asking Buildbucket for the build status
[20:21:36.244] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:36.244] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:58:0) after 1m0s
[20:22:36.365] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:58:0)
[20:22:36.365] Timer tick, asking Buildbucket for the build status
[20:22:36.466] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:36.466] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:59:0) after 1m0s
[20:23:36.515] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:59:0)
[20:23:36.515] Timer tick, asking Buildbucket for the build status
[20:23:36.578] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:36.578] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:60:0) after 1m0s
[20:24:36.651] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:60:0)
[20:24:36.651] Timer tick, asking Buildbucket for the build status
[20:24:36.723] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:36.723] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:61:0) after 1m0s
[20:25:36.917] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:61:0)
[20:25:36.917] Timer tick, asking Buildbucket for the build status
[20:25:37.188] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:37.188] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:62:0) after 1m0s
[20:26:37.271] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:62:0)
[20:26:37.271] Timer tick, asking Buildbucket for the build status
[20:26:37.379] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:37.379] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:63:0) after 1m0s
[20:27:37.490] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:63:0)
[20:27:37.490] Timer tick, asking Buildbucket for the build status
[20:27:37.577] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:37.577] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:64:0) after 1m0s
[20:28:37.604] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:64:0)
[20:28:37.604] Timer tick, asking Buildbucket for the build status
[20:28:37.667] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:37.667] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:65:0) after 1m0s
[20:29:37.696] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:65:0)
[20:29:37.696] Timer tick, asking Buildbucket for the build status
[20:29:38.469] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:38.469] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:66:0) after 1m0s
[20:30:38.678] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:66:0)
[20:30:38.678] Timer tick, asking Buildbucket for the build status
[20:30:38.745] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:38.745] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:67:0) after 1m0s
[20:31:38.815] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:67:0)
[20:31:38.815] Timer tick, asking Buildbucket for the build status
[20:31:39.238] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:39.238] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:68:0) after 1m0s
[20:32:39.262] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:68:0)
[20:32:39.262] Timer tick, asking Buildbucket for the build status
[20:32:39.534] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:39.534] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:69:0) after 1m0s
[20:33:39.562] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:69:0)
[20:33:39.562] Timer tick, asking Buildbucket for the build status
[20:33:39.643] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:39.643] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:70:0) after 1m0s
[20:34:39.727] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:70:0)
[20:34:39.727] Timer tick, asking Buildbucket for the build status
[20:34:39.987] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:39.987] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:71:0) after 1m0s
[20:35:40.049] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:71:0)
[20:35:40.049] Timer tick, asking Buildbucket for the build status
[20:35:42.450] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:42.450] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:72:0) after 1m0s
[20:36:42.537] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:72:0)
[20:36:42.537] Timer tick, asking Buildbucket for the build status
[20:36:42.652] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:42.653] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:73:0) after 1m0s
[20:37:42.749] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:73:0)
[20:37:42.749] Timer tick, asking Buildbucket for the build status
[20:37:42.832] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:42.832] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:74:0) after 1m0s
[20:38:42.944] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:74:0)
[20:38:42.945] Timer tick, asking Buildbucket for the build status
[20:38:43.247] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:43.247] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:75:0) after 1m0s
[20:39:43.298] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:75:0)
[20:39:43.298] Timer tick, asking Buildbucket for the build status
[20:39:44.049] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:44.049] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:76:0) after 1m0s
[20:40:44.075] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:76:0)
[20:40:44.075] Timer tick, asking Buildbucket for the build status
[20:40:44.232] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:44.232] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:77:0) after 1m0s
[20:41:44.209] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:77:0)
[20:41:44.209] Timer tick, asking Buildbucket for the build status
[20:41:44.487] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:44.488] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:78:0) after 1m0s
[20:42:44.547] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:78:0)
[20:42:44.547] Timer tick, asking Buildbucket for the build status
[20:42:44.629] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:44.629] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:79:0) after 1m0s
[20:43:44.781] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:79:0)
[20:43:44.781] Timer tick, asking Buildbucket for the build status
[20:43:45.093] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:45.093] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:80:0) after 1m0s
[20:44:45.131] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:80:0)
[20:44:45.131] Timer tick, asking Buildbucket for the build status
[20:44:45.280] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:45.280] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:81:0) after 1m0s
[20:45:45.337] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:81:0)
[20:45:45.337] Timer tick, asking Buildbucket for the build status
[20:45:45.533] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:45.533] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:82:0) after 1m0s
[20:46:45.533] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:82:0)
[20:46:45.533] Timer tick, asking Buildbucket for the build status
[20:46:45.895] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:45.895] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:83:0) after 1m0s
[20:47:45.927] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:83:0)
[20:47:45.927] Timer tick, asking Buildbucket for the build status
[20:47:47.474] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:47.475] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:84:0) after 1m0s
[20:48:47.628] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:84:0)
[20:48:47.628] Timer tick, asking Buildbucket for the build status
[20:48:47.742] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:47.742] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:85:0) after 1m0s
[20:49:47.818] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:85:0)
[20:49:47.818] Timer tick, asking Buildbucket for the build status
[20:49:47.888] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:47.888] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:86:0) after 1m0s
[20:50:47.947] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:86:0)
[20:50:47.947] Timer tick, asking Buildbucket for the build status
[20:50:48.019] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:48.019] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:87:0) after 1m0s
[20:51:48.128] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:87:0)
[20:51:48.128] Timer tick, asking Buildbucket for the build status
[20:51:48.341] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:48.341] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:88:0) after 1m0s
[20:52:48.352] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:88:0)
[20:52:48.352] Timer tick, asking Buildbucket for the build status
[20:52:48.426] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:48.426] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:89:0) after 1m0s
[20:53:48.444] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:89:0)
[20:53:48.444] Timer tick, asking Buildbucket for the build status
[20:53:48.512] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:48.512] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:90:0) after 1m0s
[20:54:48.526] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:90:0)
[20:54:48.526] Timer tick, asking Buildbucket for the build status
[20:54:48.594] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:48.594] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:91:0) after 1m0s
[20:55:48.619] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:91:0)
[20:55:48.619] Timer tick, asking Buildbucket for the build status
[20:55:48.923] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:48.923] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:92:0) after 1m0s
[20:56:49.031] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:92:0)
[20:56:49.031] Timer tick, asking Buildbucket for the build status
[20:56:49.183] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:49.184] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:93:0) after 1m0s
[20:57:49.229] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:93:0)
[20:57:49.229] Timer tick, asking Buildbucket for the build status
[20:57:49.303] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:49.303] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:94:0) after 1m0s
[20:58:49.378] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:94:0)
[20:58:49.378] Timer tick, asking Buildbucket for the build status
[20:58:49.452] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:49.452] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:95:0) after 1m0s
[20:59:49.435] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:95:0)
[20:59:49.435] Timer tick, asking Buildbucket for the build status
[20:59:49.525] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:49.525] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:96:0) after 1m0s
[21:00:49.557] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:96:0)
[21:00:49.557] Timer tick, asking Buildbucket for the build status
[21:00:49.674] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:49.674] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:97:0) after 1m0s
[21:01:49.706] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:97:0)
[21:01:49.706] Timer tick, asking Buildbucket for the build status
[21:01:49.836] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:49.836] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:98:0) after 1m0s
[21:02:49.937] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:98:0)
[21:02:49.937] Timer tick, asking Buildbucket for the build status
[21:02:50.057] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:50.057] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:99:0) after 1m0s
[21:03:50.119] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:99:0)
[21:03:50.119] Timer tick, asking Buildbucket for the build status
[21:03:50.311] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:50.311] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:100:0) after 1m0s
[21:04:50.392] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:100:0)
[21:04:50.392] Timer tick, asking Buildbucket for the build status
[21:04:50.510] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:50.510] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:101:0) after 1m0s
[21:05:50.588] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:101:0)
[21:05:50.588] Timer tick, asking Buildbucket for the build status
[21:05:50.662] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:50.662] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:102:0) after 1m0s
[21:06:50.745] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:102:0)
[21:06:50.745] Timer tick, asking Buildbucket for the build status
[21:06:50.896] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:50.896] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:103:0) after 1m0s
[21:07:50.958] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:103:0)
[21:07:50.958] Timer tick, asking Buildbucket for the build status
[21:07:51.408] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:51.408] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:104:0) after 1m0s
[21:08:51.443] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:104:0)
[21:08:51.443] Timer tick, asking Buildbucket for the build status
[21:08:51.513] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:51.513] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:105:0) after 1m0s
[21:09:51.680] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:105:0)
[21:09:51.680] Timer tick, asking Buildbucket for the build status
[21:09:51.872] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:51.872] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:106:0) after 1m0s
[21:10:52.204] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:106:0)
[21:10:52.204] Timer tick, asking Buildbucket for the build status
[21:10:52.281] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:52.281] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:107:0) after 1m0s
[21:11:52.385] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:107:0)
[21:11:52.385] Timer tick, asking Buildbucket for the build status
[21:11:52.542] Build 8868973933170008880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:52.543] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034403996244700672:108:0) after 1m0s
[21:12:01.876] Received PubSub notification, asking Buildbucket for the build status
[21:12:04.225] Build 8868973933170008880: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:12:04.225] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1600290721293012",
"created_by": "project:chromium",
"created_ts": "1600284369267820",
"failure_reason": "BUILD_FAILURE",
"id": "8868973933170008880",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b2ae430dd485020af3cd3caa47222b5c7eb3672b\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.browser.modaldialog.ChromeTabModalPresenterTest#testShow_UrlBarFocused\\n\\n- org.chromium.chrome.browser.autofill_assistant.AutofillAssistantGenericUiTest#testShowPopupIfClickedAtLeastThreeTimes\\n\\n- org.chromium.chrome.browser.ntp.cards.promo.HomepagePromoTest#testDismiss_Large\\n\\n- org.chromium.chrome.browser.keyboard_accessory.ManualFillingIntegrationTest#testPressingBackButtonHidesAccessorySheet\\n\\n- ...23 more failure(s) (27 total)...\"}, \"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\": \"b2ae430dd485020af3cd3caa47222b5c7eb3672b\", \"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-122-3v56\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 5067, \"got_angle_revision\": \"3018d5e57091200217e2bd688df28f52f079bab9\", \"got_dawn_revision\": \"c2367695483858cf61d59f34a41c0ead0aac7776\", \"got_nacl_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"got_revision\": \"b2ae430dd485020af3cd3caa47222b5c7eb3672b\", \"got_revision_cp\": \"refs/heads/master@{#807607}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"fe878dedd5addbedab4033c0cb6b19bbbe04f8e4\", \"got_v8_revision\": \"69e493145e02a3a292683e577892fedb6f4964fb\", \"got_v8_revision_cp\": \"refs/heads/8.7.110@{#1}\", \"got_webrtc_revision\": \"78e9acd9672649f2660ebd054bd1ce16828d992f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32116}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b2ae430dd485020af3cd3caa47222b5c7eb3672b\", \"swarm_hashes\": {\"android_browsertests\": \"9708835ec4bc96e7852ff853c4420fe62a44a10e\", \"chrome_public_test_apk\": \"8548104ab913032593d729fcf7aaf5ed4c7ab2be\", \"content_browsertests\": \"1362413fd91d844c2ff36556ead0201318b141fe\", \"content_shell_test_apk\": \"0545cf485140b0c4c7c8fcea7ba1a1065e577b6a\", \"content_unittests\": \"b9c8bf45416324bf0e02d03f271aae24c49301b9\", \"unit_tests\": \"5d2f8a16f1fe364f297feb6ac8a5b3689e32090a\"}, \"swarm_hashes_refs/heads/master(at){#807607}_without_patch\": {\"android_browsertests\": \"9708835ec4bc96e7852ff853c4420fe62a44a10e\", \"chrome_public_test_apk\": \"8548104ab913032593d729fcf7aaf5ed4c7ab2be\", \"content_browsertests\": \"1362413fd91d844c2ff36556ead0201318b141fe\", \"content_shell_test_apk\": \"0545cf485140b0c4c7c8fcea7ba1a1065e577b6a\", \"content_unittests\": \"b9c8bf45416324bf0e02d03f271aae24c49301b9\", \"unit_tests\": \"5d2f8a16f1fe364f297feb6ac8a5b3689e32090a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_v2\", \"builder_ea6f1332cf6753d9a1f310f0d5b8921378658a09424260c337767cc054aa30d1_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-122-3v56\"], \"image\": [\"chrome-xenial-20090600-f98a2a06cf8\"], \"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\": [\"5522-67570db\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.browser.modaldialog.ChromeTabModalPresenterTest#testShow_UrlBarFocused\\n\\n- org.chromium.chrome.browser.autofill_assistant.AutofillAssistantGenericUiTest#testShowPopupIfClickedAtLeastThreeTimes\\n\\n- org.chromium.chrome.browser.ntp.cards.promo.HomepagePromoTest#testDismiss_Large\\n\\n- org.chromium.chrome.browser.keyboard_accessory.ManualFillingIntegrationTest#testPressingBackButtonHidesAccessorySheet\\n\\n- ...23 more failure(s) (27 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1600284394910640",
"status": "COMPLETED",
"status_changed_ts": "1600284395287083",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/5067",
"builder:android-bfcache-rel",
"buildset:commit/git/b2ae430dd485020af3cd3caa47222b5c7eb3672b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2ae430dd485020af3cd3caa47222b5c7eb3672b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034403996244700672",
"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/8868973933170008880/+/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:4eb1332e42fd6310",
"user_agent:luci-scheduler"
],
"updated_ts": "1600290721556795",
"url": "https://ci.chromium.org/b/8868973933170008880",
"utcnow_ts": "1600290724208054"
}
}
[21:12:04.225] Invocation finished in 1h45m57.274051911s with status FAILED