[00:41:48.324] New invocation is queued and will start shortly
[00:41:49.459] Starting the invocation (attempt 1)
[00:41:49.490] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:41:49.491] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:41:49.491] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019345038369713536",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"07ef8d73c7b010a549c9bb960c6f7c73f1346fe5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9019345038369713536",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/07ef8d73c7b010a549c9bb960c6f7c73f1346fe5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/07ef8d73c7b010a549c9bb960c6f7c73f1346fe5",
"gitiles_ref:refs/heads/master"
]
}
[00:41:52.214] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614645711470990",
"id": "8853914974407893168",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"07ef8d73c7b010a549c9bb960c6f7c73f1346fe5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614645711935204",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/8064",
"builder:android-bfcache-rel",
"buildset:commit/git/07ef8d73c7b010a549c9bb960c6f7c73f1346fe5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/07ef8d73c7b010a549c9bb960c6f7c73f1346fe5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019345038369713536",
"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/8853914974407893168/+/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": "1614645711935313",
"url": "https://ci.chromium.org/b/8853914974407893168",
"utcnow_ts": "1614645712208149"
}
}
[00:41:52.214] Task URL: https://ci.chromium.org/b/8853914974407893168
[00:41:52.214] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:2:0) after 1m0s
[00:42:52.231] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:2:0)
[00:42:52.231] Timer tick, asking Buildbucket for the build status
[00:42:53.230] Build 8853914974407893168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:42:53.230] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:3:0) after 1m0s
[00:43:53.248] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:3:0)
[00:43:53.248] Timer tick, asking Buildbucket for the build status
[00:43:53.493] Build 8853914974407893168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:43:53.493] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:4:0) after 1m0s
[00:44:25.077] Received PubSub notification, asking Buildbucket for the build status
[00:44:25.796] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:53.511] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:4:0)
[00:44:53.511] Timer tick, asking Buildbucket for the build status
[00:44:53.608] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:53.608] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:6:0) after 1m0s
[00:45:53.646] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:6:0)
[00:45:53.646] Timer tick, asking Buildbucket for the build status
[00:45:53.712] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:53.712] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:7:0) after 1m0s
[00:46:53.801] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:7:0)
[00:46:53.801] Timer tick, asking Buildbucket for the build status
[00:46:53.894] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:53.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:8:0) after 1m0s
[00:47:53.934] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:8:0)
[00:47:53.934] Timer tick, asking Buildbucket for the build status
[00:47:54.078] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:54.078] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:9:0) after 1m0s
[00:48:54.087] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:9:0)
[00:48:54.087] Timer tick, asking Buildbucket for the build status
[00:48:54.238] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:54.238] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:10:0) after 1m0s
[00:49:54.239] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:10:0)
[00:49:54.239] Timer tick, asking Buildbucket for the build status
[00:49:54.307] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:54.307] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:11:0) after 1m0s
[00:50:54.330] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:11:0)
[00:50:54.330] Timer tick, asking Buildbucket for the build status
[00:50:54.400] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:54.400] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:12:0) after 1m0s
[00:51:54.462] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:12:0)
[00:51:54.462] Timer tick, asking Buildbucket for the build status
[00:51:54.541] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:54.541] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:13:0) after 1m0s
[00:52:54.700] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:13:0)
[00:52:54.700] Timer tick, asking Buildbucket for the build status
[00:52:54.825] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:54.825] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:14:0) after 1m0s
[00:53:56.932] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:14:0)
[00:53:56.932] Timer tick, asking Buildbucket for the build status
[00:53:56.998] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:56.998] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:15:0) after 1m0s
[00:54:58.007] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:15:0)
[00:54:58.007] Timer tick, asking Buildbucket for the build status
[00:54:59.025] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:59.025] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:16:0) after 1m0s
[00:56:00.870] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:16:0)
[00:56:00.870] Timer tick, asking Buildbucket for the build status
[00:56:01.020] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:01.020] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:17:0) after 1m0s
[00:57:01.138] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:17:0)
[00:57:01.138] Timer tick, asking Buildbucket for the build status
[00:57:01.254] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:01.254] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:18:0) after 1m0s
[00:58:01.749] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:18:0)
[00:58:01.749] Timer tick, asking Buildbucket for the build status
[00:58:01.886] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:01.886] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:19:0) after 1m0s
[00:59:02.263] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:19:0)
[00:59:02.263] Timer tick, asking Buildbucket for the build status
[00:59:02.380] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:02.380] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:20:0) after 1m0s
[01:00:02.462] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:20:0)
[01:00:02.462] Timer tick, asking Buildbucket for the build status
[01:00:02.556] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:02.556] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:21:0) after 1m0s
[01:01:02.704] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:21:0)
[01:01:02.704] Timer tick, asking Buildbucket for the build status
[01:01:02.921] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:02.921] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:22:0) after 1m0s
[01:02:03.025] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:22:0)
[01:02:03.025] Timer tick, asking Buildbucket for the build status
[01:02:03.648] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:03.648] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:23:0) after 1m0s
[01:03:03.913] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:23:0)
[01:03:03.913] Timer tick, asking Buildbucket for the build status
[01:03:03.984] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:03.984] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:24:0) after 1m0s
[01:04:04.180] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:24:0)
[01:04:04.180] Timer tick, asking Buildbucket for the build status
[01:04:04.334] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:04.334] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:25:0) after 1m0s
[01:05:04.342] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:25:0)
[01:05:04.342] Timer tick, asking Buildbucket for the build status
[01:05:04.427] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:04.427] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:26:0) after 1m0s
[01:06:04.549] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:26:0)
[01:06:04.549] Timer tick, asking Buildbucket for the build status
[01:06:04.637] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:04.637] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:27:0) after 1m0s
[01:07:04.700] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:27:0)
[01:07:04.700] Timer tick, asking Buildbucket for the build status
[01:07:04.859] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:04.859] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:28:0) after 1m0s
[01:08:04.935] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:28:0)
[01:08:04.935] Timer tick, asking Buildbucket for the build status
[01:08:05.099] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:05.099] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:29:0) after 1m0s
[01:09:05.158] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:29:0)
[01:09:05.158] Timer tick, asking Buildbucket for the build status
[01:09:05.481] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:05.481] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:30:0) after 1m0s
[01:10:05.530] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:30:0)
[01:10:05.530] Timer tick, asking Buildbucket for the build status
[01:10:05.713] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:05.713] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:31:0) after 1m0s
[01:11:05.742] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:31:0)
[01:11:05.742] Timer tick, asking Buildbucket for the build status
[01:11:05.887] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:05.887] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:32:0) after 1m0s
[01:12:05.949] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:32:0)
[01:12:05.949] Timer tick, asking Buildbucket for the build status
[01:12:06.013] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:06.013] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:33:0) after 1m0s
[01:13:06.127] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:33:0)
[01:13:06.127] Timer tick, asking Buildbucket for the build status
[01:13:06.261] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:06.261] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:34:0) after 1m0s
[01:14:06.294] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:34:0)
[01:14:06.294] Timer tick, asking Buildbucket for the build status
[01:14:06.457] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:06.457] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:35:0) after 1m0s
[01:15:06.453] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:35:0)
[01:15:06.453] Timer tick, asking Buildbucket for the build status
[01:15:06.521] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:06.521] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:36:0) after 1m0s
[01:16:06.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:36:0)
[01:16:06.525] Timer tick, asking Buildbucket for the build status
[01:16:06.604] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:06.604] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:37:0) after 1m0s
[01:17:06.620] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:37:0)
[01:17:06.620] Timer tick, asking Buildbucket for the build status
[01:17:06.680] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:06.680] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:38:0) after 1m0s
[01:18:06.692] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:38:0)
[01:18:06.692] Timer tick, asking Buildbucket for the build status
[01:18:06.760] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:06.760] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:39:0) after 1m0s
[01:19:06.865] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:39:0)
[01:19:06.865] Timer tick, asking Buildbucket for the build status
[01:19:06.951] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:06.951] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:40:0) after 1m0s
[01:20:07.193] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:40:0)
[01:20:07.193] Timer tick, asking Buildbucket for the build status
[01:20:07.750] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:07.750] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:41:0) after 1m0s
[01:21:07.752] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:41:0)
[01:21:07.752] Timer tick, asking Buildbucket for the build status
[01:21:07.827] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:07.827] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:42:0) after 1m0s
[01:22:07.896] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:42:0)
[01:22:07.896] Timer tick, asking Buildbucket for the build status
[01:22:08.238] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:08.238] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:43:0) after 1m0s
[01:23:08.282] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:43:0)
[01:23:08.282] Timer tick, asking Buildbucket for the build status
[01:23:08.367] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:08.367] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:44:0) after 1m0s
[01:24:08.386] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:44:0)
[01:24:08.386] Timer tick, asking Buildbucket for the build status
[01:24:08.534] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:08.534] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:45:0) after 1m0s
[01:25:08.597] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:45:0)
[01:25:08.597] Timer tick, asking Buildbucket for the build status
[01:25:08.830] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:08.830] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:46:0) after 1m0s
[01:26:08.923] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:46:0)
[01:26:08.923] Timer tick, asking Buildbucket for the build status
[01:26:09.083] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:09.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:47:0) after 1m0s
[01:27:09.565] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:47:0)
[01:27:09.565] Timer tick, asking Buildbucket for the build status
[01:27:10.013] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:10.013] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:48:0) after 1m0s
[01:28:10.605] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:48:0)
[01:28:10.605] Timer tick, asking Buildbucket for the build status
[01:28:10.686] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:10.686] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:49:0) after 1m0s
[01:29:10.797] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:49:0)
[01:29:10.797] Timer tick, asking Buildbucket for the build status
[01:29:10.887] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:10.887] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:50:0) after 1m0s
[01:30:10.938] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:50:0)
[01:30:10.938] Timer tick, asking Buildbucket for the build status
[01:30:11.032] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:11.033] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:51:0) after 1m0s
[01:31:11.187] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:51:0)
[01:31:11.187] Timer tick, asking Buildbucket for the build status
[01:31:11.271] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:11.271] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:52:0) after 1m0s
[01:32:11.317] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:52:0)
[01:32:11.317] Timer tick, asking Buildbucket for the build status
[01:32:11.415] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:11.415] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:53:0) after 1m0s
[01:33:11.402] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:53:0)
[01:33:11.402] Timer tick, asking Buildbucket for the build status
[01:33:11.498] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:11.499] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:54:0) after 1m0s
[01:34:11.699] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:54:0)
[01:34:11.699] Timer tick, asking Buildbucket for the build status
[01:34:11.845] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:11.845] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:55:0) after 1m0s
[01:35:11.918] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:55:0)
[01:35:11.918] Timer tick, asking Buildbucket for the build status
[01:35:12.006] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:12.006] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:56:0) after 1m0s
[01:36:12.024] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:56:0)
[01:36:12.024] Timer tick, asking Buildbucket for the build status
[01:36:13.538] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:13.538] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:57:0) after 1m0s
[01:37:13.628] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:57:0)
[01:37:13.628] Timer tick, asking Buildbucket for the build status
[01:37:13.692] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:13.693] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:58:0) after 1m0s
[01:38:13.817] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:58:0)
[01:38:13.817] Timer tick, asking Buildbucket for the build status
[01:38:13.912] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:13.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:59:0) after 1m0s
[01:39:13.992] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:59:0)
[01:39:13.992] Timer tick, asking Buildbucket for the build status
[01:39:14.105] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:14.105] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:60:0) after 1m0s
[01:40:14.169] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:60:0)
[01:40:14.169] Timer tick, asking Buildbucket for the build status
[01:40:14.845] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:14.845] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:61:0) after 1m0s
[01:41:14.877] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:61:0)
[01:41:14.877] Timer tick, asking Buildbucket for the build status
[01:41:15.071] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:15.071] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:62:0) after 1m0s
[01:42:15.147] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:62:0)
[01:42:15.147] Timer tick, asking Buildbucket for the build status
[01:42:16.193] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:16.193] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:63:0) after 1m0s
[01:43:16.324] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:63:0)
[01:43:16.324] Timer tick, asking Buildbucket for the build status
[01:43:16.497] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:16.497] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:64:0) after 1m0s
[01:44:16.565] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:64:0)
[01:44:16.565] Timer tick, asking Buildbucket for the build status
[01:44:16.782] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:16.782] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:65:0) after 1m0s
[01:45:16.875] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:65:0)
[01:45:16.875] Timer tick, asking Buildbucket for the build status
[01:45:16.962] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:16.962] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:66:0) after 1m0s
[01:46:16.981] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:66:0)
[01:46:16.981] Timer tick, asking Buildbucket for the build status
[01:46:17.364] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:17.364] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:67:0) after 1m0s
[01:47:17.363] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:67:0)
[01:47:17.363] Timer tick, asking Buildbucket for the build status
[01:47:17.475] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:17.475] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:68:0) after 1m0s
[01:48:17.456] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:68:0)
[01:48:17.456] Timer tick, asking Buildbucket for the build status
[01:48:17.529] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:17.529] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:69:0) after 1m0s
[01:49:17.593] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:69:0)
[01:49:17.593] Timer tick, asking Buildbucket for the build status
[01:49:17.706] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:17.706] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:70:0) after 1m0s
[01:50:17.785] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:70:0)
[01:50:17.785] Timer tick, asking Buildbucket for the build status
[01:50:17.961] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:17.961] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:71:0) after 1m0s
[01:51:17.993] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:71:0)
[01:51:17.993] Timer tick, asking Buildbucket for the build status
[01:51:18.082] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:18.082] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:72:0) after 1m0s
[01:52:18.149] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:72:0)
[01:52:18.149] Timer tick, asking Buildbucket for the build status
[01:52:18.548] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:18.548] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:73:0) after 1m0s
[01:53:18.585] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:73:0)
[01:53:18.585] Timer tick, asking Buildbucket for the build status
[01:53:18.680] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:18.680] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:74:0) after 1m0s
[01:54:18.758] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:74:0)
[01:54:18.758] Timer tick, asking Buildbucket for the build status
[01:54:19.066] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:19.066] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:75:0) after 1m0s
[01:55:19.133] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:75:0)
[01:55:19.133] Timer tick, asking Buildbucket for the build status
[01:55:19.214] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:19.214] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:76:0) after 1m0s
[01:56:19.227] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:76:0)
[01:56:19.227] Timer tick, asking Buildbucket for the build status
[01:56:19.291] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:19.291] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:77:0) after 1m0s
[01:57:19.324] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:77:0)
[01:57:19.324] Timer tick, asking Buildbucket for the build status
[01:57:19.478] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:19.478] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:78:0) after 1m0s
[01:58:19.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:78:0)
[01:58:19.525] Timer tick, asking Buildbucket for the build status
[01:58:19.608] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:19.608] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:79:0) after 1m0s
[01:59:21.180] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:79:0)
[01:59:21.180] Timer tick, asking Buildbucket for the build status
[01:59:21.367] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:21.367] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:80:0) after 1m0s
[02:00:21.382] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:80:0)
[02:00:21.382] Timer tick, asking Buildbucket for the build status
[02:00:21.969] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:21.969] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:81:0) after 1m0s
[02:01:22.023] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:81:0)
[02:01:22.023] Timer tick, asking Buildbucket for the build status
[02:01:22.114] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:22.114] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:82:0) after 1m0s
[02:02:22.095] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:82:0)
[02:02:22.095] Timer tick, asking Buildbucket for the build status
[02:02:22.307] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:22.307] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:83:0) after 1m0s
[02:03:22.349] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:83:0)
[02:03:22.349] Timer tick, asking Buildbucket for the build status
[02:03:22.449] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:22.449] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:84:0) after 1m0s
[02:04:22.542] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:84:0)
[02:04:22.542] Timer tick, asking Buildbucket for the build status
[02:04:22.750] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:22.750] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:85:0) after 1m0s
[02:05:22.774] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:85:0)
[02:05:22.774] Timer tick, asking Buildbucket for the build status
[02:05:22.847] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:22.847] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:86:0) after 1m0s
[02:06:22.913] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:86:0)
[02:06:22.913] Timer tick, asking Buildbucket for the build status
[02:06:22.981] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:22.981] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:87:0) after 1m0s
[02:07:23.040] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:87:0)
[02:07:23.040] Timer tick, asking Buildbucket for the build status
[02:07:23.176] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:23.176] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:88:0) after 1m0s
[02:08:23.231] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:88:0)
[02:08:23.231] Timer tick, asking Buildbucket for the build status
[02:08:23.300] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:23.300] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:89:0) after 1m0s
[02:09:23.442] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:89:0)
[02:09:23.442] Timer tick, asking Buildbucket for the build status
[02:09:23.526] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:23.526] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:90:0) after 1m0s
[02:10:24.191] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:90:0)
[02:10:24.191] Timer tick, asking Buildbucket for the build status
[02:10:24.287] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:24.287] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:91:0) after 1m0s
[02:11:24.345] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:91:0)
[02:11:24.345] Timer tick, asking Buildbucket for the build status
[02:11:24.415] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:24.415] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:92:0) after 1m0s
[02:12:24.650] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:92:0)
[02:12:24.650] Timer tick, asking Buildbucket for the build status
[02:12:24.758] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:24.758] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:93:0) after 1m0s
[02:13:24.938] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:93:0)
[02:13:24.938] Timer tick, asking Buildbucket for the build status
[02:13:25.021] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:25.021] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:94:0) after 1m0s
[02:14:25.068] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:94:0)
[02:14:25.068] Timer tick, asking Buildbucket for the build status
[02:14:25.166] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:25.166] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:95:0) after 1m0s
[02:15:25.192] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:95:0)
[02:15:25.192] Timer tick, asking Buildbucket for the build status
[02:15:25.316] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:25.316] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:96:0) after 1m0s
[02:16:25.395] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:96:0)
[02:16:25.395] Timer tick, asking Buildbucket for the build status
[02:16:25.581] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:25.581] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:97:0) after 1m0s
[02:17:25.607] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:97:0)
[02:17:25.607] Timer tick, asking Buildbucket for the build status
[02:17:25.806] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:25.806] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:98:0) after 1m0s
[02:18:25.808] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:98:0)
[02:18:25.808] Timer tick, asking Buildbucket for the build status
[02:18:26.142] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:26.142] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:99:0) after 1m0s
[02:19:26.353] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:99:0)
[02:19:26.353] Timer tick, asking Buildbucket for the build status
[02:19:26.583] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:26.583] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:100:0) after 1m0s
[02:20:26.607] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:100:0)
[02:20:26.607] Timer tick, asking Buildbucket for the build status
[02:20:26.690] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:26.690] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:101:0) after 1m0s
[02:21:26.685] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:101:0)
[02:21:26.685] Timer tick, asking Buildbucket for the build status
[02:21:26.849] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:26.849] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:102:0) after 1m0s
[02:22:26.868] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:102:0)
[02:22:26.868] Timer tick, asking Buildbucket for the build status
[02:22:26.955] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:26.955] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:103:0) after 1m0s
[02:23:27.089] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:103:0)
[02:23:27.089] Timer tick, asking Buildbucket for the build status
[02:23:27.480] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:27.480] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:104:0) after 1m0s
[02:24:28.170] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:104:0)
[02:24:28.170] Timer tick, asking Buildbucket for the build status
[02:24:28.311] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:28.311] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:105:0) after 1m0s
[02:25:28.556] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:105:0)
[02:25:28.556] Timer tick, asking Buildbucket for the build status
[02:25:28.655] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:28.655] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:106:0) after 1m0s
[02:26:28.721] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:106:0)
[02:26:28.721] Timer tick, asking Buildbucket for the build status
[02:26:28.950] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:28.950] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:107:0) after 1m0s
[02:27:28.936] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:107:0)
[02:27:28.936] Timer tick, asking Buildbucket for the build status
[02:27:29.065] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:29.065] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:108:0) after 1m0s
[02:28:29.185] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:108:0)
[02:28:29.185] Timer tick, asking Buildbucket for the build status
[02:28:29.541] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:29.541] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:109:0) after 1m0s
[02:29:29.866] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:109:0)
[02:29:29.866] Timer tick, asking Buildbucket for the build status
[02:29:30.297] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:30.297] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:110:0) after 1m0s
[02:30:30.375] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:110:0)
[02:30:30.375] Timer tick, asking Buildbucket for the build status
[02:30:30.468] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:30.468] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:111:0) after 1m0s
[02:31:30.491] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:111:0)
[02:31:30.491] Timer tick, asking Buildbucket for the build status
[02:31:30.578] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:30.578] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:112:0) after 1m0s
[02:32:30.743] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:112:0)
[02:32:30.743] Timer tick, asking Buildbucket for the build status
[02:32:30.857] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:30.857] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:113:0) after 1m0s
[02:33:31.039] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:113:0)
[02:33:31.039] Timer tick, asking Buildbucket for the build status
[02:33:31.131] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:31.131] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:114:0) after 1m0s
[02:34:31.177] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:114:0)
[02:34:31.177] Timer tick, asking Buildbucket for the build status
[02:34:31.276] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:31.276] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:115:0) after 1m0s
[02:35:31.374] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:115:0)
[02:35:31.374] Timer tick, asking Buildbucket for the build status
[02:35:31.463] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:31.463] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:116:0) after 1m0s
[02:36:31.559] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:116:0)
[02:36:31.559] Timer tick, asking Buildbucket for the build status
[02:36:31.634] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:31.634] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:117:0) after 1m0s
[02:37:31.660] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:117:0)
[02:37:31.660] Timer tick, asking Buildbucket for the build status
[02:37:32.188] Build 8853914974407893168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:32.189] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019345038369713536:118:0) after 1m0s
[02:38:00.782] Received PubSub notification, asking Buildbucket for the build status
[02:38:00.944] Build 8853914974407893168: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:38:00.944] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614652680562316",
"created_by": "project:chromium",
"created_ts": "1614645711470990",
"failure_reason": "BUILD_FAILURE",
"id": "8853914974407893168",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"07ef8d73c7b010a549c9bb960c6f7c73f1346fe5\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed.\"}, \"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\": \"07ef8d73c7b010a549c9bb960c6f7c73f1346fe5\", \"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-east1-d-8-82-q8n4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 8064, \"got_angle_revision\": \"5b82fa2e842475cd93c6a6119b6e07635054e836\", \"got_dawn_revision\": \"931182485579d2eec3b24c1f2df646870f80da68\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"07ef8d73c7b010a549c9bb960c6f7c73f1346fe5\", \"got_revision_cp\": \"refs/heads/master@{#858802}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"851ca4314ae4a367bcc4cabb20326029eff18492\", \"got_v8_revision_cp\": \"refs/heads/9.1.7@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"07ef8d73c7b010a549c9bb960c6f7c73f1346fe5\", \"swarm_hashes_refs/heads/master(at){#858802}_without_patch\": {\"android_browsertests\": \"bc2ee98a48190e2182ba659d7d715f3235f680ac\", \"chrome_public_test_apk\": \"e2e38b8d1f554107081fcbe760d589811ffca963\", \"content_browsertests\": \"92a5cc32dfedd5b2dcdcaf1f7cd3c2487be4d0cc\", \"content_shell_test_apk\": \"b2fb3f39755a3e9e3b445588a07b75e9e6fdd427\", \"content_unittests\": \"18113836772260dbff11f90f0faf34892dcbe767\", \"unit_tests\": \"5f39fa350c16ce513dcc533289ead3795c6635ca\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3d5f41e0e2939f2447be43122175fb826239370d7da06e5b6b03ccaa65028999_v2\", \"builder_b14893b55edaf5e4dad6913e524bd3694194da568bc8f7a76820eff0afe1bec5_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"builder_ea4e7feff896b82ff6619a3b9c5371d5e74ebdd508befd295e2f5ab02f5eefaf_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-east1-d-8-82-q8n4\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614645864238531",
"status": "COMPLETED",
"status_changed_ts": "1614645864618921",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/8064",
"builder:android-bfcache-rel",
"buildset:commit/git/07ef8d73c7b010a549c9bb960c6f7c73f1346fe5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/07ef8d73c7b010a549c9bb960c6f7c73f1346fe5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019345038369713536",
"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/8853914974407893168/+/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:520933ddf9ea6a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614652680562699",
"url": "https://ci.chromium.org/b/8853914974407893168",
"utcnow_ts": "1614652680936820"
}
}
[02:38:00.944] Invocation finished in 1h56m12.635675367s with status FAILED