[18:07:54.120] New invocation is queued and will start shortly
[18:07:55.197] Starting the invocation (attempt 1)
[18:07:55.235] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:07:55.235] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:07:55.235] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9041837868299117840",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0f8da8249f1a145887281cb9d461ab242c1dda51\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9041837868299117840",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/0f8da8249f1a145887281cb9d461ab242c1dda51",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0f8da8249f1a145887281cb9d461ab242c1dda51",
"gitiles_ref:refs/heads/master"
]
}
[18:07:56.202] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1593194875321613",
"id": "8876407806374014160",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0f8da8249f1a145887281cb9d461ab242c1dda51\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1593194876042730",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/3579",
"builder:android-bfcache-rel",
"buildset:commit/git/0f8da8249f1a145887281cb9d461ab242c1dda51",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0f8da8249f1a145887281cb9d461ab242c1dda51",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9041837868299117840",
"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/8876407806374014160/+/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": "1593194876042880",
"url": "https://ci.chromium.org/b/8876407806374014160",
"utcnow_ts": "1593194876189228"
}
}
[18:07:56.202] Task URL: https://ci.chromium.org/b/8876407806374014160
[18:07:56.202] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:2:0) after 1m0s
[18:08:56.264] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:2:0)
[18:08:56.264] Timer tick, asking Buildbucket for the build status
[18:08:56.667] Build 8876407806374014160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:08:56.667] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:3:0) after 1m0s
[18:09:56.651] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:3:0)
[18:09:56.651] Timer tick, asking Buildbucket for the build status
[18:09:57.871] Build 8876407806374014160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:09:57.871] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:4:0) after 1m0s
[18:10:57.985] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:4:0)
[18:10:57.985] Timer tick, asking Buildbucket for the build status
[18:10:58.683] Build 8876407806374014160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:10:58.683] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:5:0) after 1m0s
[18:11:58.743] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:5:0)
[18:11:58.743] Timer tick, asking Buildbucket for the build status
[18:11:59.122] Build 8876407806374014160: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:11:59.122] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:6:0) after 1m0s
[18:12:09.032] Received PubSub notification, asking Buildbucket for the build status
[18:12:09.359] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:59.166] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:6:0)
[18:12:59.166] Timer tick, asking Buildbucket for the build status
[18:12:59.511] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:59.511] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:8:0) after 1m0s
[18:13:59.605] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:8:0)
[18:13:59.605] Timer tick, asking Buildbucket for the build status
[18:13:59.753] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:59.753] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:9:0) after 1m0s
[18:14:59.777] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:9:0)
[18:14:59.777] Timer tick, asking Buildbucket for the build status
[18:14:59.938] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:59.938] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:10:0) after 1m0s
[18:16:00.017] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:10:0)
[18:16:00.017] Timer tick, asking Buildbucket for the build status
[18:16:00.861] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:00.861] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:11:0) after 1m0s
[18:17:01.559] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:11:0)
[18:17:01.559] Timer tick, asking Buildbucket for the build status
[18:17:01.709] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:01.709] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:12:0) after 1m0s
[18:18:01.813] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:12:0)
[18:18:01.813] Timer tick, asking Buildbucket for the build status
[18:18:02.051] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:02.051] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:13:0) after 1m0s
[18:19:02.097] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:13:0)
[18:19:02.097] Timer tick, asking Buildbucket for the build status
[18:19:02.269] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:02.269] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:14:0) after 1m0s
[18:20:02.289] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:14:0)
[18:20:02.289] Timer tick, asking Buildbucket for the build status
[18:20:05.256] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:05.256] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:15:0) after 1m0s
[18:21:05.292] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:15:0)
[18:21:05.292] Timer tick, asking Buildbucket for the build status
[18:21:05.417] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:05.417] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:16:0) after 1m0s
[18:22:05.477] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:16:0)
[18:22:05.477] Timer tick, asking Buildbucket for the build status
[18:22:05.640] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:05.640] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:17:0) after 1m0s
[18:23:05.686] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:17:0)
[18:23:05.686] Timer tick, asking Buildbucket for the build status
[18:23:06.034] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:06.035] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:18:0) after 1m0s
[18:24:06.118] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:18:0)
[18:24:06.118] Timer tick, asking Buildbucket for the build status
[18:24:06.695] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:06.695] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:19:0) after 1m0s
[18:25:06.732] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:19:0)
[18:25:06.732] Timer tick, asking Buildbucket for the build status
[18:25:06.909] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:06.909] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:20:0) after 1m0s
[18:26:07.021] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:20:0)
[18:26:07.021] Timer tick, asking Buildbucket for the build status
[18:26:07.163] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:07.163] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:21:0) after 1m0s
[18:27:07.187] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:21:0)
[18:27:07.187] Timer tick, asking Buildbucket for the build status
[18:27:07.856] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:07.856] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:22:0) after 1m0s
[18:28:07.992] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:22:0)
[18:28:07.992] Timer tick, asking Buildbucket for the build status
[18:28:08.239] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:08.239] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:23:0) after 1m0s
[18:29:08.215] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:23:0)
[18:29:08.215] Timer tick, asking Buildbucket for the build status
[18:29:08.885] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:08.885] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:24:0) after 1m0s
[18:30:08.891] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:24:0)
[18:30:08.891] Timer tick, asking Buildbucket for the build status
[18:30:09.205] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:09.205] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:25:0) after 1m0s
[18:31:09.278] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:25:0)
[18:31:09.278] Timer tick, asking Buildbucket for the build status
[18:31:09.660] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:09.660] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:26:0) after 1m0s
[18:32:09.785] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:26:0)
[18:32:09.785] Timer tick, asking Buildbucket for the build status
[18:32:10.091] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:10.091] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:27:0) after 1m0s
[18:33:10.141] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:27:0)
[18:33:10.141] Timer tick, asking Buildbucket for the build status
[18:33:10.306] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:10.306] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:28:0) after 1m0s
[18:34:10.332] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:28:0)
[18:34:10.332] Timer tick, asking Buildbucket for the build status
[18:34:10.560] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:10.560] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:29:0) after 1m0s
[18:35:10.702] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:29:0)
[18:35:10.702] Timer tick, asking Buildbucket for the build status
[18:35:11.213] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:11.213] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:30:0) after 1m0s
[18:36:11.258] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:30:0)
[18:36:11.258] Timer tick, asking Buildbucket for the build status
[18:36:11.389] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:11.389] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:31:0) after 1m0s
[18:37:11.405] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:31:0)
[18:37:11.405] Timer tick, asking Buildbucket for the build status
[18:37:11.702] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:11.702] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:32:0) after 1m0s
[18:38:11.786] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:32:0)
[18:38:11.786] Timer tick, asking Buildbucket for the build status
[18:38:12.128] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:12.128] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:33:0) after 1m0s
[18:39:12.165] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:33:0)
[18:39:12.165] Timer tick, asking Buildbucket for the build status
[18:39:13.897] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:13.897] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:34:0) after 1m0s
[18:40:13.903] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:34:0)
[18:40:13.903] Timer tick, asking Buildbucket for the build status
[18:40:14.276] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:14.276] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:35:0) after 1m0s
[18:41:14.338] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:35:0)
[18:41:14.338] Timer tick, asking Buildbucket for the build status
[18:41:14.697] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:14.697] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:36:0) after 1m0s
[18:42:15.169] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:36:0)
[18:42:15.169] Timer tick, asking Buildbucket for the build status
[18:42:15.453] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:15.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:37:0) after 1m0s
[18:43:15.844] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:37:0)
[18:43:15.844] Timer tick, asking Buildbucket for the build status
[18:43:16.784] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:16.784] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:38:0) after 1m0s
[18:44:16.964] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:38:0)
[18:44:16.964] Timer tick, asking Buildbucket for the build status
[18:44:17.276] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:17.276] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:39:0) after 1m0s
[18:45:17.282] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:39:0)
[18:45:17.282] Timer tick, asking Buildbucket for the build status
[18:45:17.599] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:17.599] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:40:0) after 1m0s
[18:46:18.032] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:40:0)
[18:46:18.032] Timer tick, asking Buildbucket for the build status
[18:46:18.179] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:18.179] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:41:0) after 1m0s
[18:47:18.782] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:41:0)
[18:47:18.782] Timer tick, asking Buildbucket for the build status
[18:47:19.061] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:19.061] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:42:0) after 1m0s
[18:48:19.262] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:42:0)
[18:48:19.262] Timer tick, asking Buildbucket for the build status
[18:48:19.499] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:19.499] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:43:0) after 1m0s
[18:49:19.499] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:43:0)
[18:49:19.499] Timer tick, asking Buildbucket for the build status
[18:49:19.699] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:19.699] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:44:0) after 1m0s
[18:50:19.815] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:44:0)
[18:50:19.815] Timer tick, asking Buildbucket for the build status
[18:50:19.985] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:19.985] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:45:0) after 1m0s
[18:51:20.415] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:45:0)
[18:51:20.415] Timer tick, asking Buildbucket for the build status
[18:51:20.803] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:20.803] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:46:0) after 1m0s
[18:52:21.220] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:46:0)
[18:52:21.220] Timer tick, asking Buildbucket for the build status
[18:52:21.389] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:21.389] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:47:0) after 1m0s
[18:53:21.550] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:47:0)
[18:53:21.550] Timer tick, asking Buildbucket for the build status
[18:53:21.774] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:21.774] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:48:0) after 1m0s
[18:54:22.208] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:48:0)
[18:54:22.208] Timer tick, asking Buildbucket for the build status
[18:54:22.436] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:22.436] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:49:0) after 1m0s
[18:55:23.030] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:49:0)
[18:55:23.030] Timer tick, asking Buildbucket for the build status
[18:55:23.415] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:23.415] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:50:0) after 1m0s
[18:56:23.715] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:50:0)
[18:56:23.715] Timer tick, asking Buildbucket for the build status
[18:56:23.889] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:23.889] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:51:0) after 1m0s
[18:57:24.036] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:51:0)
[18:57:24.036] Timer tick, asking Buildbucket for the build status
[18:57:24.192] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:24.192] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:52:0) after 1m0s
[18:58:24.235] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:52:0)
[18:58:24.235] Timer tick, asking Buildbucket for the build status
[18:58:24.368] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:24.368] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:53:0) after 1m0s
[18:59:25.791] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:53:0)
[18:59:25.791] Timer tick, asking Buildbucket for the build status
[18:59:27.269] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:27.269] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:54:0) after 1m0s
[19:00:27.749] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:54:0)
[19:00:27.749] Timer tick, asking Buildbucket for the build status
[19:00:27.849] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:27.849] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:55:0) after 1m0s
[19:01:28.122] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:55:0)
[19:01:28.122] Timer tick, asking Buildbucket for the build status
[19:01:28.249] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:28.249] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:56:0) after 1m0s
[19:02:28.337] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:56:0)
[19:02:28.337] Timer tick, asking Buildbucket for the build status
[19:02:28.436] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:28.436] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:57:0) after 1m0s
[19:03:28.746] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:57:0)
[19:03:28.746] Timer tick, asking Buildbucket for the build status
[19:03:29.024] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:29.024] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:58:0) after 1m0s
[19:04:29.067] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:58:0)
[19:04:29.067] Timer tick, asking Buildbucket for the build status
[19:04:29.790] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:29.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:59:0) after 1m0s
[19:05:29.936] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:59:0)
[19:05:29.936] Timer tick, asking Buildbucket for the build status
[19:05:30.392] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:30.392] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:60:0) after 1m0s
[19:06:30.781] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:60:0)
[19:06:30.781] Timer tick, asking Buildbucket for the build status
[19:06:30.972] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:30.972] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:61:0) after 1m0s
[19:07:31.212] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:61:0)
[19:07:31.212] Timer tick, asking Buildbucket for the build status
[19:07:31.362] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:31.362] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:62:0) after 1m0s
[19:08:31.508] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:62:0)
[19:08:31.508] Timer tick, asking Buildbucket for the build status
[19:08:31.625] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:31.625] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:63:0) after 1m0s
[19:09:31.801] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:63:0)
[19:09:31.801] Timer tick, asking Buildbucket for the build status
[19:09:31.959] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:31.959] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:64:0) after 1m0s
[19:10:32.931] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:64:0)
[19:10:32.931] Timer tick, asking Buildbucket for the build status
[19:10:33.746] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:33.746] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:65:0) after 1m0s
[19:11:34.087] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:65:0)
[19:11:34.087] Timer tick, asking Buildbucket for the build status
[19:11:34.307] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:34.307] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:66:0) after 1m0s
[19:12:34.626] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:66:0)
[19:12:34.626] Timer tick, asking Buildbucket for the build status
[19:12:34.966] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:34.966] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:67:0) after 1m0s
[19:13:35.024] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:67:0)
[19:13:35.025] Timer tick, asking Buildbucket for the build status
[19:13:35.489] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:35.489] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:68:0) after 1m0s
[19:14:35.692] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:68:0)
[19:14:35.692] Timer tick, asking Buildbucket for the build status
[19:14:37.495] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:37.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:69:0) after 1m0s
[19:15:37.508] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:69:0)
[19:15:37.508] Timer tick, asking Buildbucket for the build status
[19:15:37.922] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:37.922] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:70:0) after 1m0s
[19:16:38.063] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:70:0)
[19:16:38.063] Timer tick, asking Buildbucket for the build status
[19:16:38.252] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:38.252] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:71:0) after 1m0s
[19:17:38.353] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:71:0)
[19:17:38.353] Timer tick, asking Buildbucket for the build status
[19:17:38.505] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:38.505] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:72:0) after 1m0s
[19:18:38.532] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:72:0)
[19:18:38.532] Timer tick, asking Buildbucket for the build status
[19:18:38.792] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:38.792] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:73:0) after 1m0s
[19:19:38.900] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:73:0)
[19:19:38.900] Timer tick, asking Buildbucket for the build status
[19:19:39.348] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:39.348] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:74:0) after 1m0s
[19:20:39.812] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:74:0)
[19:20:39.812] Timer tick, asking Buildbucket for the build status
[19:20:39.930] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:39.930] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:75:0) after 1m0s
[19:21:39.937] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:75:0)
[19:21:39.938] Timer tick, asking Buildbucket for the build status
[19:21:40.166] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:40.166] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:76:0) after 1m0s
[19:22:40.294] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:76:0)
[19:22:40.294] Timer tick, asking Buildbucket for the build status
[19:22:40.444] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:40.445] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:77:0) after 1m0s
[19:23:40.461] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:77:0)
[19:23:40.461] Timer tick, asking Buildbucket for the build status
[19:23:40.614] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:40.615] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:78:0) after 1m0s
[19:24:40.618] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:78:0)
[19:24:40.618] Timer tick, asking Buildbucket for the build status
[19:24:41.322] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:41.322] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:79:0) after 1m0s
[19:25:41.366] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:79:0)
[19:25:41.366] Timer tick, asking Buildbucket for the build status
[19:25:41.679] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:41.679] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:80:0) after 1m0s
[19:26:41.715] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:80:0)
[19:26:41.715] Timer tick, asking Buildbucket for the build status
[19:26:41.869] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:41.869] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:81:0) after 1m0s
[19:27:41.998] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:81:0)
[19:27:41.998] Timer tick, asking Buildbucket for the build status
[19:27:42.296] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:42.296] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:82:0) after 1m0s
[19:28:42.338] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:82:0)
[19:28:42.338] Timer tick, asking Buildbucket for the build status
[19:28:42.570] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:42.570] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:83:0) after 1m0s
[19:29:42.613] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:83:0)
[19:29:42.613] Timer tick, asking Buildbucket for the build status
[19:29:48.148] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:48.148] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:84:0) after 1m0s
[19:30:48.214] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:84:0)
[19:30:48.214] Timer tick, asking Buildbucket for the build status
[19:30:48.436] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:48.436] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:85:0) after 1m0s
[19:31:48.418] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:85:0)
[19:31:48.418] Timer tick, asking Buildbucket for the build status
[19:31:49.440] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:49.440] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:86:0) after 1m0s
[19:32:49.466] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:86:0)
[19:32:49.466] Timer tick, asking Buildbucket for the build status
[19:32:49.612] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:49.612] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:87:0) after 1m0s
[19:33:49.687] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:87:0)
[19:33:49.687] Timer tick, asking Buildbucket for the build status
[19:33:49.871] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:49.871] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:88:0) after 1m0s
[19:34:49.907] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:88:0)
[19:34:49.907] Timer tick, asking Buildbucket for the build status
[19:34:50.443] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:50.443] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:89:0) after 1m0s
[19:35:50.481] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:89:0)
[19:35:50.481] Timer tick, asking Buildbucket for the build status
[19:35:50.693] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:50.693] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:90:0) after 1m0s
[19:36:50.728] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:90:0)
[19:36:50.728] Timer tick, asking Buildbucket for the build status
[19:36:51.232] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:51.232] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:91:0) after 1m0s
[19:37:51.285] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:91:0)
[19:37:51.285] Timer tick, asking Buildbucket for the build status
[19:37:51.512] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:51.512] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:92:0) after 1m0s
[19:38:51.540] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:92:0)
[19:38:51.540] Timer tick, asking Buildbucket for the build status
[19:38:51.641] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:51.641] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:93:0) after 1m0s
[19:39:51.668] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:93:0)
[19:39:51.668] Timer tick, asking Buildbucket for the build status
[19:39:51.912] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:51.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:94:0) after 1m0s
[19:40:51.969] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:94:0)
[19:40:51.969] Timer tick, asking Buildbucket for the build status
[19:40:52.204] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:52.204] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:95:0) after 1m0s
[19:41:52.219] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:95:0)
[19:41:52.219] Timer tick, asking Buildbucket for the build status
[19:41:52.365] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:52.365] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:96:0) after 1m0s
[19:42:52.456] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:96:0)
[19:42:52.456] Timer tick, asking Buildbucket for the build status
[19:42:52.659] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:52.659] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:97:0) after 1m0s
[19:43:52.653] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:97:0)
[19:43:52.653] Timer tick, asking Buildbucket for the build status
[19:43:52.917] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:52.917] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:98:0) after 1m0s
[19:44:52.942] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:98:0)
[19:44:52.942] Timer tick, asking Buildbucket for the build status
[19:44:58.823] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:58.823] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:99:0) after 1m0s
[19:45:58.834] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:99:0)
[19:45:58.834] Timer tick, asking Buildbucket for the build status
[19:45:59.242] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:59.242] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:100:0) after 1m0s
[19:46:59.271] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:100:0)
[19:46:59.271] Timer tick, asking Buildbucket for the build status
[19:46:59.469] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:59.469] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:101:0) after 1m0s
[19:47:59.509] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:101:0)
[19:47:59.509] Timer tick, asking Buildbucket for the build status
[19:47:59.931] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:59.931] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:102:0) after 1m0s
[19:48:59.965] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:102:0)
[19:48:59.965] Timer tick, asking Buildbucket for the build status
[19:49:00.337] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:00.337] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:103:0) after 1m0s
[19:50:00.353] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:103:0)
[19:50:00.353] Timer tick, asking Buildbucket for the build status
[19:50:03.092] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:03.093] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:104:0) after 1m0s
[19:51:03.213] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:104:0)
[19:51:03.213] Timer tick, asking Buildbucket for the build status
[19:51:03.674] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:03.674] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:105:0) after 1m0s
[19:52:03.736] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:105:0)
[19:52:03.736] Timer tick, asking Buildbucket for the build status
[19:52:03.886] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:03.886] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:106:0) after 1m0s
[19:53:03.967] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:106:0)
[19:53:03.967] Timer tick, asking Buildbucket for the build status
[19:53:04.113] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:04.113] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:107:0) after 1m0s
[19:54:04.321] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:107:0)
[19:54:04.321] Timer tick, asking Buildbucket for the build status
[19:54:04.441] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:04.441] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:108:0) after 1m0s
[19:55:04.530] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:108:0)
[19:55:04.530] Timer tick, asking Buildbucket for the build status
[19:55:04.655] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:04.655] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:109:0) after 1m0s
[19:56:04.755] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:109:0)
[19:56:04.755] Timer tick, asking Buildbucket for the build status
[19:56:05.173] Build 8876407806374014160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:05.173] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9041837868299117840:110:0) after 1m0s
[19:56:21.351] Received PubSub notification, asking Buildbucket for the build status
[19:56:21.416] Build 8876407806374014160: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[19:56:21.416] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1593201380788039",
"created_by": "project:chromium",
"created_ts": "1593194875321613",
"failure_reason": "BUILD_FAILURE",
"id": "8876407806374014160",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0f8da8249f1a145887281cb9d461ab242c1dda51\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 Test Suite(s) failed.\\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#testShow_SingleAsTabSwitcher__NoInstant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsHomepage__Instant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceLayoutTest#testTabSuggestionMessageCardDismissAfterTabClosing\\n\\n- ...131 more failure(s) (135 total)...\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- RenderDocumentHostUserDataTest.CrossSiteNavigation\\n\\n- All/SitePerProcessBrowserTest.NavigateMainFrameToChildSite/2\\n\\n- ...50 more failure(s) (52 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-133-uo7k\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 3579, \"got_angle_revision\": \"c9f311e46255f65f5aa72beee8c70dca515f10d3\", \"got_dawn_revision\": \"ff90599cdf600e48d5868f8b3d35698686f5b161\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"0f8da8249f1a145887281cb9d461ab242c1dda51\", \"got_revision_cp\": \"refs/heads/master@{#783066}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"5c7b568c6d20c47660bf89629d74a8d7b93a8e35\", \"got_v8_revision\": \"a7f8bc434b35c3122a859f094fa541febd74ec7c\", \"got_v8_revision_cp\": \"refs/heads/8.5.210@{#1}\", \"got_webrtc_revision\": \"efc55b0134fac0bf6d46aa43bcdaef84e4b8d00f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31573}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.android.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0f8da8249f1a145887281cb9d461ab242c1dda51\", \"swarm_hashes\": {\"android_browsertests\": \"e63e0b5a7e2d2e58e483aa02aca1dc0ccb812e78\", \"chrome_public_test_apk\": \"9eed006c07eac487652b6c4756108a11ca00d307\", \"content_browsertests\": \"0f7674a49d8505dc4586f018df5f4271939bcde3\", \"content_shell_test_apk\": \"04eaf2ec9b8214fe710fc94a0912458dce87508e\", \"content_unittests\": \"0eb99bf94833ac742dc7dfcc36d4e2c32bb5c3fe\", \"unit_tests\": \"f5ed11ba94ea1eb96a524b4573ede68af492c16a\"}, \"swarm_hashes_refs/heads/master(at){#783066}_without_patch\": {\"android_browsertests\": \"e63e0b5a7e2d2e58e483aa02aca1dc0ccb812e78\", \"chrome_public_test_apk\": \"9eed006c07eac487652b6c4756108a11ca00d307\", \"content_browsertests\": \"0f7674a49d8505dc4586f018df5f4271939bcde3\", \"content_shell_test_apk\": \"04eaf2ec9b8214fe710fc94a0912458dce87508e\", \"content_unittests\": \"0eb99bf94833ac742dc7dfcc36d4e2c32bb5c3fe\", \"unit_tests\": \"f5ed11ba94ea1eb96a524b4573ede68af492c16a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_21a338e382a0dbd787bea981107dd7bac336a437920c3cc1b87ea8999b8bcb15_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_578c225c2c50d5653cce8ddfaab266952737b31d66b6113fbb64cc6f5229aebd_v2\", \"builder_e4464922e5c60bddfcc3d01cfc511ef7f4a711bded636fa98c66f03a573264ee_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-133-uo7k\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5218-123b763\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"3 Test Suite(s) failed.\\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#testShow_SingleAsTabSwitcher__NoInstant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsHomepage__Instant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceLayoutTest#testTabSuggestionMessageCardDismissAfterTabClosing\\n\\n- ...131 more failure(s) (135 total)...\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- RenderDocumentHostUserDataTest.CrossSiteNavigation\\n\\n- All/SitePerProcessBrowserTest.NavigateMainFrameToChildSite/2\\n\\n- ...50 more failure(s) (52 total)...\\n\\n#### ...1 more test(s)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1593195128282183",
"status": "COMPLETED",
"status_changed_ts": "1593195128643873",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/3579",
"builder:android-bfcache-rel",
"buildset:commit/git/0f8da8249f1a145887281cb9d461ab242c1dda51",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0f8da8249f1a145887281cb9d461ab242c1dda51",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9041837868299117840",
"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/8876407806374014160/+/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:4d0aa2177c527710",
"user_agent:luci-scheduler"
],
"updated_ts": "1593201380919687",
"url": "https://ci.chromium.org/b/8876407806374014160",
"utcnow_ts": "1593201381409006"
}
}
[19:56:21.416] Invocation finished in 1h48m27.314874587s with status FAILED