[15:37:02.636] New invocation is queued and will start shortly
[15:37:04.610] Starting the invocation (attempt 1)
[15:37:04.718] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:37:04.718] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:37:04.718] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045199447227305312",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"08108e54259312ca3d1e2bf22ec5cc504f821971\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9045199447227305312",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/08108e54259312ca3d1e2bf22ec5cc504f821971",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08108e54259312ca3d1e2bf22ec5cc504f821971",
"gitiles_ref:refs/heads/master"
]
}
[15:37:05.572] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1589989024894689",
"id": "8879769384190805424",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"08108e54259312ca3d1e2bf22ec5cc504f821971\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1589989025367358",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/2828",
"builder:android-bfcache-rel",
"buildset:commit/git/08108e54259312ca3d1e2bf22ec5cc504f821971",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08108e54259312ca3d1e2bf22ec5cc504f821971",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045199447227305312",
"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/8879769384190805424/+/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": "1589989025367611",
"url": "https://ci.chromium.org/b/8879769384190805424",
"utcnow_ts": "1589989025552675"
}
}
[15:37:05.572] Task URL: https://ci.chromium.org/b/8879769384190805424
[15:37:05.572] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:2:0) after 1m0s
[15:38:06.049] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:2:0)
[15:38:06.049] Timer tick, asking Buildbucket for the build status
[15:38:06.197] Build 8879769384190805424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:38:06.197] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:3:0) after 1m0s
[15:39:06.463] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:3:0)
[15:39:06.463] Timer tick, asking Buildbucket for the build status
[15:39:06.828] Build 8879769384190805424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:39:06.829] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:4:0) after 1m0s
[15:40:07.498] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:4:0)
[15:40:07.498] Timer tick, asking Buildbucket for the build status
[15:40:07.643] Build 8879769384190805424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:40:07.643] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:5:0) after 1m0s
[15:41:07.867] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:5:0)
[15:41:07.867] Timer tick, asking Buildbucket for the build status
[15:41:08.970] Build 8879769384190805424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:41:08.970] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:6:0) after 1m0s
[15:42:09.390] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:6:0)
[15:42:09.390] Timer tick, asking Buildbucket for the build status
[15:42:09.614] Build 8879769384190805424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:42:09.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:7:0) after 1m0s
[15:43:10.013] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:7:0)
[15:43:10.013] Timer tick, asking Buildbucket for the build status
[15:43:10.176] Build 8879769384190805424: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:43:10.176] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:8:0) after 1m0s
[15:43:44.010] Received PubSub notification, asking Buildbucket for the build status
[15:43:44.130] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:10.572] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:8:0)
[15:44:10.572] Timer tick, asking Buildbucket for the build status
[15:44:10.799] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:10.799] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:10:0) after 1m0s
[15:45:11.074] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:10:0)
[15:45:11.074] Timer tick, asking Buildbucket for the build status
[15:45:11.250] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:11.250] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:11:0) after 1m0s
[15:46:11.385] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:11:0)
[15:46:11.385] Timer tick, asking Buildbucket for the build status
[15:46:11.870] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:11.870] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:12:0) after 1m0s
[15:47:12.114] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:12:0)
[15:47:12.114] Timer tick, asking Buildbucket for the build status
[15:47:12.305] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:12.305] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:13:0) after 1m0s
[15:48:12.532] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:13:0)
[15:48:12.532] Timer tick, asking Buildbucket for the build status
[15:48:12.731] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:12.731] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:14:0) after 1m0s
[15:49:13.181] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:14:0)
[15:49:13.181] Timer tick, asking Buildbucket for the build status
[15:49:13.745] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:13.745] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:15:0) after 1m0s
[15:50:13.861] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:15:0)
[15:50:13.861] Timer tick, asking Buildbucket for the build status
[15:50:14.644] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:14.644] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:16:0) after 1m0s
[15:51:14.686] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:16:0)
[15:51:14.686] Timer tick, asking Buildbucket for the build status
[15:51:14.872] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:14.872] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:17:0) after 1m0s
[15:52:15.047] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:17:0)
[15:52:15.047] Timer tick, asking Buildbucket for the build status
[15:52:15.247] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:15.247] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:18:0) after 1m0s
[15:53:15.439] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:18:0)
[15:53:15.439] Timer tick, asking Buildbucket for the build status
[15:53:15.623] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:15.623] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:19:0) after 1m0s
[15:54:15.753] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:19:0)
[15:54:15.753] Timer tick, asking Buildbucket for the build status
[15:54:16.163] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:16.163] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:20:0) after 1m0s
[15:55:16.273] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:20:0)
[15:55:16.273] Timer tick, asking Buildbucket for the build status
[15:55:16.478] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:16.478] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:21:0) after 1m0s
[15:56:16.603] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:21:0)
[15:56:16.603] Timer tick, asking Buildbucket for the build status
[15:56:16.815] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:16.815] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:22:0) after 1m0s
[15:57:16.929] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:22:0)
[15:57:16.929] Timer tick, asking Buildbucket for the build status
[15:57:17.270] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:17.270] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:23:0) after 1m0s
[15:58:17.338] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:23:0)
[15:58:17.338] Timer tick, asking Buildbucket for the build status
[15:58:17.678] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:17.678] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:24:0) after 1m0s
[15:59:17.916] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:24:0)
[15:59:17.916] Timer tick, asking Buildbucket for the build status
[15:59:18.195] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:18.195] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:25:0) after 1m0s
[16:00:18.209] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:25:0)
[16:00:18.209] Timer tick, asking Buildbucket for the build status
[16:00:18.401] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:18.401] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:26:0) after 1m0s
[16:01:18.520] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:26:0)
[16:01:18.520] Timer tick, asking Buildbucket for the build status
[16:01:19.249] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:19.249] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:27:0) after 1m0s
[16:02:19.331] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:27:0)
[16:02:19.331] Timer tick, asking Buildbucket for the build status
[16:02:19.431] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:19.431] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:28:0) after 1m0s
[16:03:19.642] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:28:0)
[16:03:19.642] Timer tick, asking Buildbucket for the build status
[16:03:19.983] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:19.983] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:29:0) after 1m0s
[16:04:20.006] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:29:0)
[16:04:20.006] Timer tick, asking Buildbucket for the build status
[16:04:20.083] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:20.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:30:0) after 1m0s
[16:05:20.191] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:30:0)
[16:05:20.191] Timer tick, asking Buildbucket for the build status
[16:05:20.959] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:20.959] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:31:0) after 1m0s
[16:06:21.084] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:31:0)
[16:06:21.084] Timer tick, asking Buildbucket for the build status
[16:06:21.274] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:21.274] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:32:0) after 1m0s
[16:07:21.311] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:32:0)
[16:07:21.311] Timer tick, asking Buildbucket for the build status
[16:07:21.901] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:21.901] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:33:0) after 1m0s
[16:08:21.915] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:33:0)
[16:08:21.915] Timer tick, asking Buildbucket for the build status
[16:08:22.096] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:22.096] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:34:0) after 1m0s
[16:09:22.136] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:34:0)
[16:09:22.136] Timer tick, asking Buildbucket for the build status
[16:09:22.414] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:22.415] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:35:0) after 1m0s
[16:10:22.437] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:35:0)
[16:10:22.437] Timer tick, asking Buildbucket for the build status
[16:10:22.693] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:22.693] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:36:0) after 1m0s
[16:11:22.824] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:36:0)
[16:11:22.824] Timer tick, asking Buildbucket for the build status
[16:11:23.032] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:23.032] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:37:0) after 1m0s
[16:12:23.054] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:37:0)
[16:12:23.054] Timer tick, asking Buildbucket for the build status
[16:12:23.313] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:23.313] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:38:0) after 1m0s
[16:13:23.373] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:38:0)
[16:13:23.373] Timer tick, asking Buildbucket for the build status
[16:13:23.497] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:23.497] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:39:0) after 1m0s
[16:14:23.566] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:39:0)
[16:14:23.566] Timer tick, asking Buildbucket for the build status
[16:14:23.742] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:23.742] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:40:0) after 1m0s
[16:15:23.790] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:40:0)
[16:15:23.790] Timer tick, asking Buildbucket for the build status
[16:15:23.979] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:23.979] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:41:0) after 1m0s
[16:16:24.059] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:41:0)
[16:16:24.059] Timer tick, asking Buildbucket for the build status
[16:16:24.504] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:24.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:42:0) after 1m0s
[16:17:24.734] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:42:0)
[16:17:24.734] Timer tick, asking Buildbucket for the build status
[16:17:25.146] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:25.146] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:43:0) after 1m0s
[16:18:25.197] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:43:0)
[16:18:25.197] Timer tick, asking Buildbucket for the build status
[16:18:25.294] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:25.294] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:44:0) after 1m0s
[16:19:25.389] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:44:0)
[16:19:25.389] Timer tick, asking Buildbucket for the build status
[16:19:25.525] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:25.525] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:45:0) after 1m0s
[16:20:25.603] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:45:0)
[16:20:25.603] Timer tick, asking Buildbucket for the build status
[16:20:26.719] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:26.719] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:46:0) after 1m0s
[16:21:26.826] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:46:0)
[16:21:26.826] Timer tick, asking Buildbucket for the build status
[16:21:26.994] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:26.994] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:47:0) after 1m0s
[16:22:27.433] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:47:0)
[16:22:27.433] Timer tick, asking Buildbucket for the build status
[16:22:27.586] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:27.586] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:48:0) after 1m0s
[16:23:27.899] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:48:0)
[16:23:27.899] Timer tick, asking Buildbucket for the build status
[16:23:28.317] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:28.317] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:49:0) after 1m0s
[16:24:28.443] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:49:0)
[16:24:28.443] Timer tick, asking Buildbucket for the build status
[16:24:28.728] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:28.728] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:50:0) after 1m0s
[16:25:28.759] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:50:0)
[16:25:28.759] Timer tick, asking Buildbucket for the build status
[16:25:29.517] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:29.517] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:51:0) after 1m0s
[16:26:29.556] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:51:0)
[16:26:29.556] Timer tick, asking Buildbucket for the build status
[16:26:29.774] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:29.774] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:52:0) after 1m0s
[16:27:29.798] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:52:0)
[16:27:29.798] Timer tick, asking Buildbucket for the build status
[16:27:30.006] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:30.006] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:53:0) after 1m0s
[16:28:30.077] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:53:0)
[16:28:30.077] Timer tick, asking Buildbucket for the build status
[16:28:30.253] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:30.253] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:54:0) after 1m0s
[16:29:30.361] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:54:0)
[16:29:30.361] Timer tick, asking Buildbucket for the build status
[16:29:30.950] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:30.950] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:55:0) after 1m0s
[16:30:30.995] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:55:0)
[16:30:30.995] Timer tick, asking Buildbucket for the build status
[16:30:31.128] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:31.128] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:56:0) after 1m0s
[16:31:31.182] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:56:0)
[16:31:31.182] Timer tick, asking Buildbucket for the build status
[16:31:31.304] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:31.304] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:57:0) after 1m0s
[16:32:31.480] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:57:0)
[16:32:31.480] Timer tick, asking Buildbucket for the build status
[16:32:31.620] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:31.620] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:58:0) after 1m0s
[16:33:31.682] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:58:0)
[16:33:31.682] Timer tick, asking Buildbucket for the build status
[16:33:32.127] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:32.127] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:59:0) after 1m0s
[16:34:32.399] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:59:0)
[16:34:32.399] Timer tick, asking Buildbucket for the build status
[16:34:32.550] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:32.550] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:60:0) after 1m0s
[16:35:32.586] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:60:0)
[16:35:32.586] Timer tick, asking Buildbucket for the build status
[16:35:32.834] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:32.834] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:61:0) after 1m0s
[16:36:32.860] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:61:0)
[16:36:32.860] Timer tick, asking Buildbucket for the build status
[16:36:33.154] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:33.154] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:62:0) after 1m0s
[16:37:33.164] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:62:0)
[16:37:33.164] Timer tick, asking Buildbucket for the build status
[16:37:33.363] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:33.363] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:63:0) after 1m0s
[16:38:33.479] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:63:0)
[16:38:33.479] Timer tick, asking Buildbucket for the build status
[16:38:35.587] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:35.587] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:64:0) after 1m0s
[16:39:35.598] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:64:0)
[16:39:35.598] Timer tick, asking Buildbucket for the build status
[16:39:35.772] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:35.772] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:65:0) after 1m0s
[16:40:35.824] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:65:0)
[16:40:35.824] Timer tick, asking Buildbucket for the build status
[16:40:36.293] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:36.293] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:66:0) after 1m0s
[16:41:36.287] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:66:0)
[16:41:36.287] Timer tick, asking Buildbucket for the build status
[16:41:36.486] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:36.486] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:67:0) after 1m0s
[16:42:36.520] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:67:0)
[16:42:36.520] Timer tick, asking Buildbucket for the build status
[16:42:36.912] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:36.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:68:0) after 1m0s
[16:43:36.985] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:68:0)
[16:43:36.985] Timer tick, asking Buildbucket for the build status
[16:43:37.227] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:37.227] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:69:0) after 1m0s
[16:44:37.285] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:69:0)
[16:44:37.285] Timer tick, asking Buildbucket for the build status
[16:44:37.473] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:37.473] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:70:0) after 1m0s
[16:45:37.638] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:70:0)
[16:45:37.638] Timer tick, asking Buildbucket for the build status
[16:45:37.739] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:37.739] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:71:0) after 1m0s
[16:46:37.778] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:71:0)
[16:46:37.778] Timer tick, asking Buildbucket for the build status
[16:46:37.932] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:37.932] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:72:0) after 1m0s
[16:47:37.998] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:72:0)
[16:47:37.998] Timer tick, asking Buildbucket for the build status
[16:47:38.986] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:38.986] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:73:0) after 1m0s
[16:48:39.092] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:73:0)
[16:48:39.092] Timer tick, asking Buildbucket for the build status
[16:48:39.303] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:39.303] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:74:0) after 1m0s
[16:49:39.345] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:74:0)
[16:49:39.345] Timer tick, asking Buildbucket for the build status
[16:49:39.487] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:39.487] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:75:0) after 1m0s
[16:50:39.483] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:75:0)
[16:50:39.483] Timer tick, asking Buildbucket for the build status
[16:50:39.704] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:39.704] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:76:0) after 1m0s
[16:51:39.744] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:76:0)
[16:51:39.744] Timer tick, asking Buildbucket for the build status
[16:51:39.941] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:39.941] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:77:0) after 1m0s
[16:52:40.015] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:77:0)
[16:52:40.015] Timer tick, asking Buildbucket for the build status
[16:52:40.197] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:40.197] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:78:0) after 1m0s
[16:53:40.254] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:78:0)
[16:53:40.254] Timer tick, asking Buildbucket for the build status
[16:53:40.669] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:40.669] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:79:0) after 1m0s
[16:54:40.773] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:79:0)
[16:54:40.773] Timer tick, asking Buildbucket for the build status
[16:54:40.906] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:40.906] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:80:0) after 1m0s
[16:55:40.992] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:80:0)
[16:55:40.992] Timer tick, asking Buildbucket for the build status
[16:55:41.215] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:41.215] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:81:0) after 1m0s
[16:56:41.288] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:81:0)
[16:56:41.288] Timer tick, asking Buildbucket for the build status
[16:56:41.444] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:41.444] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:82:0) after 1m0s
[16:57:41.518] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:82:0)
[16:57:41.518] Timer tick, asking Buildbucket for the build status
[16:57:41.652] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:41.652] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:83:0) after 1m0s
[16:58:41.693] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:83:0)
[16:58:41.693] Timer tick, asking Buildbucket for the build status
[16:58:42.288] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:42.288] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:84:0) after 1m0s
[16:59:42.384] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:84:0)
[16:59:42.384] Timer tick, asking Buildbucket for the build status
[16:59:42.523] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:42.523] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:85:0) after 1m0s
[17:00:42.559] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:85:0)
[17:00:42.559] Timer tick, asking Buildbucket for the build status
[17:00:44.718] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:44.718] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:86:0) after 1m0s
[17:01:44.785] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:86:0)
[17:01:44.785] Timer tick, asking Buildbucket for the build status
[17:01:45.131] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:45.131] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:87:0) after 1m0s
[17:02:45.163] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:87:0)
[17:02:45.163] Timer tick, asking Buildbucket for the build status
[17:02:45.507] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:45.507] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:88:0) after 1m0s
[17:03:45.516] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:88:0)
[17:03:45.516] Timer tick, asking Buildbucket for the build status
[17:03:45.709] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:45.709] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:89:0) after 1m0s
[17:04:45.740] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:89:0)
[17:04:45.740] Timer tick, asking Buildbucket for the build status
[17:04:47.557] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:47.557] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:90:0) after 1m0s
[17:05:47.694] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:90:0)
[17:05:47.694] Timer tick, asking Buildbucket for the build status
[17:05:47.784] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:47.784] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:91:0) after 1m0s
[17:06:47.829] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:91:0)
[17:06:47.829] Timer tick, asking Buildbucket for the build status
[17:06:48.075] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:48.075] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:92:0) after 1m0s
[17:07:48.126] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:92:0)
[17:07:48.126] Timer tick, asking Buildbucket for the build status
[17:07:48.522] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:48.522] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:93:0) after 1m0s
[17:08:48.499] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:93:0)
[17:08:48.499] Timer tick, asking Buildbucket for the build status
[17:08:48.661] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:48.661] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:94:0) after 1m0s
[17:09:48.746] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:94:0)
[17:09:48.746] Timer tick, asking Buildbucket for the build status
[17:09:48.899] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:48.899] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:95:0) after 1m0s
[17:10:49.038] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:95:0)
[17:10:49.038] Timer tick, asking Buildbucket for the build status
[17:10:49.208] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:49.208] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:96:0) after 1m0s
[17:11:49.345] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:96:0)
[17:11:49.345] Timer tick, asking Buildbucket for the build status
[17:11:49.539] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:49.539] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:97:0) after 1m0s
[17:12:49.772] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:97:0)
[17:12:49.772] Timer tick, asking Buildbucket for the build status
[17:12:49.912] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:49.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:98:0) after 1m0s
[17:13:51.551] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:98:0)
[17:13:51.551] Timer tick, asking Buildbucket for the build status
[17:13:51.798] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:51.798] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:99:0) after 1m0s
[17:14:52.519] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:99:0)
[17:14:52.519] Timer tick, asking Buildbucket for the build status
[17:14:52.665] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:52.665] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:100:0) after 1m0s
[17:15:53.632] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:100:0)
[17:15:53.632] Timer tick, asking Buildbucket for the build status
[17:15:53.726] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:53.726] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:101:0) after 1m0s
[17:16:54.094] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:101:0)
[17:16:54.094] Timer tick, asking Buildbucket for the build status
[17:16:54.538] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:54.538] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:102:0) after 1m0s
[17:17:54.603] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:102:0)
[17:17:54.603] Timer tick, asking Buildbucket for the build status
[17:17:55.114] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:55.114] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:103:0) after 1m0s
[17:18:55.231] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:103:0)
[17:18:55.231] Timer tick, asking Buildbucket for the build status
[17:18:55.458] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:55.458] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:104:0) after 1m0s
[17:19:55.550] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:104:0)
[17:19:55.550] Timer tick, asking Buildbucket for the build status
[17:19:56.559] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:56.559] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:105:0) after 1m0s
[17:20:56.634] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:105:0)
[17:20:56.634] Timer tick, asking Buildbucket for the build status
[17:20:56.943] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:56.943] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:106:0) after 1m0s
[17:21:56.974] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:106:0)
[17:21:56.974] Timer tick, asking Buildbucket for the build status
[17:21:57.141] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:57.142] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:107:0) after 1m0s
[17:22:57.250] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:107:0)
[17:22:57.250] Timer tick, asking Buildbucket for the build status
[17:22:57.406] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:57.406] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:108:0) after 1m0s
[17:23:57.445] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:108:0)
[17:23:57.445] Timer tick, asking Buildbucket for the build status
[17:23:57.578] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:57.578] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:109:0) after 1m0s
[17:24:57.728] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:109:0)
[17:24:57.728] Timer tick, asking Buildbucket for the build status
[17:24:58.483] Build 8879769384190805424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:58.483] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045199447227305312:110:0) after 1m0s
[17:25:28.721] Received PubSub notification, asking Buildbucket for the build status
[17:25:28.883] Build 8879769384190805424: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:25:28.883] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1589995527516414",
"created_by": "project:chromium",
"created_ts": "1589989024894689",
"failure_reason": "BUILD_FAILURE",
"id": "8879769384190805424",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"08108e54259312ca3d1e2bf22ec5cc504f821971\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- RenderDocumentHostUserDataTest.CrossSiteNavigation\\n\\n- SitePerProcessBrowserTest.NavigateMainFrameToChildSite\\n\\n- SitePerProcessBrowserTest.ActiveSandboxFlagsRetainedAfterUnload\\n\\n- RenderDocumentHostUserDataTest.FailedNavigation\\n\\n- ...25 more failure(s) (29 total)...\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testSearchInIncognitoSingleSurface__Instant_Return\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testScroll_OmniboxOnly_Top__NoInstant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsTabSwitcher__Instant_NoReturn\\n\\n- ...123 more failure(s) (126 total)...\\n\\n#### ...1 more test(s)...\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-38-04ut\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 2828, \"got_angle_revision\": \"583c9a38d9bd702e2d9364f72b72a3a090fd1747\", \"got_dawn_revision\": \"78f7e8640f1452eab5a31bd07ec955b3a41d0aba\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"08108e54259312ca3d1e2bf22ec5cc504f821971\", \"got_revision_cp\": \"refs/heads/master@{#770600}\", \"got_swarming_client_revision\": \"7e8636295f4763a5f5aace1e700b17a4af3c81b7\", \"got_swiftshader_revision\": \"b6e8c3f0f4830887d69ba765a922ac3c40e81dd9\", \"got_v8_revision\": \"b072390cd31323aec324401a835bc319b94878d4\", \"got_v8_revision_cp\": \"refs/heads/8.5.29@{#1}\", \"got_webrtc_revision\": \"4b860c1fb389b641acf8595a1ca38fd07f11bc2d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31331}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.android.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"08108e54259312ca3d1e2bf22ec5cc504f821971\", \"swarm_hashes\": {\"android_browsertests\": \"ffe5c2649187942c8f537e9b8add1405ec96aa64\", \"chrome_public_test_apk\": \"3a1d3feec8f813e7bc5a85494a329c180d2dcf31\", \"content_browsertests\": \"e693afcd49d686b63934b033909991cc6aadbee0\", \"content_shell_test_apk\": \"3b9decee7f5f6ac1ea6398b933f3a5eda1acab4c\", \"content_unittests\": \"48f6d3145b2fb19b00b59608b5b2b5b9ef1f84b0\", \"unit_tests\": \"995c7022bac7116038eaeab0a7904e24beed97ba\"}, \"swarm_hashes_refs/heads/master(at){#770600}_without_patch\": {\"android_browsertests\": \"ffe5c2649187942c8f537e9b8add1405ec96aa64\", \"chrome_public_test_apk\": \"3a1d3feec8f813e7bc5a85494a329c180d2dcf31\", \"content_browsertests\": \"e693afcd49d686b63934b033909991cc6aadbee0\", \"content_shell_test_apk\": \"3b9decee7f5f6ac1ea6398b933f3a5eda1acab4c\", \"content_unittests\": \"48f6d3145b2fb19b00b59608b5b2b5b9ef1f84b0\", \"unit_tests\": \"995c7022bac7116038eaeab0a7904e24beed97ba\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_40238b720ec4feb1f57c327a3b72021d0e440ababc8fca32fd370c36be82ffcf_v2\", \"builder_69f5bab4a885266166e099964d6d1498f6d3761c92bc1d5b083a29cb822fe90c_v2\", \"builder_bee64b857be6df8b7c1ab34ae7b2c6eab296c35495667b8b8424b2083d103b1e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-38-04ut\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5100-d2625c1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- RenderDocumentHostUserDataTest.CrossSiteNavigation\\n\\n- SitePerProcessBrowserTest.NavigateMainFrameToChildSite\\n\\n- SitePerProcessBrowserTest.ActiveSandboxFlagsRetainedAfterUnload\\n\\n- RenderDocumentHostUserDataTest.FailedNavigation\\n\\n- ...25 more failure(s) (29 total)...\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testSearchInIncognitoSingleSurface__Instant_Return\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testScroll_OmniboxOnly_Top__NoInstant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsTabSwitcher__Instant_NoReturn\\n\\n- ...123 more failure(s) (126 total)...\\n\\n#### ...1 more test(s)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1589989423159622",
"status": "COMPLETED",
"status_changed_ts": "1589989423670680",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/2828",
"builder:android-bfcache-rel",
"buildset:commit/git/08108e54259312ca3d1e2bf22ec5cc504f821971",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08108e54259312ca3d1e2bf22ec5cc504f821971",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045199447227305312",
"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/8879769384190805424/+/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:4c4b8cb2afa6c610",
"user_agent:luci-scheduler"
],
"updated_ts": "1589995528041406",
"url": "https://ci.chromium.org/b/8879769384190805424",
"utcnow_ts": "1589995528868786"
}
}
[17:25:28.883] Invocation finished in 1h48m26.268174262s with status FAILED