[01:02:21.290] New invocation is queued and will start shortly
[01:02:22.484] Starting the invocation (attempt 1)
[01:02:22.523] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:02:22.523] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:02:22.523] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034564035872699216",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9034564035872699216",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759",
"gitiles_ref:refs/heads/master"
]
}
[01:02:23.264] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1600131742636618",
"id": "8869133973792452560",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1600131743149324",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/5036",
"builder:android-bfcache-rel",
"buildset:commit/git/37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034564035872699216",
"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/8869133973792452560/+/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": "1600131743149452",
"url": "https://ci.chromium.org/b/8869133973792452560",
"utcnow_ts": "1600131743252772"
}
}
[01:02:23.264] Task URL: https://ci.chromium.org/b/8869133973792452560
[01:02:23.264] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:2:0) after 1m0s
[01:03:23.337] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:2:0)
[01:03:23.337] Timer tick, asking Buildbucket for the build status
[01:03:23.709] Build 8869133973792452560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:03:23.709] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:3:0) after 1m0s
[01:04:23.728] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:3:0)
[01:04:23.728] Timer tick, asking Buildbucket for the build status
[01:04:24.401] Build 8869133973792452560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:04:24.401] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:4:0) after 1m0s
[01:05:24.427] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:4:0)
[01:05:24.427] Timer tick, asking Buildbucket for the build status
[01:05:24.745] Build 8869133973792452560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:05:24.745] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:5:0) after 1m0s
[01:06:24.732] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:5:0)
[01:06:24.732] Timer tick, asking Buildbucket for the build status
[01:06:24.860] Build 8869133973792452560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:06:24.860] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:6:0) after 1m0s
[01:07:24.915] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:6:0)
[01:07:24.915] Timer tick, asking Buildbucket for the build status
[01:07:25.037] Build 8869133973792452560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:07:25.037] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:7:0) after 1m0s
[01:08:25.128] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:7:0)
[01:08:25.128] Timer tick, asking Buildbucket for the build status
[01:08:25.210] Build 8869133973792452560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:08:25.211] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:8:0) after 1m0s
[01:09:25.250] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:8:0)
[01:09:25.250] Timer tick, asking Buildbucket for the build status
[01:09:25.602] Build 8869133973792452560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:09:25.602] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:9:0) after 1m0s
[01:10:25.720] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:9:0)
[01:10:25.720] Timer tick, asking Buildbucket for the build status
[01:10:25.796] Build 8869133973792452560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:10:25.796] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:10:0) after 1m0s
[01:11:25.905] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:10:0)
[01:11:25.905] Timer tick, asking Buildbucket for the build status
[01:11:26.107] Build 8869133973792452560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:11:26.107] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:11:0) after 1m0s
[01:12:04.133] Received PubSub notification, asking Buildbucket for the build status
[01:12:04.484] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:26.225] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:11:0)
[01:12:26.225] Timer tick, asking Buildbucket for the build status
[01:12:26.435] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:26.435] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:13:0) after 1m0s
[01:13:26.458] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:13:0)
[01:13:26.458] Timer tick, asking Buildbucket for the build status
[01:13:26.555] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:26.555] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:14:0) after 1m0s
[01:14:26.664] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:14:0)
[01:14:26.664] Timer tick, asking Buildbucket for the build status
[01:14:26.747] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:26.748] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:15:0) after 1m0s
[01:15:26.787] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:15:0)
[01:15:26.787] Timer tick, asking Buildbucket for the build status
[01:15:26.866] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:26.866] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:16:0) after 1m0s
[01:16:26.953] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:16:0)
[01:16:26.953] Timer tick, asking Buildbucket for the build status
[01:16:27.103] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:27.103] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:17:0) after 1m0s
[01:17:27.152] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:17:0)
[01:17:27.152] Timer tick, asking Buildbucket for the build status
[01:17:27.282] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:27.282] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:18:0) after 1m0s
[01:18:27.303] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:18:0)
[01:18:27.303] Timer tick, asking Buildbucket for the build status
[01:18:27.447] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:27.447] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:19:0) after 1m0s
[01:19:27.505] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:19:0)
[01:19:27.505] Timer tick, asking Buildbucket for the build status
[01:19:27.594] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:27.594] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:20:0) after 1m0s
[01:20:27.695] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:20:0)
[01:20:27.695] Timer tick, asking Buildbucket for the build status
[01:20:27.870] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:27.870] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:21:0) after 1m0s
[01:21:29.325] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:21:0)
[01:21:29.325] Timer tick, asking Buildbucket for the build status
[01:21:30.106] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:30.106] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:22:0) after 1m0s
[01:22:30.160] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:22:0)
[01:22:30.160] Timer tick, asking Buildbucket for the build status
[01:22:30.281] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:30.281] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:23:0) after 1m0s
[01:23:30.401] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:23:0)
[01:23:30.401] Timer tick, asking Buildbucket for the build status
[01:23:30.493] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:30.494] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:24:0) after 1m0s
[01:24:30.524] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:24:0)
[01:24:30.524] Timer tick, asking Buildbucket for the build status
[01:24:30.793] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:30.793] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:25:0) after 1m0s
[01:25:30.852] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:25:0)
[01:25:30.852] Timer tick, asking Buildbucket for the build status
[01:25:31.026] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:31.026] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:26:0) after 1m0s
[01:26:31.092] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:26:0)
[01:26:31.092] Timer tick, asking Buildbucket for the build status
[01:26:31.259] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:31.259] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:27:0) after 1m0s
[01:27:31.341] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:27:0)
[01:27:31.341] Timer tick, asking Buildbucket for the build status
[01:27:31.458] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:31.458] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:28:0) after 1m0s
[01:28:31.500] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:28:0)
[01:28:31.500] Timer tick, asking Buildbucket for the build status
[01:28:33.163] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:33.163] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:29:0) after 1m0s
[01:29:33.321] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:29:0)
[01:29:33.321] Timer tick, asking Buildbucket for the build status
[01:29:33.436] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:33.436] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:30:0) after 1m0s
[01:30:33.556] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:30:0)
[01:30:33.556] Timer tick, asking Buildbucket for the build status
[01:30:33.720] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:33.721] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:31:0) after 1m0s
[01:31:33.744] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:31:0)
[01:31:33.744] Timer tick, asking Buildbucket for the build status
[01:31:33.944] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:33.944] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:32:0) after 1m0s
[01:32:33.962] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:32:0)
[01:32:33.962] Timer tick, asking Buildbucket for the build status
[01:32:34.108] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:34.108] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:33:0) after 1m0s
[01:33:34.132] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:33:0)
[01:33:34.132] Timer tick, asking Buildbucket for the build status
[01:33:34.337] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:34.337] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:34:0) after 1m0s
[01:34:34.397] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:34:0)
[01:34:34.397] Timer tick, asking Buildbucket for the build status
[01:34:34.469] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:34.469] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:35:0) after 1m0s
[01:35:34.524] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:35:0)
[01:35:34.524] Timer tick, asking Buildbucket for the build status
[01:35:34.598] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:34.598] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:36:0) after 1m0s
[01:36:34.631] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:36:0)
[01:36:34.631] Timer tick, asking Buildbucket for the build status
[01:36:34.700] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:34.700] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:37:0) after 1m0s
[01:37:34.839] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:37:0)
[01:37:34.839] Timer tick, asking Buildbucket for the build status
[01:37:35.109] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:35.109] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:38:0) after 1m0s
[01:38:35.209] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:38:0)
[01:38:35.209] Timer tick, asking Buildbucket for the build status
[01:38:35.439] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:35.439] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:39:0) after 1m0s
[01:39:35.518] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:39:0)
[01:39:35.518] Timer tick, asking Buildbucket for the build status
[01:39:35.956] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:35.956] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:40:0) after 1m0s
[01:40:35.988] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:40:0)
[01:40:35.988] Timer tick, asking Buildbucket for the build status
[01:40:36.201] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:36.201] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:41:0) after 1m0s
[01:41:36.212] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:41:0)
[01:41:36.212] Timer tick, asking Buildbucket for the build status
[01:41:36.279] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:36.279] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:42:0) after 1m0s
[01:42:36.283] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:42:0)
[01:42:36.283] Timer tick, asking Buildbucket for the build status
[01:42:36.531] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:36.531] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:43:0) after 1m0s
[01:43:36.607] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:43:0)
[01:43:36.607] Timer tick, asking Buildbucket for the build status
[01:43:36.773] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:36.773] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:44:0) after 1m0s
[01:44:36.845] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:44:0)
[01:44:36.845] Timer tick, asking Buildbucket for the build status
[01:44:37.127] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:37.127] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:45:0) after 1m0s
[01:45:37.141] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:45:0)
[01:45:37.141] Timer tick, asking Buildbucket for the build status
[01:45:37.301] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:37.301] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:46:0) after 1m0s
[01:46:37.408] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:46:0)
[01:46:37.408] Timer tick, asking Buildbucket for the build status
[01:46:37.541] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:37.541] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:47:0) after 1m0s
[01:47:37.641] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:47:0)
[01:47:37.641] Timer tick, asking Buildbucket for the build status
[01:47:37.772] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:37.772] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:48:0) after 1m0s
[01:48:37.871] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:48:0)
[01:48:37.871] Timer tick, asking Buildbucket for the build status
[01:48:37.943] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:37.943] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:49:0) after 1m0s
[01:49:38.025] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:49:0)
[01:49:38.025] Timer tick, asking Buildbucket for the build status
[01:49:38.101] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:38.101] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:50:0) after 1m0s
[01:50:38.183] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:50:0)
[01:50:38.183] Timer tick, asking Buildbucket for the build status
[01:50:38.779] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:38.779] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:51:0) after 1m0s
[01:51:38.843] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:51:0)
[01:51:38.843] Timer tick, asking Buildbucket for the build status
[01:51:39.194] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:39.194] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:52:0) after 1m0s
[01:52:39.278] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:52:0)
[01:52:39.278] Timer tick, asking Buildbucket for the build status
[01:52:39.492] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:39.492] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:53:0) after 1m0s
[01:53:39.572] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:53:0)
[01:53:39.572] Timer tick, asking Buildbucket for the build status
[01:53:39.631] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:39.631] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:54:0) after 1m0s
[01:54:39.716] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:54:0)
[01:54:39.716] Timer tick, asking Buildbucket for the build status
[01:54:39.799] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:39.799] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:55:0) after 1m0s
[01:55:39.804] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:55:0)
[01:55:39.804] Timer tick, asking Buildbucket for the build status
[01:55:39.878] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:39.878] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:56:0) after 1m0s
[01:56:39.929] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:56:0)
[01:56:39.929] Timer tick, asking Buildbucket for the build status
[01:56:40.000] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:40.000] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:57:0) after 1m0s
[01:57:40.076] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:57:0)
[01:57:40.076] Timer tick, asking Buildbucket for the build status
[01:57:40.196] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:40.196] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:58:0) after 1m0s
[01:58:40.303] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:58:0)
[01:58:40.303] Timer tick, asking Buildbucket for the build status
[01:58:40.377] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:40.377] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:59:0) after 1m0s
[01:59:40.517] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:59:0)
[01:59:40.517] Timer tick, asking Buildbucket for the build status
[01:59:40.572] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:40.572] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:60:0) after 1m0s
[02:00:40.647] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:60:0)
[02:00:40.647] Timer tick, asking Buildbucket for the build status
[02:00:40.926] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:40.926] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:61:0) after 1m0s
[02:01:40.946] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:61:0)
[02:01:40.946] Timer tick, asking Buildbucket for the build status
[02:01:41.141] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:41.141] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:62:0) after 1m0s
[02:02:41.183] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:62:0)
[02:02:41.183] Timer tick, asking Buildbucket for the build status
[02:02:41.373] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:41.373] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:63:0) after 1m0s
[02:03:41.423] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:63:0)
[02:03:41.423] Timer tick, asking Buildbucket for the build status
[02:03:41.781] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:41.781] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:64:0) after 1m0s
[02:04:41.825] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:64:0)
[02:04:41.825] Timer tick, asking Buildbucket for the build status
[02:04:41.901] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:41.901] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:65:0) after 1m0s
[02:05:41.956] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:65:0)
[02:05:41.956] Timer tick, asking Buildbucket for the build status
[02:05:42.106] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:42.106] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:66:0) after 1m0s
[02:06:42.149] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:66:0)
[02:06:42.149] Timer tick, asking Buildbucket for the build status
[02:06:42.413] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:42.413] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:67:0) after 1m0s
[02:07:42.472] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:67:0)
[02:07:42.472] Timer tick, asking Buildbucket for the build status
[02:07:42.879] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:42.879] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:68:0) after 1m0s
[02:08:42.914] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:68:0)
[02:08:42.914] Timer tick, asking Buildbucket for the build status
[02:08:42.982] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:42.982] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:69:0) after 1m0s
[02:09:43.154] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:69:0)
[02:09:43.154] Timer tick, asking Buildbucket for the build status
[02:09:43.252] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:43.252] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:70:0) after 1m0s
[02:10:43.301] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:70:0)
[02:10:43.301] Timer tick, asking Buildbucket for the build status
[02:10:43.446] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:43.446] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:71:0) after 1m0s
[02:11:43.529] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:71:0)
[02:11:43.529] Timer tick, asking Buildbucket for the build status
[02:11:43.600] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:43.600] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:72:0) after 1m0s
[02:12:43.633] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:72:0)
[02:12:43.633] Timer tick, asking Buildbucket for the build status
[02:12:43.819] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:43.819] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:73:0) after 1m0s
[02:13:43.938] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:73:0)
[02:13:43.938] Timer tick, asking Buildbucket for the build status
[02:13:44.013] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:44.013] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:74:0) after 1m0s
[02:14:44.422] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:74:0)
[02:14:44.422] Timer tick, asking Buildbucket for the build status
[02:14:44.519] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:44.519] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:75:0) after 1m0s
[02:15:44.720] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:75:0)
[02:15:44.720] Timer tick, asking Buildbucket for the build status
[02:15:44.788] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:44.788] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:76:0) after 1m0s
[02:16:44.911] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:76:0)
[02:16:44.911] Timer tick, asking Buildbucket for the build status
[02:16:44.971] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:44.971] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:77:0) after 1m0s
[02:17:45.081] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:77:0)
[02:17:45.081] Timer tick, asking Buildbucket for the build status
[02:17:45.248] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:45.248] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:78:0) after 1m0s
[02:18:45.320] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:78:0)
[02:18:45.320] Timer tick, asking Buildbucket for the build status
[02:18:45.413] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:45.413] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:79:0) after 1m0s
[02:19:45.579] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:79:0)
[02:19:45.579] Timer tick, asking Buildbucket for the build status
[02:19:45.718] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:45.718] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:80:0) after 1m0s
[02:20:45.939] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:80:0)
[02:20:45.939] Timer tick, asking Buildbucket for the build status
[02:20:46.030] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:46.030] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:81:0) after 1m0s
[02:21:46.173] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:81:0)
[02:21:46.173] Timer tick, asking Buildbucket for the build status
[02:21:46.317] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:46.317] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:82:0) after 1m0s
[02:22:46.352] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:82:0)
[02:22:46.352] Timer tick, asking Buildbucket for the build status
[02:22:46.493] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:46.493] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:83:0) after 1m0s
[02:23:46.561] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:83:0)
[02:23:46.561] Timer tick, asking Buildbucket for the build status
[02:23:46.714] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:46.714] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:84:0) after 1m0s
[02:24:46.742] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:84:0)
[02:24:46.742] Timer tick, asking Buildbucket for the build status
[02:24:46.808] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:46.808] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:85:0) after 1m0s
[02:25:46.909] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:85:0)
[02:25:46.909] Timer tick, asking Buildbucket for the build status
[02:25:46.976] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:46.976] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:86:0) after 1m0s
[02:26:47.065] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:86:0)
[02:26:47.065] Timer tick, asking Buildbucket for the build status
[02:26:47.312] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:47.312] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:87:0) after 1m0s
[02:27:47.416] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:87:0)
[02:27:47.416] Timer tick, asking Buildbucket for the build status
[02:27:47.685] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:47.686] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:88:0) after 1m0s
[02:28:47.743] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:88:0)
[02:28:47.743] Timer tick, asking Buildbucket for the build status
[02:28:47.815] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:47.815] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:89:0) after 1m0s
[02:29:48.004] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:89:0)
[02:29:48.004] Timer tick, asking Buildbucket for the build status
[02:29:48.075] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:48.075] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:90:0) after 1m0s
[02:30:48.094] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:90:0)
[02:30:48.094] Timer tick, asking Buildbucket for the build status
[02:30:48.184] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:48.184] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:91:0) after 1m0s
[02:31:48.214] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:91:0)
[02:31:48.214] Timer tick, asking Buildbucket for the build status
[02:31:48.300] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:48.300] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:92:0) after 1m0s
[02:32:48.348] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:92:0)
[02:32:48.348] Timer tick, asking Buildbucket for the build status
[02:32:48.515] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:48.515] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:93:0) after 1m0s
[02:33:48.600] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:93:0)
[02:33:48.600] Timer tick, asking Buildbucket for the build status
[02:33:48.687] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:48.687] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:94:0) after 1m0s
[02:34:48.791] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:94:0)
[02:34:48.791] Timer tick, asking Buildbucket for the build status
[02:34:48.899] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:48.899] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:95:0) after 1m0s
[02:35:48.976] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:95:0)
[02:35:48.976] Timer tick, asking Buildbucket for the build status
[02:35:49.369] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:49.369] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:96:0) after 1m0s
[02:36:49.815] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:96:0)
[02:36:49.816] Timer tick, asking Buildbucket for the build status
[02:36:49.920] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:49.920] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:97:0) after 1m0s
[02:37:50.087] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:97:0)
[02:37:50.087] Timer tick, asking Buildbucket for the build status
[02:37:50.203] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:50.203] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:98:0) after 1m0s
[02:38:50.479] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:98:0)
[02:38:50.479] Timer tick, asking Buildbucket for the build status
[02:38:50.607] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:50.607] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:99:0) after 1m0s
[02:39:50.897] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:99:0)
[02:39:50.897] Timer tick, asking Buildbucket for the build status
[02:39:51.332] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:51.332] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:100:0) after 1m0s
[02:40:51.445] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:100:0)
[02:40:51.445] Timer tick, asking Buildbucket for the build status
[02:40:51.558] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:51.558] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:101:0) after 1m0s
[02:41:51.628] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:101:0)
[02:41:51.628] Timer tick, asking Buildbucket for the build status
[02:41:51.707] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:51.708] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:102:0) after 1m0s
[02:42:51.754] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:102:0)
[02:42:51.754] Timer tick, asking Buildbucket for the build status
[02:42:51.886] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:51.886] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:103:0) after 1m0s
[02:43:51.895] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:103:0)
[02:43:51.895] Timer tick, asking Buildbucket for the build status
[02:43:51.974] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:51.974] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:104:0) after 1m0s
[02:44:52.204] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:104:0)
[02:44:52.204] Timer tick, asking Buildbucket for the build status
[02:44:52.394] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:52.394] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:105:0) after 1m0s
[02:45:52.426] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:105:0)
[02:45:52.426] Timer tick, asking Buildbucket for the build status
[02:45:54.978] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:54.978] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:106:0) after 1m0s
[02:46:55.041] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:106:0)
[02:46:55.041] Timer tick, asking Buildbucket for the build status
[02:46:55.374] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:55.374] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:107:0) after 1m0s
[02:47:55.422] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:107:0)
[02:47:55.422] Timer tick, asking Buildbucket for the build status
[02:47:55.559] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:55.559] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:108:0) after 1m0s
[02:48:55.590] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:108:0)
[02:48:55.590] Timer tick, asking Buildbucket for the build status
[02:48:55.659] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:55.659] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:109:0) after 1m0s
[02:49:55.695] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:109:0)
[02:49:55.695] Timer tick, asking Buildbucket for the build status
[02:49:56.031] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:56.031] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:110:0) after 1m0s
[02:50:56.097] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:110:0)
[02:50:56.097] Timer tick, asking Buildbucket for the build status
[02:50:56.171] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:56.171] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:111:0) after 1m0s
[02:51:56.246] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:111:0)
[02:51:56.246] Timer tick, asking Buildbucket for the build status
[02:51:56.444] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:56.444] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:112:0) after 1m0s
[02:52:56.865] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:112:0)
[02:52:56.865] Timer tick, asking Buildbucket for the build status
[02:52:57.205] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:57.205] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:113:0) after 1m0s
[02:53:57.450] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:113:0)
[02:53:57.450] Timer tick, asking Buildbucket for the build status
[02:53:57.577] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:57.577] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:114:0) after 1m0s
[02:54:58.107] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:114:0)
[02:54:58.107] Timer tick, asking Buildbucket for the build status
[02:54:58.386] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:58.386] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:115:0) after 1m0s
[02:55:58.630] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:115:0)
[02:55:58.630] Timer tick, asking Buildbucket for the build status
[02:55:58.699] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:58.699] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:116:0) after 1m0s
[02:56:58.822] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:116:0)
[02:56:58.822] Timer tick, asking Buildbucket for the build status
[02:56:59.102] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:59.102] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:117:0) after 1m0s
[02:57:59.300] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:117:0)
[02:57:59.300] Timer tick, asking Buildbucket for the build status
[02:57:59.457] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:59.457] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:118:0) after 1m0s
[02:58:59.619] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:118:0)
[02:58:59.619] Timer tick, asking Buildbucket for the build status
[02:58:59.709] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:59.709] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:119:0) after 1m0s
[02:59:59.933] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:119:0)
[02:59:59.933] Timer tick, asking Buildbucket for the build status
[03:00:00.114] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:00.114] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:120:0) after 1m0s
[03:01:00.262] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:120:0)
[03:01:00.262] Timer tick, asking Buildbucket for the build status
[03:01:00.347] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:00.347] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:121:0) after 1m0s
[03:02:00.571] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:121:0)
[03:02:00.571] Timer tick, asking Buildbucket for the build status
[03:02:00.643] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:00.643] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:122:0) after 1m0s
[03:03:00.846] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:122:0)
[03:03:00.846] Timer tick, asking Buildbucket for the build status
[03:03:00.980] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:00.980] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:123:0) after 1m0s
[03:04:01.746] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:123:0)
[03:04:01.746] Timer tick, asking Buildbucket for the build status
[03:04:02.669] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:02.669] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:124:0) after 1m0s
[03:05:03.412] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:124:0)
[03:05:03.412] Timer tick, asking Buildbucket for the build status
[03:05:03.506] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:03.506] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:125:0) after 1m0s
[03:06:03.548] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:125:0)
[03:06:03.548] Timer tick, asking Buildbucket for the build status
[03:06:03.785] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:03.785] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:126:0) after 1m0s
[03:07:03.918] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:126:0)
[03:07:03.918] Timer tick, asking Buildbucket for the build status
[03:07:04.159] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:04.159] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:127:0) after 1m0s
[03:08:04.218] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:127:0)
[03:08:04.218] Timer tick, asking Buildbucket for the build status
[03:08:04.963] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:04.963] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:128:0) after 1m0s
[03:09:05.123] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:128:0)
[03:09:05.123] Timer tick, asking Buildbucket for the build status
[03:09:05.185] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:05.185] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:129:0) after 1m0s
[03:10:05.189] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:129:0)
[03:10:05.189] Timer tick, asking Buildbucket for the build status
[03:10:05.280] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:05.280] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:130:0) after 1m0s
[03:11:05.395] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:130:0)
[03:11:05.395] Timer tick, asking Buildbucket for the build status
[03:11:05.503] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:05.503] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:131:0) after 1m0s
[03:12:05.637] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:131:0)
[03:12:05.637] Timer tick, asking Buildbucket for the build status
[03:12:05.765] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:05.765] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:132:0) after 1m0s
[03:13:05.933] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:132:0)
[03:13:05.933] Timer tick, asking Buildbucket for the build status
[03:13:07.022] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:07.023] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:133:0) after 1m0s
[03:14:07.051] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:133:0)
[03:14:07.051] Timer tick, asking Buildbucket for the build status
[03:14:07.116] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:07.116] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:134:0) after 1m0s
[03:15:07.171] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:134:0)
[03:15:07.171] Timer tick, asking Buildbucket for the build status
[03:15:07.271] Build 8869133973792452560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:07.271] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9034564035872699216:135:0) after 1m0s
[03:15:45.245] Received PubSub notification, asking Buildbucket for the build status
[03:15:45.333] Build 8869133973792452560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:15:45.333] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1600139744450948",
"created_by": "project:chromium",
"created_ts": "1600131742636618",
"id": "8869133973792452560",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759\", \"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-59-0xho\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 5036, \"got_angle_revision\": \"75d257686e00d26633d0ae4648b1c9939fffda22\", \"got_dawn_revision\": \"dbd34449af20f2d026b1e7f959073e254066ec83\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759\", \"got_revision_cp\": \"refs/heads/master@{#806799}\", \"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\": \"295570eb332df04a16c830e99d7e95c80626c325\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32098}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759\", \"swarm_hashes\": {\"android_browsertests\": \"d6f6f507774c2b91fbc74468cf21870df761b5e6\", \"chrome_public_test_apk\": \"96dd6c89178480705e8d5fc02d202e44f7b00408\", \"content_browsertests\": \"581bfe4f590671847661821cd9e37b7ba4130e19\", \"content_shell_test_apk\": \"58040398173e8161e26b4ae6d094b0671f0b4839\", \"content_unittests\": \"74a87bd5deb62dc95aee0fd7396edf801172f2e3\", \"unit_tests\": \"10c3e44fb6a5aaf973da0e19b07ccc0058859d69\"}, \"swarm_hashes_refs/heads/master(at){#806799}_without_patch\": {\"android_browsertests\": \"d6f6f507774c2b91fbc74468cf21870df761b5e6\", \"chrome_public_test_apk\": \"96dd6c89178480705e8d5fc02d202e44f7b00408\", \"content_browsertests\": \"581bfe4f590671847661821cd9e37b7ba4130e19\", \"content_shell_test_apk\": \"58040398173e8161e26b4ae6d094b0671f0b4839\", \"content_unittests\": \"74a87bd5deb62dc95aee0fd7396edf801172f2e3\", \"unit_tests\": \"10c3e44fb6a5aaf973da0e19b07ccc0058859d69\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_304607b978b8f4bcd63bac0f543c3a69f6b4c7cf202dcd2d3c5b8d4a70be201e_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_3e75b41c9bcf12a22209c03b338cce1fafa12941d3074ed1e1ed2450e6b71594_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_953e900270162ec95f568ea264af47d43b9a29a15e01ede040ffa4d15b188919_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_c33cb68a27562f3c0030aeadb8872bc9395ca543fdfb70fdbe284a5ae715c202_v2\", \"builder_e4464922e5c60bddfcc3d01cfc511ef7f4a711bded636fa98c66f03a573264ee_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-59-0xho\"], \"image\": [\"chrome-xenial-20090600-f98a2a06cf8\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5522-67570db\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1600132323448775",
"status": "COMPLETED",
"status_changed_ts": "1600139744822188",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/5036",
"builder:android-bfcache-rel",
"buildset:commit/git/37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/37e23fcbc3ab3d8e6b6f47c41446f7e831ed3759",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034564035872699216",
"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/8869133973792452560/+/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:4ea81a4786b2be10",
"user_agent:luci-scheduler"
],
"updated_ts": "1600139744828905",
"url": "https://ci.chromium.org/b/8869133973792452560",
"utcnow_ts": "1600139745325060"
}
}
[03:15:45.333] Invocation finished in 2h13m24.06517214s with status SUCCEEDED