[02:22:50.832] New invocation is queued and will start shortly
[02:22:52.045] Starting the invocation (attempt 1)
[02:22:52.078] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:22:52.078] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:22:52.079] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032203450600554752",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9b7f3504e7d259f846f96c6b57a85cbbc92fec20\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9032203450600554752",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/9b7f3504e7d259f846f96c6b57a85cbbc92fec20",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b7f3504e7d259f846f96c6b57a85cbbc92fec20",
"gitiles_ref:refs/heads/master"
]
}
[02:22:52.886] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602382972153286",
"id": "8866773388549729760",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b7f3504e7d259f846f96c6b57a85cbbc92fec20\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602382972663272",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/5452",
"builder:android-bfcache-rel",
"buildset:commit/git/9b7f3504e7d259f846f96c6b57a85cbbc92fec20",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b7f3504e7d259f846f96c6b57a85cbbc92fec20",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032203450600554752",
"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/8866773388549729760/+/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": "1602382972663393",
"url": "https://ci.chromium.org/b/8866773388549729760",
"utcnow_ts": "1602382972870813"
}
}
[02:22:52.886] Task URL: https://ci.chromium.org/b/8866773388549729760
[02:22:52.886] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:2:0) after 1m0s
[02:23:52.946] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:2:0)
[02:23:52.946] Timer tick, asking Buildbucket for the build status
[02:23:53.112] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:53.112] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:3:0) after 1m0s
[02:24:53.190] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:3:0)
[02:24:53.190] Timer tick, asking Buildbucket for the build status
[02:24:53.267] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:53.267] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:4:0) after 1m0s
[02:25:53.353] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:4:0)
[02:25:53.354] Timer tick, asking Buildbucket for the build status
[02:25:53.428] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:53.428] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:5:0) after 1m0s
[02:26:53.438] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:5:0)
[02:26:53.438] Timer tick, asking Buildbucket for the build status
[02:26:53.511] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:53.511] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:6:0) after 1m0s
[02:27:53.538] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:6:0)
[02:27:53.538] Timer tick, asking Buildbucket for the build status
[02:27:53.603] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:53.603] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:7:0) after 1m0s
[02:28:53.629] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:7:0)
[02:28:53.629] Timer tick, asking Buildbucket for the build status
[02:28:53.729] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:53.729] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:8:0) after 1m0s
[02:29:54.023] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:8:0)
[02:29:54.023] Timer tick, asking Buildbucket for the build status
[02:29:54.106] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:54.106] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:9:0) after 1m0s
[02:30:54.194] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:9:0)
[02:30:54.194] Timer tick, asking Buildbucket for the build status
[02:30:54.254] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:30:54.254] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:10:0) after 1m0s
[02:31:54.234] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:10:0)
[02:31:54.234] Timer tick, asking Buildbucket for the build status
[02:31:54.303] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:31:54.303] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:11:0) after 1m0s
[02:32:54.359] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:11:0)
[02:32:54.359] Timer tick, asking Buildbucket for the build status
[02:32:54.460] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:32:54.460] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:12:0) after 1m0s
[02:33:54.516] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:12:0)
[02:33:54.516] Timer tick, asking Buildbucket for the build status
[02:33:54.826] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:33:54.826] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:13:0) after 1m0s
[02:34:55.206] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:13:0)
[02:34:55.206] Timer tick, asking Buildbucket for the build status
[02:34:55.276] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:34:55.276] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:14:0) after 1m0s
[02:35:55.428] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:14:0)
[02:35:55.428] Timer tick, asking Buildbucket for the build status
[02:35:55.488] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:35:55.488] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:15:0) after 1m0s
[02:36:55.616] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:15:0)
[02:36:55.616] Timer tick, asking Buildbucket for the build status
[02:36:55.705] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:36:55.705] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:16:0) after 1m0s
[02:37:55.806] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:16:0)
[02:37:55.806] Timer tick, asking Buildbucket for the build status
[02:37:55.915] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:37:55.915] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:17:0) after 1m0s
[02:38:55.932] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:17:0)
[02:38:55.932] Timer tick, asking Buildbucket for the build status
[02:38:56.219] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:38:56.219] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:18:0) after 1m0s
[02:39:56.371] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:18:0)
[02:39:56.371] Timer tick, asking Buildbucket for the build status
[02:39:56.437] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:39:56.437] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:19:0) after 1m0s
[02:40:56.432] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:19:0)
[02:40:56.432] Timer tick, asking Buildbucket for the build status
[02:40:56.509] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:40:56.509] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:20:0) after 1m0s
[02:41:56.562] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:20:0)
[02:41:56.562] Timer tick, asking Buildbucket for the build status
[02:41:56.685] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:41:56.685] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:21:0) after 1m0s
[02:42:56.713] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:21:0)
[02:42:56.713] Timer tick, asking Buildbucket for the build status
[02:42:56.974] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:42:56.974] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:22:0) after 1m0s
[02:43:57.049] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:22:0)
[02:43:57.049] Timer tick, asking Buildbucket for the build status
[02:43:57.137] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:43:57.137] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:23:0) after 1m0s
[02:44:57.161] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:23:0)
[02:44:57.161] Timer tick, asking Buildbucket for the build status
[02:44:57.245] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:44:57.245] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:24:0) after 1m0s
[02:45:57.221] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:24:0)
[02:45:57.221] Timer tick, asking Buildbucket for the build status
[02:45:57.294] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:45:57.294] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:25:0) after 1m0s
[02:46:57.315] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:25:0)
[02:46:57.315] Timer tick, asking Buildbucket for the build status
[02:46:57.384] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:46:57.384] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:26:0) after 1m0s
[02:47:57.420] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:26:0)
[02:47:57.420] Timer tick, asking Buildbucket for the build status
[02:47:57.523] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:47:57.523] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:27:0) after 1m0s
[02:48:57.629] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:27:0)
[02:48:57.629] Timer tick, asking Buildbucket for the build status
[02:48:57.775] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:48:57.775] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:28:0) after 1m0s
[02:49:57.792] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:28:0)
[02:49:57.792] Timer tick, asking Buildbucket for the build status
[02:49:58.034] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:58.034] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:29:0) after 1m0s
[02:50:58.120] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:29:0)
[02:50:58.120] Timer tick, asking Buildbucket for the build status
[02:50:58.223] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:50:58.223] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:30:0) after 1m0s
[02:51:58.242] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:30:0)
[02:51:58.242] Timer tick, asking Buildbucket for the build status
[02:51:58.308] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:51:58.308] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:31:0) after 1m0s
[02:52:58.329] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:31:0)
[02:52:58.329] Timer tick, asking Buildbucket for the build status
[02:52:58.426] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:52:58.426] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:32:0) after 1m0s
[02:53:58.558] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:32:0)
[02:53:58.558] Timer tick, asking Buildbucket for the build status
[02:53:59.793] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:53:59.793] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:33:0) after 1m0s
[02:54:59.835] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:33:0)
[02:54:59.835] Timer tick, asking Buildbucket for the build status
[02:54:59.916] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:54:59.916] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:34:0) after 1m0s
[02:55:59.971] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:34:0)
[02:55:59.971] Timer tick, asking Buildbucket for the build status
[02:56:00.138] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:56:00.138] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:35:0) after 1m0s
[02:57:00.210] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:35:0)
[02:57:00.210] Timer tick, asking Buildbucket for the build status
[02:57:00.288] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:57:00.289] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:36:0) after 1m0s
[02:59:11.878] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:36:0)
[02:59:11.878] Timer tick, asking Buildbucket for the build status
[02:59:11.980] Build 8866773388549729760: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:59:11.980] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:37:0) after 1m0s
[02:59:30.150] Received PubSub notification, asking Buildbucket for the build status
[02:59:30.283] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:11.999] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:37:0)
[03:00:11.999] Timer tick, asking Buildbucket for the build status
[03:00:12.369] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:12.369] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:39:0) after 1m0s
[03:01:12.396] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:39:0)
[03:01:12.396] Timer tick, asking Buildbucket for the build status
[03:01:12.511] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:12.511] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:40:0) after 1m0s
[03:02:14.398] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:40:0)
[03:02:14.398] Timer tick, asking Buildbucket for the build status
[03:02:14.492] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:14.492] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:41:0) after 1m0s
[03:03:14.512] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:41:0)
[03:03:14.512] Timer tick, asking Buildbucket for the build status
[03:03:14.625] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:14.625] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:42:0) after 1m0s
[03:04:14.643] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:42:0)
[03:04:14.643] Timer tick, asking Buildbucket for the build status
[03:04:14.968] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:14.968] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:43:0) after 1m0s
[03:05:15.030] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:43:0)
[03:05:15.030] Timer tick, asking Buildbucket for the build status
[03:05:15.093] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:15.093] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:44:0) after 1m0s
[03:06:15.212] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:44:0)
[03:06:15.212] Timer tick, asking Buildbucket for the build status
[03:06:15.263] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:15.263] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:45:0) after 1m0s
[03:07:15.336] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:45:0)
[03:07:15.336] Timer tick, asking Buildbucket for the build status
[03:07:15.426] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:15.426] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:46:0) after 1m0s
[03:08:15.955] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:46:0)
[03:08:15.955] Timer tick, asking Buildbucket for the build status
[03:08:16.057] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:16.057] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:47:0) after 1m0s
[03:09:16.248] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:47:0)
[03:09:16.248] Timer tick, asking Buildbucket for the build status
[03:09:16.415] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:16.415] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:48:0) after 1m0s
[03:10:16.966] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:48:0)
[03:10:16.966] Timer tick, asking Buildbucket for the build status
[03:10:17.055] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:17.055] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:49:0) after 1m0s
[03:11:17.288] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:49:0)
[03:11:17.288] Timer tick, asking Buildbucket for the build status
[03:11:17.492] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:17.492] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:50:0) after 1m0s
[03:12:17.917] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:50:0)
[03:12:17.917] Timer tick, asking Buildbucket for the build status
[03:12:17.983] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:17.983] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:51:0) after 1m0s
[03:13:18.094] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:51:0)
[03:13:18.094] Timer tick, asking Buildbucket for the build status
[03:13:18.187] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:18.187] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:52:0) after 1m0s
[03:14:18.380] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:52:0)
[03:14:18.380] Timer tick, asking Buildbucket for the build status
[03:14:18.463] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:18.463] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:53:0) after 1m0s
[03:15:18.622] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:53:0)
[03:15:18.622] Timer tick, asking Buildbucket for the build status
[03:15:18.678] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:18.678] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:54:0) after 1m0s
[03:16:18.736] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:54:0)
[03:16:18.736] Timer tick, asking Buildbucket for the build status
[03:16:18.799] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:18.799] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:55:0) after 1m0s
[03:17:19.003] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:55:0)
[03:17:19.003] Timer tick, asking Buildbucket for the build status
[03:17:19.059] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:19.060] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:56:0) after 1m0s
[03:18:19.146] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:56:0)
[03:18:19.146] Timer tick, asking Buildbucket for the build status
[03:18:19.245] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:19.245] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:57:0) after 1m0s
[03:19:19.394] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:57:0)
[03:19:19.394] Timer tick, asking Buildbucket for the build status
[03:19:19.455] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:19.455] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:58:0) after 1m0s
[03:20:19.612] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:58:0)
[03:20:19.612] Timer tick, asking Buildbucket for the build status
[03:20:19.801] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:19.801] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:59:0) after 1m0s
[03:21:19.846] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:59:0)
[03:21:19.846] Timer tick, asking Buildbucket for the build status
[03:21:19.901] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:19.901] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:60:0) after 1m0s
[03:22:19.993] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:60:0)
[03:22:19.993] Timer tick, asking Buildbucket for the build status
[03:22:20.052] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:20.052] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:61:0) after 1m0s
[03:23:20.235] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:61:0)
[03:23:20.235] Timer tick, asking Buildbucket for the build status
[03:23:20.411] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:20.411] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:62:0) after 1m0s
[03:24:20.489] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:62:0)
[03:24:20.489] Timer tick, asking Buildbucket for the build status
[03:24:22.699] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:22.699] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:63:0) after 1m0s
[03:25:22.842] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:63:0)
[03:25:22.842] Timer tick, asking Buildbucket for the build status
[03:25:22.947] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:22.947] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:64:0) after 1m0s
[03:26:22.967] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:64:0)
[03:26:22.968] Timer tick, asking Buildbucket for the build status
[03:26:23.087] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:23.087] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:65:0) after 1m0s
[03:27:23.101] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:65:0)
[03:27:23.101] Timer tick, asking Buildbucket for the build status
[03:27:23.181] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:23.181] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:66:0) after 1m0s
[03:28:23.261] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:66:0)
[03:28:23.261] Timer tick, asking Buildbucket for the build status
[03:28:23.671] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:23.671] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:67:0) after 1m0s
[03:29:23.720] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:67:0)
[03:29:23.720] Timer tick, asking Buildbucket for the build status
[03:29:23.775] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:23.775] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:68:0) after 1m0s
[03:30:23.869] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:68:0)
[03:30:23.869] Timer tick, asking Buildbucket for the build status
[03:30:24.217] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:24.217] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:69:0) after 1m0s
[03:31:24.287] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:69:0)
[03:31:24.287] Timer tick, asking Buildbucket for the build status
[03:31:24.365] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:24.365] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:70:0) after 1m0s
[03:32:24.394] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:70:0)
[03:32:24.394] Timer tick, asking Buildbucket for the build status
[03:32:24.461] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:24.461] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:71:0) after 1m0s
[03:33:24.481] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:71:0)
[03:33:24.481] Timer tick, asking Buildbucket for the build status
[03:33:24.598] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:24.598] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:72:0) after 1m0s
[03:34:24.710] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:72:0)
[03:34:24.710] Timer tick, asking Buildbucket for the build status
[03:34:24.899] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:24.900] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:73:0) after 1m0s
[03:35:24.967] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:73:0)
[03:35:24.967] Timer tick, asking Buildbucket for the build status
[03:35:25.038] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:25.038] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:74:0) after 1m0s
[03:36:25.011] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:74:0)
[03:36:25.011] Timer tick, asking Buildbucket for the build status
[03:36:25.087] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:25.087] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:75:0) after 1m0s
[03:37:25.113] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:75:0)
[03:37:25.113] Timer tick, asking Buildbucket for the build status
[03:37:25.232] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:25.232] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:76:0) after 1m0s
[03:38:25.256] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:76:0)
[03:38:25.256] Timer tick, asking Buildbucket for the build status
[03:38:25.413] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:25.413] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:77:0) after 1m0s
[03:39:25.452] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:77:0)
[03:39:25.452] Timer tick, asking Buildbucket for the build status
[03:39:25.591] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:25.591] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:78:0) after 1m0s
[03:40:25.614] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:78:0)
[03:40:25.614] Timer tick, asking Buildbucket for the build status
[03:40:25.725] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:25.725] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:79:0) after 1m0s
[03:41:25.794] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:79:0)
[03:41:25.794] Timer tick, asking Buildbucket for the build status
[03:41:25.855] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:25.855] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:80:0) after 1m0s
[03:42:25.876] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:80:0)
[03:42:25.876] Timer tick, asking Buildbucket for the build status
[03:42:25.932] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:25.932] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:81:0) after 1m0s
[03:43:25.980] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:81:0)
[03:43:25.980] Timer tick, asking Buildbucket for the build status
[03:43:26.124] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:26.124] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:82:0) after 1m0s
[03:44:26.152] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:82:0)
[03:44:26.152] Timer tick, asking Buildbucket for the build status
[03:44:26.223] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:26.223] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:83:0) after 1m0s
[03:45:26.272] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:83:0)
[03:45:26.272] Timer tick, asking Buildbucket for the build status
[03:45:26.338] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:26.338] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:84:0) after 1m0s
[03:46:26.476] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:84:0)
[03:46:26.476] Timer tick, asking Buildbucket for the build status
[03:46:26.529] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:26.529] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:85:0) after 1m0s
[03:47:26.599] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:85:0)
[03:47:26.599] Timer tick, asking Buildbucket for the build status
[03:47:26.878] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:26.878] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:86:0) after 1m0s
[03:48:26.941] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:86:0)
[03:48:26.941] Timer tick, asking Buildbucket for the build status
[03:48:27.045] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:27.045] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:87:0) after 1m0s
[03:49:27.101] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:87:0)
[03:49:27.101] Timer tick, asking Buildbucket for the build status
[03:49:27.217] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:27.217] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:88:0) after 1m0s
[03:50:27.237] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:88:0)
[03:50:27.237] Timer tick, asking Buildbucket for the build status
[03:50:27.324] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:27.324] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:89:0) after 1m0s
[03:51:27.401] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:89:0)
[03:51:27.401] Timer tick, asking Buildbucket for the build status
[03:51:27.464] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:27.464] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:90:0) after 1m0s
[03:52:28.399] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:90:0)
[03:52:28.399] Timer tick, asking Buildbucket for the build status
[03:52:28.476] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:28.476] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:91:0) after 1m0s
[03:53:28.629] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:91:0)
[03:53:28.629] Timer tick, asking Buildbucket for the build status
[03:53:28.792] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:28.792] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:92:0) after 1m0s
[03:54:28.900] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:92:0)
[03:54:28.900] Timer tick, asking Buildbucket for the build status
[03:54:28.973] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:28.973] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:93:0) after 1m0s
[03:55:29.165] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:93:0)
[03:55:29.165] Timer tick, asking Buildbucket for the build status
[03:55:29.237] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:29.238] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:94:0) after 1m0s
[03:56:29.404] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:94:0)
[03:56:29.404] Timer tick, asking Buildbucket for the build status
[03:56:29.701] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:29.701] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:95:0) after 1m0s
[03:57:29.825] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:95:0)
[03:57:29.825] Timer tick, asking Buildbucket for the build status
[03:57:29.885] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:29.885] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:96:0) after 1m0s
[03:58:30.019] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:96:0)
[03:58:30.019] Timer tick, asking Buildbucket for the build status
[03:58:30.140] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:30.140] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:97:0) after 1m0s
[03:59:30.234] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:97:0)
[03:59:30.234] Timer tick, asking Buildbucket for the build status
[03:59:30.300] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:30.300] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:98:0) after 1m0s
[04:00:30.391] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:98:0)
[04:00:30.391] Timer tick, asking Buildbucket for the build status
[04:00:30.727] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:30.727] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:99:0) after 1m0s
[04:01:30.885] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:99:0)
[04:01:30.885] Timer tick, asking Buildbucket for the build status
[04:01:30.972] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:30.972] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:100:0) after 1m0s
[04:02:31.021] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:100:0)
[04:02:31.021] Timer tick, asking Buildbucket for the build status
[04:02:31.091] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:31.091] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:101:0) after 1m0s
[04:03:31.187] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:101:0)
[04:03:31.187] Timer tick, asking Buildbucket for the build status
[04:03:31.288] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:31.288] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:102:0) after 1m0s
[04:04:31.329] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:102:0)
[04:04:31.329] Timer tick, asking Buildbucket for the build status
[04:04:31.392] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:31.392] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:103:0) after 1m0s
[04:05:31.461] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:103:0)
[04:05:31.461] Timer tick, asking Buildbucket for the build status
[04:05:31.596] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:31.596] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:104:0) after 1m0s
[04:06:31.656] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:104:0)
[04:06:31.656] Timer tick, asking Buildbucket for the build status
[04:06:31.719] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:31.719] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:105:0) after 1m0s
[04:07:31.717] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:105:0)
[04:07:31.717] Timer tick, asking Buildbucket for the build status
[04:07:31.775] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:31.775] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:106:0) after 1m0s
[04:08:34.287] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:106:0)
[04:08:34.287] Timer tick, asking Buildbucket for the build status
[04:08:34.408] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:34.408] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:107:0) after 1m0s
[04:09:34.631] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:107:0)
[04:09:34.631] Timer tick, asking Buildbucket for the build status
[04:09:34.715] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:34.715] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:108:0) after 1m0s
[04:10:34.796] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:108:0)
[04:10:34.796] Timer tick, asking Buildbucket for the build status
[04:10:34.859] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:34.859] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:109:0) after 1m0s
[04:11:34.999] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:109:0)
[04:11:34.999] Timer tick, asking Buildbucket for the build status
[04:11:35.054] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:35.054] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:110:0) after 1m0s
[04:12:35.099] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:110:0)
[04:12:35.099] Timer tick, asking Buildbucket for the build status
[04:12:35.406] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:35.406] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:111:0) after 1m0s
[04:13:35.453] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:111:0)
[04:13:35.453] Timer tick, asking Buildbucket for the build status
[04:13:36.008] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:36.008] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:112:0) after 1m0s
[04:14:36.176] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:112:0)
[04:14:36.176] Timer tick, asking Buildbucket for the build status
[04:14:36.381] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:36.381] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:113:0) after 1m0s
[04:15:36.408] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:113:0)
[04:15:36.408] Timer tick, asking Buildbucket for the build status
[04:15:36.468] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:36.468] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:114:0) after 1m0s
[04:16:36.465] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:114:0)
[04:16:36.465] Timer tick, asking Buildbucket for the build status
[04:16:36.561] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:36.561] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:115:0) after 1m0s
[04:17:36.687] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:115:0)
[04:17:36.687] Timer tick, asking Buildbucket for the build status
[04:17:36.794] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:36.794] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:116:0) after 1m0s
[04:18:36.898] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:116:0)
[04:18:36.898] Timer tick, asking Buildbucket for the build status
[04:18:37.590] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:37.590] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:117:0) after 1m0s
[04:19:37.660] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:117:0)
[04:19:37.660] Timer tick, asking Buildbucket for the build status
[04:19:37.786] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:37.786] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:118:0) after 1m0s
[04:20:37.980] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:118:0)
[04:20:37.980] Timer tick, asking Buildbucket for the build status
[04:20:38.047] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:38.047] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:119:0) after 1m0s
[04:21:38.220] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:119:0)
[04:21:38.220] Timer tick, asking Buildbucket for the build status
[04:21:38.336] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:38.336] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:120:0) after 1m0s
[04:22:38.553] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:120:0)
[04:22:38.553] Timer tick, asking Buildbucket for the build status
[04:22:38.613] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:38.613] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:121:0) after 1m0s
[04:23:38.727] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:121:0)
[04:23:38.727] Timer tick, asking Buildbucket for the build status
[04:23:38.832] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:38.832] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:122:0) after 1m0s
[04:24:38.854] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:122:0)
[04:24:38.854] Timer tick, asking Buildbucket for the build status
[04:24:38.949] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:38.949] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:123:0) after 1m0s
[04:25:38.972] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:123:0)
[04:25:38.972] Timer tick, asking Buildbucket for the build status
[04:25:39.035] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:39.035] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:124:0) after 1m0s
[04:26:39.064] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:124:0)
[04:26:39.064] Timer tick, asking Buildbucket for the build status
[04:26:39.273] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:39.273] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:125:0) after 1m0s
[04:27:39.373] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:125:0)
[04:27:39.373] Timer tick, asking Buildbucket for the build status
[04:27:39.630] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:39.630] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:126:0) after 1m0s
[04:28:39.762] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:126:0)
[04:28:39.762] Timer tick, asking Buildbucket for the build status
[04:28:39.882] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:39.882] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:127:0) after 1m0s
[04:29:40.015] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:127:0)
[04:29:40.015] Timer tick, asking Buildbucket for the build status
[04:29:40.072] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:40.072] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:128:0) after 1m0s
[04:30:40.154] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:128:0)
[04:30:40.154] Timer tick, asking Buildbucket for the build status
[04:30:40.223] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:40.223] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:129:0) after 1m0s
[04:31:40.289] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:129:0)
[04:31:40.289] Timer tick, asking Buildbucket for the build status
[04:31:40.349] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:40.349] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:130:0) after 1m0s
[04:32:40.410] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:130:0)
[04:32:40.410] Timer tick, asking Buildbucket for the build status
[04:32:40.476] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:40.476] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:131:0) after 1m0s
[04:33:40.595] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:131:0)
[04:33:40.595] Timer tick, asking Buildbucket for the build status
[04:33:40.694] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:40.694] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:132:0) after 1m0s
[04:34:40.773] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:132:0)
[04:34:40.773] Timer tick, asking Buildbucket for the build status
[04:34:40.908] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:40.908] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:133:0) after 1m0s
[04:35:40.930] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:133:0)
[04:35:40.930] Timer tick, asking Buildbucket for the build status
[04:35:41.035] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:41.035] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:134:0) after 1m0s
[04:36:41.063] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:134:0)
[04:36:41.063] Timer tick, asking Buildbucket for the build status
[04:36:41.132] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:41.132] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:135:0) after 1m0s
[04:37:41.154] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:135:0)
[04:37:41.154] Timer tick, asking Buildbucket for the build status
[04:37:41.227] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:41.227] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:136:0) after 1m0s
[04:38:41.276] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:136:0)
[04:38:41.276] Timer tick, asking Buildbucket for the build status
[04:38:41.665] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:41.665] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:137:0) after 1m0s
[04:39:41.709] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:137:0)
[04:39:41.709] Timer tick, asking Buildbucket for the build status
[04:39:41.781] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:41.781] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:138:0) after 1m0s
[04:40:41.812] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:138:0)
[04:40:41.812] Timer tick, asking Buildbucket for the build status
[04:40:41.868] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:41.868] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:139:0) after 1m0s
[04:41:41.894] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:139:0)
[04:41:41.894] Timer tick, asking Buildbucket for the build status
[04:41:41.951] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:41.952] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:140:0) after 1m0s
[04:42:41.985] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:140:0)
[04:42:41.985] Timer tick, asking Buildbucket for the build status
[04:42:42.409] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:42.409] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:141:0) after 1m0s
[04:43:42.436] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:141:0)
[04:43:42.436] Timer tick, asking Buildbucket for the build status
[04:43:42.982] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:42.982] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:142:0) after 1m0s
[04:44:43.036] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:142:0)
[04:44:43.036] Timer tick, asking Buildbucket for the build status
[04:44:43.129] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:43.129] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:143:0) after 1m0s
[04:45:43.155] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:143:0)
[04:45:43.155] Timer tick, asking Buildbucket for the build status
[04:45:43.219] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:43.220] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:144:0) after 1m0s
[04:46:43.250] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:144:0)
[04:46:43.250] Timer tick, asking Buildbucket for the build status
[04:46:43.313] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:43.313] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:145:0) after 1m0s
[04:47:43.342] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:145:0)
[04:47:43.342] Timer tick, asking Buildbucket for the build status
[04:47:43.422] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:43.422] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:146:0) after 1m0s
[04:48:43.442] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:146:0)
[04:48:43.442] Timer tick, asking Buildbucket for the build status
[04:48:43.712] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:43.712] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:147:0) after 1m0s
[04:49:43.738] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:147:0)
[04:49:43.738] Timer tick, asking Buildbucket for the build status
[04:49:43.792] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:43.792] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:148:0) after 1m0s
[04:50:43.814] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:148:0)
[04:50:43.814] Timer tick, asking Buildbucket for the build status
[04:50:43.894] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:43.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:149:0) after 1m0s
[04:51:43.917] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:149:0)
[04:51:43.917] Timer tick, asking Buildbucket for the build status
[04:51:44.009] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:44.009] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:150:0) after 1m0s
[04:52:44.035] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:150:0)
[04:52:44.035] Timer tick, asking Buildbucket for the build status
[04:52:44.195] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:44.195] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:151:0) after 1m0s
[04:53:44.221] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:151:0)
[04:53:44.221] Timer tick, asking Buildbucket for the build status
[04:53:44.425] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:44.425] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:152:0) after 1m0s
[04:54:44.493] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:152:0)
[04:54:44.493] Timer tick, asking Buildbucket for the build status
[04:54:44.565] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:44.565] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:153:0) after 1m0s
[04:55:44.638] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:153:0)
[04:55:44.638] Timer tick, asking Buildbucket for the build status
[04:55:44.696] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:44.696] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:154:0) after 1m0s
[04:56:44.788] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:154:0)
[04:56:44.788] Timer tick, asking Buildbucket for the build status
[04:56:44.879] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:44.879] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:155:0) after 1m0s
[04:57:44.920] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:155:0)
[04:57:44.920] Timer tick, asking Buildbucket for the build status
[04:57:44.996] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:44.996] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:156:0) after 1m0s
[04:58:45.027] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:156:0)
[04:58:45.027] Timer tick, asking Buildbucket for the build status
[04:58:45.522] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:45.522] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:157:0) after 1m0s
[04:59:45.551] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:157:0)
[04:59:45.551] Timer tick, asking Buildbucket for the build status
[04:59:45.621] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:45.621] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:158:0) after 1m0s
[05:00:45.648] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:158:0)
[05:00:45.648] Timer tick, asking Buildbucket for the build status
[05:00:45.727] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:45.727] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:159:0) after 1m0s
[05:01:45.763] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:159:0)
[05:01:45.763] Timer tick, asking Buildbucket for the build status
[05:01:45.829] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:45.829] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:160:0) after 1m0s
[05:02:45.855] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:160:0)
[05:02:45.855] Timer tick, asking Buildbucket for the build status
[05:02:46.005] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:46.006] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:161:0) after 1m0s
[05:03:46.037] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:161:0)
[05:03:46.037] Timer tick, asking Buildbucket for the build status
[05:03:46.237] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:46.237] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:162:0) after 1m0s
[05:04:46.264] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:162:0)
[05:04:46.264] Timer tick, asking Buildbucket for the build status
[05:04:46.320] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:46.320] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:163:0) after 1m0s
[05:05:46.308] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:163:0)
[05:05:46.308] Timer tick, asking Buildbucket for the build status
[05:05:46.693] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:46.693] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:164:0) after 1m0s
[05:06:46.722] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:164:0)
[05:06:46.722] Timer tick, asking Buildbucket for the build status
[05:06:46.791] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:46.791] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:165:0) after 1m0s
[05:07:46.820] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:165:0)
[05:07:46.820] Timer tick, asking Buildbucket for the build status
[05:07:46.900] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:46.900] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:166:0) after 1m0s
[05:08:46.924] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:166:0)
[05:08:46.924] Timer tick, asking Buildbucket for the build status
[05:08:47.132] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:47.132] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:167:0) after 1m0s
[05:09:47.205] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:167:0)
[05:09:47.205] Timer tick, asking Buildbucket for the build status
[05:09:47.422] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:47.422] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:168:0) after 1m0s
[05:10:47.443] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:168:0)
[05:10:47.443] Timer tick, asking Buildbucket for the build status
[05:10:47.504] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:47.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:169:0) after 1m0s
[05:11:47.535] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:169:0)
[05:11:47.535] Timer tick, asking Buildbucket for the build status
[05:11:47.604] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:47.604] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:170:0) after 1m0s
[05:12:47.618] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:170:0)
[05:12:47.618] Timer tick, asking Buildbucket for the build status
[05:12:47.820] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:47.820] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:171:0) after 1m0s
[05:13:47.870] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:171:0)
[05:13:47.870] Timer tick, asking Buildbucket for the build status
[05:13:47.982] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:47.982] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:172:0) after 1m0s
[05:14:48.032] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:172:0)
[05:14:48.032] Timer tick, asking Buildbucket for the build status
[05:14:48.192] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:48.192] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:173:0) after 1m0s
[05:15:48.220] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:173:0)
[05:15:48.220] Timer tick, asking Buildbucket for the build status
[05:15:48.279] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:48.279] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:174:0) after 1m0s
[05:16:48.383] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:174:0)
[05:16:48.383] Timer tick, asking Buildbucket for the build status
[05:16:48.607] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:48.607] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:175:0) after 1m0s
[05:17:48.635] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:175:0)
[05:17:48.635] Timer tick, asking Buildbucket for the build status
[05:17:48.731] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:48.731] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:176:0) after 1m0s
[05:18:48.828] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:176:0)
[05:18:48.828] Timer tick, asking Buildbucket for the build status
[05:18:49.282] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:49.282] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:177:0) after 1m0s
[05:19:49.308] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:177:0)
[05:19:49.308] Timer tick, asking Buildbucket for the build status
[05:19:49.417] Build 8866773388549729760: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:49.417] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9032203450600554752:178:0) after 1m0s
[05:19:59.391] Received PubSub notification, asking Buildbucket for the build status
[05:19:59.450] Build 8866773388549729760: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:19:59.451] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602393599044468",
"created_by": "project:chromium",
"created_ts": "1602382972153286",
"failure_reason": "BUILD_FAILURE",
"id": "8866773388549729760",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b7f3504e7d259f846f96c6b57a85cbbc92fec20\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- All/RenderFrameHostManagerTest.ForegroundNavigationIsNeverBackgroundedWithoutSpareProcess/1\\n\\n- SavePageAsWebBundleBrowserTest.GenerateOnePageSimpleWebBundle\\n\\n- All/NavigationControllerBrowserTest.SiteInstanceChangeOnHistoryNavigation/0\\n\\n- All/SitePerProcessBrowserTest.SubframePostMessage/2\\n\\n- ...292 more failure(s) (296 total)...\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"9b7f3504e7d259f846f96c6b57a85cbbc92fec20\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-21-ky1o\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 5452, \"got_angle_revision\": \"3345e5fdc5c4360c770ddad6260dd10f80dbd762\", \"got_dawn_revision\": \"1c25198384e7ecfebbd3ac84203d3b1d46a0e228\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"9b7f3504e7d259f846f96c6b57a85cbbc92fec20\", \"got_revision_cp\": \"refs/heads/master@{#815980}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"cca740fc48dfffbe24a5ee0bfe23ed1ec2b21580\", \"got_v8_revision\": \"07b0b1dcde4a99294b8028d83f4ea244885cc091\", \"got_v8_revision_cp\": \"refs/heads/8.8.62@{#1}\", \"got_webrtc_revision\": \"3326535126e435f1ba647885ce43a8f0f3d317eb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32375}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9b7f3504e7d259f846f96c6b57a85cbbc92fec20\", \"swarm_hashes\": {\"android_browsertests\": \"0de86b892fdb1a6a4f528c3525a09679e9e228dc\", \"chrome_public_test_apk\": \"d9c571556e6ecfd404c21c19de9350344b9fddab\", \"content_browsertests\": \"48f8ce0b60837529850c8f7ab73f13f95a5ce245\", \"content_shell_test_apk\": \"64423a02f96e3ba40dd332d6a808176add896de8\", \"content_unittests\": \"7bdf9c2e3b72f6dcc82fc64b751c9e0f8303e56b\", \"unit_tests\": \"5f2f16ed6d03ae1dfcd03f19521568cb3e077d2b\"}, \"swarm_hashes_refs/heads/master(at){#815980}_without_patch\": {\"android_browsertests\": \"0de86b892fdb1a6a4f528c3525a09679e9e228dc\", \"chrome_public_test_apk\": \"d9c571556e6ecfd404c21c19de9350344b9fddab\", \"content_browsertests\": \"48f8ce0b60837529850c8f7ab73f13f95a5ce245\", \"content_shell_test_apk\": \"64423a02f96e3ba40dd332d6a808176add896de8\", \"content_unittests\": \"7bdf9c2e3b72f6dcc82fc64b751c9e0f8303e56b\", \"unit_tests\": \"5f2f16ed6d03ae1dfcd03f19521568cb3e077d2b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06bf165a3bf7a25e93955b74ebaf013d13a4a87ad7bcb716437f8a47afa74d09_v2\", \"builder_08506e22a0e0fdc29bd318165699b599f0671cf91287ea7a96642b02d7ff24e4_v2\", \"builder_0cd6cf41ec42413cc9e5bdc0dde565dc7bee061bff1a52db1e25d07760950df7_v2\", \"builder_642e8105f745eb1a71ee53fae678c471391c0152dcfea24d527182ac47960a08_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_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-21-ky1o\"], \"image\": [\"chrome-xenial-20100400-30cd36dae64\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- All/RenderFrameHostManagerTest.ForegroundNavigationIsNeverBackgroundedWithoutSpareProcess/1\\n\\n- SavePageAsWebBundleBrowserTest.GenerateOnePageSimpleWebBundle\\n\\n- All/NavigationControllerBrowserTest.SiteInstanceChangeOnHistoryNavigation/0\\n\\n- All/SitePerProcessBrowserTest.SubframePostMessage/2\\n\\n- ...292 more failure(s) (296 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602385169602961",
"status": "COMPLETED",
"status_changed_ts": "1602385169949539",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/5452",
"builder:android-bfcache-rel",
"buildset:commit/git/9b7f3504e7d259f846f96c6b57a85cbbc92fec20",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9b7f3504e7d259f846f96c6b57a85cbbc92fec20",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032203450600554752",
"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/8866773388549729760/+/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:4f2e494fd397e210",
"user_agent:luci-scheduler"
],
"updated_ts": "1602393599158736",
"url": "https://ci.chromium.org/b/8866773388549729760",
"utcnow_ts": "1602393599443286"
}
}
[05:19:59.451] Invocation finished in 2h57m8.636829939s with status FAILED