[17:32:04.248] New invocation is queued and will start shortly
[17:32:05.429] Starting the invocation (attempt 1)
[17:32:05.464] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:32:05.464] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:32:05.464] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034773559221132224",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0db97558c8f1e9fa1eca35b01af7c930cc29aec2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9034773559221132224",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/0db97558c8f1e9fa1eca35b01af7c930cc29aec2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0db97558c8f1e9fa1eca35b01af7c930cc29aec2",
"gitiles_ref:refs/heads/master"
]
}
[17:32:06.331] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1599931925582684",
"id": "8869343497159470368",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0db97558c8f1e9fa1eca35b01af7c930cc29aec2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599931926117837",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4997",
"builder:android-bfcache-rel",
"buildset:commit/git/0db97558c8f1e9fa1eca35b01af7c930cc29aec2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0db97558c8f1e9fa1eca35b01af7c930cc29aec2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034773559221132224",
"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/8869343497159470368/+/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": "1599931926117953",
"url": "https://ci.chromium.org/b/8869343497159470368",
"utcnow_ts": "1599931926317837"
}
}
[17:32:06.331] Task URL: https://ci.chromium.org/b/8869343497159470368
[17:32:06.331] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:2:0) after 1m0s
[17:33:06.529] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:2:0)
[17:33:06.529] Timer tick, asking Buildbucket for the build status
[17:33:06.645] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:33:06.645] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:3:0) after 1m0s
[17:34:06.826] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:3:0)
[17:34:06.826] Timer tick, asking Buildbucket for the build status
[17:34:07.086] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:34:07.086] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:4:0) after 1m0s
[17:35:07.203] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:4:0)
[17:35:07.203] Timer tick, asking Buildbucket for the build status
[17:35:07.358] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:35:07.358] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:5:0) after 1m0s
[17:36:07.399] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:5:0)
[17:36:07.399] Timer tick, asking Buildbucket for the build status
[17:36:07.485] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:36:07.485] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:6:0) after 1m0s
[17:37:07.543] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:6:0)
[17:37:07.543] Timer tick, asking Buildbucket for the build status
[17:37:07.899] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:37:07.899] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:7:0) after 1m0s
[17:38:07.929] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:7:0)
[17:38:07.929] Timer tick, asking Buildbucket for the build status
[17:38:08.311] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:38:08.311] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:8:0) after 1m0s
[17:39:08.334] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:8:0)
[17:39:08.334] Timer tick, asking Buildbucket for the build status
[17:39:08.416] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:39:08.416] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:9:0) after 1m0s
[17:40:08.435] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:9:0)
[17:40:08.435] Timer tick, asking Buildbucket for the build status
[17:40:08.528] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:40:08.528] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:10:0) after 1m0s
[17:41:08.577] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:10:0)
[17:41:08.577] Timer tick, asking Buildbucket for the build status
[17:41:08.652] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:41:08.652] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:11:0) after 1m0s
[17:42:08.671] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:11:0)
[17:42:08.671] Timer tick, asking Buildbucket for the build status
[17:42:08.849] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:42:08.849] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:12:0) after 1m0s
[17:43:08.973] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:12:0)
[17:43:08.973] Timer tick, asking Buildbucket for the build status
[17:43:09.039] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:43:09.039] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:13:0) after 1m0s
[17:44:09.193] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:13:0)
[17:44:09.193] Timer tick, asking Buildbucket for the build status
[17:44:09.265] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:09.265] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:14:0) after 1m0s
[17:45:09.484] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:14:0)
[17:45:09.484] Timer tick, asking Buildbucket for the build status
[17:45:09.884] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:09.884] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:15:0) after 1m0s
[17:46:09.972] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:15:0)
[17:46:09.972] Timer tick, asking Buildbucket for the build status
[17:46:10.150] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:46:10.151] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:16:0) after 1m0s
[17:47:10.209] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:16:0)
[17:47:10.209] Timer tick, asking Buildbucket for the build status
[17:47:10.304] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:47:10.304] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:17:0) after 1m0s
[17:48:10.377] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:17:0)
[17:48:10.377] Timer tick, asking Buildbucket for the build status
[17:48:10.457] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:48:10.457] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:18:0) after 1m0s
[17:49:10.486] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:18:0)
[17:49:10.486] Timer tick, asking Buildbucket for the build status
[17:49:10.560] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:49:10.560] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:19:0) after 1m0s
[17:50:10.669] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:19:0)
[17:50:10.669] Timer tick, asking Buildbucket for the build status
[17:50:10.883] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:50:10.883] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:20:0) after 1m0s
[17:51:11.004] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:20:0)
[17:51:11.005] Timer tick, asking Buildbucket for the build status
[17:51:11.088] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:51:11.088] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:21:0) after 1m0s
[17:52:11.188] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:21:0)
[17:52:11.188] Timer tick, asking Buildbucket for the build status
[17:52:11.305] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:52:11.305] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:22:0) after 1m0s
[17:53:11.393] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:22:0)
[17:53:11.393] Timer tick, asking Buildbucket for the build status
[17:53:11.476] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:53:11.476] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:23:0) after 1m0s
[17:54:11.524] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:23:0)
[17:54:11.524] Timer tick, asking Buildbucket for the build status
[17:54:11.643] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:54:11.643] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:24:0) after 1m0s
[17:55:11.717] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:24:0)
[17:55:11.717] Timer tick, asking Buildbucket for the build status
[17:55:11.821] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:55:11.821] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:25:0) after 1m0s
[17:56:11.942] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:25:0)
[17:56:11.942] Timer tick, asking Buildbucket for the build status
[17:56:12.028] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:56:12.028] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:26:0) after 1m0s
[17:57:12.085] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:26:0)
[17:57:12.085] Timer tick, asking Buildbucket for the build status
[17:57:12.473] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:57:12.473] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:27:0) after 1m0s
[17:58:12.669] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:27:0)
[17:58:12.669] Timer tick, asking Buildbucket for the build status
[17:58:12.761] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:58:12.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:28:0) after 1m0s
[17:59:12.830] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:28:0)
[17:59:12.830] Timer tick, asking Buildbucket for the build status
[17:59:12.895] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:59:12.895] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:29:0) after 1m0s
[18:00:12.980] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:29:0)
[18:00:12.980] Timer tick, asking Buildbucket for the build status
[18:00:13.099] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:00:13.099] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:30:0) after 1m0s
[18:01:13.211] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:30:0)
[18:01:13.211] Timer tick, asking Buildbucket for the build status
[18:01:13.300] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:01:13.300] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:31:0) after 1m0s
[18:02:13.365] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:31:0)
[18:02:13.365] Timer tick, asking Buildbucket for the build status
[18:02:13.506] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:02:13.506] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:32:0) after 1m0s
[18:03:13.597] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:32:0)
[18:03:13.597] Timer tick, asking Buildbucket for the build status
[18:03:13.701] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:03:13.701] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:33:0) after 1m0s
[18:04:13.829] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:33:0)
[18:04:13.829] Timer tick, asking Buildbucket for the build status
[18:04:13.910] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:04:13.910] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:34:0) after 1m0s
[18:05:13.947] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:34:0)
[18:05:13.947] Timer tick, asking Buildbucket for the build status
[18:05:14.068] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:05:14.068] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:35:0) after 1m0s
[18:06:14.156] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:35:0)
[18:06:14.156] Timer tick, asking Buildbucket for the build status
[18:06:14.334] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:06:14.334] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:36:0) after 1m0s
[18:07:14.328] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:36:0)
[18:07:14.328] Timer tick, asking Buildbucket for the build status
[18:07:14.421] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:07:14.421] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:37:0) after 1m0s
[18:08:14.465] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:37:0)
[18:08:14.465] Timer tick, asking Buildbucket for the build status
[18:08:14.562] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:14.562] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:38:0) after 1m0s
[18:09:14.578] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:38:0)
[18:09:14.578] Timer tick, asking Buildbucket for the build status
[18:09:14.795] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:14.795] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:39:0) after 1m0s
[18:10:14.935] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:39:0)
[18:10:14.935] Timer tick, asking Buildbucket for the build status
[18:10:15.030] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:10:15.030] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:40:0) after 1m0s
[18:11:15.136] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:40:0)
[18:11:15.136] Timer tick, asking Buildbucket for the build status
[18:11:15.400] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:11:15.401] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:41:0) after 1m0s
[18:12:15.518] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:41:0)
[18:12:15.518] Timer tick, asking Buildbucket for the build status
[18:12:15.615] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:12:15.615] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:42:0) after 1m0s
[18:13:15.715] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:42:0)
[18:13:15.715] Timer tick, asking Buildbucket for the build status
[18:13:15.786] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:13:15.786] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:43:0) after 1m0s
[18:14:15.852] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:43:0)
[18:14:15.852] Timer tick, asking Buildbucket for the build status
[18:14:15.991] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:14:15.991] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:44:0) after 1m0s
[18:15:16.127] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:44:0)
[18:15:16.127] Timer tick, asking Buildbucket for the build status
[18:15:16.218] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:15:16.218] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:45:0) after 1m0s
[18:16:16.314] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:45:0)
[18:16:16.314] Timer tick, asking Buildbucket for the build status
[18:16:16.473] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:16:16.473] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:46:0) after 1m0s
[18:17:16.473] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:46:0)
[18:17:16.473] Timer tick, asking Buildbucket for the build status
[18:17:16.789] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:17:16.789] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:47:0) after 1m0s
[18:18:16.903] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:47:0)
[18:18:16.903] Timer tick, asking Buildbucket for the build status
[18:18:16.986] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:18:16.986] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:48:0) after 1m0s
[18:19:17.147] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:48:0)
[18:19:17.147] Timer tick, asking Buildbucket for the build status
[18:19:17.504] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:17.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:49:0) after 1m0s
[18:20:17.624] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:49:0)
[18:20:17.624] Timer tick, asking Buildbucket for the build status
[18:20:17.738] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:17.738] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:50:0) after 1m0s
[18:21:17.755] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:50:0)
[18:21:17.755] Timer tick, asking Buildbucket for the build status
[18:21:19.329] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:19.329] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:51:0) after 1m0s
[18:22:19.552] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:51:0)
[18:22:19.552] Timer tick, asking Buildbucket for the build status
[18:22:19.658] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:19.658] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:52:0) after 1m0s
[18:23:19.715] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:52:0)
[18:23:19.715] Timer tick, asking Buildbucket for the build status
[18:23:19.787] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:19.787] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:53:0) after 1m0s
[18:24:19.839] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:53:0)
[18:24:19.839] Timer tick, asking Buildbucket for the build status
[18:24:20.067] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:24:20.067] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:54:0) after 1m0s
[18:25:20.111] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:54:0)
[18:25:20.111] Timer tick, asking Buildbucket for the build status
[18:25:20.195] Build 8869343497159470368: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:25:20.195] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:55:0) after 1m0s
[18:25:56.523] Received PubSub notification, asking Buildbucket for the build status
[18:25:56.587] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:20.295] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:55:0)
[18:26:20.295] Timer tick, asking Buildbucket for the build status
[18:26:20.369] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:20.369] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:57:0) after 1m0s
[18:27:20.393] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:57:0)
[18:27:20.393] Timer tick, asking Buildbucket for the build status
[18:27:20.545] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:20.545] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:58:0) after 1m0s
[18:28:20.688] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:58:0)
[18:28:20.688] Timer tick, asking Buildbucket for the build status
[18:28:21.097] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:21.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:59:0) after 1m0s
[18:29:21.125] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:59:0)
[18:29:21.125] Timer tick, asking Buildbucket for the build status
[18:29:21.339] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:21.339] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:60:0) after 1m0s
[18:30:21.362] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:60:0)
[18:30:21.362] Timer tick, asking Buildbucket for the build status
[18:30:21.428] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:21.428] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:61:0) after 1m0s
[18:31:21.454] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:61:0)
[18:31:21.454] Timer tick, asking Buildbucket for the build status
[18:31:21.712] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:21.712] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:62:0) after 1m0s
[18:32:21.856] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:62:0)
[18:32:21.856] Timer tick, asking Buildbucket for the build status
[18:32:22.097] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:22.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:63:0) after 1m0s
[18:33:22.148] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:63:0)
[18:33:22.148] Timer tick, asking Buildbucket for the build status
[18:33:22.477] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:22.477] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:64:0) after 1m0s
[18:34:22.515] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:64:0)
[18:34:22.515] Timer tick, asking Buildbucket for the build status
[18:34:22.596] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:22.596] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:65:0) after 1m0s
[18:35:22.675] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:65:0)
[18:35:22.675] Timer tick, asking Buildbucket for the build status
[18:35:22.809] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:22.809] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:66:0) after 1m0s
[18:36:22.925] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:66:0)
[18:36:22.925] Timer tick, asking Buildbucket for the build status
[18:36:23.619] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:23.619] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:67:0) after 1m0s
[18:37:23.648] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:67:0)
[18:37:23.648] Timer tick, asking Buildbucket for the build status
[18:37:23.809] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:23.809] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:68:0) after 1m0s
[18:38:23.828] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:68:0)
[18:38:23.828] Timer tick, asking Buildbucket for the build status
[18:38:24.226] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:24.226] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:69:0) after 1m0s
[18:39:24.381] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:69:0)
[18:39:24.381] Timer tick, asking Buildbucket for the build status
[18:39:24.451] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:24.451] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:70:0) after 1m0s
[18:40:24.553] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:70:0)
[18:40:24.554] Timer tick, asking Buildbucket for the build status
[18:40:24.612] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:24.612] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:71:0) after 1m0s
[18:41:24.715] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:71:0)
[18:41:24.715] Timer tick, asking Buildbucket for the build status
[18:41:24.783] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:24.783] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:72:0) after 1m0s
[18:42:24.860] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:72:0)
[18:42:24.860] Timer tick, asking Buildbucket for the build status
[18:42:24.968] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:24.968] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:73:0) after 1m0s
[18:43:25.053] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:73:0)
[18:43:25.053] Timer tick, asking Buildbucket for the build status
[18:43:25.211] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:25.211] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:74:0) after 1m0s
[18:44:25.324] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:74:0)
[18:44:25.324] Timer tick, asking Buildbucket for the build status
[18:44:25.385] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:25.385] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:75:0) after 1m0s
[18:45:25.534] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:75:0)
[18:45:25.534] Timer tick, asking Buildbucket for the build status
[18:45:25.782] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:25.782] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:76:0) after 1m0s
[18:46:25.952] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:76:0)
[18:46:25.952] Timer tick, asking Buildbucket for the build status
[18:46:26.028] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:26.028] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:77:0) after 1m0s
[18:47:26.177] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:77:0)
[18:47:26.177] Timer tick, asking Buildbucket for the build status
[18:47:26.290] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:26.290] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:78:0) after 1m0s
[18:48:26.434] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:78:0)
[18:48:26.434] Timer tick, asking Buildbucket for the build status
[18:48:26.497] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:26.497] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:79:0) after 1m0s
[18:49:26.612] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:79:0)
[18:49:26.612] Timer tick, asking Buildbucket for the build status
[18:49:26.911] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:26.911] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:80:0) after 1m0s
[18:50:26.947] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:80:0)
[18:50:26.947] Timer tick, asking Buildbucket for the build status
[18:50:27.024] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:27.024] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:81:0) after 1m0s
[18:51:27.054] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:81:0)
[18:51:27.054] Timer tick, asking Buildbucket for the build status
[18:51:27.141] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:27.141] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:82:0) after 1m0s
[18:52:27.304] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:82:0)
[18:52:27.304] Timer tick, asking Buildbucket for the build status
[18:52:27.640] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:27.640] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:83:0) after 1m0s
[18:53:27.703] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:83:0)
[18:53:27.703] Timer tick, asking Buildbucket for the build status
[18:53:27.831] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:27.831] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:84:0) after 1m0s
[18:54:27.822] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:84:0)
[18:54:27.822] Timer tick, asking Buildbucket for the build status
[18:54:28.346] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:28.346] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:85:0) after 1m0s
[18:55:28.392] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:85:0)
[18:55:28.393] Timer tick, asking Buildbucket for the build status
[18:55:28.727] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:28.727] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:86:0) after 1m0s
[18:56:28.846] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:86:0)
[18:56:28.846] Timer tick, asking Buildbucket for the build status
[18:56:28.917] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:28.917] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:87:0) after 1m0s
[18:57:29.072] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:87:0)
[18:57:29.072] Timer tick, asking Buildbucket for the build status
[18:57:29.924] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:29.924] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:88:0) after 1m0s
[18:58:29.983] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:88:0)
[18:58:29.983] Timer tick, asking Buildbucket for the build status
[18:58:30.079] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:30.079] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:89:0) after 1m0s
[18:59:30.108] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:89:0)
[18:59:30.108] Timer tick, asking Buildbucket for the build status
[18:59:31.907] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:31.907] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:90:0) after 1m0s
[19:00:31.935] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:90:0)
[19:00:31.935] Timer tick, asking Buildbucket for the build status
[19:00:32.375] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:32.375] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:91:0) after 1m0s
[19:01:32.423] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:91:0)
[19:01:32.423] Timer tick, asking Buildbucket for the build status
[19:01:32.517] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:32.517] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:92:0) after 1m0s
[19:02:32.572] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:92:0)
[19:02:32.572] Timer tick, asking Buildbucket for the build status
[19:02:32.761] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:32.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:93:0) after 1m0s
[19:03:32.782] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:93:0)
[19:03:32.782] Timer tick, asking Buildbucket for the build status
[19:03:33.167] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:33.167] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:94:0) after 1m0s
[19:04:33.219] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:94:0)
[19:04:33.219] Timer tick, asking Buildbucket for the build status
[19:04:33.287] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:33.287] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:95:0) after 1m0s
[19:05:33.341] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:95:0)
[19:05:33.341] Timer tick, asking Buildbucket for the build status
[19:05:33.520] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:33.520] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:96:0) after 1m0s
[19:06:33.588] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:96:0)
[19:06:33.588] Timer tick, asking Buildbucket for the build status
[19:06:33.912] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:33.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:97:0) after 1m0s
[19:07:34.074] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:97:0)
[19:07:34.074] Timer tick, asking Buildbucket for the build status
[19:07:34.252] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:34.252] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:98:0) after 1m0s
[19:08:34.416] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:98:0)
[19:08:34.416] Timer tick, asking Buildbucket for the build status
[19:08:34.476] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:34.476] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:99:0) after 1m0s
[19:09:34.729] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:99:0)
[19:09:34.729] Timer tick, asking Buildbucket for the build status
[19:09:34.782] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:34.782] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:100:0) after 1m0s
[19:10:34.851] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:100:0)
[19:10:34.851] Timer tick, asking Buildbucket for the build status
[19:10:35.122] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:35.122] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:101:0) after 1m0s
[19:11:35.370] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:101:0)
[19:11:35.370] Timer tick, asking Buildbucket for the build status
[19:11:35.721] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:35.721] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:102:0) after 1m0s
[19:12:35.778] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:102:0)
[19:12:35.778] Timer tick, asking Buildbucket for the build status
[19:12:35.877] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:35.877] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:103:0) after 1m0s
[19:13:35.895] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:103:0)
[19:13:35.895] Timer tick, asking Buildbucket for the build status
[19:13:35.957] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:35.957] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:104:0) after 1m0s
[19:14:36.026] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:104:0)
[19:14:36.026] Timer tick, asking Buildbucket for the build status
[19:14:36.134] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:36.134] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:105:0) after 1m0s
[19:15:36.184] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:105:0)
[19:15:36.184] Timer tick, asking Buildbucket for the build status
[19:15:36.252] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:36.252] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:106:0) after 1m0s
[19:16:36.284] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:106:0)
[19:16:36.284] Timer tick, asking Buildbucket for the build status
[19:16:36.343] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:36.343] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:107:0) after 1m0s
[19:17:36.371] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:107:0)
[19:17:36.371] Timer tick, asking Buildbucket for the build status
[19:17:36.464] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:36.464] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:108:0) after 1m0s
[19:18:36.506] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:108:0)
[19:18:36.506] Timer tick, asking Buildbucket for the build status
[19:18:36.722] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:36.722] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:109:0) after 1m0s
[19:19:36.838] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:109:0)
[19:19:36.838] Timer tick, asking Buildbucket for the build status
[19:19:36.917] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:36.917] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:110:0) after 1m0s
[19:20:37.025] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:110:0)
[19:20:37.025] Timer tick, asking Buildbucket for the build status
[19:20:37.196] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:37.196] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:111:0) after 1m0s
[19:21:37.218] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:111:0)
[19:21:37.218] Timer tick, asking Buildbucket for the build status
[19:21:37.277] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:37.277] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:112:0) after 1m0s
[19:22:37.312] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:112:0)
[19:22:37.312] Timer tick, asking Buildbucket for the build status
[19:22:37.734] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:37.734] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:113:0) after 1m0s
[19:23:37.722] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:113:0)
[19:23:37.722] Timer tick, asking Buildbucket for the build status
[19:23:37.938] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:37.938] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:114:0) after 1m0s
[19:24:38.049] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:114:0)
[19:24:38.049] Timer tick, asking Buildbucket for the build status
[19:24:38.176] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:38.176] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:115:0) after 1m0s
[19:25:38.257] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:115:0)
[19:25:38.257] Timer tick, asking Buildbucket for the build status
[19:25:38.329] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:38.329] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:116:0) after 1m0s
[19:26:38.396] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:116:0)
[19:26:38.396] Timer tick, asking Buildbucket for the build status
[19:26:38.452] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:38.452] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:117:0) after 1m0s
[19:27:38.531] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:117:0)
[19:27:38.531] Timer tick, asking Buildbucket for the build status
[19:27:38.718] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:38.718] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:118:0) after 1m0s
[19:28:38.777] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:118:0)
[19:28:38.777] Timer tick, asking Buildbucket for the build status
[19:28:38.839] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:38.839] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:119:0) after 1m0s
[19:29:38.941] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:119:0)
[19:29:38.942] Timer tick, asking Buildbucket for the build status
[19:29:39.012] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:39.012] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:120:0) after 1m0s
[19:30:39.035] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:120:0)
[19:30:39.036] Timer tick, asking Buildbucket for the build status
[19:30:39.104] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:39.104] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:121:0) after 1m0s
[19:31:39.166] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:121:0)
[19:31:39.166] Timer tick, asking Buildbucket for the build status
[19:31:39.239] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:39.239] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:122:0) after 1m0s
[19:32:39.312] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:122:0)
[19:32:39.312] Timer tick, asking Buildbucket for the build status
[19:32:39.516] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:39.516] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:123:0) after 1m0s
[19:33:39.573] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:123:0)
[19:33:39.573] Timer tick, asking Buildbucket for the build status
[19:33:39.632] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:39.632] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:124:0) after 1m0s
[19:34:39.748] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:124:0)
[19:34:39.748] Timer tick, asking Buildbucket for the build status
[19:34:39.878] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:39.878] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:125:0) after 1m0s
[19:35:40.081] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:125:0)
[19:35:40.081] Timer tick, asking Buildbucket for the build status
[19:35:40.302] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:40.302] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:126:0) after 1m0s
[19:36:40.373] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:126:0)
[19:36:40.373] Timer tick, asking Buildbucket for the build status
[19:36:40.451] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:40.451] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:127:0) after 1m0s
[19:37:40.587] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:127:0)
[19:37:40.587] Timer tick, asking Buildbucket for the build status
[19:37:40.682] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:40.683] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:128:0) after 1m0s
[19:38:40.851] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:128:0)
[19:38:40.851] Timer tick, asking Buildbucket for the build status
[19:38:40.933] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:40.933] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:129:0) after 1m0s
[19:39:41.018] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:129:0)
[19:39:41.018] Timer tick, asking Buildbucket for the build status
[19:39:41.079] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:41.079] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:130:0) after 1m0s
[19:40:41.154] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:130:0)
[19:40:41.154] Timer tick, asking Buildbucket for the build status
[19:40:41.234] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:41.234] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:131:0) after 1m0s
[19:41:41.329] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:131:0)
[19:41:41.329] Timer tick, asking Buildbucket for the build status
[19:41:41.421] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:41.421] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:132:0) after 1m0s
[19:42:41.452] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:132:0)
[19:42:41.452] Timer tick, asking Buildbucket for the build status
[19:42:41.713] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:41.713] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:133:0) after 1m0s
[19:43:41.811] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:133:0)
[19:43:41.811] Timer tick, asking Buildbucket for the build status
[19:43:42.023] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:42.023] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:134:0) after 1m0s
[19:44:42.071] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:134:0)
[19:44:42.071] Timer tick, asking Buildbucket for the build status
[19:44:42.416] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:42.416] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:135:0) after 1m0s
[19:45:42.473] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:135:0)
[19:45:42.473] Timer tick, asking Buildbucket for the build status
[19:45:42.592] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:42.592] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:136:0) after 1m0s
[19:46:42.627] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:136:0)
[19:46:42.627] Timer tick, asking Buildbucket for the build status
[19:46:42.793] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:42.793] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:137:0) after 1m0s
[19:47:42.886] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:137:0)
[19:47:42.886] Timer tick, asking Buildbucket for the build status
[19:47:43.277] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:43.277] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:138:0) after 1m0s
[19:48:43.404] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:138:0)
[19:48:43.404] Timer tick, asking Buildbucket for the build status
[19:48:43.524] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:43.524] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:139:0) after 1m0s
[19:49:43.594] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:139:0)
[19:49:43.594] Timer tick, asking Buildbucket for the build status
[19:49:43.688] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:43.688] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:140:0) after 1m0s
[19:50:43.768] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:140:0)
[19:50:43.768] Timer tick, asking Buildbucket for the build status
[19:50:44.232] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:44.232] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:141:0) after 1m0s
[19:51:44.395] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:141:0)
[19:51:44.395] Timer tick, asking Buildbucket for the build status
[19:51:44.539] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:44.539] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:142:0) after 1m0s
[19:52:44.586] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:142:0)
[19:52:44.586] Timer tick, asking Buildbucket for the build status
[19:52:45.090] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:45.090] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:143:0) after 1m0s
[19:53:45.144] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:143:0)
[19:53:45.144] Timer tick, asking Buildbucket for the build status
[19:53:45.643] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:45.643] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:144:0) after 1m0s
[19:54:45.772] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:144:0)
[19:54:45.772] Timer tick, asking Buildbucket for the build status
[19:54:45.942] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:45.942] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:145:0) after 1m0s
[19:55:46.006] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:145:0)
[19:55:46.006] Timer tick, asking Buildbucket for the build status
[19:55:46.132] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:46.132] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:146:0) after 1m0s
[19:56:46.157] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:146:0)
[19:56:46.157] Timer tick, asking Buildbucket for the build status
[19:56:46.254] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:46.254] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:147:0) after 1m0s
[19:57:46.351] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:147:0)
[19:57:46.351] Timer tick, asking Buildbucket for the build status
[19:57:46.713] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:46.713] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:148:0) after 1m0s
[19:58:46.724] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:148:0)
[19:58:46.724] Timer tick, asking Buildbucket for the build status
[19:58:46.783] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:46.783] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:149:0) after 1m0s
[19:59:46.894] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:149:0)
[19:59:46.894] Timer tick, asking Buildbucket for the build status
[19:59:46.976] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:46.976] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:150:0) after 1m0s
[20:00:47.019] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:150:0)
[20:00:47.019] Timer tick, asking Buildbucket for the build status
[20:00:47.141] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:47.142] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:151:0) after 1m0s
[20:01:47.118] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:151:0)
[20:01:47.118] Timer tick, asking Buildbucket for the build status
[20:01:47.299] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:47.299] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:152:0) after 1m0s
[20:02:47.387] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:152:0)
[20:02:47.387] Timer tick, asking Buildbucket for the build status
[20:02:47.513] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:47.513] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:153:0) after 1m0s
[20:03:47.604] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:153:0)
[20:03:47.604] Timer tick, asking Buildbucket for the build status
[20:03:47.669] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:47.669] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:154:0) after 1m0s
[20:04:47.745] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:154:0)
[20:04:47.745] Timer tick, asking Buildbucket for the build status
[20:04:47.828] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:47.828] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:155:0) after 1m0s
[20:05:47.898] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:155:0)
[20:05:47.899] Timer tick, asking Buildbucket for the build status
[20:05:47.987] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:47.987] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:156:0) after 1m0s
[20:06:48.019] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:156:0)
[20:06:48.019] Timer tick, asking Buildbucket for the build status
[20:06:48.366] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:48.366] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:157:0) after 1m0s
[20:07:48.395] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:157:0)
[20:07:48.395] Timer tick, asking Buildbucket for the build status
[20:07:49.008] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:49.008] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:158:0) after 1m0s
[20:08:49.177] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:158:0)
[20:08:49.177] Timer tick, asking Buildbucket for the build status
[20:08:49.416] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:49.416] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:159:0) after 1m0s
[20:09:49.555] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:159:0)
[20:09:49.555] Timer tick, asking Buildbucket for the build status
[20:09:49.644] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:49.644] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:160:0) after 1m0s
[20:10:49.673] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:160:0)
[20:10:49.673] Timer tick, asking Buildbucket for the build status
[20:10:50.185] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:50.185] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:161:0) after 1m0s
[20:11:50.287] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:161:0)
[20:11:50.287] Timer tick, asking Buildbucket for the build status
[20:11:50.438] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:50.438] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:162:0) after 1m0s
[20:12:50.455] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:162:0)
[20:12:50.455] Timer tick, asking Buildbucket for the build status
[20:12:50.605] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:50.605] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:163:0) after 1m0s
[20:13:50.726] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:163:0)
[20:13:50.726] Timer tick, asking Buildbucket for the build status
[20:13:50.941] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:50.941] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:164:0) after 1m0s
[20:14:50.982] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:164:0)
[20:14:50.982] Timer tick, asking Buildbucket for the build status
[20:14:51.052] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:51.052] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:165:0) after 1m0s
[20:15:51.103] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:165:0)
[20:15:51.103] Timer tick, asking Buildbucket for the build status
[20:15:51.192] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:51.192] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:166:0) after 1m0s
[20:16:51.253] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:166:0)
[20:16:51.253] Timer tick, asking Buildbucket for the build status
[20:16:51.336] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:51.336] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:167:0) after 1m0s
[20:17:51.414] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:167:0)
[20:17:51.414] Timer tick, asking Buildbucket for the build status
[20:17:51.532] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:51.532] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:168:0) after 1m0s
[20:18:51.530] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:168:0)
[20:18:51.530] Timer tick, asking Buildbucket for the build status
[20:18:51.599] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:51.599] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:169:0) after 1m0s
[20:19:51.644] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:169:0)
[20:19:51.644] Timer tick, asking Buildbucket for the build status
[20:19:51.713] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:51.713] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:170:0) after 1m0s
[20:20:51.765] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:170:0)
[20:20:51.765] Timer tick, asking Buildbucket for the build status
[20:20:51.911] Build 8869343497159470368: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:51.911] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034773559221132224:171:0) after 1m0s
[20:21:40.937] Received PubSub notification, asking Buildbucket for the build status
[20:21:41.125] Build 8869343497159470368: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:21:41.125] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1599942100286050",
"created_by": "project:chromium",
"created_ts": "1599931925582684",
"failure_reason": "BUILD_FAILURE",
"id": "8869343497159470368",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0db97558c8f1e9fa1eca35b01af7c930cc29aec2\"}}",
"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 because of:\\n\\n- WebRtcAudioBrowserTest.EstablishAudioVideoCallAndVerifyLocalMutingWorks\"}, \"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\": \"0db97558c8f1e9fa1eca35b01af7c930cc29aec2\", \"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-100-iupy\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 4997, \"got_angle_revision\": \"2879eb5512c2e42998dc4ecb08d338d88cb2928e\", \"got_dawn_revision\": \"dbd34449af20f2d026b1e7f959073e254066ec83\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"0db97558c8f1e9fa1eca35b01af7c930cc29aec2\", \"got_revision_cp\": \"refs/heads/master@{#806458}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"41974f57973ebcdab4cfde6cc60354f6b79a5901\", \"got_v8_revision\": \"bb4817544d7ce327fc432a8229efa213952ca979\", \"got_v8_revision_cp\": \"refs/heads/8.7.76@{#1}\", \"got_webrtc_revision\": \"5c8aa5cd05ae56ac783145a04ed21c5ebd2dfc4d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32089}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0db97558c8f1e9fa1eca35b01af7c930cc29aec2\", \"swarm_hashes\": {\"android_browsertests\": \"4bc127bdf4c328fff42b4733ed5ce8a078a6302b\", \"chrome_public_test_apk\": \"c986a24cb55116248aa225e22022b57298c0be41\", \"content_browsertests\": \"ffb19d962974cde66318fac46fcd998f56e50e73\", \"content_shell_test_apk\": \"6821c8734352fb9c033ea6f541925ad270148a81\", \"content_unittests\": \"ef5a5025555e8bcec69fc51e473cb36313898311\", \"unit_tests\": \"07dfc531429e6eece853e25c49193564de337766\"}, \"swarm_hashes_refs/heads/master(at){#806458}_without_patch\": {\"android_browsertests\": \"4bc127bdf4c328fff42b4733ed5ce8a078a6302b\", \"chrome_public_test_apk\": \"c986a24cb55116248aa225e22022b57298c0be41\", \"content_browsertests\": \"ffb19d962974cde66318fac46fcd998f56e50e73\", \"content_shell_test_apk\": \"6821c8734352fb9c033ea6f541925ad270148a81\", \"content_unittests\": \"ef5a5025555e8bcec69fc51e473cb36313898311\", \"unit_tests\": \"07dfc531429e6eece853e25c49193564de337766\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4f2591ede8786d6a64772378dd14b2c2025b224161485e8988b4d5f036ceec5d_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_6cd5ded23cefc640ae511b7a529237cb2561e39c1afb96e401c63016ddcf35a6_v2\", \"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_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-100-iupy\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"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\": [\"5518-246c570\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- WebRtcAudioBrowserTest.EstablishAudioVideoCallAndVerifyLocalMutingWorks\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599935155514833",
"status": "COMPLETED",
"status_changed_ts": "1599935155885726",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4997",
"builder:android-bfcache-rel",
"buildset:commit/git/0db97558c8f1e9fa1eca35b01af7c930cc29aec2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0db97558c8f1e9fa1eca35b01af7c930cc29aec2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034773559221132224",
"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/8869343497159470368/+/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:4e9c3151a8fabd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1599942100523832",
"url": "https://ci.chromium.org/b/8869343497159470368",
"utcnow_ts": "1599942101110375"
}
}
[20:21:41.125] Invocation finished in 2h49m36.893255621s with status FAILED