[00:22:53.330] New invocation is queued and will start shortly
[00:22:56.254] Starting the invocation (attempt 1)
[00:22:56.295] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:22:56.296] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:22:56.296] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9044441588189504976",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"efa26f8b28c644155cba9994d33fd0b8b702b36c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9044441588189504976",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/efa26f8b28c644155cba9994d33fd0b8b702b36c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/efa26f8b28c644155cba9994d33fd0b8b702b36c",
"gitiles_ref:refs/heads/master"
]
}
[00:22:57.311] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1590711776428189",
"id": "8879011524278375168",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"efa26f8b28c644155cba9994d33fd0b8b702b36c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1590711777098005",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/3015",
"builder:android-bfcache-rel",
"buildset:commit/git/efa26f8b28c644155cba9994d33fd0b8b702b36c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/efa26f8b28c644155cba9994d33fd0b8b702b36c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044441588189504976",
"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/8879011524278375168/+/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": "1590711777098271",
"url": "https://ci.chromium.org/b/8879011524278375168",
"utcnow_ts": "1590711777301198"
}
}
[00:22:57.311] Task URL: https://ci.chromium.org/b/8879011524278375168
[00:22:57.311] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:2:0) after 1m0s
[00:23:57.331] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:2:0)
[00:23:57.331] Timer tick, asking Buildbucket for the build status
[00:23:59.836] Build 8879011524278375168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:23:59.836] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:3:0) after 1m0s
[00:24:59.879] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:3:0)
[00:24:59.879] Timer tick, asking Buildbucket for the build status
[00:25:00.245] Build 8879011524278375168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:25:00.245] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:4:0) after 1m0s
[00:26:00.359] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:4:0)
[00:26:00.359] Timer tick, asking Buildbucket for the build status
[00:26:00.810] Build 8879011524278375168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:26:00.811] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:5:0) after 1m0s
[00:27:00.919] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:5:0)
[00:27:00.919] Timer tick, asking Buildbucket for the build status
[00:27:01.112] Build 8879011524278375168: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:27:01.112] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:6:0) after 1m0s
[00:27:08.958] Received PubSub notification, asking Buildbucket for the build status
[00:27:09.161] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:01.692] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:6:0)
[00:28:01.692] Timer tick, asking Buildbucket for the build status
[00:28:01.889] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:01.889] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:8:0) after 1m0s
[00:29:01.914] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:8:0)
[00:29:01.914] Timer tick, asking Buildbucket for the build status
[00:29:02.058] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:02.058] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:9:0) after 1m0s
[00:30:02.429] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:9:0)
[00:30:02.429] Timer tick, asking Buildbucket for the build status
[00:30:02.908] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:02.908] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:10:0) after 1m0s
[00:31:02.979] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:10:0)
[00:31:02.979] Timer tick, asking Buildbucket for the build status
[00:31:03.612] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:03.612] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:11:0) after 1m0s
[00:32:03.636] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:11:0)
[00:32:03.636] Timer tick, asking Buildbucket for the build status
[00:32:04.092] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:04.092] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:12:0) after 1m0s
[00:33:04.119] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:12:0)
[00:33:04.119] Timer tick, asking Buildbucket for the build status
[00:33:04.429] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:04.429] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:13:0) after 1m0s
[00:34:04.518] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:13:0)
[00:34:04.518] Timer tick, asking Buildbucket for the build status
[00:34:04.859] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:04.859] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:14:0) after 1m0s
[00:35:04.911] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:14:0)
[00:35:04.911] Timer tick, asking Buildbucket for the build status
[00:35:05.532] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:05.532] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:15:0) after 1m0s
[00:36:05.583] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:15:0)
[00:36:05.583] Timer tick, asking Buildbucket for the build status
[00:36:05.777] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:05.777] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:16:0) after 1m0s
[00:37:05.871] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:16:0)
[00:37:05.871] Timer tick, asking Buildbucket for the build status
[00:37:06.108] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:06.108] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:17:0) after 1m0s
[00:38:06.128] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:17:0)
[00:38:06.128] Timer tick, asking Buildbucket for the build status
[00:38:06.562] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:06.562] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:18:0) after 1m0s
[00:39:06.663] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:18:0)
[00:39:06.663] Timer tick, asking Buildbucket for the build status
[00:39:06.825] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:06.825] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:19:0) after 1m0s
[00:40:06.853] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:19:0)
[00:40:06.853] Timer tick, asking Buildbucket for the build status
[00:40:07.141] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:07.141] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:20:0) after 1m0s
[00:41:07.180] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:20:0)
[00:41:07.180] Timer tick, asking Buildbucket for the build status
[00:41:07.302] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:07.302] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:21:0) after 1m0s
[00:42:07.383] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:21:0)
[00:42:07.383] Timer tick, asking Buildbucket for the build status
[00:42:08.703] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:08.703] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:22:0) after 1m0s
[00:43:08.766] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:22:0)
[00:43:08.766] Timer tick, asking Buildbucket for the build status
[00:43:08.947] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:08.947] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:23:0) after 1m0s
[00:44:09.007] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:23:0)
[00:44:09.007] Timer tick, asking Buildbucket for the build status
[00:44:11.190] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:11.190] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:24:0) after 1m0s
[00:45:11.209] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:24:0)
[00:45:11.209] Timer tick, asking Buildbucket for the build status
[00:45:11.397] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:11.398] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:25:0) after 1m0s
[00:46:11.452] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:25:0)
[00:46:11.452] Timer tick, asking Buildbucket for the build status
[00:46:11.798] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:11.798] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:26:0) after 1m0s
[00:47:11.826] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:26:0)
[00:47:11.826] Timer tick, asking Buildbucket for the build status
[00:47:11.972] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:11.972] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:27:0) after 1m0s
[00:48:12.034] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:27:0)
[00:48:12.034] Timer tick, asking Buildbucket for the build status
[00:48:13.022] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:13.022] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:28:0) after 1m0s
[00:49:13.059] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:28:0)
[00:49:13.059] Timer tick, asking Buildbucket for the build status
[00:49:13.214] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:13.214] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:29:0) after 1m0s
[00:50:13.286] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:29:0)
[00:50:13.286] Timer tick, asking Buildbucket for the build status
[00:50:13.822] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:13.822] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:30:0) after 1m0s
[00:51:13.949] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:30:0)
[00:51:13.949] Timer tick, asking Buildbucket for the build status
[00:51:14.148] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:14.148] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:31:0) after 1m0s
[00:52:14.242] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:31:0)
[00:52:14.242] Timer tick, asking Buildbucket for the build status
[00:52:15.483] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:15.483] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:32:0) after 1m0s
[00:53:15.516] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:32:0)
[00:53:15.516] Timer tick, asking Buildbucket for the build status
[00:53:15.744] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:15.744] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:33:0) after 1m0s
[00:54:15.988] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:33:0)
[00:54:15.988] Timer tick, asking Buildbucket for the build status
[00:54:16.315] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:16.315] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:34:0) after 1m0s
[00:55:16.438] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:34:0)
[00:55:16.438] Timer tick, asking Buildbucket for the build status
[00:55:16.649] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:16.649] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:35:0) after 1m0s
[00:56:16.794] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:35:0)
[00:56:16.794] Timer tick, asking Buildbucket for the build status
[00:56:16.940] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:16.940] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:36:0) after 1m0s
[00:57:17.000] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:36:0)
[00:57:17.000] Timer tick, asking Buildbucket for the build status
[00:57:17.231] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:17.231] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:37:0) after 1m0s
[00:58:17.292] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:37:0)
[00:58:17.293] Timer tick, asking Buildbucket for the build status
[00:58:17.677] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:17.677] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:38:0) after 1m0s
[00:59:17.740] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:38:0)
[00:59:17.740] Timer tick, asking Buildbucket for the build status
[00:59:17.894] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:17.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:39:0) after 1m0s
[01:00:18.030] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:39:0)
[01:00:18.030] Timer tick, asking Buildbucket for the build status
[01:00:21.584] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:21.584] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:40:0) after 1m0s
[01:01:21.654] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:40:0)
[01:01:21.654] Timer tick, asking Buildbucket for the build status
[01:01:23.075] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:23.075] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:41:0) after 1m0s
[01:02:23.129] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:41:0)
[01:02:23.129] Timer tick, asking Buildbucket for the build status
[01:02:23.636] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:23.636] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:42:0) after 1m0s
[01:03:23.703] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:42:0)
[01:03:23.703] Timer tick, asking Buildbucket for the build status
[01:03:23.981] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:23.981] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:43:0) after 1m0s
[01:04:24.091] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:43:0)
[01:04:24.091] Timer tick, asking Buildbucket for the build status
[01:04:24.238] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:24.238] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:44:0) after 1m0s
[01:05:24.295] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:44:0)
[01:05:24.295] Timer tick, asking Buildbucket for the build status
[01:05:24.499] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:24.499] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:45:0) after 1m0s
[01:06:24.676] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:45:0)
[01:06:24.676] Timer tick, asking Buildbucket for the build status
[01:06:24.842] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:24.842] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:46:0) after 1m0s
[01:07:24.978] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:46:0)
[01:07:24.978] Timer tick, asking Buildbucket for the build status
[01:07:25.164] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:25.164] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:47:0) after 1m0s
[01:08:25.260] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:47:0)
[01:08:25.260] Timer tick, asking Buildbucket for the build status
[01:08:25.471] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:25.471] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:48:0) after 1m0s
[01:09:25.599] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:48:0)
[01:09:25.599] Timer tick, asking Buildbucket for the build status
[01:09:25.929] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:25.929] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:49:0) after 1m0s
[01:10:25.965] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:49:0)
[01:10:25.965] Timer tick, asking Buildbucket for the build status
[01:10:26.093] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:26.093] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:50:0) after 1m0s
[01:11:26.330] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:50:0)
[01:11:26.330] Timer tick, asking Buildbucket for the build status
[01:11:26.444] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:26.444] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:51:0) after 1m0s
[01:12:26.479] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:51:0)
[01:12:26.479] Timer tick, asking Buildbucket for the build status
[01:12:26.782] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:26.782] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:52:0) after 1m0s
[01:13:26.846] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:52:0)
[01:13:26.846] Timer tick, asking Buildbucket for the build status
[01:13:26.955] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:26.955] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:53:0) after 1m0s
[01:14:26.986] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:53:0)
[01:14:26.986] Timer tick, asking Buildbucket for the build status
[01:14:27.206] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:27.206] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:54:0) after 1m0s
[01:15:27.271] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:54:0)
[01:15:27.271] Timer tick, asking Buildbucket for the build status
[01:15:27.411] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:27.411] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:55:0) after 1m0s
[01:16:27.514] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:55:0)
[01:16:27.514] Timer tick, asking Buildbucket for the build status
[01:16:27.666] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:27.666] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:56:0) after 1m0s
[01:17:27.688] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:56:0)
[01:17:27.688] Timer tick, asking Buildbucket for the build status
[01:17:27.858] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:27.858] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:57:0) after 1m0s
[01:18:27.933] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:57:0)
[01:18:27.933] Timer tick, asking Buildbucket for the build status
[01:18:28.027] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:28.027] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:58:0) after 1m0s
[01:19:28.077] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:58:0)
[01:19:28.077] Timer tick, asking Buildbucket for the build status
[01:19:28.271] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:28.271] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:59:0) after 1m0s
[01:20:28.322] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:59:0)
[01:20:28.322] Timer tick, asking Buildbucket for the build status
[01:20:28.603] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:28.603] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:60:0) after 1m0s
[01:21:28.676] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:60:0)
[01:21:28.676] Timer tick, asking Buildbucket for the build status
[01:21:28.944] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:28.944] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:61:0) after 1m0s
[01:22:28.990] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:61:0)
[01:22:28.990] Timer tick, asking Buildbucket for the build status
[01:22:29.926] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:29.926] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:62:0) after 1m0s
[01:23:29.935] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:62:0)
[01:23:29.935] Timer tick, asking Buildbucket for the build status
[01:23:30.380] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:30.380] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:63:0) after 1m0s
[01:24:30.365] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:63:0)
[01:24:30.365] Timer tick, asking Buildbucket for the build status
[01:24:30.778] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:30.778] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:64:0) after 1m0s
[01:25:30.813] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:64:0)
[01:25:30.813] Timer tick, asking Buildbucket for the build status
[01:25:31.917] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:31.917] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:65:0) after 1m0s
[01:26:31.899] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:65:0)
[01:26:31.899] Timer tick, asking Buildbucket for the build status
[01:26:32.092] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:32.092] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:66:0) after 1m0s
[01:27:32.164] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:66:0)
[01:27:32.165] Timer tick, asking Buildbucket for the build status
[01:27:32.400] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:32.400] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:67:0) after 1m0s
[01:28:32.392] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:67:0)
[01:28:32.392] Timer tick, asking Buildbucket for the build status
[01:28:32.498] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:32.498] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:68:0) after 1m0s
[01:29:32.542] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:68:0)
[01:29:32.542] Timer tick, asking Buildbucket for the build status
[01:29:32.657] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:32.657] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:69:0) after 1m0s
[01:30:32.719] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:69:0)
[01:30:32.719] Timer tick, asking Buildbucket for the build status
[01:30:32.846] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:32.846] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:70:0) after 1m0s
[01:31:32.897] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:70:0)
[01:31:32.897] Timer tick, asking Buildbucket for the build status
[01:31:33.184] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:33.184] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:71:0) after 1m0s
[01:32:33.205] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:71:0)
[01:32:33.205] Timer tick, asking Buildbucket for the build status
[01:32:33.595] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:33.595] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:72:0) after 1m0s
[01:33:33.605] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:72:0)
[01:33:33.605] Timer tick, asking Buildbucket for the build status
[01:33:33.759] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:33.759] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:73:0) after 1m0s
[01:34:33.812] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:73:0)
[01:34:33.812] Timer tick, asking Buildbucket for the build status
[01:34:34.048] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:34.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:74:0) after 1m0s
[01:35:34.077] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:74:0)
[01:35:34.077] Timer tick, asking Buildbucket for the build status
[01:35:34.341] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:34.341] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:75:0) after 1m0s
[01:36:34.386] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:75:0)
[01:36:34.386] Timer tick, asking Buildbucket for the build status
[01:36:34.707] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:34.707] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:76:0) after 1m0s
[01:37:34.857] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:76:0)
[01:37:34.857] Timer tick, asking Buildbucket for the build status
[01:37:35.064] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:35.064] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:77:0) after 1m0s
[01:38:35.181] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:77:0)
[01:38:35.181] Timer tick, asking Buildbucket for the build status
[01:38:35.389] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:35.389] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:78:0) after 1m0s
[01:39:35.437] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:78:0)
[01:39:35.437] Timer tick, asking Buildbucket for the build status
[01:39:35.826] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:35.826] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:79:0) after 1m0s
[01:40:35.853] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:79:0)
[01:40:35.853] Timer tick, asking Buildbucket for the build status
[01:40:36.102] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:36.102] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:80:0) after 1m0s
[01:41:36.227] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:80:0)
[01:41:36.227] Timer tick, asking Buildbucket for the build status
[01:41:36.361] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:36.361] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:81:0) after 1m0s
[01:42:36.403] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:81:0)
[01:42:36.403] Timer tick, asking Buildbucket for the build status
[01:42:36.520] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:36.520] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:82:0) after 1m0s
[01:43:36.640] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:82:0)
[01:43:36.640] Timer tick, asking Buildbucket for the build status
[01:43:36.827] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:36.827] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:83:0) after 1m0s
[01:44:36.851] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:83:0)
[01:44:36.851] Timer tick, asking Buildbucket for the build status
[01:44:37.001] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:37.001] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:84:0) after 1m0s
[01:45:37.085] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:84:0)
[01:45:37.085] Timer tick, asking Buildbucket for the build status
[01:45:37.405] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:37.405] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:85:0) after 1m0s
[01:46:37.462] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:85:0)
[01:46:37.462] Timer tick, asking Buildbucket for the build status
[01:46:37.801] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:37.801] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:86:0) after 1m0s
[01:47:38.015] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:86:0)
[01:47:38.015] Timer tick, asking Buildbucket for the build status
[01:47:38.171] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:38.171] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:87:0) after 1m0s
[01:48:38.188] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:87:0)
[01:48:38.188] Timer tick, asking Buildbucket for the build status
[01:48:38.650] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:38.650] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:88:0) after 1m0s
[01:49:38.757] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:88:0)
[01:49:38.757] Timer tick, asking Buildbucket for the build status
[01:49:39.233] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:39.233] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:89:0) after 1m0s
[01:50:39.334] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:89:0)
[01:50:39.334] Timer tick, asking Buildbucket for the build status
[01:50:39.860] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:39.860] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:90:0) after 1m0s
[01:51:39.980] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:90:0)
[01:51:39.980] Timer tick, asking Buildbucket for the build status
[01:51:40.146] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:40.146] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:91:0) after 1m0s
[01:52:40.194] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:91:0)
[01:52:40.194] Timer tick, asking Buildbucket for the build status
[01:52:40.478] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:40.478] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:92:0) after 1m0s
[01:53:40.553] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:92:0)
[01:53:40.553] Timer tick, asking Buildbucket for the build status
[01:53:40.889] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:40.889] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:93:0) after 1m0s
[01:54:40.990] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:93:0)
[01:54:40.990] Timer tick, asking Buildbucket for the build status
[01:54:41.099] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:41.099] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:94:0) after 1m0s
[01:55:41.138] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:94:0)
[01:55:41.138] Timer tick, asking Buildbucket for the build status
[01:55:41.463] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:41.463] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:95:0) after 1m0s
[01:56:41.494] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:95:0)
[01:56:41.494] Timer tick, asking Buildbucket for the build status
[01:56:41.758] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:41.758] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:96:0) after 1m0s
[01:57:41.774] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:96:0)
[01:57:41.774] Timer tick, asking Buildbucket for the build status
[01:57:42.164] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:42.165] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:97:0) after 1m0s
[01:58:42.208] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:97:0)
[01:58:42.208] Timer tick, asking Buildbucket for the build status
[01:58:42.329] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:42.329] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:98:0) after 1m0s
[01:59:42.396] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:98:0)
[01:59:42.396] Timer tick, asking Buildbucket for the build status
[01:59:42.608] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:42.608] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:99:0) after 1m0s
[02:00:42.645] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:99:0)
[02:00:42.645] Timer tick, asking Buildbucket for the build status
[02:00:43.028] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:43.028] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:100:0) after 1m0s
[02:01:43.050] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:100:0)
[02:01:43.050] Timer tick, asking Buildbucket for the build status
[02:01:43.195] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:43.195] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:101:0) after 1m0s
[02:02:43.248] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:101:0)
[02:02:43.248] Timer tick, asking Buildbucket for the build status
[02:02:43.548] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:43.548] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:102:0) after 1m0s
[02:03:43.584] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:102:0)
[02:03:43.584] Timer tick, asking Buildbucket for the build status
[02:03:43.847] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:43.847] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:103:0) after 1m0s
[02:04:43.882] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:103:0)
[02:04:43.882] Timer tick, asking Buildbucket for the build status
[02:04:44.008] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:44.008] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:104:0) after 1m0s
[02:05:44.310] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:104:0)
[02:05:44.310] Timer tick, asking Buildbucket for the build status
[02:05:44.636] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:44.636] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:105:0) after 1m0s
[02:06:44.826] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:105:0)
[02:06:44.826] Timer tick, asking Buildbucket for the build status
[02:06:45.133] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:45.133] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:106:0) after 1m0s
[02:07:45.196] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:106:0)
[02:07:45.196] Timer tick, asking Buildbucket for the build status
[02:07:45.761] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:45.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:107:0) after 1m0s
[02:08:45.835] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:107:0)
[02:08:45.836] Timer tick, asking Buildbucket for the build status
[02:08:46.290] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:46.290] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:108:0) after 1m0s
[02:09:46.465] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:108:0)
[02:09:46.465] Timer tick, asking Buildbucket for the build status
[02:09:46.632] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:46.632] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:109:0) after 1m0s
[02:10:46.790] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:109:0)
[02:10:46.790] Timer tick, asking Buildbucket for the build status
[02:10:47.107] Build 8879011524278375168: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:47.107] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9044441588189504976:110:0) after 1m0s
[02:11:25.651] Received PubSub notification, asking Buildbucket for the build status
[02:11:25.831] Build 8879011524278375168: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:11:25.831] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1590718284759422",
"created_by": "project:chromium",
"created_ts": "1590711776428189",
"failure_reason": "BUILD_FAILURE",
"id": "8879011524278375168",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"efa26f8b28c644155cba9994d33fd0b8b702b36c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_unittests on Android device Nexus 5** failed because of:\\n\\n- NavigatorTest.RendererNonUserInitiatedNavigationCancelSimilarNavigation\\n\\n- NavigatorTest.SimpleRendererInitiatedCrossSiteNavigation\\n\\n- All/RenderFrameHostManagerTest.BeginNavigationIgnoredWhenNotActive/1\\n\\n- All/RenderFrameHostManagerTest.BeginNavigationIgnoredWhenNotActive/0\\n\\n- ...3 more failure(s) (7 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__NoInstant_NoReturn\\n\\n- ...118 more failure(s) (121 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-central1-b-8-14-g35z\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 3015, \"got_angle_revision\": \"209cf8fa408b0a45c3b0577a51c0260971fcfda3\", \"got_dawn_revision\": \"295a4177aebc5c306a84b0d2c49218496299b2ce\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"efa26f8b28c644155cba9994d33fd0b8b702b36c\", \"got_revision_cp\": \"refs/heads/master@{#772958}\", \"got_swarming_client_revision\": \"90c5e17a82612bc898c90ab1530dd1bd5822eae8\", \"got_swiftshader_revision\": \"471c120ac92a584e1007f5a3cf22619647bc90a1\", \"got_v8_revision\": \"b28e75d6db7ab366c53586b2b777c84a1876887b\", \"got_v8_revision_cp\": \"refs/heads/8.5.60@{#1}\", \"got_webrtc_revision\": \"1a4975642bf962ae059674b1b89cde4d785aba5b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31380}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.android.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"efa26f8b28c644155cba9994d33fd0b8b702b36c\", \"swarm_hashes\": {\"android_browsertests\": \"a39153ee3fe201752a6d1e9e28c343685aa441ec\", \"chrome_public_test_apk\": \"00a65e19b0bbee9471184b83cfad58a087d910b0\", \"content_browsertests\": \"ba930a305251a8a536b6f2fe0d27f31df0520900\", \"content_shell_test_apk\": \"505a98a7927d0b7217b8804be87f2d223c34eef1\", \"content_unittests\": \"e50384cc8b88f5fdd118f1769d559284c77d0230\", \"unit_tests\": \"d175587ee24dad365bc65cd58a933ad9c708f2e4\"}, \"swarm_hashes_refs/heads/master(at){#772958}_without_patch\": {\"android_browsertests\": \"a39153ee3fe201752a6d1e9e28c343685aa441ec\", \"chrome_public_test_apk\": \"00a65e19b0bbee9471184b83cfad58a087d910b0\", \"content_browsertests\": \"ba930a305251a8a536b6f2fe0d27f31df0520900\", \"content_shell_test_apk\": \"505a98a7927d0b7217b8804be87f2d223c34eef1\", \"content_unittests\": \"e50384cc8b88f5fdd118f1769d559284c77d0230\", \"unit_tests\": \"d175587ee24dad365bc65cd58a933ad9c708f2e4\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_ceef2698322d50dacce0e8fa5a27dc204b84feefd63e7c13651337203433dfad_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-14-g35z\"], \"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\": [\"5142-e16b32c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_unittests on Android device Nexus 5** failed because of:\\n\\n- NavigatorTest.RendererNonUserInitiatedNavigationCancelSimilarNavigation\\n\\n- NavigatorTest.SimpleRendererInitiatedCrossSiteNavigation\\n\\n- All/RenderFrameHostManagerTest.BeginNavigationIgnoredWhenNotActive/1\\n\\n- All/RenderFrameHostManagerTest.BeginNavigationIgnoredWhenNotActive/0\\n\\n- ...3 more failure(s) (7 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__NoInstant_NoReturn\\n\\n- ...118 more failure(s) (121 total)...\\n\\n#### ...1 more test(s)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1590712027937892",
"status": "COMPLETED",
"status_changed_ts": "1590712028656250",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/3015",
"builder:android-bfcache-rel",
"buildset:commit/git/efa26f8b28c644155cba9994d33fd0b8b702b36c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/efa26f8b28c644155cba9994d33fd0b8b702b36c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044441588189504976",
"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/8879011524278375168/+/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:4c76a100c9362210",
"user_agent:luci-scheduler"
],
"updated_ts": "1590718285346874",
"url": "https://ci.chromium.org/b/8879011524278375168",
"utcnow_ts": "1590718285805396"
}
}
[02:11:25.831] Invocation finished in 1h48m32.516283584s with status FAILED