[08:06:26.526] New invocation is queued and will start shortly
[08:06:27.660] Starting the invocation (attempt 1)
[08:06:27.706] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:06:27.706] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:06:27.706] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017867512783338864",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b77dff0b7321dfddad75a94003d345d58295aeb7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9017867512783338864",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/b77dff0b7321dfddad75a94003d345d58295aeb7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b77dff0b7321dfddad75a94003d345d58295aeb7",
"gitiles_ref:refs/heads/master"
]
}
[08:06:28.706] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616054787831527",
"id": "8852437450753429408",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b77dff0b7321dfddad75a94003d345d58295aeb7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616054788335209",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/8318",
"builder:android-bfcache-rel",
"buildset:commit/git/b77dff0b7321dfddad75a94003d345d58295aeb7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b77dff0b7321dfddad75a94003d345d58295aeb7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017867512783338864",
"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/8852437450753429408/+/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": "1616054788335333",
"url": "https://ci.chromium.org/b/8852437450753429408",
"utcnow_ts": "1616054788699418"
}
}
[08:06:28.706] Task URL: https://ci.chromium.org/b/8852437450753429408
[08:06:28.706] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:2:0) after 1m0s
[08:07:03.967] Received PubSub notification, asking Buildbucket for the build status
[08:07:04.164] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:28.832] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:2:0)
[08:07:28.832] Timer tick, asking Buildbucket for the build status
[08:07:28.989] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:28.989] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:4:0) after 1m0s
[08:08:29.011] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:4:0)
[08:08:29.011] Timer tick, asking Buildbucket for the build status
[08:08:29.142] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:29.142] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:5:0) after 1m0s
[08:09:29.144] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:5:0)
[08:09:29.144] Timer tick, asking Buildbucket for the build status
[08:09:29.207] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:29.207] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:6:0) after 1m0s
[08:10:29.291] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:6:0)
[08:10:29.291] Timer tick, asking Buildbucket for the build status
[08:10:29.476] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:29.476] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:7:0) after 1m0s
[08:11:29.608] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:7:0)
[08:11:29.608] Timer tick, asking Buildbucket for the build status
[08:11:29.697] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:29.697] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:8:0) after 1m0s
[08:12:29.891] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:8:0)
[08:12:29.891] Timer tick, asking Buildbucket for the build status
[08:12:30.000] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:30.000] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:9:0) after 1m0s
[08:13:30.168] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:9:0)
[08:13:30.168] Timer tick, asking Buildbucket for the build status
[08:13:30.275] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:30.275] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:10:0) after 1m0s
[08:14:30.367] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:10:0)
[08:14:30.367] Timer tick, asking Buildbucket for the build status
[08:14:30.654] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:30.654] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:11:0) after 1m0s
[08:15:30.727] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:11:0)
[08:15:30.727] Timer tick, asking Buildbucket for the build status
[08:15:30.806] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:30.806] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:12:0) after 1m0s
[08:16:30.870] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:12:0)
[08:16:30.870] Timer tick, asking Buildbucket for the build status
[08:16:30.977] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:30.977] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:13:0) after 1m0s
[08:17:31.010] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:13:0)
[08:17:31.010] Timer tick, asking Buildbucket for the build status
[08:17:31.141] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:31.141] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:14:0) after 1m0s
[08:18:31.235] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:14:0)
[08:18:31.235] Timer tick, asking Buildbucket for the build status
[08:18:31.313] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:31.313] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:15:0) after 1m0s
[08:19:31.388] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:15:0)
[08:19:31.388] Timer tick, asking Buildbucket for the build status
[08:19:31.448] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:31.448] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:16:0) after 1m0s
[08:20:31.465] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:16:0)
[08:20:31.465] Timer tick, asking Buildbucket for the build status
[08:20:31.590] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:31.590] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:17:0) after 1m0s
[08:21:31.736] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:17:0)
[08:21:31.736] Timer tick, asking Buildbucket for the build status
[08:21:32.006] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:32.006] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:18:0) after 1m0s
[08:22:32.115] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:18:0)
[08:22:32.115] Timer tick, asking Buildbucket for the build status
[08:22:32.264] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:32.264] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:19:0) after 1m0s
[08:23:32.324] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:19:0)
[08:23:32.324] Timer tick, asking Buildbucket for the build status
[08:23:32.472] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:32.472] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:20:0) after 1m0s
[08:24:32.618] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:20:0)
[08:24:32.618] Timer tick, asking Buildbucket for the build status
[08:24:32.735] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:32.735] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:21:0) after 1m0s
[08:25:32.731] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:21:0)
[08:25:32.731] Timer tick, asking Buildbucket for the build status
[08:25:32.797] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:32.797] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:22:0) after 1m0s
[08:26:32.906] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:22:0)
[08:26:32.906] Timer tick, asking Buildbucket for the build status
[08:26:32.979] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:32.979] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:23:0) after 1m0s
[08:27:32.989] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:23:0)
[08:27:32.989] Timer tick, asking Buildbucket for the build status
[08:27:33.067] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:33.067] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:24:0) after 1m0s
[08:28:33.104] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:24:0)
[08:28:33.104] Timer tick, asking Buildbucket for the build status
[08:28:33.178] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:33.178] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:25:0) after 1m0s
[08:29:33.228] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:25:0)
[08:29:33.228] Timer tick, asking Buildbucket for the build status
[08:29:33.289] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:33.289] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:26:0) after 1m0s
[08:30:33.406] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:26:0)
[08:30:33.406] Timer tick, asking Buildbucket for the build status
[08:30:33.615] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:33.615] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:27:0) after 1m0s
[08:31:33.824] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:27:0)
[08:31:33.825] Timer tick, asking Buildbucket for the build status
[08:31:33.908] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:33.908] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:28:0) after 1m0s
[08:32:33.994] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:28:0)
[08:32:33.994] Timer tick, asking Buildbucket for the build status
[08:32:34.487] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:34.487] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:29:0) after 1m0s
[08:33:34.573] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:29:0)
[08:33:34.573] Timer tick, asking Buildbucket for the build status
[08:33:34.658] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:34.658] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:30:0) after 1m0s
[08:34:34.691] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:30:0)
[08:34:34.691] Timer tick, asking Buildbucket for the build status
[08:34:34.769] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:34.769] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:31:0) after 1m0s
[08:35:35.034] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:31:0)
[08:35:35.034] Timer tick, asking Buildbucket for the build status
[08:35:35.127] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:35.127] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:32:0) after 1m0s
[08:36:35.274] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:32:0)
[08:36:35.274] Timer tick, asking Buildbucket for the build status
[08:36:35.648] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:35.648] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:33:0) after 1m0s
[08:37:35.817] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:33:0)
[08:37:35.817] Timer tick, asking Buildbucket for the build status
[08:37:35.889] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:35.889] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:34:0) after 1m0s
[08:38:35.982] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:34:0)
[08:38:35.982] Timer tick, asking Buildbucket for the build status
[08:38:36.249] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:36.249] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:35:0) after 1m0s
[08:39:36.382] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:35:0)
[08:39:36.382] Timer tick, asking Buildbucket for the build status
[08:39:36.453] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:36.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:36:0) after 1m0s
[08:40:36.466] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:36:0)
[08:40:36.466] Timer tick, asking Buildbucket for the build status
[08:40:36.556] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:36.556] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:37:0) after 1m0s
[08:41:36.584] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:37:0)
[08:41:36.584] Timer tick, asking Buildbucket for the build status
[08:41:37.057] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:37.057] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:38:0) after 1m0s
[08:42:37.174] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:38:0)
[08:42:37.174] Timer tick, asking Buildbucket for the build status
[08:42:37.261] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:37.261] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:39:0) after 1m0s
[08:43:37.328] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:39:0)
[08:43:37.328] Timer tick, asking Buildbucket for the build status
[08:43:37.396] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:37.396] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:40:0) after 1m0s
[08:44:37.490] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:40:0)
[08:44:37.490] Timer tick, asking Buildbucket for the build status
[08:44:37.646] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:37.646] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:41:0) after 1m0s
[08:45:37.727] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:41:0)
[08:45:37.728] Timer tick, asking Buildbucket for the build status
[08:45:37.793] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:37.793] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:42:0) after 1m0s
[08:46:37.909] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:42:0)
[08:46:37.909] Timer tick, asking Buildbucket for the build status
[08:46:37.993] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:37.993] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:43:0) after 1m0s
[08:47:38.046] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:43:0)
[08:47:38.046] Timer tick, asking Buildbucket for the build status
[08:47:38.118] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:38.118] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:44:0) after 1m0s
[08:48:38.178] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:44:0)
[08:48:38.178] Timer tick, asking Buildbucket for the build status
[08:48:38.247] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:38.247] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:45:0) after 1m0s
[08:49:38.279] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:45:0)
[08:49:38.279] Timer tick, asking Buildbucket for the build status
[08:49:38.354] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:38.354] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:46:0) after 1m0s
[08:50:38.362] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:46:0)
[08:50:38.362] Timer tick, asking Buildbucket for the build status
[08:50:38.443] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:38.443] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:47:0) after 1m0s
[08:51:38.463] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:47:0)
[08:51:38.463] Timer tick, asking Buildbucket for the build status
[08:51:38.683] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:38.683] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:48:0) after 1m0s
[08:52:38.763] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:48:0)
[08:52:38.764] Timer tick, asking Buildbucket for the build status
[08:52:38.849] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:38.849] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:49:0) after 1m0s
[08:53:38.902] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:49:0)
[08:53:38.902] Timer tick, asking Buildbucket for the build status
[08:53:39.028] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:39.029] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:50:0) after 1m0s
[08:54:39.098] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:50:0)
[08:54:39.098] Timer tick, asking Buildbucket for the build status
[08:54:39.265] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:39.265] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:51:0) after 1m0s
[08:55:39.594] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:51:0)
[08:55:39.594] Timer tick, asking Buildbucket for the build status
[08:55:39.691] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:39.692] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:52:0) after 1m0s
[08:56:39.807] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:52:0)
[08:56:39.807] Timer tick, asking Buildbucket for the build status
[08:56:39.883] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:39.883] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:53:0) after 1m0s
[08:57:39.861] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:53:0)
[08:57:39.861] Timer tick, asking Buildbucket for the build status
[08:57:39.942] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:39.942] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:54:0) after 1m0s
[08:58:40.096] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:54:0)
[08:58:40.096] Timer tick, asking Buildbucket for the build status
[08:58:40.175] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:40.175] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:55:0) after 1m0s
[08:59:40.316] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:55:0)
[08:59:40.316] Timer tick, asking Buildbucket for the build status
[08:59:40.399] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:40.399] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:56:0) after 1m0s
[09:00:40.469] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:56:0)
[09:00:40.469] Timer tick, asking Buildbucket for the build status
[09:00:40.559] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:40.559] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:57:0) after 1m0s
[09:01:40.757] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:57:0)
[09:01:40.757] Timer tick, asking Buildbucket for the build status
[09:01:40.900] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:40.900] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:58:0) after 1m0s
[09:02:41.019] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:58:0)
[09:02:41.020] Timer tick, asking Buildbucket for the build status
[09:02:41.144] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:41.144] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:59:0) after 1m0s
[09:03:41.214] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:59:0)
[09:03:41.214] Timer tick, asking Buildbucket for the build status
[09:03:41.384] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:41.384] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:60:0) after 1m0s
[09:04:41.449] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:60:0)
[09:04:41.449] Timer tick, asking Buildbucket for the build status
[09:04:41.791] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:41.791] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:61:0) after 1m0s
[09:05:41.809] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:61:0)
[09:05:41.809] Timer tick, asking Buildbucket for the build status
[09:05:41.875] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:41.875] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:62:0) after 1m0s
[09:06:42.060] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:62:0)
[09:06:42.060] Timer tick, asking Buildbucket for the build status
[09:06:42.173] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:42.173] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:63:0) after 1m0s
[09:07:42.273] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:63:0)
[09:07:42.273] Timer tick, asking Buildbucket for the build status
[09:07:42.345] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:42.345] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:64:0) after 1m0s
[09:08:43.035] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:64:0)
[09:08:43.035] Timer tick, asking Buildbucket for the build status
[09:08:43.219] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:43.219] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:65:0) after 1m0s
[09:09:43.313] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:65:0)
[09:09:43.313] Timer tick, asking Buildbucket for the build status
[09:09:43.384] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:43.384] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:66:0) after 1m0s
[09:10:43.419] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:66:0)
[09:10:43.419] Timer tick, asking Buildbucket for the build status
[09:10:43.493] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:43.493] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:67:0) after 1m0s
[09:11:43.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:67:0)
[09:11:43.525] Timer tick, asking Buildbucket for the build status
[09:11:43.619] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:43.619] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:68:0) after 1m0s
[09:12:43.640] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:68:0)
[09:12:43.640] Timer tick, asking Buildbucket for the build status
[09:12:43.731] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:43.731] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:69:0) after 1m0s
[09:13:43.901] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:69:0)
[09:13:43.901] Timer tick, asking Buildbucket for the build status
[09:13:43.972] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:43.972] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:70:0) after 1m0s
[09:14:44.013] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:70:0)
[09:14:44.013] Timer tick, asking Buildbucket for the build status
[09:14:44.081] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:44.081] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:71:0) after 1m0s
[09:15:44.091] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:71:0)
[09:15:44.091] Timer tick, asking Buildbucket for the build status
[09:15:44.165] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:44.165] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:72:0) after 1m0s
[09:16:44.226] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:72:0)
[09:16:44.226] Timer tick, asking Buildbucket for the build status
[09:16:44.314] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:44.315] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:73:0) after 1m0s
[09:17:44.327] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:73:0)
[09:17:44.327] Timer tick, asking Buildbucket for the build status
[09:17:44.402] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:44.402] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:74:0) after 1m0s
[09:18:44.434] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:74:0)
[09:18:44.434] Timer tick, asking Buildbucket for the build status
[09:18:44.503] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:44.503] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:75:0) after 1m0s
[09:19:44.689] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:75:0)
[09:19:44.689] Timer tick, asking Buildbucket for the build status
[09:19:44.843] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:44.843] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:76:0) after 1m0s
[09:20:44.899] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:76:0)
[09:20:44.899] Timer tick, asking Buildbucket for the build status
[09:20:44.963] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:44.963] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:77:0) after 1m0s
[09:21:44.993] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:77:0)
[09:21:44.993] Timer tick, asking Buildbucket for the build status
[09:21:45.075] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:45.075] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:78:0) after 1m0s
[09:22:45.112] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:78:0)
[09:22:45.112] Timer tick, asking Buildbucket for the build status
[09:22:45.173] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:45.173] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:79:0) after 1m0s
[09:23:45.275] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:79:0)
[09:23:45.275] Timer tick, asking Buildbucket for the build status
[09:23:45.351] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:45.352] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:80:0) after 1m0s
[09:24:45.379] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:80:0)
[09:24:45.379] Timer tick, asking Buildbucket for the build status
[09:24:45.469] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:45.469] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:81:0) after 1m0s
[09:25:45.621] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:81:0)
[09:25:45.621] Timer tick, asking Buildbucket for the build status
[09:25:45.709] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:45.709] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:82:0) after 1m0s
[09:26:45.814] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:82:0)
[09:26:45.814] Timer tick, asking Buildbucket for the build status
[09:26:46.103] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:46.103] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:83:0) after 1m0s
[09:27:46.150] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:83:0)
[09:27:46.150] Timer tick, asking Buildbucket for the build status
[09:27:46.424] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:46.424] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:84:0) after 1m0s
[09:28:46.486] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:84:0)
[09:28:46.486] Timer tick, asking Buildbucket for the build status
[09:28:46.578] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:46.578] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:85:0) after 1m0s
[09:29:46.593] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:85:0)
[09:29:46.593] Timer tick, asking Buildbucket for the build status
[09:29:46.806] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:46.806] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:86:0) after 1m0s
[09:30:47.015] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:86:0)
[09:30:47.015] Timer tick, asking Buildbucket for the build status
[09:30:47.445] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:47.446] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:87:0) after 1m0s
[09:31:47.560] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:87:0)
[09:31:47.560] Timer tick, asking Buildbucket for the build status
[09:31:47.669] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:47.669] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:88:0) after 1m0s
[09:32:47.722] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:88:0)
[09:32:47.722] Timer tick, asking Buildbucket for the build status
[09:32:47.782] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:47.782] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:89:0) after 1m0s
[09:33:47.956] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:89:0)
[09:33:47.956] Timer tick, asking Buildbucket for the build status
[09:33:48.029] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:48.029] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:90:0) after 1m0s
[09:34:48.133] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:90:0)
[09:34:48.133] Timer tick, asking Buildbucket for the build status
[09:34:48.295] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:48.295] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:91:0) after 1m0s
[09:35:48.396] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:91:0)
[09:35:48.396] Timer tick, asking Buildbucket for the build status
[09:35:48.545] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:48.545] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:92:0) after 1m0s
[09:36:48.627] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:92:0)
[09:36:48.627] Timer tick, asking Buildbucket for the build status
[09:36:48.906] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:48.906] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:93:0) after 1m0s
[09:37:48.973] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:93:0)
[09:37:48.973] Timer tick, asking Buildbucket for the build status
[09:37:49.047] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:49.047] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:94:0) after 1m0s
[09:38:49.395] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:94:0)
[09:38:49.395] Timer tick, asking Buildbucket for the build status
[09:38:49.462] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:49.462] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:95:0) after 1m0s
[09:39:49.588] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:95:0)
[09:39:49.588] Timer tick, asking Buildbucket for the build status
[09:39:49.708] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:49.708] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:96:0) after 1m0s
[09:40:49.810] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:96:0)
[09:40:49.810] Timer tick, asking Buildbucket for the build status
[09:40:50.268] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:50.268] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:97:0) after 1m0s
[09:41:50.350] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:97:0)
[09:41:50.350] Timer tick, asking Buildbucket for the build status
[09:41:50.478] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:50.478] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:98:0) after 1m0s
[09:42:50.500] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:98:0)
[09:42:50.500] Timer tick, asking Buildbucket for the build status
[09:42:50.720] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:50.720] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:99:0) after 1m0s
[09:43:50.832] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:99:0)
[09:43:50.832] Timer tick, asking Buildbucket for the build status
[09:43:51.055] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:51.055] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:100:0) after 1m0s
[09:44:51.114] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:100:0)
[09:44:51.114] Timer tick, asking Buildbucket for the build status
[09:44:51.182] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:51.183] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:101:0) after 1m0s
[09:45:51.246] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:101:0)
[09:45:51.246] Timer tick, asking Buildbucket for the build status
[09:45:51.336] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:51.336] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:102:0) after 1m0s
[09:46:51.394] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:102:0)
[09:46:51.394] Timer tick, asking Buildbucket for the build status
[09:46:51.612] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:51.612] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:103:0) after 1m0s
[09:47:51.698] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:103:0)
[09:47:51.698] Timer tick, asking Buildbucket for the build status
[09:47:52.040] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:52.040] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:104:0) after 1m0s
[09:48:52.109] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:104:0)
[09:48:52.109] Timer tick, asking Buildbucket for the build status
[09:48:52.185] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:52.185] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:105:0) after 1m0s
[09:49:52.237] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:105:0)
[09:49:52.237] Timer tick, asking Buildbucket for the build status
[09:49:52.352] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:52.352] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:106:0) after 1m0s
[09:50:52.417] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:106:0)
[09:50:52.417] Timer tick, asking Buildbucket for the build status
[09:50:52.481] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:52.481] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:107:0) after 1m0s
[09:51:52.546] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:107:0)
[09:51:52.546] Timer tick, asking Buildbucket for the build status
[09:51:52.676] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:52.676] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:108:0) after 1m0s
[09:52:52.750] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:108:0)
[09:52:52.750] Timer tick, asking Buildbucket for the build status
[09:52:52.812] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:52.812] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:109:0) after 1m0s
[09:53:52.865] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:109:0)
[09:53:52.865] Timer tick, asking Buildbucket for the build status
[09:53:53.031] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:53.031] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:110:0) after 1m0s
[09:54:53.056] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:110:0)
[09:54:53.056] Timer tick, asking Buildbucket for the build status
[09:54:53.560] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:53.560] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:111:0) after 1m0s
[09:55:53.617] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:111:0)
[09:55:53.617] Timer tick, asking Buildbucket for the build status
[09:55:53.997] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:53.997] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:112:0) after 1m0s
[09:56:54.038] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:112:0)
[09:56:54.039] Timer tick, asking Buildbucket for the build status
[09:56:54.452] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:54.452] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:113:0) after 1m0s
[09:57:54.479] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:113:0)
[09:57:54.479] Timer tick, asking Buildbucket for the build status
[09:57:54.553] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:54.553] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:114:0) after 1m0s
[09:58:54.608] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:114:0)
[09:58:54.608] Timer tick, asking Buildbucket for the build status
[09:58:54.915] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:54.916] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:115:0) after 1m0s
[09:59:54.936] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:115:0)
[09:59:54.936] Timer tick, asking Buildbucket for the build status
[09:59:55.035] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:55.035] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:116:0) after 1m0s
[10:00:55.065] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:116:0)
[10:00:55.065] Timer tick, asking Buildbucket for the build status
[10:00:55.161] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:55.161] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:117:0) after 1m0s
[10:01:55.250] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:117:0)
[10:01:55.250] Timer tick, asking Buildbucket for the build status
[10:01:55.337] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:55.337] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:118:0) after 1m0s
[10:02:55.416] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:118:0)
[10:02:55.416] Timer tick, asking Buildbucket for the build status
[10:02:55.496] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:55.496] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:119:0) after 1m0s
[10:03:55.568] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:119:0)
[10:03:55.568] Timer tick, asking Buildbucket for the build status
[10:03:55.639] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:55.639] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:120:0) after 1m0s
[10:04:55.744] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:120:0)
[10:04:55.744] Timer tick, asking Buildbucket for the build status
[10:04:55.905] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:55.905] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:121:0) after 1m0s
[10:05:55.931] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:121:0)
[10:05:55.931] Timer tick, asking Buildbucket for the build status
[10:05:56.010] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:56.010] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:122:0) after 1m0s
[10:06:55.993] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:122:0)
[10:06:55.993] Timer tick, asking Buildbucket for the build status
[10:06:56.355] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:56.355] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:123:0) after 1m0s
[10:07:56.497] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:123:0)
[10:07:56.497] Timer tick, asking Buildbucket for the build status
[10:07:56.584] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:56.584] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:124:0) after 1m0s
[10:08:56.659] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:124:0)
[10:08:56.659] Timer tick, asking Buildbucket for the build status
[10:08:56.720] Build 8852437450753429408: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:56.720] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9017867512783338864:125:0) after 1m0s
[10:09:24.707] Received PubSub notification, asking Buildbucket for the build status
[10:09:24.948] Build 8852437450753429408: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[10:09:24.948] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616062164335716",
"created_by": "project:chromium",
"created_ts": "1616054787831527",
"failure_reason": "BUILD_FAILURE",
"id": "8852437450753429408",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b77dff0b7321dfddad75a94003d345d58295aeb7\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- All/PrerenderBrowserTest.PrerenderedPageSameSiteNavigation/MPArch\\n\\n- All/PrerenderBrowserTest.RenderFrameHostLifecycleState/MPArch\\n\\n- All/PrerenderBrowserTest.LinkRelPrerender_Duplicate/MPArch\\n\\n- All/PrerenderBrowserTest.LinkRelPrerender_Multiple/MPArch\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.browser.compositor.layouts.LayoutManagerTest#testLayoutObserverNotification_ShowAndHide_TabSwitcher\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#startSurfaceRecordHistogramsTest__Instant_Return\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#startSurfaceRecordHistogramsTest__NoInstant_Return\\n\\n#### ...1 more test(s)...\"}, \"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\": \"b77dff0b7321dfddad75a94003d345d58295aeb7\", \"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-170-idad\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 8318, \"got_angle_revision\": \"bb7c1442587acf6bdee94f62f18d85e0485c3ab7\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"b77dff0b7321dfddad75a94003d345d58295aeb7\", \"got_revision_cp\": \"refs/heads/master@{#864149}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"4f0f4e2a3c5ad9dc7312774da5197e0179c30863\", \"got_v8_revision_cp\": \"refs/heads/9.1.146@{#1}\", \"got_webrtc_revision\": \"92a768ad66f54ca57002f6f2e87c7a732e3fec39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33488}\", \"is_cached\": true, \"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\": \"b77dff0b7321dfddad75a94003d345d58295aeb7\", \"swarm_hashes_refs/heads/master(at){#864149}_without_patch\": {\"android_browsertests\": \"ef90e8a7789f4c9fa356f7a82c3897ca392784aa\", \"chrome_public_test_apk\": \"6067ac25faabc8d173230d5ad5d3b56e93878ebe\", \"content_browsertests\": \"8aeafac0343a96d08cf4a68667cec8838437ef46\", \"content_shell_test_apk\": \"6fc4064ed8df242b502bfa0507f9cb63e83ed31c\", \"content_unittests\": \"c4ca8e347042ee5ebcead498d6654769239e8a3d\", \"unit_tests\": \"ae01a1a3eeb3d332d0dfdb4c4c4e44e84b22c94c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1143bf8a0c86d96d189f99a4f0f749b4f3d1e46c849c82cdd2c6ebe168938b3a_v2\", \"builder_4026221a727cf2e856e94035b8eeb49c4c65d62e8974e693170551540c198531_v2\", \"builder_73a5b2ce307b316a1240917eaad41a92e4adc44903c6789e05a5f10300306cda_v2\", \"builder_8083860191ac1707bdac6310382d6ca226876fc8f88202f45d8d07453f74f5a4_v2\", \"builder_9bfd7171a3bbd1a8f2af02f1311f913ecc6693b330c40ec1ccf845ae76a71675_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"builder_c51cbc0fa58cffa92874f1299c6c1508716c9d07d5ca701eb7e233fcc35e4da9_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-170-idad\"], \"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\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- All/PrerenderBrowserTest.PrerenderedPageSameSiteNavigation/MPArch\\n\\n- All/PrerenderBrowserTest.RenderFrameHostLifecycleState/MPArch\\n\\n- All/PrerenderBrowserTest.LinkRelPrerender_Duplicate/MPArch\\n\\n- All/PrerenderBrowserTest.LinkRelPrerender_Multiple/MPArch\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.browser.compositor.layouts.LayoutManagerTest#testLayoutObserverNotification_ShowAndHide_TabSwitcher\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#startSurfaceRecordHistogramsTest__Instant_Return\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#startSurfaceRecordHistogramsTest__NoInstant_Return\\n\\n#### ...1 more test(s)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616054823315886",
"status": "COMPLETED",
"status_changed_ts": "1616054823798747",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/8318",
"builder:android-bfcache-rel",
"buildset:commit/git/b77dff0b7321dfddad75a94003d345d58295aeb7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b77dff0b7321dfddad75a94003d345d58295aeb7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017867512783338864",
"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/8852437450753429408/+/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:525d30abdf628110",
"user_agent:luci-scheduler"
],
"updated_ts": "1616062164336099",
"url": "https://ci.chromium.org/b/8852437450753429408",
"utcnow_ts": "1616062164934541"
}
}
[10:09:24.948] Invocation finished in 2h2m58.436114693s with status FAILED