[22:33:04.602] New invocation is queued and will start shortly
[22:33:05.779] Starting the invocation (attempt 1)
[22:33:05.832] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:33:05.832] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:33:05.832] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9042817751576554400",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b22e1927c7acb94a92a859f08ee0f544cbbefb3f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9042817751576554400",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/b22e1927c7acb94a92a859f08ee0f544cbbefb3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b22e1927c7acb94a92a859f08ee0f544cbbefb3f",
"gitiles_ref:refs/heads/master"
]
}
[22:33:06.759] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1592260385982200",
"id": "8877387689466482800",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b22e1927c7acb94a92a859f08ee0f544cbbefb3f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1592260386534684",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/3359",
"builder:android-bfcache-rel",
"buildset:commit/git/b22e1927c7acb94a92a859f08ee0f544cbbefb3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b22e1927c7acb94a92a859f08ee0f544cbbefb3f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9042817751576554400",
"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/8877387689466482800/+/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": "1592260386534863",
"url": "https://ci.chromium.org/b/8877387689466482800",
"utcnow_ts": "1592260386737961"
}
}
[22:33:06.759] Task URL: https://ci.chromium.org/b/8877387689466482800
[22:33:06.759] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:2:0) after 1m0s
[22:34:06.924] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:2:0)
[22:34:06.924] Timer tick, asking Buildbucket for the build status
[22:34:07.566] Build 8877387689466482800: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:34:07.566] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:3:0) after 1m0s
[22:34:35.526] Received PubSub notification, asking Buildbucket for the build status
[22:34:35.740] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:07.638] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:3:0)
[22:35:07.638] Timer tick, asking Buildbucket for the build status
[22:35:08.222] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:08.222] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:5:0) after 1m0s
[22:36:08.261] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:5:0)
[22:36:08.261] Timer tick, asking Buildbucket for the build status
[22:36:08.544] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:08.544] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:6:0) after 1m0s
[22:37:08.549] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:6:0)
[22:37:08.549] Timer tick, asking Buildbucket for the build status
[22:37:08.829] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:08.829] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:7:0) after 1m0s
[22:38:08.869] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:7:0)
[22:38:08.869] Timer tick, asking Buildbucket for the build status
[22:38:09.259] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:09.259] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:8:0) after 1m0s
[22:39:09.338] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:8:0)
[22:39:09.338] Timer tick, asking Buildbucket for the build status
[22:39:09.592] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:09.592] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:9:0) after 1m0s
[22:40:09.720] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:9:0)
[22:40:09.720] Timer tick, asking Buildbucket for the build status
[22:40:09.867] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:09.867] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:10:0) after 1m0s
[22:41:09.947] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:10:0)
[22:41:09.947] Timer tick, asking Buildbucket for the build status
[22:41:10.166] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:10.166] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:11:0) after 1m0s
[22:42:10.150] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:11:0)
[22:42:10.150] Timer tick, asking Buildbucket for the build status
[22:42:10.819] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:10.819] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:12:0) after 1m0s
[22:43:10.904] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:12:0)
[22:43:10.904] Timer tick, asking Buildbucket for the build status
[22:43:12.375] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:12.375] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:13:0) after 1m0s
[22:44:12.461] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:13:0)
[22:44:12.461] Timer tick, asking Buildbucket for the build status
[22:44:12.770] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:12.770] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:14:0) after 1m0s
[22:45:12.923] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:14:0)
[22:45:12.923] Timer tick, asking Buildbucket for the build status
[22:45:13.048] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:13.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:15:0) after 1m0s
[22:46:13.247] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:15:0)
[22:46:13.247] Timer tick, asking Buildbucket for the build status
[22:46:13.720] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:13.720] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:16:0) after 1m0s
[22:47:13.892] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:16:0)
[22:47:13.892] Timer tick, asking Buildbucket for the build status
[22:47:14.062] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:14.062] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:17:0) after 1m0s
[22:48:14.564] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:17:0)
[22:48:14.564] Timer tick, asking Buildbucket for the build status
[22:48:14.693] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:14.693] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:18:0) after 1m0s
[22:49:14.772] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:18:0)
[22:49:14.772] Timer tick, asking Buildbucket for the build status
[22:49:15.065] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:15.065] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:19:0) after 1m0s
[22:50:15.437] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:19:0)
[22:50:15.437] Timer tick, asking Buildbucket for the build status
[22:50:15.661] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:15.661] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:20:0) after 1m0s
[22:51:16.121] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:20:0)
[22:51:16.121] Timer tick, asking Buildbucket for the build status
[22:51:17.074] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:17.074] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:21:0) after 1m0s
[22:52:17.298] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:21:0)
[22:52:17.298] Timer tick, asking Buildbucket for the build status
[22:52:17.446] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:17.446] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:22:0) after 1m0s
[22:53:17.713] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:22:0)
[22:53:17.713] Timer tick, asking Buildbucket for the build status
[22:53:17.835] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:17.835] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:23:0) after 1m0s
[22:54:17.941] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:23:0)
[22:54:17.941] Timer tick, asking Buildbucket for the build status
[22:54:18.118] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:18.118] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:24:0) after 1m0s
[22:55:18.274] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:24:0)
[22:55:18.274] Timer tick, asking Buildbucket for the build status
[22:55:18.399] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:18.399] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:25:0) after 1m0s
[22:56:18.575] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:25:0)
[22:56:18.575] Timer tick, asking Buildbucket for the build status
[22:56:18.860] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:18.860] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:26:0) after 1m0s
[22:57:19.520] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:26:0)
[22:57:19.520] Timer tick, asking Buildbucket for the build status
[22:57:19.806] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:19.806] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:27:0) after 1m0s
[22:58:19.836] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:27:0)
[22:58:19.836] Timer tick, asking Buildbucket for the build status
[22:58:19.985] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:19.985] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:28:0) after 1m0s
[22:59:20.243] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:28:0)
[22:59:20.243] Timer tick, asking Buildbucket for the build status
[22:59:21.652] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:21.652] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:29:0) after 1m0s
[23:00:21.780] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:29:0)
[23:00:21.780] Timer tick, asking Buildbucket for the build status
[23:00:21.970] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:21.970] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:30:0) after 1m0s
[23:01:22.031] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:30:0)
[23:01:22.031] Timer tick, asking Buildbucket for the build status
[23:01:22.623] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:22.623] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:31:0) after 1m0s
[23:02:22.751] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:31:0)
[23:02:22.751] Timer tick, asking Buildbucket for the build status
[23:02:23.072] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:23.072] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:32:0) after 1m0s
[23:03:23.487] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:32:0)
[23:03:23.487] Timer tick, asking Buildbucket for the build status
[23:03:23.741] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:23.741] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:33:0) after 1m0s
[23:04:23.824] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:33:0)
[23:04:23.824] Timer tick, asking Buildbucket for the build status
[23:04:24.173] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:24.173] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:34:0) after 1m0s
[23:05:24.328] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:34:0)
[23:05:24.328] Timer tick, asking Buildbucket for the build status
[23:05:24.503] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:24.503] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:35:0) after 1m0s
[23:06:24.529] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:35:0)
[23:06:24.529] Timer tick, asking Buildbucket for the build status
[23:06:24.665] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:24.665] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:36:0) after 1m0s
[23:07:24.703] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:36:0)
[23:07:24.703] Timer tick, asking Buildbucket for the build status
[23:07:25.254] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:25.254] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:37:0) after 1m0s
[23:08:25.335] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:37:0)
[23:08:25.335] Timer tick, asking Buildbucket for the build status
[23:08:25.695] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:25.695] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:38:0) after 1m0s
[23:09:25.830] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:38:0)
[23:09:25.830] Timer tick, asking Buildbucket for the build status
[23:09:26.351] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:26.351] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:39:0) after 1m0s
[23:10:26.393] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:39:0)
[23:10:26.393] Timer tick, asking Buildbucket for the build status
[23:10:26.509] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:26.509] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:40:0) after 1m0s
[23:11:26.518] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:40:0)
[23:11:26.518] Timer tick, asking Buildbucket for the build status
[23:11:27.055] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:27.055] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:41:0) after 1m0s
[23:12:27.096] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:41:0)
[23:12:27.096] Timer tick, asking Buildbucket for the build status
[23:12:27.964] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:27.964] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:42:0) after 1m0s
[23:13:27.967] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:42:0)
[23:13:27.967] Timer tick, asking Buildbucket for the build status
[23:13:28.335] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:28.335] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:43:0) after 1m0s
[23:14:28.395] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:43:0)
[23:14:28.395] Timer tick, asking Buildbucket for the build status
[23:14:29.306] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:29.306] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:44:0) after 1m0s
[23:15:29.301] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:44:0)
[23:15:29.301] Timer tick, asking Buildbucket for the build status
[23:15:29.504] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:29.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:45:0) after 1m0s
[23:16:29.529] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:45:0)
[23:16:29.529] Timer tick, asking Buildbucket for the build status
[23:16:29.658] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:29.658] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:46:0) after 1m0s
[23:17:29.685] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:46:0)
[23:17:29.685] Timer tick, asking Buildbucket for the build status
[23:17:29.994] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:29.995] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:47:0) after 1m0s
[23:18:30.021] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:47:0)
[23:18:30.021] Timer tick, asking Buildbucket for the build status
[23:18:30.519] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:30.519] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:48:0) after 1m0s
[23:19:30.549] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:48:0)
[23:19:30.549] Timer tick, asking Buildbucket for the build status
[23:19:30.906] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:30.906] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:49:0) after 1m0s
[23:20:30.964] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:49:0)
[23:20:30.964] Timer tick, asking Buildbucket for the build status
[23:20:31.104] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:31.104] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:50:0) after 1m0s
[23:21:31.181] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:50:0)
[23:21:31.181] Timer tick, asking Buildbucket for the build status
[23:21:31.794] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:31.794] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:51:0) after 1m0s
[23:22:31.867] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:51:0)
[23:22:31.867] Timer tick, asking Buildbucket for the build status
[23:22:32.181] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:32.181] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:52:0) after 1m0s
[23:23:32.217] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:52:0)
[23:23:32.217] Timer tick, asking Buildbucket for the build status
[23:23:32.407] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:32.407] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:53:0) after 1m0s
[23:24:32.456] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:53:0)
[23:24:32.457] Timer tick, asking Buildbucket for the build status
[23:24:32.592] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:32.592] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:54:0) after 1m0s
[23:25:32.631] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:54:0)
[23:25:32.632] Timer tick, asking Buildbucket for the build status
[23:25:32.754] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:32.754] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:55:0) after 1m0s
[23:26:32.821] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:55:0)
[23:26:32.821] Timer tick, asking Buildbucket for the build status
[23:26:33.030] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:33.030] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:56:0) after 1m0s
[23:27:33.057] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:56:0)
[23:27:33.058] Timer tick, asking Buildbucket for the build status
[23:27:33.432] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:33.432] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:57:0) after 1m0s
[23:28:33.604] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:57:0)
[23:28:33.604] Timer tick, asking Buildbucket for the build status
[23:28:33.770] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:33.770] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:58:0) after 1m0s
[23:29:33.882] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:58:0)
[23:29:33.882] Timer tick, asking Buildbucket for the build status
[23:29:33.991] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:33.991] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:59:0) after 1m0s
[23:30:34.088] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:59:0)
[23:30:34.088] Timer tick, asking Buildbucket for the build status
[23:30:34.536] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:34.536] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:60:0) after 1m0s
[23:31:34.597] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:60:0)
[23:31:34.597] Timer tick, asking Buildbucket for the build status
[23:31:34.801] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:34.801] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:61:0) after 1m0s
[23:32:35.714] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:61:0)
[23:32:35.714] Timer tick, asking Buildbucket for the build status
[23:32:36.412] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:36.412] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:62:0) after 1m0s
[23:33:36.522] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:62:0)
[23:33:36.522] Timer tick, asking Buildbucket for the build status
[23:33:36.940] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:36.940] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:63:0) after 1m0s
[23:34:37.078] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:63:0)
[23:34:37.078] Timer tick, asking Buildbucket for the build status
[23:34:37.272] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:37.272] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:64:0) after 1m0s
[23:35:37.336] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:64:0)
[23:35:37.336] Timer tick, asking Buildbucket for the build status
[23:35:37.464] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:37.464] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:65:0) after 1m0s
[23:36:37.527] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:65:0)
[23:36:37.527] Timer tick, asking Buildbucket for the build status
[23:36:37.647] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:37.648] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:66:0) after 1m0s
[23:37:37.841] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:66:0)
[23:37:37.841] Timer tick, asking Buildbucket for the build status
[23:37:45.045] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:45.045] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:67:0) after 1m0s
[23:38:45.097] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:67:0)
[23:38:45.097] Timer tick, asking Buildbucket for the build status
[23:38:45.495] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:45.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:68:0) after 1m0s
[23:39:45.518] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:68:0)
[23:39:45.518] Timer tick, asking Buildbucket for the build status
[23:39:45.698] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:45.698] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:69:0) after 1m0s
[23:40:45.723] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:69:0)
[23:40:45.723] Timer tick, asking Buildbucket for the build status
[23:40:45.842] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:45.842] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:70:0) after 1m0s
[23:41:45.876] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:70:0)
[23:41:45.876] Timer tick, asking Buildbucket for the build status
[23:41:46.069] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:46.069] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:71:0) after 1m0s
[23:42:46.103] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:71:0)
[23:42:46.103] Timer tick, asking Buildbucket for the build status
[23:42:48.417] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:48.417] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:72:0) after 1m0s
[23:43:48.664] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:72:0)
[23:43:48.664] Timer tick, asking Buildbucket for the build status
[23:43:48.887] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:48.887] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:73:0) after 1m0s
[23:44:48.945] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:73:0)
[23:44:48.945] Timer tick, asking Buildbucket for the build status
[23:44:51.004] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:51.004] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:74:0) after 1m0s
[23:45:51.161] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:74:0)
[23:45:51.161] Timer tick, asking Buildbucket for the build status
[23:45:51.360] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:51.360] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:75:0) after 1m0s
[23:46:51.603] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:75:0)
[23:46:51.603] Timer tick, asking Buildbucket for the build status
[23:46:51.797] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:51.797] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:76:0) after 1m0s
[23:47:51.934] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:76:0)
[23:47:51.934] Timer tick, asking Buildbucket for the build status
[23:47:54.538] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:54.538] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:77:0) after 1m0s
[23:48:54.896] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:77:0)
[23:48:54.896] Timer tick, asking Buildbucket for the build status
[23:48:55.282] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:55.282] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:78:0) after 1m0s
[23:49:55.592] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:78:0)
[23:49:55.592] Timer tick, asking Buildbucket for the build status
[23:49:55.831] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:55.831] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:79:0) after 1m0s
[23:50:56.038] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:79:0)
[23:50:56.038] Timer tick, asking Buildbucket for the build status
[23:50:56.278] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:56.278] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:80:0) after 1m0s
[23:51:56.377] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:80:0)
[23:51:56.377] Timer tick, asking Buildbucket for the build status
[23:51:56.970] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:56.970] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:81:0) after 1m0s
[23:52:56.993] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:81:0)
[23:52:56.993] Timer tick, asking Buildbucket for the build status
[23:53:04.293] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:04.293] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:82:0) after 1m0s
[23:54:04.295] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:82:0)
[23:54:04.295] Timer tick, asking Buildbucket for the build status
[23:54:04.847] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:04.847] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:83:0) after 1m0s
[23:55:04.905] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:83:0)
[23:55:04.905] Timer tick, asking Buildbucket for the build status
[23:55:05.147] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:05.147] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:84:0) after 1m0s
[23:56:05.253] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:84:0)
[23:56:05.253] Timer tick, asking Buildbucket for the build status
[23:56:05.424] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:05.424] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:85:0) after 1m0s
[23:57:05.531] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:85:0)
[23:57:05.531] Timer tick, asking Buildbucket for the build status
[23:57:05.887] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:05.887] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:86:0) after 1m0s
[23:58:06.012] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:86:0)
[23:58:06.012] Timer tick, asking Buildbucket for the build status
[23:58:06.323] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:06.323] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:87:0) after 1m0s
[23:59:06.355] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:87:0)
[23:59:06.355] Timer tick, asking Buildbucket for the build status
[23:59:06.504] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:06.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:88:0) after 1m0s
[00:00:06.805] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:88:0)
[00:00:06.805] Timer tick, asking Buildbucket for the build status
[00:00:06.950] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:06.950] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:89:0) after 1m0s
[00:01:07.301] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:89:0)
[00:01:07.301] Timer tick, asking Buildbucket for the build status
[00:01:07.471] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:07.471] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:90:0) after 1m0s
[00:02:07.597] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:90:0)
[00:02:07.597] Timer tick, asking Buildbucket for the build status
[00:02:07.865] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:07.865] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:91:0) after 1m0s
[00:03:07.868] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:91:0)
[00:03:07.868] Timer tick, asking Buildbucket for the build status
[00:03:08.063] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:08.063] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:92:0) after 1m0s
[00:04:08.108] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:92:0)
[00:04:08.108] Timer tick, asking Buildbucket for the build status
[00:04:08.568] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:08.568] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:93:0) after 1m0s
[00:05:08.598] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:93:0)
[00:05:08.598] Timer tick, asking Buildbucket for the build status
[00:05:09.255] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:09.255] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:94:0) after 1m0s
[00:06:09.314] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:94:0)
[00:06:09.315] Timer tick, asking Buildbucket for the build status
[00:06:09.925] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:09.925] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:95:0) after 1m0s
[00:07:09.978] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:95:0)
[00:07:09.978] Timer tick, asking Buildbucket for the build status
[00:07:10.515] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:10.515] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:96:0) after 1m0s
[00:08:10.633] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:96:0)
[00:08:10.633] Timer tick, asking Buildbucket for the build status
[00:08:10.879] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:10.879] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:97:0) after 1m0s
[00:09:10.903] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:97:0)
[00:09:10.903] Timer tick, asking Buildbucket for the build status
[00:09:11.039] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:11.039] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:98:0) after 1m0s
[00:10:11.092] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:98:0)
[00:10:11.092] Timer tick, asking Buildbucket for the build status
[00:10:11.401] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:11.401] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:99:0) after 1m0s
[00:11:11.428] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:99:0)
[00:11:11.428] Timer tick, asking Buildbucket for the build status
[00:11:11.783] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:11.783] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:100:0) after 1m0s
[00:12:11.809] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:100:0)
[00:12:11.809] Timer tick, asking Buildbucket for the build status
[00:12:11.995] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:11.996] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:101:0) after 1m0s
[00:13:12.092] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:101:0)
[00:13:12.092] Timer tick, asking Buildbucket for the build status
[00:13:12.622] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:12.622] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:102:0) after 1m0s
[00:14:12.677] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:102:0)
[00:14:12.677] Timer tick, asking Buildbucket for the build status
[00:14:12.904] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:12.904] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:103:0) after 1m0s
[00:15:12.971] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:103:0)
[00:15:12.971] Timer tick, asking Buildbucket for the build status
[00:15:13.545] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:13.545] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:104:0) after 1m0s
[00:16:13.639] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:104:0)
[00:16:13.639] Timer tick, asking Buildbucket for the build status
[00:16:13.981] Build 8877387689466482800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:13.981] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9042817751576554400:105:0) after 1m0s
[00:17:13.722] Received PubSub notification, asking Buildbucket for the build status
[00:17:13.841] Build 8877387689466482800: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:17:13.841] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1592266632899044",
"created_by": "project:chromium",
"created_ts": "1592260385982200",
"failure_reason": "BUILD_FAILURE",
"id": "8877387689466482800",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b22e1927c7acb94a92a859f08ee0f544cbbefb3f\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"6 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed.\\n\\n**bf_cache_android_browsertests on Android device Nexus 5** failed.\\n\\n**bf_cache_content_shell_test_apk on Android device Nexus 5** failed.\\n\\n**bf_cache_content_unittests on Android device Nexus 5** failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed.\\n\\n**bf_cache_unit_tests on Android device Nexus 5** failed.\"}, \"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-150-b5rb\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 3359, \"got_angle_revision\": \"e95e2c3c48a45001f390aa942a52dd539fb7d207\", \"got_dawn_revision\": \"c3c2c9b6b09c5f7cdd6cebe77e29dbc2e16eaa4a\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"b22e1927c7acb94a92a859f08ee0f544cbbefb3f\", \"got_revision_cp\": \"refs/heads/master@{#778529}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"8cbee4107cf13e97cdbe30e98dfc0517de2b350f\", \"got_v8_revision\": \"85169498948711a5f024a1f44ef14afcd6fc329e\", \"got_v8_revision_cp\": \"refs/heads/8.5.162@{#1}\", \"got_webrtc_revision\": \"9465978a3b627655b2c99389dc35bcd343866ee1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31522}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.android.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b22e1927c7acb94a92a859f08ee0f544cbbefb3f\", \"swarm_hashes\": {\"android_browsertests\": \"2b3a315a80afbe1d2bc790e9bcdce1d89375cc0f\", \"chrome_public_test_apk\": \"a051ab43b0b1137c005bea94530ef5608d8a7478\", \"content_browsertests\": \"ef66d4f4f774bc92c1adcda457b9c8fa8e4fa351\", \"content_shell_test_apk\": \"660c89efb2c564346abdaaa499db6ed1d534ee77\", \"content_unittests\": \"86239a5b3c376c8c78aa5ce231238ec5b387bc52\", \"unit_tests\": \"ffe7a37013f1cc0369213d6d06a2f3bd0e290749\"}, \"swarm_hashes_refs/heads/master(at){#778529}_without_patch\": {\"android_browsertests\": \"2b3a315a80afbe1d2bc790e9bcdce1d89375cc0f\", \"chrome_public_test_apk\": \"a051ab43b0b1137c005bea94530ef5608d8a7478\", \"content_browsertests\": \"ef66d4f4f774bc92c1adcda457b9c8fa8e4fa351\", \"content_shell_test_apk\": \"660c89efb2c564346abdaaa499db6ed1d534ee77\", \"content_unittests\": \"86239a5b3c376c8c78aa5ce231238ec5b387bc52\", \"unit_tests\": \"ffe7a37013f1cc0369213d6d06a2f3bd0e290749\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_43669e6da0a1e0cd185803e862ec4a06b87e030633384f552dd7121826828522_v2\", \"builder_a2762fc34916ccddaf93df3ba974050968da64cd82521aaf473d97885fea8846_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_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-150-b5rb\"], \"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\": [\"5207-21acfae\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"6 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed.\\n\\n**bf_cache_android_browsertests on Android device Nexus 5** failed.\\n\\n**bf_cache_content_shell_test_apk on Android device Nexus 5** failed.\\n\\n**bf_cache_content_unittests on Android device Nexus 5** failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed.\\n\\n**bf_cache_unit_tests on Android device Nexus 5** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1592260474525965",
"status": "COMPLETED",
"status_changed_ts": "1592260475025736",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/3359",
"builder:android-bfcache-rel",
"buildset:commit/git/b22e1927c7acb94a92a859f08ee0f544cbbefb3f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b22e1927c7acb94a92a859f08ee0f544cbbefb3f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9042817751576554400",
"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/8877387689466482800/+/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:4cd2eefcaf706710",
"user_agent:luci-scheduler"
],
"updated_ts": "1592266633128599",
"url": "https://ci.chromium.org/b/8877387689466482800",
"utcnow_ts": "1592266633814082"
}
}
[00:17:13.841] Invocation finished in 1h44m9.254641451s with status FAILED