[00:47:08.872] New invocation is queued and will start shortly
[00:47:10.901] Starting the invocation (attempt 1)
[00:47:10.938] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:47:10.938] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:47:10.938] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9038279468232719520",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"76b2872853d0affae07d710ad5b1a93b790246e8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9038279468232719520",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/76b2872853d0affae07d710ad5b1a93b790246e8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/76b2872853d0affae07d710ad5b1a93b790246e8",
"gitiles_ref:refs/heads/master"
]
}
[00:47:12.822] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1596588431170014",
"id": "8872849405156224272",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"76b2872853d0affae07d710ad5b1a93b790246e8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1596588432460838",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4311",
"builder:android-bfcache-rel",
"buildset:commit/git/76b2872853d0affae07d710ad5b1a93b790246e8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/76b2872853d0affae07d710ad5b1a93b790246e8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038279468232719520",
"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/8872849405156224272/+/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": "1596588432460978",
"url": "https://ci.chromium.org/b/8872849405156224272",
"utcnow_ts": "1596588432807339"
}
}
[00:47:12.822] Task URL: https://ci.chromium.org/b/8872849405156224272
[00:47:12.822] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:2:0) after 1m0s
[00:48:12.831] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:2:0)
[00:48:12.831] Timer tick, asking Buildbucket for the build status
[00:48:13.398] Build 8872849405156224272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:48:13.398] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:3:0) after 1m0s
[00:49:13.554] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:3:0)
[00:49:13.554] Timer tick, asking Buildbucket for the build status
[00:49:13.654] Build 8872849405156224272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:49:13.654] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:4:0) after 1m0s
[00:50:13.788] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:4:0)
[00:50:13.788] Timer tick, asking Buildbucket for the build status
[00:50:13.955] Build 8872849405156224272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:50:13.955] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:5:0) after 1m0s
[00:51:13.978] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:5:0)
[00:51:13.978] Timer tick, asking Buildbucket for the build status
[00:51:15.535] Build 8872849405156224272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:51:15.535] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:6:0) after 1m0s
[00:52:15.603] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:6:0)
[00:52:15.603] Timer tick, asking Buildbucket for the build status
[00:52:15.735] Build 8872849405156224272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:52:15.735] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:7:0) after 1m0s
[00:53:15.795] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:7:0)
[00:53:15.795] Timer tick, asking Buildbucket for the build status
[00:53:15.861] Build 8872849405156224272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:53:15.861] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:8:0) after 1m0s
[00:54:15.864] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:8:0)
[00:54:15.864] Timer tick, asking Buildbucket for the build status
[00:54:16.025] Build 8872849405156224272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:54:16.025] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:9:0) after 1m0s
[00:55:16.135] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:9:0)
[00:55:16.135] Timer tick, asking Buildbucket for the build status
[00:55:16.261] Build 8872849405156224272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:55:16.261] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:10:0) after 1m0s
[00:55:33.093] Received PubSub notification, asking Buildbucket for the build status
[00:55:33.591] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:16.308] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:10:0)
[00:56:16.308] Timer tick, asking Buildbucket for the build status
[00:56:16.386] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:16.386] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:12:0) after 1m0s
[00:57:16.450] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:12:0)
[00:57:16.450] Timer tick, asking Buildbucket for the build status
[00:57:16.553] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:16.553] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:13:0) after 1m0s
[00:58:16.577] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:13:0)
[00:58:16.577] Timer tick, asking Buildbucket for the build status
[00:58:16.647] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:16.647] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:14:0) after 1m0s
[00:59:16.662] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:14:0)
[00:59:16.662] Timer tick, asking Buildbucket for the build status
[00:59:16.823] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:16.823] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:15:0) after 1m0s
[01:00:16.877] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:15:0)
[01:00:16.877] Timer tick, asking Buildbucket for the build status
[01:00:17.055] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:17.055] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:16:0) after 1m0s
[01:01:17.064] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:16:0)
[01:01:17.064] Timer tick, asking Buildbucket for the build status
[01:01:17.198] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:17.198] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:17:0) after 1m0s
[01:02:17.263] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:17:0)
[01:02:17.263] Timer tick, asking Buildbucket for the build status
[01:02:17.453] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:17.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:18:0) after 1m0s
[01:03:17.552] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:18:0)
[01:03:17.552] Timer tick, asking Buildbucket for the build status
[01:03:17.619] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:17.619] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:19:0) after 1m0s
[01:04:17.692] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:19:0)
[01:04:17.692] Timer tick, asking Buildbucket for the build status
[01:04:17.957] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:17.957] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:20:0) after 1m0s
[01:05:17.974] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:20:0)
[01:05:17.974] Timer tick, asking Buildbucket for the build status
[01:05:18.041] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:18.041] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:21:0) after 1m0s
[01:06:18.078] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:21:0)
[01:06:18.078] Timer tick, asking Buildbucket for the build status
[01:06:18.171] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:18.171] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:22:0) after 1m0s
[01:07:18.181] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:22:0)
[01:07:18.181] Timer tick, asking Buildbucket for the build status
[01:07:18.756] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:18.756] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:23:0) after 1m0s
[01:08:18.782] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:23:0)
[01:08:18.782] Timer tick, asking Buildbucket for the build status
[01:08:19.263] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:19.263] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:24:0) after 1m0s
[01:09:19.320] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:24:0)
[01:09:19.320] Timer tick, asking Buildbucket for the build status
[01:09:19.426] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:19.426] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:25:0) after 1m0s
[01:10:19.464] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:25:0)
[01:10:19.464] Timer tick, asking Buildbucket for the build status
[01:10:21.097] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:21.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:26:0) after 1m0s
[01:11:21.128] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:26:0)
[01:11:21.128] Timer tick, asking Buildbucket for the build status
[01:11:21.290] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:21.290] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:27:0) after 1m0s
[01:12:21.356] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:27:0)
[01:12:21.356] Timer tick, asking Buildbucket for the build status
[01:12:21.496] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:21.496] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:28:0) after 1m0s
[01:13:21.517] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:28:0)
[01:13:21.517] Timer tick, asking Buildbucket for the build status
[01:13:21.815] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:21.815] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:29:0) after 1m0s
[01:14:21.822] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:29:0)
[01:14:21.822] Timer tick, asking Buildbucket for the build status
[01:14:21.985] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:21.985] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:30:0) after 1m0s
[01:15:22.030] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:30:0)
[01:15:22.030] Timer tick, asking Buildbucket for the build status
[01:15:22.155] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:22.155] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:31:0) after 1m0s
[01:16:22.281] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:31:0)
[01:16:22.281] Timer tick, asking Buildbucket for the build status
[01:16:22.386] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:22.386] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:32:0) after 1m0s
[01:17:22.396] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:32:0)
[01:17:22.396] Timer tick, asking Buildbucket for the build status
[01:17:22.580] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:22.580] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:33:0) after 1m0s
[01:18:22.833] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:33:0)
[01:18:22.833] Timer tick, asking Buildbucket for the build status
[01:18:22.936] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:22.936] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:34:0) after 1m0s
[01:19:23.230] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:34:0)
[01:19:23.230] Timer tick, asking Buildbucket for the build status
[01:19:23.369] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:23.369] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:35:0) after 1m0s
[01:20:23.579] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:35:0)
[01:20:23.579] Timer tick, asking Buildbucket for the build status
[01:20:23.644] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:23.644] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:36:0) after 1m0s
[01:21:23.697] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:36:0)
[01:21:23.697] Timer tick, asking Buildbucket for the build status
[01:21:24.706] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:24.706] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:37:0) after 1m0s
[01:22:24.867] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:37:0)
[01:22:24.867] Timer tick, asking Buildbucket for the build status
[01:22:25.370] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:25.370] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:38:0) after 1m0s
[01:23:25.440] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:38:0)
[01:23:25.440] Timer tick, asking Buildbucket for the build status
[01:23:25.565] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:25.565] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:39:0) after 1m0s
[01:24:25.730] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:39:0)
[01:24:25.730] Timer tick, asking Buildbucket for the build status
[01:24:26.222] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:26.222] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:40:0) after 1m0s
[01:25:26.302] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:40:0)
[01:25:26.302] Timer tick, asking Buildbucket for the build status
[01:25:26.451] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:26.451] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:41:0) after 1m0s
[01:26:26.526] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:41:0)
[01:26:26.526] Timer tick, asking Buildbucket for the build status
[01:26:26.620] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:26.620] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:42:0) after 1m0s
[01:27:26.767] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:42:0)
[01:27:26.767] Timer tick, asking Buildbucket for the build status
[01:27:26.992] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:26.992] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:43:0) after 1m0s
[01:28:27.157] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:43:0)
[01:28:27.157] Timer tick, asking Buildbucket for the build status
[01:28:27.333] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:27.333] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:44:0) after 1m0s
[01:29:27.488] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:44:0)
[01:29:27.488] Timer tick, asking Buildbucket for the build status
[01:29:27.555] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:27.555] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:45:0) after 1m0s
[01:30:27.562] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:45:0)
[01:30:27.562] Timer tick, asking Buildbucket for the build status
[01:30:27.635] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:27.636] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:46:0) after 1m0s
[01:31:27.683] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:46:0)
[01:31:27.683] Timer tick, asking Buildbucket for the build status
[01:31:27.756] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:27.756] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:47:0) after 1m0s
[01:32:27.783] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:47:0)
[01:32:27.783] Timer tick, asking Buildbucket for the build status
[01:32:27.923] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:27.923] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:48:0) after 1m0s
[01:33:27.977] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:48:0)
[01:33:27.977] Timer tick, asking Buildbucket for the build status
[01:33:28.068] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:28.068] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:49:0) after 1m0s
[01:34:28.131] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:49:0)
[01:34:28.132] Timer tick, asking Buildbucket for the build status
[01:34:28.352] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:28.352] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:50:0) after 1m0s
[01:35:28.368] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:50:0)
[01:35:28.368] Timer tick, asking Buildbucket for the build status
[01:35:28.530] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:28.530] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:51:0) after 1m0s
[01:36:28.607] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:51:0)
[01:36:28.607] Timer tick, asking Buildbucket for the build status
[01:36:28.672] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:28.672] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:52:0) after 1m0s
[01:37:28.725] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:52:0)
[01:37:28.725] Timer tick, asking Buildbucket for the build status
[01:37:28.880] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:28.880] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:53:0) after 1m0s
[01:38:28.983] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:53:0)
[01:38:28.983] Timer tick, asking Buildbucket for the build status
[01:38:29.062] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:29.062] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:54:0) after 1m0s
[01:39:29.146] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:54:0)
[01:39:29.146] Timer tick, asking Buildbucket for the build status
[01:39:29.424] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:29.424] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:55:0) after 1m0s
[01:40:29.431] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:55:0)
[01:40:29.431] Timer tick, asking Buildbucket for the build status
[01:40:29.495] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:29.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:56:0) after 1m0s
[01:41:29.519] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:56:0)
[01:41:29.519] Timer tick, asking Buildbucket for the build status
[01:41:29.591] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:29.591] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:57:0) after 1m0s
[01:42:29.650] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:57:0)
[01:42:29.650] Timer tick, asking Buildbucket for the build status
[01:42:29.868] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:29.868] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:58:0) after 1m0s
[01:43:29.906] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:58:0)
[01:43:29.906] Timer tick, asking Buildbucket for the build status
[01:43:29.968] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:29.968] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:59:0) after 1m0s
[01:44:30.028] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:59:0)
[01:44:30.028] Timer tick, asking Buildbucket for the build status
[01:44:30.099] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:30.099] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:60:0) after 1m0s
[01:45:30.130] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:60:0)
[01:45:30.130] Timer tick, asking Buildbucket for the build status
[01:45:30.248] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:30.248] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:61:0) after 1m0s
[01:46:30.336] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:61:0)
[01:46:30.336] Timer tick, asking Buildbucket for the build status
[01:46:30.494] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:30.494] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:62:0) after 1m0s
[01:47:30.552] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:62:0)
[01:47:30.552] Timer tick, asking Buildbucket for the build status
[01:47:30.682] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:30.682] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:63:0) after 1m0s
[01:48:30.757] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:63:0)
[01:48:30.757] Timer tick, asking Buildbucket for the build status
[01:48:30.919] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:30.919] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:64:0) after 1m0s
[01:49:30.957] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:64:0)
[01:49:30.957] Timer tick, asking Buildbucket for the build status
[01:49:31.102] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:31.102] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:65:0) after 1m0s
[01:50:31.125] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:65:0)
[01:50:31.125] Timer tick, asking Buildbucket for the build status
[01:50:31.234] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:31.234] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:66:0) after 1m0s
[01:51:31.275] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:66:0)
[01:51:31.275] Timer tick, asking Buildbucket for the build status
[01:51:31.379] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:31.379] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:67:0) after 1m0s
[01:52:31.660] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:67:0)
[01:52:31.660] Timer tick, asking Buildbucket for the build status
[01:52:31.791] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:31.791] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:68:0) after 1m0s
[01:53:31.975] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:68:0)
[01:53:31.975] Timer tick, asking Buildbucket for the build status
[01:53:32.122] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:32.122] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:69:0) after 1m0s
[01:54:32.240] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:69:0)
[01:54:32.240] Timer tick, asking Buildbucket for the build status
[01:54:32.329] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:32.329] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:70:0) after 1m0s
[01:55:32.562] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:70:0)
[01:55:32.562] Timer tick, asking Buildbucket for the build status
[01:55:32.642] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:32.642] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:71:0) after 1m0s
[01:56:32.898] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:71:0)
[01:56:32.898] Timer tick, asking Buildbucket for the build status
[01:56:33.122] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:33.122] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:72:0) after 1m0s
[01:57:33.385] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:72:0)
[01:57:33.385] Timer tick, asking Buildbucket for the build status
[01:57:33.817] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:33.817] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:73:0) after 1m0s
[01:58:33.982] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:73:0)
[01:58:33.982] Timer tick, asking Buildbucket for the build status
[01:58:34.213] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:34.213] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:74:0) after 1m0s
[01:59:34.307] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:74:0)
[01:59:34.307] Timer tick, asking Buildbucket for the build status
[01:59:34.364] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:34.364] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:75:0) after 1m0s
[02:00:34.482] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:75:0)
[02:00:34.482] Timer tick, asking Buildbucket for the build status
[02:00:34.562] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:34.562] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:76:0) after 1m0s
[02:01:34.671] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:76:0)
[02:01:34.671] Timer tick, asking Buildbucket for the build status
[02:01:34.781] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:34.782] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:77:0) after 1m0s
[02:02:34.908] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:77:0)
[02:02:34.908] Timer tick, asking Buildbucket for the build status
[02:02:35.214] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:35.214] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:78:0) after 1m0s
[02:03:35.230] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:78:0)
[02:03:35.230] Timer tick, asking Buildbucket for the build status
[02:03:35.293] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:35.293] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:79:0) after 1m0s
[02:04:35.437] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:79:0)
[02:04:35.437] Timer tick, asking Buildbucket for the build status
[02:04:35.533] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:35.533] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:80:0) after 1m0s
[02:05:35.627] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:80:0)
[02:05:35.627] Timer tick, asking Buildbucket for the build status
[02:05:35.754] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:35.754] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:81:0) after 1m0s
[02:06:35.788] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:81:0)
[02:06:35.788] Timer tick, asking Buildbucket for the build status
[02:06:35.869] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:35.869] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:82:0) after 1m0s
[02:07:35.864] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:82:0)
[02:07:35.864] Timer tick, asking Buildbucket for the build status
[02:07:35.990] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:35.990] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:83:0) after 1m0s
[02:08:36.047] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:83:0)
[02:08:36.047] Timer tick, asking Buildbucket for the build status
[02:08:36.226] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:36.226] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:84:0) after 1m0s
[02:09:36.261] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:84:0)
[02:09:36.261] Timer tick, asking Buildbucket for the build status
[02:09:36.366] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:36.366] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:85:0) after 1m0s
[02:10:36.450] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:85:0)
[02:10:36.450] Timer tick, asking Buildbucket for the build status
[02:10:36.504] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:36.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:86:0) after 1m0s
[02:11:36.546] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:86:0)
[02:11:36.547] Timer tick, asking Buildbucket for the build status
[02:11:36.703] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:36.703] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:87:0) after 1m0s
[02:12:36.750] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:87:0)
[02:12:36.750] Timer tick, asking Buildbucket for the build status
[02:12:36.971] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:36.971] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:88:0) after 1m0s
[02:13:36.966] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:88:0)
[02:13:36.966] Timer tick, asking Buildbucket for the build status
[02:13:37.029] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:37.029] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:89:0) after 1m0s
[02:14:37.137] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:89:0)
[02:14:37.137] Timer tick, asking Buildbucket for the build status
[02:14:37.332] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:37.332] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:90:0) after 1m0s
[02:15:37.447] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:90:0)
[02:15:37.447] Timer tick, asking Buildbucket for the build status
[02:15:37.557] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:37.557] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:91:0) after 1m0s
[02:16:37.682] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:91:0)
[02:16:37.682] Timer tick, asking Buildbucket for the build status
[02:16:37.861] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:37.862] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:92:0) after 1m0s
[02:17:37.946] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:92:0)
[02:17:37.946] Timer tick, asking Buildbucket for the build status
[02:17:38.103] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:93:0) after 1m0s
[02:18:38.149] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:93:0)
[02:18:38.149] Timer tick, asking Buildbucket for the build status
[02:18:38.223] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:38.223] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:94:0) after 1m0s
[02:19:38.257] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:94:0)
[02:19:38.257] Timer tick, asking Buildbucket for the build status
[02:19:38.327] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:38.327] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:95:0) after 1m0s
[02:20:38.475] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:95:0)
[02:20:38.475] Timer tick, asking Buildbucket for the build status
[02:20:38.621] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:38.621] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:96:0) after 1m0s
[02:21:38.695] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:96:0)
[02:21:38.695] Timer tick, asking Buildbucket for the build status
[02:21:38.775] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:38.775] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:97:0) after 1m0s
[02:22:38.799] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:97:0)
[02:22:38.799] Timer tick, asking Buildbucket for the build status
[02:22:39.233] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:39.233] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:98:0) after 1m0s
[02:23:39.318] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:98:0)
[02:23:39.318] Timer tick, asking Buildbucket for the build status
[02:23:39.816] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:39.816] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:99:0) after 1m0s
[02:24:40.177] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:99:0)
[02:24:40.177] Timer tick, asking Buildbucket for the build status
[02:24:40.439] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:40.439] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:100:0) after 1m0s
[02:25:40.644] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:100:0)
[02:25:40.644] Timer tick, asking Buildbucket for the build status
[02:25:40.700] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:40.700] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:101:0) after 1m0s
[02:26:40.831] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:101:0)
[02:26:40.831] Timer tick, asking Buildbucket for the build status
[02:26:40.977] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:40.977] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:102:0) after 1m0s
[02:27:41.142] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:102:0)
[02:27:41.142] Timer tick, asking Buildbucket for the build status
[02:27:41.268] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:41.268] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:103:0) after 1m0s
[02:28:41.455] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:103:0)
[02:28:41.455] Timer tick, asking Buildbucket for the build status
[02:28:41.625] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:41.625] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:104:0) after 1m0s
[02:29:41.892] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:104:0)
[02:29:41.892] Timer tick, asking Buildbucket for the build status
[02:29:42.066] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:42.066] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:105:0) after 1m0s
[02:30:42.311] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:105:0)
[02:30:42.311] Timer tick, asking Buildbucket for the build status
[02:30:42.409] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:42.409] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:106:0) after 1m0s
[02:31:42.575] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:106:0)
[02:31:42.575] Timer tick, asking Buildbucket for the build status
[02:31:42.717] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:42.717] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:107:0) after 1m0s
[02:32:42.848] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:107:0)
[02:32:42.848] Timer tick, asking Buildbucket for the build status
[02:32:43.097] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:43.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:108:0) after 1m0s
[02:33:43.170] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:108:0)
[02:33:43.170] Timer tick, asking Buildbucket for the build status
[02:33:43.320] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:43.320] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:109:0) after 1m0s
[02:34:43.417] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:109:0)
[02:34:43.417] Timer tick, asking Buildbucket for the build status
[02:34:43.511] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:43.511] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:110:0) after 1m0s
[02:35:43.602] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:110:0)
[02:35:43.602] Timer tick, asking Buildbucket for the build status
[02:35:43.741] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:43.741] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:111:0) after 1m0s
[02:36:43.777] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:111:0)
[02:36:43.777] Timer tick, asking Buildbucket for the build status
[02:36:43.883] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:43.883] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:112:0) after 1m0s
[02:37:43.917] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:112:0)
[02:37:43.917] Timer tick, asking Buildbucket for the build status
[02:37:44.094] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:44.094] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:113:0) after 1m0s
[02:38:44.134] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:113:0)
[02:38:44.134] Timer tick, asking Buildbucket for the build status
[02:38:44.359] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:44.359] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:114:0) after 1m0s
[02:39:44.402] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:114:0)
[02:39:44.402] Timer tick, asking Buildbucket for the build status
[02:39:44.983] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:44.983] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:115:0) after 1m0s
[02:40:45.084] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:115:0)
[02:40:45.084] Timer tick, asking Buildbucket for the build status
[02:40:45.277] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:45.277] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:116:0) after 1m0s
[02:41:45.323] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:116:0)
[02:41:45.323] Timer tick, asking Buildbucket for the build status
[02:41:45.783] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:45.783] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:117:0) after 1m0s
[02:42:45.828] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:117:0)
[02:42:45.828] Timer tick, asking Buildbucket for the build status
[02:42:46.001] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:46.001] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:118:0) after 1m0s
[02:43:46.085] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:118:0)
[02:43:46.085] Timer tick, asking Buildbucket for the build status
[02:43:46.167] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:46.167] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:119:0) after 1m0s
[02:44:46.298] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:119:0)
[02:44:46.298] Timer tick, asking Buildbucket for the build status
[02:44:46.390] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:46.390] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:120:0) after 1m0s
[02:45:46.474] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:120:0)
[02:45:46.474] Timer tick, asking Buildbucket for the build status
[02:45:46.652] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:46.652] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:121:0) after 1m0s
[02:46:46.752] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:121:0)
[02:46:46.752] Timer tick, asking Buildbucket for the build status
[02:46:46.871] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:46.872] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:122:0) after 1m0s
[02:47:46.967] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:122:0)
[02:47:46.967] Timer tick, asking Buildbucket for the build status
[02:47:47.191] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:47.191] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:123:0) after 1m0s
[02:48:47.436] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:123:0)
[02:48:47.436] Timer tick, asking Buildbucket for the build status
[02:48:47.518] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:47.518] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:124:0) after 1m0s
[02:49:47.645] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:124:0)
[02:49:47.645] Timer tick, asking Buildbucket for the build status
[02:49:47.720] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:47.720] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:125:0) after 1m0s
[02:50:47.852] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:125:0)
[02:50:47.852] Timer tick, asking Buildbucket for the build status
[02:50:47.980] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:47.980] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:126:0) after 1m0s
[02:51:48.006] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:126:0)
[02:51:48.006] Timer tick, asking Buildbucket for the build status
[02:51:48.082] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:48.082] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:127:0) after 1m0s
[02:52:48.132] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:127:0)
[02:52:48.132] Timer tick, asking Buildbucket for the build status
[02:52:48.310] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:48.310] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:128:0) after 1m0s
[02:53:48.404] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:128:0)
[02:53:48.404] Timer tick, asking Buildbucket for the build status
[02:53:48.622] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:48.622] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:129:0) after 1m0s
[02:54:48.686] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:129:0)
[02:54:48.686] Timer tick, asking Buildbucket for the build status
[02:54:48.935] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:48.935] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:130:0) after 1m0s
[02:55:49.008] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:130:0)
[02:55:49.008] Timer tick, asking Buildbucket for the build status
[02:55:49.089] Build 8872849405156224272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:49.090] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9038279468232719520:131:0) after 1m0s
[02:56:20.947] Received PubSub notification, asking Buildbucket for the build status
[02:56:21.081] Build 8872849405156224272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:56:21.081] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1596596180182990",
"created_by": "project:chromium",
"created_ts": "1596588431170014",
"id": "8872849405156224272",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"76b2872853d0affae07d710ad5b1a93b790246e8\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"76b2872853d0affae07d710ad5b1a93b790246e8\", \"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-65-z36s\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 4311, \"got_angle_revision\": \"d41280a787d1594470053dfa15b3330822049612\", \"got_dawn_revision\": \"0a4342793e0e31ed36e59d2eef36817c82ede555\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"76b2872853d0affae07d710ad5b1a93b790246e8\", \"got_revision_cp\": \"refs/heads/master@{#794789}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"be7c55a2a8cebd46ba6912e6b7d4dae8353d154c\", \"got_v8_revision\": \"cc5f2c8c9d9aca964a29ea1bf3130a6fd402c755\", \"got_v8_revision_cp\": \"refs/heads/8.6.333@{#1}\", \"got_webrtc_revision\": \"7e30909bf44a224f7dbb49fc6bac6f2fdd4fd822\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31842}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.android.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"76b2872853d0affae07d710ad5b1a93b790246e8\", \"swarm_hashes\": {\"android_browsertests\": \"9c3b26d663348634bcf75635b03817aa906eeb97\", \"chrome_public_test_apk\": \"42e14bf8f5da1d097e458e1ccd291f90381a911a\", \"content_browsertests\": \"f23ccc136d492a2e9b42e5b593e8f1457e1287a7\", \"content_shell_test_apk\": \"621eb2ac6ea3156beee5ca6850cf68e7a88f7f0e\", \"content_unittests\": \"7efdf4a98b8e43758ac30dcf265bf83b454b916d\", \"unit_tests\": \"1dc0bdc5ff62f9126905a19599065a9c7c8005b4\"}, \"swarm_hashes_refs/heads/master(at){#794789}_without_patch\": {\"android_browsertests\": \"9c3b26d663348634bcf75635b03817aa906eeb97\", \"chrome_public_test_apk\": \"42e14bf8f5da1d097e458e1ccd291f90381a911a\", \"content_browsertests\": \"f23ccc136d492a2e9b42e5b593e8f1457e1287a7\", \"content_shell_test_apk\": \"621eb2ac6ea3156beee5ca6850cf68e7a88f7f0e\", \"content_unittests\": \"7efdf4a98b8e43758ac30dcf265bf83b454b916d\", \"unit_tests\": \"1dc0bdc5ff62f9126905a19599065a9c7c8005b4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_36fe1eb6b69fde039fcb7d0dbef9d650d6ee5da308e5a21dca08b29e461764a0_v2\", \"builder_3df726b65531685b338b7c2caf48988c15becc2e6a96e549d7512dce09d4fac6_v2\", \"builder_431ae331f5ec3b188f86fcc0bfb7f77f1cf0532726a0b003d9cf2f8977acf8c7_v2\", \"builder_573c606f18492d6cde6d25a02b12203725732038b1c2909b0b80126d2afb25c2_v2\", \"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_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-65-z36s\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"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\": [\"5436-adf7f8a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1596588932306205",
"status": "COMPLETED",
"status_changed_ts": "1596596180639676",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4311",
"builder:android-bfcache-rel",
"buildset:commit/git/76b2872853d0affae07d710ad5b1a93b790246e8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/76b2872853d0affae07d710ad5b1a93b790246e8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9038279468232719520",
"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/8872849405156224272/+/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:4dd4e7a62d012a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1596596180653639",
"url": "https://ci.chromium.org/b/8872849405156224272",
"utcnow_ts": "1596596181069622"
}
}
[02:56:21.081] Invocation finished in 2h9m12.229448385s with status SUCCEEDED