[20:10:47.606] New invocation is queued and will start shortly
[20:10:48.720] Starting the invocation (attempt 1)
[20:10:48.758] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:10:48.758] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:10:48.759] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9035578945958619616",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dc93664835ca758491be33480d84d536cb5055cc\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9035578945958619616",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/dc93664835ca758491be33480d84d536cb5055cc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc93664835ca758491be33480d84d536cb5055cc",
"gitiles_ref:refs/heads/master"
]
}
[20:10:50.131] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1599163848882297",
"id": "8870148883952559952",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc93664835ca758491be33480d84d536cb5055cc\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599163849728708",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4838",
"builder:android-bfcache-rel",
"buildset:commit/git/dc93664835ca758491be33480d84d536cb5055cc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc93664835ca758491be33480d84d536cb5055cc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035578945958619616",
"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/8870148883952559952/+/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": "1599163849728892",
"url": "https://ci.chromium.org/b/8870148883952559952",
"utcnow_ts": "1599163850121633"
}
}
[20:10:50.131] Task URL: https://ci.chromium.org/b/8870148883952559952
[20:10:50.131] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:2:0) after 1m0s
[20:11:50.316] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:2:0)
[20:11:50.316] Timer tick, asking Buildbucket for the build status
[20:11:50.846] Build 8870148883952559952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:50.846] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:3:0) after 1m0s
[20:12:51.116] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:3:0)
[20:12:51.116] Timer tick, asking Buildbucket for the build status
[20:12:51.396] Build 8870148883952559952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:51.396] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:4:0) after 1m0s
[20:13:51.439] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:4:0)
[20:13:51.439] Timer tick, asking Buildbucket for the build status
[20:13:51.738] Build 8870148883952559952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:51.738] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:5:0) after 1m0s
[20:14:51.747] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:5:0)
[20:14:51.747] Timer tick, asking Buildbucket for the build status
[20:14:51.887] Build 8870148883952559952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:51.887] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:6:0) after 1m0s
[20:15:51.904] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:6:0)
[20:15:51.904] Timer tick, asking Buildbucket for the build status
[20:15:52.290] Build 8870148883952559952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:52.290] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:7:0) after 1m0s
[20:16:52.278] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:7:0)
[20:16:52.278] Timer tick, asking Buildbucket for the build status
[20:16:52.411] Build 8870148883952559952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:52.411] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:8:0) after 1m0s
[20:17:52.463] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:8:0)
[20:17:52.463] Timer tick, asking Buildbucket for the build status
[20:17:52.569] Build 8870148883952559952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:52.569] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:9:0) after 1m0s
[20:18:52.615] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:9:0)
[20:18:52.616] Timer tick, asking Buildbucket for the build status
[20:18:52.727] Build 8870148883952559952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:18:52.727] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:10:0) after 1m0s
[20:19:52.730] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:10:0)
[20:19:52.730] Timer tick, asking Buildbucket for the build status
[20:19:52.854] Build 8870148883952559952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:19:52.854] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:11:0) after 1m0s
[20:20:18.496] Received PubSub notification, asking Buildbucket for the build status
[20:20:18.616] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:52.863] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:11:0)
[20:20:52.863] Timer tick, asking Buildbucket for the build status
[20:20:52.966] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:52.966] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:13:0) after 1m0s
[20:21:53.015] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:13:0)
[20:21:53.015] Timer tick, asking Buildbucket for the build status
[20:21:53.092] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:53.092] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:14:0) after 1m0s
[20:22:53.154] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:14:0)
[20:22:53.154] Timer tick, asking Buildbucket for the build status
[20:22:53.287] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:53.287] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:15:0) after 1m0s
[20:23:54.293] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:15:0)
[20:23:54.294] Timer tick, asking Buildbucket for the build status
[20:23:54.490] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:54.490] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:16:0) after 1m0s
[20:24:54.639] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:16:0)
[20:24:54.639] Timer tick, asking Buildbucket for the build status
[20:24:54.963] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:54.963] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:17:0) after 1m0s
[20:25:55.100] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:17:0)
[20:25:55.103] Timer tick, asking Buildbucket for the build status
[20:25:55.274] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:55.274] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:18:0) after 1m0s
[20:26:55.398] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:18:0)
[20:26:55.398] Timer tick, asking Buildbucket for the build status
[20:26:55.792] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:55.792] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:19:0) after 1m0s
[20:27:55.876] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:19:0)
[20:27:55.876] Timer tick, asking Buildbucket for the build status
[20:27:55.945] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:55.945] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:20:0) after 1m0s
[20:28:56.059] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:20:0)
[20:28:56.059] Timer tick, asking Buildbucket for the build status
[20:28:56.279] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:56.279] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:21:0) after 1m0s
[20:29:56.466] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:21:0)
[20:29:56.466] Timer tick, asking Buildbucket for the build status
[20:29:56.759] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:56.759] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:22:0) after 1m0s
[20:30:56.782] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:22:0)
[20:30:56.782] Timer tick, asking Buildbucket for the build status
[20:30:56.996] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:56.996] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:23:0) after 1m0s
[20:31:57.088] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:23:0)
[20:31:57.088] Timer tick, asking Buildbucket for the build status
[20:31:57.397] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:57.397] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:24:0) after 1m0s
[20:32:57.522] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:24:0)
[20:32:57.522] Timer tick, asking Buildbucket for the build status
[20:32:57.597] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:57.597] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:25:0) after 1m0s
[20:33:57.610] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:25:0)
[20:33:57.610] Timer tick, asking Buildbucket for the build status
[20:33:57.901] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:57.901] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:26:0) after 1m0s
[20:34:57.981] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:26:0)
[20:34:57.981] Timer tick, asking Buildbucket for the build status
[20:34:58.046] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:58.046] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:27:0) after 1m0s
[20:35:58.182] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:27:0)
[20:35:58.182] Timer tick, asking Buildbucket for the build status
[20:35:58.406] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:58.406] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:28:0) after 1m0s
[20:36:58.567] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:28:0)
[20:36:58.567] Timer tick, asking Buildbucket for the build status
[20:36:58.774] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:58.774] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:29:0) after 1m0s
[20:37:58.835] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:29:0)
[20:37:58.835] Timer tick, asking Buildbucket for the build status
[20:37:58.946] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:58.946] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:30:0) after 1m0s
[20:38:58.985] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:30:0)
[20:38:58.985] Timer tick, asking Buildbucket for the build status
[20:38:59.083] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:59.083] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:31:0) after 1m0s
[20:39:59.109] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:31:0)
[20:39:59.109] Timer tick, asking Buildbucket for the build status
[20:39:59.336] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:59.336] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:32:0) after 1m0s
[20:40:59.462] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:32:0)
[20:40:59.462] Timer tick, asking Buildbucket for the build status
[20:40:59.843] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:59.843] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:33:0) after 1m0s
[20:41:59.857] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:33:0)
[20:41:59.857] Timer tick, asking Buildbucket for the build status
[20:42:00.166] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:00.166] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:34:0) after 1m0s
[20:43:00.328] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:34:0)
[20:43:00.328] Timer tick, asking Buildbucket for the build status
[20:43:00.440] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:00.440] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:35:0) after 1m0s
[20:44:02.156] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:35:0)
[20:44:02.164] Timer tick, asking Buildbucket for the build status
[20:44:02.303] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:02.303] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:36:0) after 1m0s
[20:45:02.342] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:36:0)
[20:45:02.342] Timer tick, asking Buildbucket for the build status
[20:45:02.523] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:02.523] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:37:0) after 1m0s
[20:46:02.561] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:37:0)
[20:46:02.561] Timer tick, asking Buildbucket for the build status
[20:46:02.978] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:02.978] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:38:0) after 1m0s
[20:47:03.000] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:38:0)
[20:47:03.000] Timer tick, asking Buildbucket for the build status
[20:47:04.024] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:04.024] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:39:0) after 1m0s
[20:48:04.135] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:39:0)
[20:48:04.135] Timer tick, asking Buildbucket for the build status
[20:48:04.263] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:04.263] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:40:0) after 1m0s
[20:49:05.231] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:40:0)
[20:49:05.231] Timer tick, asking Buildbucket for the build status
[20:49:05.642] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:05.642] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:41:0) after 1m0s
[20:50:05.666] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:41:0)
[20:50:05.666] Timer tick, asking Buildbucket for the build status
[20:50:06.097] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:06.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:42:0) after 1m0s
[20:51:06.142] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:42:0)
[20:51:06.142] Timer tick, asking Buildbucket for the build status
[20:51:06.278] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:06.278] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:43:0) after 1m0s
[20:52:06.379] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:43:0)
[20:52:06.379] Timer tick, asking Buildbucket for the build status
[20:52:06.499] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:06.500] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:44:0) after 1m0s
[20:53:06.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:44:0)
[20:53:06.525] Timer tick, asking Buildbucket for the build status
[20:53:06.609] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:06.609] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:45:0) after 1m0s
[20:54:06.772] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:45:0)
[20:54:06.772] Timer tick, asking Buildbucket for the build status
[20:54:06.880] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:06.880] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:46:0) after 1m0s
[20:55:06.983] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:46:0)
[20:55:06.983] Timer tick, asking Buildbucket for the build status
[20:55:07.271] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:07.271] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:47:0) after 1m0s
[20:56:07.779] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:47:0)
[20:56:07.779] Timer tick, asking Buildbucket for the build status
[20:56:08.096] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:08.096] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:48:0) after 1m0s
[20:57:08.128] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:48:0)
[20:57:08.128] Timer tick, asking Buildbucket for the build status
[20:57:08.225] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:08.225] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:49:0) after 1m0s
[20:58:08.293] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:49:0)
[20:58:08.293] Timer tick, asking Buildbucket for the build status
[20:58:08.511] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:08.511] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:50:0) after 1m0s
[20:59:08.610] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:50:0)
[20:59:08.610] Timer tick, asking Buildbucket for the build status
[20:59:08.878] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:08.878] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:51:0) after 1m0s
[21:00:08.942] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:51:0)
[21:00:08.942] Timer tick, asking Buildbucket for the build status
[21:00:09.155] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:09.155] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:52:0) after 1m0s
[21:01:09.492] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:52:0)
[21:01:09.492] Timer tick, asking Buildbucket for the build status
[21:01:09.679] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:09.679] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:53:0) after 1m0s
[21:02:09.961] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:53:0)
[21:02:09.961] Timer tick, asking Buildbucket for the build status
[21:02:10.101] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:10.101] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:54:0) after 1m0s
[21:03:10.306] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:54:0)
[21:03:10.306] Timer tick, asking Buildbucket for the build status
[21:03:10.403] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:10.403] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:55:0) after 1m0s
[21:04:10.535] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:55:0)
[21:04:10.535] Timer tick, asking Buildbucket for the build status
[21:04:10.803] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:10.805] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:56:0) after 1m0s
[21:05:11.203] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:56:0)
[21:05:11.203] Timer tick, asking Buildbucket for the build status
[21:05:11.503] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:11.503] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:57:0) after 1m0s
[21:06:11.614] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:57:0)
[21:06:11.614] Timer tick, asking Buildbucket for the build status
[21:06:11.778] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:11.778] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:58:0) after 1m0s
[21:07:11.818] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:58:0)
[21:07:11.818] Timer tick, asking Buildbucket for the build status
[21:07:11.925] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:11.925] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:59:0) after 1m0s
[21:08:12.031] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:59:0)
[21:08:12.031] Timer tick, asking Buildbucket for the build status
[21:08:12.114] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:12.114] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:60:0) after 1m0s
[21:09:12.210] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:60:0)
[21:09:12.210] Timer tick, asking Buildbucket for the build status
[21:09:12.290] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:12.291] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:61:0) after 1m0s
[21:10:12.307] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:61:0)
[21:10:12.307] Timer tick, asking Buildbucket for the build status
[21:10:12.414] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:12.414] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:62:0) after 1m0s
[21:11:12.448] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:62:0)
[21:11:12.448] Timer tick, asking Buildbucket for the build status
[21:11:12.556] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:12.556] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:63:0) after 1m0s
[21:12:12.549] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:63:0)
[21:12:12.549] Timer tick, asking Buildbucket for the build status
[21:12:12.753] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:12.753] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:64:0) after 1m0s
[21:13:12.812] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:64:0)
[21:13:12.812] Timer tick, asking Buildbucket for the build status
[21:13:13.055] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:13.055] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:65:0) after 1m0s
[21:14:13.118] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:65:0)
[21:14:13.118] Timer tick, asking Buildbucket for the build status
[21:14:13.422] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:13.422] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:66:0) after 1m0s
[21:15:13.470] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:66:0)
[21:15:13.470] Timer tick, asking Buildbucket for the build status
[21:15:13.546] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:13.546] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:67:0) after 1m0s
[21:16:13.622] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:67:0)
[21:16:13.622] Timer tick, asking Buildbucket for the build status
[21:16:13.761] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:13.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:68:0) after 1m0s
[21:17:13.851] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:68:0)
[21:17:13.851] Timer tick, asking Buildbucket for the build status
[21:17:13.928] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:13.928] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:69:0) after 1m0s
[21:18:14.458] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:69:0)
[21:18:14.458] Timer tick, asking Buildbucket for the build status
[21:18:14.592] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:14.592] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:70:0) after 1m0s
[21:19:14.699] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:70:0)
[21:19:14.699] Timer tick, asking Buildbucket for the build status
[21:19:14.825] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:14.825] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:71:0) after 1m0s
[21:20:14.892] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:71:0)
[21:20:14.892] Timer tick, asking Buildbucket for the build status
[21:20:14.986] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:14.986] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:72:0) after 1m0s
[21:21:15.062] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:72:0)
[21:21:15.062] Timer tick, asking Buildbucket for the build status
[21:21:15.210] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:15.210] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:73:0) after 1m0s
[21:22:15.323] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:73:0)
[21:22:15.323] Timer tick, asking Buildbucket for the build status
[21:22:15.412] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:15.412] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:74:0) after 1m0s
[21:23:15.527] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:74:0)
[21:23:15.527] Timer tick, asking Buildbucket for the build status
[21:23:15.693] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:15.693] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:75:0) after 1m0s
[21:24:15.954] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:75:0)
[21:24:15.954] Timer tick, asking Buildbucket for the build status
[21:24:16.073] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:16.073] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:76:0) after 1m0s
[21:25:16.752] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:76:0)
[21:25:16.752] Timer tick, asking Buildbucket for the build status
[21:25:17.161] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:17.161] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:77:0) after 1m0s
[21:26:17.201] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:77:0)
[21:26:17.201] Timer tick, asking Buildbucket for the build status
[21:26:17.322] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:17.322] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:78:0) after 1m0s
[21:27:17.303] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:78:0)
[21:27:17.303] Timer tick, asking Buildbucket for the build status
[21:27:17.523] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:17.523] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:79:0) after 1m0s
[21:28:17.546] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:79:0)
[21:28:17.546] Timer tick, asking Buildbucket for the build status
[21:28:17.640] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:17.640] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:80:0) after 1m0s
[21:29:17.635] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:80:0)
[21:29:17.635] Timer tick, asking Buildbucket for the build status
[21:29:17.728] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:17.728] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:81:0) after 1m0s
[21:30:17.755] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:81:0)
[21:30:17.755] Timer tick, asking Buildbucket for the build status
[21:30:17.927] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:17.927] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:82:0) after 1m0s
[21:31:18.285] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:82:0)
[21:31:18.285] Timer tick, asking Buildbucket for the build status
[21:31:18.631] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:18.631] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:83:0) after 1m0s
[21:32:18.749] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:83:0)
[21:32:18.749] Timer tick, asking Buildbucket for the build status
[21:32:18.814] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:18.814] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:84:0) after 1m0s
[21:33:19.429] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:84:0)
[21:33:19.429] Timer tick, asking Buildbucket for the build status
[21:33:19.664] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:19.665] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:85:0) after 1m0s
[21:34:19.858] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:85:0)
[21:34:19.858] Timer tick, asking Buildbucket for the build status
[21:34:20.127] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:20.127] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:86:0) after 1m0s
[21:35:20.177] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:86:0)
[21:35:20.177] Timer tick, asking Buildbucket for the build status
[21:35:20.504] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:20.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:87:0) after 1m0s
[21:36:20.511] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:87:0)
[21:36:20.511] Timer tick, asking Buildbucket for the build status
[21:36:21.636] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:21.636] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:88:0) after 1m0s
[21:37:21.991] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:88:0)
[21:37:21.991] Timer tick, asking Buildbucket for the build status
[21:37:22.133] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:22.133] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:89:0) after 1m0s
[21:38:22.183] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:89:0)
[21:38:22.183] Timer tick, asking Buildbucket for the build status
[21:38:22.491] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:22.491] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:90:0) after 1m0s
[21:39:25.564] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:90:0)
[21:39:25.564] Timer tick, asking Buildbucket for the build status
[21:39:25.815] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:25.815] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:91:0) after 1m0s
[21:40:25.945] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:91:0)
[21:40:25.945] Timer tick, asking Buildbucket for the build status
[21:40:26.143] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:26.143] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:92:0) after 1m0s
[21:41:26.388] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:92:0)
[21:41:26.388] Timer tick, asking Buildbucket for the build status
[21:41:26.627] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:26.627] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:93:0) after 1m0s
[21:42:26.738] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:93:0)
[21:42:26.738] Timer tick, asking Buildbucket for the build status
[21:42:26.864] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:26.864] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:94:0) after 1m0s
[21:43:27.078] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:94:0)
[21:43:27.078] Timer tick, asking Buildbucket for the build status
[21:43:27.252] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:27.252] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:95:0) after 1m0s
[21:44:27.367] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:95:0)
[21:44:27.367] Timer tick, asking Buildbucket for the build status
[21:44:27.643] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:27.643] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:96:0) after 1m0s
[21:45:27.742] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:96:0)
[21:45:27.742] Timer tick, asking Buildbucket for the build status
[21:45:27.919] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:27.919] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:97:0) after 1m0s
[21:46:28.065] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:97:0)
[21:46:28.065] Timer tick, asking Buildbucket for the build status
[21:46:28.288] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:28.288] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:98:0) after 1m0s
[21:47:28.597] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:98:0)
[21:47:28.598] Timer tick, asking Buildbucket for the build status
[21:47:28.827] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:28.827] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:99:0) after 1m0s
[21:48:28.873] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:99:0)
[21:48:28.873] Timer tick, asking Buildbucket for the build status
[21:48:28.947] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:28.947] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:100:0) after 1m0s
[21:49:29.180] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:100:0)
[21:49:29.180] Timer tick, asking Buildbucket for the build status
[21:49:29.622] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:29.622] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:101:0) after 1m0s
[21:50:31.556] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:101:0)
[21:50:31.557] Timer tick, asking Buildbucket for the build status
[21:50:32.799] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:32.799] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:102:0) after 1m0s
[21:51:32.831] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:102:0)
[21:51:32.831] Timer tick, asking Buildbucket for the build status
[21:51:32.988] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:32.988] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:103:0) after 1m0s
[21:52:33.016] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:103:0)
[21:52:33.016] Timer tick, asking Buildbucket for the build status
[21:52:33.145] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:33.145] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:104:0) after 1m0s
[21:53:33.182] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:104:0)
[21:53:33.182] Timer tick, asking Buildbucket for the build status
[21:53:33.591] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:33.591] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:105:0) after 1m0s
[21:54:33.636] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:105:0)
[21:54:33.636] Timer tick, asking Buildbucket for the build status
[21:54:33.734] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:33.734] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:106:0) after 1m0s
[21:55:33.808] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:106:0)
[21:55:33.808] Timer tick, asking Buildbucket for the build status
[21:55:34.302] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:34.302] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:107:0) after 1m0s
[21:56:34.415] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:107:0)
[21:56:34.416] Timer tick, asking Buildbucket for the build status
[21:56:35.756] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:35.756] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:108:0) after 1m0s
[21:57:35.908] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:108:0)
[21:57:35.908] Timer tick, asking Buildbucket for the build status
[21:57:36.026] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:36.026] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:109:0) after 1m0s
[21:58:36.092] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:109:0)
[21:58:36.092] Timer tick, asking Buildbucket for the build status
[21:58:36.164] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:36.164] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:110:0) after 1m0s
[21:59:36.229] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:110:0)
[21:59:36.229] Timer tick, asking Buildbucket for the build status
[21:59:36.293] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:36.293] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:111:0) after 1m0s
[22:00:36.316] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:111:0)
[22:00:36.316] Timer tick, asking Buildbucket for the build status
[22:00:36.541] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:36.541] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:112:0) after 1m0s
[22:01:36.825] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:112:0)
[22:01:36.825] Timer tick, asking Buildbucket for the build status
[22:01:37.526] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:37.526] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:113:0) after 1m0s
[22:02:37.578] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:113:0)
[22:02:37.578] Timer tick, asking Buildbucket for the build status
[22:02:38.019] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:38.020] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:114:0) after 1m0s
[22:03:38.079] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:114:0)
[22:03:38.079] Timer tick, asking Buildbucket for the build status
[22:03:38.144] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:38.144] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:115:0) after 1m0s
[22:04:38.179] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:115:0)
[22:04:38.179] Timer tick, asking Buildbucket for the build status
[22:04:38.257] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:38.257] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:116:0) after 1m0s
[22:05:38.287] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:116:0)
[22:05:38.287] Timer tick, asking Buildbucket for the build status
[22:05:38.403] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:38.403] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:117:0) after 1m0s
[22:06:38.435] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:117:0)
[22:06:38.435] Timer tick, asking Buildbucket for the build status
[22:06:38.596] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:38.596] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:118:0) after 1m0s
[22:07:38.718] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:118:0)
[22:07:38.718] Timer tick, asking Buildbucket for the build status
[22:07:38.790] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:38.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:119:0) after 1m0s
[22:08:38.875] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:119:0)
[22:08:38.875] Timer tick, asking Buildbucket for the build status
[22:08:39.021] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:39.021] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:120:0) after 1m0s
[22:09:39.622] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:120:0)
[22:09:39.622] Timer tick, asking Buildbucket for the build status
[22:09:39.775] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:39.775] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:121:0) after 1m0s
[22:10:39.955] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:121:0)
[22:10:39.955] Timer tick, asking Buildbucket for the build status
[22:10:40.079] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:40.079] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:122:0) after 1m0s
[22:11:40.354] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:122:0)
[22:11:40.354] Timer tick, asking Buildbucket for the build status
[22:11:40.508] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:40.508] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:123:0) after 1m0s
[22:12:40.640] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:123:0)
[22:12:40.641] Timer tick, asking Buildbucket for the build status
[22:12:40.758] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:40.758] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:124:0) after 1m0s
[22:13:41.073] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:124:0)
[22:13:41.073] Timer tick, asking Buildbucket for the build status
[22:13:41.175] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:41.181] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:125:0) after 1m0s
[22:14:41.392] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:125:0)
[22:14:41.392] Timer tick, asking Buildbucket for the build status
[22:14:41.520] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:41.521] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:126:0) after 1m0s
[22:15:41.714] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:126:0)
[22:15:41.714] Timer tick, asking Buildbucket for the build status
[22:15:41.802] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:41.802] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:127:0) after 1m0s
[22:16:42.167] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:127:0)
[22:16:42.167] Timer tick, asking Buildbucket for the build status
[22:16:42.960] Build 8870148883952559952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:42.960] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9035578945958619616:128:0) after 1m0s
[22:16:45.268] Received PubSub notification, asking Buildbucket for the build status
[22:16:45.500] Build 8870148883952559952: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:16:45.500] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1599171403801700",
"created_by": "project:chromium",
"created_ts": "1599163848882297",
"failure_reason": "BUILD_FAILURE",
"id": "8870148883952559952",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc93664835ca758491be33480d84d536cb5055cc\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- WebRtcMediaRecorderTest.Resume\"}, \"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\": \"dc93664835ca758491be33480d84d536cb5055cc\", \"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-3-6q6p\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 4838, \"got_angle_revision\": \"999c85ee82154eadb9aebc1be9eaf32102462023\", \"got_dawn_revision\": \"b44ca92f1cdd2a28540d5652ff25dcd36d5ff3b9\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"dc93664835ca758491be33480d84d536cb5055cc\", \"got_revision_cp\": \"refs/heads/master@{#804380}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"75690ce7ef4a189c914cc27ebbd1dbc1155382cb\", \"got_v8_revision\": \"6d46b6f18d743b6d87e9bfdf41e1d4e56cde7986\", \"got_v8_revision_cp\": \"refs/heads/8.7.69@{#1}\", \"got_webrtc_revision\": \"c94650d88fd7c1041b0ab7ab1ced78b2dfb5c27b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32033}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc93664835ca758491be33480d84d536cb5055cc\", \"swarm_hashes\": {\"android_browsertests\": \"801aea67eabafe466c1d5a7aeebfffb74cbd0fc7\", \"chrome_public_test_apk\": \"4d8f5d1ddb8cabb19ee0a50f1d93222fbee9608d\", \"content_browsertests\": \"26e0f596631e0ceac44dbf104588463cc02c292c\", \"content_shell_test_apk\": \"ddb20c46748128b24fe14c2408feee1f7e2c5223\", \"content_unittests\": \"cee2795f9b50968d49e9d77d82358afd4e8230f3\", \"unit_tests\": \"106781bfbd07ff4532c6a2d44fcd153cf557af44\"}, \"swarm_hashes_refs/heads/master(at){#804380}_without_patch\": {\"android_browsertests\": \"801aea67eabafe466c1d5a7aeebfffb74cbd0fc7\", \"chrome_public_test_apk\": \"4d8f5d1ddb8cabb19ee0a50f1d93222fbee9608d\", \"content_browsertests\": \"26e0f596631e0ceac44dbf104588463cc02c292c\", \"content_shell_test_apk\": \"ddb20c46748128b24fe14c2408feee1f7e2c5223\", \"content_unittests\": \"cee2795f9b50968d49e9d77d82358afd4e8230f3\", \"unit_tests\": \"106781bfbd07ff4532c6a2d44fcd153cf557af44\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_3e75b41c9bcf12a22209c03b338cce1fafa12941d3074ed1e1ed2450e6b71594_v2\", \"builder_c189ef7f675e7e5e0fb70e027be89e273234556521e23e859ce8cec70612954d_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_dc45faf1d7d5fa61c97a020287f0c8532c944f5ffcf96875ec590f5c9bab0d83_v2\", \"builder_ffe1f610f578c7fcf9a76dff0895ce724c581006460de4387e25092b7c1f2739_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-3-6q6p\"], \"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_browsertests on Android device Nexus 5** failed because of:\\n\\n- WebRtcMediaRecorderTest.Resume\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599164417506554",
"status": "COMPLETED",
"status_changed_ts": "1599164418068369",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4838",
"builder:android-bfcache-rel",
"buildset:commit/git/dc93664835ca758491be33480d84d536cb5055cc",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc93664835ca758491be33480d84d536cb5055cc",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9035578945958619616",
"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/8870148883952559952/+/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:4e6e6965ff266510",
"user_agent:luci-scheduler"
],
"updated_ts": "1599171404589300",
"url": "https://ci.chromium.org/b/8870148883952559952",
"utcnow_ts": "1599171405484118"
}
}
[22:16:45.500] Invocation finished in 2h5m57.91376517s with status FAILED