[18:50:21.228] New invocation is queued and will start shortly
[18:50:22.622] Starting the invocation (attempt 1)
[18:50:22.663] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:50:22.663] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:50:22.663] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9035493409848225264",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f443c012834d56e3f70a4ca6aff1fcb3184b2d77\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9035493409848225264",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/f443c012834d56e3f70a4ca6aff1fcb3184b2d77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f443c012834d56e3f70a4ca6aff1fcb3184b2d77",
"gitiles_ref:refs/heads/master"
]
}
[18:50:25.188] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1599245422983022",
"id": "8870063347308757456",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f443c012834d56e3f70a4ca6aff1fcb3184b2d77\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599245424697738",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4859",
"builder:android-bfcache-rel",
"buildset:commit/git/f443c012834d56e3f70a4ca6aff1fcb3184b2d77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f443c012834d56e3f70a4ca6aff1fcb3184b2d77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035493409848225264",
"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/8870063347308757456/+/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": "1599245424699637",
"url": "https://ci.chromium.org/b/8870063347308757456",
"utcnow_ts": "1599245425131513"
}
}
[18:50:25.188] Task URL: https://ci.chromium.org/b/8870063347308757456
[18:50:25.188] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:2:0) after 1m0s
[18:51:25.386] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:2:0)
[18:51:25.386] Timer tick, asking Buildbucket for the build status
[18:51:25.531] Build 8870063347308757456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:51:25.531] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:3:0) after 1m0s
[18:52:25.667] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:3:0)
[18:52:25.667] Timer tick, asking Buildbucket for the build status
[18:52:28.621] Build 8870063347308757456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:28.621] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:4:0) after 1m0s
[18:53:28.725] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:4:0)
[18:53:28.725] Timer tick, asking Buildbucket for the build status
[18:53:28.823] Build 8870063347308757456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:28.823] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:5:0) after 1m0s
[18:54:28.888] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:5:0)
[18:54:28.888] Timer tick, asking Buildbucket for the build status
[18:54:29.922] Build 8870063347308757456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:29.922] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:6:0) after 1m0s
[18:55:07.593] Received PubSub notification, asking Buildbucket for the build status
[18:55:07.872] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:29.968] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:6:0)
[18:55:29.968] Timer tick, asking Buildbucket for the build status
[18:55:30.682] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:30.682] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:8:0) after 1m0s
[18:56:30.706] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:8:0)
[18:56:30.706] Timer tick, asking Buildbucket for the build status
[18:56:30.820] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:30.821] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:9:0) after 1m0s
[18:57:30.839] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:9:0)
[18:57:30.839] Timer tick, asking Buildbucket for the build status
[18:57:31.148] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:31.148] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:10:0) after 1m0s
[18:58:31.191] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:10:0)
[18:58:31.191] Timer tick, asking Buildbucket for the build status
[18:58:31.317] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:31.317] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:11:0) after 1m0s
[18:59:31.345] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:11:0)
[18:59:31.345] Timer tick, asking Buildbucket for the build status
[18:59:32.040] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:32.040] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:12:0) after 1m0s
[19:00:32.142] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:12:0)
[19:00:32.142] Timer tick, asking Buildbucket for the build status
[19:00:32.266] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:32.266] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:13:0) after 1m0s
[19:01:32.297] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:13:0)
[19:01:32.297] Timer tick, asking Buildbucket for the build status
[19:01:32.402] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:32.402] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:14:0) after 1m0s
[19:02:32.503] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:14:0)
[19:02:32.503] Timer tick, asking Buildbucket for the build status
[19:02:32.600] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:32.600] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:15:0) after 1m0s
[19:03:32.657] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:15:0)
[19:03:32.657] Timer tick, asking Buildbucket for the build status
[19:03:32.789] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:32.789] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:16:0) after 1m0s
[19:04:32.782] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:16:0)
[19:04:32.782] Timer tick, asking Buildbucket for the build status
[19:04:32.853] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:32.853] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:17:0) after 1m0s
[19:05:32.953] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:17:0)
[19:05:32.953] Timer tick, asking Buildbucket for the build status
[19:05:33.168] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:33.168] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:18:0) after 1m0s
[19:06:33.306] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:18:0)
[19:06:33.306] Timer tick, asking Buildbucket for the build status
[19:06:33.426] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:33.426] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:19:0) after 1m0s
[19:07:33.504] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:19:0)
[19:07:33.504] Timer tick, asking Buildbucket for the build status
[19:07:33.622] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:33.622] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:20:0) after 1m0s
[19:08:33.675] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:20:0)
[19:08:33.675] Timer tick, asking Buildbucket for the build status
[19:08:34.266] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:34.266] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:21:0) after 1m0s
[19:09:34.359] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:21:0)
[19:09:34.359] Timer tick, asking Buildbucket for the build status
[19:09:34.430] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:34.430] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:22:0) after 1m0s
[19:10:34.463] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:22:0)
[19:10:34.463] Timer tick, asking Buildbucket for the build status
[19:10:34.859] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:34.859] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:23:0) after 1m0s
[19:11:35.015] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:23:0)
[19:11:35.015] Timer tick, asking Buildbucket for the build status
[19:11:35.251] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:35.251] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:24:0) after 1m0s
[19:12:35.276] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:24:0)
[19:12:35.276] Timer tick, asking Buildbucket for the build status
[19:12:35.344] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:35.344] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:25:0) after 1m0s
[19:13:35.740] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:25:0)
[19:13:35.740] Timer tick, asking Buildbucket for the build status
[19:13:35.814] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:35.814] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:26:0) after 1m0s
[19:14:35.838] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:26:0)
[19:14:35.838] Timer tick, asking Buildbucket for the build status
[19:14:36.084] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:36.084] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:27:0) after 1m0s
[19:15:36.195] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:27:0)
[19:15:36.195] Timer tick, asking Buildbucket for the build status
[19:15:36.413] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:36.413] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:28:0) after 1m0s
[19:16:36.446] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:28:0)
[19:16:36.446] Timer tick, asking Buildbucket for the build status
[19:16:36.533] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:36.533] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:29:0) after 1m0s
[19:17:36.694] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:29:0)
[19:17:36.694] Timer tick, asking Buildbucket for the build status
[19:17:36.777] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:36.777] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:30:0) after 1m0s
[19:18:36.883] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:30:0)
[19:18:36.883] Timer tick, asking Buildbucket for the build status
[19:18:36.957] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:36.957] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:31:0) after 1m0s
[19:19:37.326] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:31:0)
[19:19:37.326] Timer tick, asking Buildbucket for the build status
[19:19:37.432] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:37.432] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:32:0) after 1m0s
[19:20:37.645] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:32:0)
[19:20:37.645] Timer tick, asking Buildbucket for the build status
[19:20:37.774] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:37.774] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:33:0) after 1m0s
[19:21:37.884] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:33:0)
[19:21:37.884] Timer tick, asking Buildbucket for the build status
[19:21:38.165] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:38.165] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:34:0) after 1m0s
[19:22:38.147] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:34:0)
[19:22:38.147] Timer tick, asking Buildbucket for the build status
[19:22:38.301] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:38.301] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:35:0) after 1m0s
[19:23:38.414] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:35:0)
[19:23:38.414] Timer tick, asking Buildbucket for the build status
[19:23:38.553] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:38.553] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:36:0) after 1m0s
[19:24:38.727] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:36:0)
[19:24:38.727] Timer tick, asking Buildbucket for the build status
[19:24:38.844] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:38.844] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:37:0) after 1m0s
[19:25:38.984] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:37:0)
[19:25:38.984] Timer tick, asking Buildbucket for the build status
[19:25:39.262] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:39.262] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:38:0) after 1m0s
[19:26:39.373] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:38:0)
[19:26:39.373] Timer tick, asking Buildbucket for the build status
[19:26:39.632] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:39.632] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:39:0) after 1m0s
[19:27:39.659] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:39:0)
[19:27:39.659] Timer tick, asking Buildbucket for the build status
[19:27:39.776] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:39.776] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:40:0) after 1m0s
[19:28:42.719] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:40:0)
[19:28:42.719] Timer tick, asking Buildbucket for the build status
[19:28:42.788] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:42.789] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:41:0) after 1m0s
[19:29:42.852] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:41:0)
[19:29:42.852] Timer tick, asking Buildbucket for the build status
[19:29:42.922] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:42.922] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:42:0) after 1m0s
[19:30:43.086] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:42:0)
[19:30:43.086] Timer tick, asking Buildbucket for the build status
[19:30:43.390] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:43.390] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:43:0) after 1m0s
[19:31:43.530] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:43:0)
[19:31:43.530] Timer tick, asking Buildbucket for the build status
[19:31:43.624] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:43.624] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:44:0) after 1m0s
[19:32:43.709] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:44:0)
[19:32:43.709] Timer tick, asking Buildbucket for the build status
[19:32:44.055] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:44.055] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:45:0) after 1m0s
[19:33:44.314] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:45:0)
[19:33:44.314] Timer tick, asking Buildbucket for the build status
[19:33:44.441] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:44.441] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:46:0) after 1m0s
[19:34:44.628] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:46:0)
[19:34:44.628] Timer tick, asking Buildbucket for the build status
[19:34:44.724] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:44.724] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:47:0) after 1m0s
[19:35:44.756] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:47:0)
[19:35:44.756] Timer tick, asking Buildbucket for the build status
[19:35:44.864] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:44.864] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:48:0) after 1m0s
[19:36:44.890] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:48:0)
[19:36:44.890] Timer tick, asking Buildbucket for the build status
[19:36:45.052] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:45.052] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:49:0) after 1m0s
[19:37:45.140] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:49:0)
[19:37:45.140] Timer tick, asking Buildbucket for the build status
[19:37:45.395] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:45.395] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:50:0) after 1m0s
[19:38:45.548] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:50:0)
[19:38:45.548] Timer tick, asking Buildbucket for the build status
[19:38:45.788] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:45.788] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:51:0) after 1m0s
[19:39:46.104] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:51:0)
[19:39:46.104] Timer tick, asking Buildbucket for the build status
[19:39:46.169] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:46.169] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:52:0) after 1m0s
[19:40:46.270] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:52:0)
[19:40:46.270] Timer tick, asking Buildbucket for the build status
[19:40:46.716] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:46.716] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:53:0) after 1m0s
[19:41:46.770] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:53:0)
[19:41:46.770] Timer tick, asking Buildbucket for the build status
[19:41:47.076] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:47.076] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:54:0) after 1m0s
[19:42:47.133] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:54:0)
[19:42:47.133] Timer tick, asking Buildbucket for the build status
[19:42:47.219] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:47.219] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:55:0) after 1m0s
[19:43:47.231] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:55:0)
[19:43:47.231] Timer tick, asking Buildbucket for the build status
[19:43:47.332] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:47.332] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:56:0) after 1m0s
[19:44:47.555] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:56:0)
[19:44:47.555] Timer tick, asking Buildbucket for the build status
[19:44:47.728] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:47.728] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:57:0) after 1m0s
[19:45:47.844] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:57:0)
[19:45:47.844] Timer tick, asking Buildbucket for the build status
[19:45:47.973] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:47.973] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:58:0) after 1m0s
[19:46:48.076] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:58:0)
[19:46:48.076] Timer tick, asking Buildbucket for the build status
[19:46:48.147] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:48.147] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:59:0) after 1m0s
[19:47:48.306] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:59:0)
[19:47:48.306] Timer tick, asking Buildbucket for the build status
[19:47:48.408] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:48.408] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:60:0) after 1m0s
[19:48:48.556] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:60:0)
[19:48:48.556] Timer tick, asking Buildbucket for the build status
[19:48:48.720] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:48.721] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:61:0) after 1m0s
[19:49:48.822] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:61:0)
[19:49:48.822] Timer tick, asking Buildbucket for the build status
[19:49:48.907] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:48.907] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:62:0) after 1m0s
[19:50:48.930] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:62:0)
[19:50:48.930] Timer tick, asking Buildbucket for the build status
[19:50:49.105] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:49.105] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:63:0) after 1m0s
[19:51:49.188] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:63:0)
[19:51:49.189] Timer tick, asking Buildbucket for the build status
[19:51:49.387] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:49.387] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:64:0) after 1m0s
[19:52:49.421] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:64:0)
[19:52:49.421] Timer tick, asking Buildbucket for the build status
[19:52:49.561] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:49.561] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:65:0) after 1m0s
[19:53:49.621] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:65:0)
[19:53:49.621] Timer tick, asking Buildbucket for the build status
[19:53:50.004] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:50.004] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:66:0) after 1m0s
[19:54:50.047] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:66:0)
[19:54:50.047] Timer tick, asking Buildbucket for the build status
[19:54:50.124] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:50.124] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:67:0) after 1m0s
[19:55:50.155] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:67:0)
[19:55:50.155] Timer tick, asking Buildbucket for the build status
[19:55:50.515] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:50.515] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:68:0) after 1m0s
[19:56:50.818] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:68:0)
[19:56:50.818] Timer tick, asking Buildbucket for the build status
[19:56:51.153] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:51.154] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:69:0) after 1m0s
[19:57:51.274] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:69:0)
[19:57:51.274] Timer tick, asking Buildbucket for the build status
[19:57:51.500] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:51.500] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:70:0) after 1m0s
[19:58:51.622] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:70:0)
[19:58:51.622] Timer tick, asking Buildbucket for the build status
[19:58:51.680] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:51.680] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:71:0) after 1m0s
[19:59:51.768] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:71:0)
[19:59:51.768] Timer tick, asking Buildbucket for the build status
[19:59:51.994] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:51.994] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:72:0) after 1m0s
[20:00:52.337] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:72:0)
[20:00:52.337] Timer tick, asking Buildbucket for the build status
[20:00:52.497] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:52.497] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:73:0) after 1m0s
[20:01:52.855] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:73:0)
[20:01:52.856] Timer tick, asking Buildbucket for the build status
[20:01:52.953] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:52.953] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:74:0) after 1m0s
[20:02:53.257] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:74:0)
[20:02:53.257] Timer tick, asking Buildbucket for the build status
[20:02:53.355] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:53.355] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:75:0) after 1m0s
[20:03:53.587] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:75:0)
[20:03:53.587] Timer tick, asking Buildbucket for the build status
[20:03:53.656] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:53.656] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:76:0) after 1m0s
[20:04:54.038] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:76:0)
[20:04:54.038] Timer tick, asking Buildbucket for the build status
[20:04:54.254] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:54.256] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:77:0) after 1m0s
[20:05:54.842] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:77:0)
[20:05:54.842] Timer tick, asking Buildbucket for the build status
[20:05:55.027] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:55.027] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:78:0) after 1m0s
[20:06:55.174] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:78:0)
[20:06:55.174] Timer tick, asking Buildbucket for the build status
[20:06:55.303] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:55.303] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:79:0) after 1m0s
[20:07:55.430] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:79:0)
[20:07:55.430] Timer tick, asking Buildbucket for the build status
[20:07:55.508] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:55.508] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:80:0) after 1m0s
[20:08:55.651] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:80:0)
[20:08:55.651] Timer tick, asking Buildbucket for the build status
[20:08:55.933] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:55.933] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:81:0) after 1m0s
[20:09:56.344] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:81:0)
[20:09:56.344] Timer tick, asking Buildbucket for the build status
[20:09:56.781] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:56.781] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:82:0) after 1m0s
[20:10:57.005] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:82:0)
[20:10:57.005] Timer tick, asking Buildbucket for the build status
[20:10:57.286] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:57.286] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:83:0) after 1m0s
[20:11:57.263] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:83:0)
[20:11:57.263] Timer tick, asking Buildbucket for the build status
[20:11:57.331] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:57.331] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:84:0) after 1m0s
[20:12:57.456] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:84:0)
[20:12:57.456] Timer tick, asking Buildbucket for the build status
[20:12:57.629] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:57.629] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:85:0) after 1m0s
[20:13:57.654] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:85:0)
[20:13:57.654] Timer tick, asking Buildbucket for the build status
[20:13:57.813] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:57.813] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:86:0) after 1m0s
[20:14:57.988] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:86:0)
[20:14:57.988] Timer tick, asking Buildbucket for the build status
[20:14:58.412] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:58.412] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:87:0) after 1m0s
[20:15:58.453] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:87:0)
[20:15:58.453] Timer tick, asking Buildbucket for the build status
[20:15:58.583] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:58.583] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:88:0) after 1m0s
[20:16:58.643] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:88:0)
[20:16:58.643] Timer tick, asking Buildbucket for the build status
[20:16:59.047] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:59.047] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:89:0) after 1m0s
[20:17:59.759] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:89:0)
[20:17:59.759] Timer tick, asking Buildbucket for the build status
[20:18:00.234] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:00.234] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:90:0) after 1m0s
[20:19:01.458] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:90:0)
[20:19:01.458] Timer tick, asking Buildbucket for the build status
[20:19:01.608] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:01.608] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:91:0) after 1m0s
[20:20:01.641] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:91:0)
[20:20:01.641] Timer tick, asking Buildbucket for the build status
[20:20:01.806] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:01.806] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:92:0) after 1m0s
[20:21:02.056] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:92:0)
[20:21:02.056] Timer tick, asking Buildbucket for the build status
[20:21:02.338] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:02.338] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:93:0) after 1m0s
[20:22:02.431] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:93:0)
[20:22:02.431] Timer tick, asking Buildbucket for the build status
[20:22:02.939] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:02.939] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:94:0) after 1m0s
[20:23:02.972] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:94:0)
[20:23:02.972] Timer tick, asking Buildbucket for the build status
[20:23:03.147] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:03.147] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:95:0) after 1m0s
[20:24:03.245] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:95:0)
[20:24:03.245] Timer tick, asking Buildbucket for the build status
[20:24:03.376] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:03.376] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:96:0) after 1m0s
[20:25:03.458] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:96:0)
[20:25:03.458] Timer tick, asking Buildbucket for the build status
[20:25:03.889] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:03.889] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:97:0) after 1m0s
[20:26:03.911] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:97:0)
[20:26:03.911] Timer tick, asking Buildbucket for the build status
[20:26:05.282] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:05.282] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:98:0) after 1m0s
[20:27:05.432] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:98:0)
[20:27:05.432] Timer tick, asking Buildbucket for the build status
[20:27:05.532] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:05.532] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:99:0) after 1m0s
[20:28:05.588] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:99:0)
[20:28:05.588] Timer tick, asking Buildbucket for the build status
[20:28:05.664] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:05.664] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:100:0) after 1m0s
[20:29:05.667] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:100:0)
[20:29:05.667] Timer tick, asking Buildbucket for the build status
[20:29:05.824] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:05.824] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:101:0) after 1m0s
[20:30:05.853] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:101:0)
[20:30:05.853] Timer tick, asking Buildbucket for the build status
[20:30:06.109] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:06.109] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:102:0) after 1m0s
[20:31:06.198] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:102:0)
[20:31:06.198] Timer tick, asking Buildbucket for the build status
[20:31:06.524] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:06.525] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:103:0) after 1m0s
[20:32:07.017] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:103:0)
[20:32:07.018] Timer tick, asking Buildbucket for the build status
[20:32:07.249] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:07.249] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:104:0) after 1m0s
[20:33:07.307] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:104:0)
[20:33:07.307] Timer tick, asking Buildbucket for the build status
[20:33:07.495] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:07.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:105:0) after 1m0s
[20:34:07.603] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:105:0)
[20:34:07.603] Timer tick, asking Buildbucket for the build status
[20:34:07.757] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:07.757] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:106:0) after 1m0s
[20:35:07.931] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:106:0)
[20:35:07.931] Timer tick, asking Buildbucket for the build status
[20:35:08.145] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:08.145] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:107:0) after 1m0s
[20:36:08.476] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:107:0)
[20:36:08.476] Timer tick, asking Buildbucket for the build status
[20:36:08.669] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:08.669] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:108:0) after 1m0s
[20:37:08.866] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:108:0)
[20:37:08.866] Timer tick, asking Buildbucket for the build status
[20:37:08.982] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:08.982] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:109:0) after 1m0s
[20:38:09.056] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:109:0)
[20:38:09.056] Timer tick, asking Buildbucket for the build status
[20:38:09.336] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:09.336] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:110:0) after 1m0s
[20:39:09.366] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:110:0)
[20:39:09.366] Timer tick, asking Buildbucket for the build status
[20:39:09.510] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:09.511] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:111:0) after 1m0s
[20:40:09.661] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:111:0)
[20:40:09.661] Timer tick, asking Buildbucket for the build status
[20:40:09.796] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:09.796] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:112:0) after 1m0s
[20:41:09.977] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:112:0)
[20:41:09.977] Timer tick, asking Buildbucket for the build status
[20:41:10.414] Build 8870063347308757456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:10.415] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035493409848225264:113:0) after 1m0s
[20:41:33.452] Received PubSub notification, asking Buildbucket for the build status
[20:41:33.590] Build 8870063347308757456: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:41:33.590] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1599252092746526",
"created_by": "project:chromium",
"created_ts": "1599245422983022",
"failure_reason": "BUILD_FAILURE",
"id": "8870063347308757456",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f443c012834d56e3f70a4ca6aff1fcb3184b2d77\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_content_shell_test_apk on Android device Nexus 5** failed.\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"f443c012834d56e3f70a4ca6aff1fcb3184b2d77\", \"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-160-8s9n\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 4859, \"got_angle_revision\": \"f005191db5baf138e50b80d46bac7bf90fe27a11\", \"got_dawn_revision\": \"62442aceb0fb8af0c1edd07b5f18b4ec181b8fbf\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"f443c012834d56e3f70a4ca6aff1fcb3184b2d77\", \"got_revision_cp\": \"refs/heads/master@{#804572}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"e63aa953ddfd935a022090b3ef221438a328d1a1\", \"got_v8_revision\": \"5966c3d2c86b03e150e629f78184a192d72b4b99\", \"got_v8_revision_cp\": \"refs/heads/8.7.72@{#1}\", \"got_webrtc_revision\": \"d46db9f1523ae45909b4a6fdc90a140443068bc6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32036}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f443c012834d56e3f70a4ca6aff1fcb3184b2d77\", \"swarm_hashes\": {\"android_browsertests\": \"eceeaa3d41ef619afab998ddceef91c18493a697\", \"chrome_public_test_apk\": \"115e303413afae1f382280b2b54f4e0def5acf67\", \"content_browsertests\": \"2e7fdb29e188531557b54f8ce75335eda430ccff\", \"content_shell_test_apk\": \"9ef1a77a50b93583c987de87e8454495357dd20f\", \"content_unittests\": \"b60e003555e5bfddba1a4f7fcca4f50db50fd305\", \"unit_tests\": \"5c09037bfa9984625aad559eba5bd7d39fd2f683\"}, \"swarm_hashes_refs/heads/master(at){#804572}_without_patch\": {\"android_browsertests\": \"eceeaa3d41ef619afab998ddceef91c18493a697\", \"chrome_public_test_apk\": \"115e303413afae1f382280b2b54f4e0def5acf67\", \"content_browsertests\": \"2e7fdb29e188531557b54f8ce75335eda430ccff\", \"content_shell_test_apk\": \"9ef1a77a50b93583c987de87e8454495357dd20f\", \"content_unittests\": \"b60e003555e5bfddba1a4f7fcca4f50db50fd305\", \"unit_tests\": \"5c09037bfa9984625aad559eba5bd7d39fd2f683\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_20aad707bde81044119dd77cf5c9d90dd36ea4d1587e350d19bd0c1a6099dab7_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_7701d7ffc8ab5fe38a709c77d4f18478e80f1a1d01dd8053f239f119334d81d1_v2\", \"builder_c2e18f250454808c3325933ba97ff5750a1e0f151767b7488b92f902efd64419_v2\", \"builder_c38832248eaa59248ebe0e5d5ae62a6bc955f53f6a99a9c0e5cded93d679f9bc_v2\", \"builder_f5610824250c57fc28679fbc8606252c3dbaca731fb7f2a4bebf1e0fc7f48a3a_v2\", \"builder_fb6ecb76f10f395b8e0ed02e3b32c76529bc11151897411e1cd7b938357df296_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-160-8s9n\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"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\": [\"5507-6e8d655\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_content_shell_test_apk on Android device Nexus 5** failed.\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599245706091662",
"status": "COMPLETED",
"status_changed_ts": "1599245706731087",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4859",
"builder:android-bfcache-rel",
"buildset:commit/git/f443c012834d56e3f70a4ca6aff1fcb3184b2d77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f443c012834d56e3f70a4ca6aff1fcb3184b2d77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035493409848225264",
"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/8870063347308757456/+/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:4e7346229a4ae610",
"user_agent:luci-scheduler"
],
"updated_ts": "1599252093021676",
"url": "https://ci.chromium.org/b/8870063347308757456",
"utcnow_ts": "1599252093569569"
}
}
[20:41:33.590] Invocation finished in 1h51m12.41349423s with status FAILED