[21:15:34.432] New invocation is queued and will start shortly
[21:15:37.056] Starting the invocation (attempt 1)
[21:15:37.098] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:15:37.098] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:15:37.098] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9036390243046433136",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9036390243046433136",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974",
"gitiles_ref:refs/heads/master"
]
}
[21:15:38.179] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1598390137290196",
"id": "8870960179358877552",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1598390137968152",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4688",
"builder:android-bfcache-rel",
"buildset:commit/git/d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036390243046433136",
"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/8870960179358877552/+/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": "1598390137968263",
"url": "https://ci.chromium.org/b/8870960179358877552",
"utcnow_ts": "1598390138163053"
}
}
[21:15:38.179] Task URL: https://ci.chromium.org/b/8870960179358877552
[21:15:38.179] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:2:0) after 1m0s
[21:16:38.327] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:2:0)
[21:16:38.327] Timer tick, asking Buildbucket for the build status
[21:16:38.417] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:16:38.417] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:3:0) after 1m0s
[21:17:38.442] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:3:0)
[21:17:38.442] Timer tick, asking Buildbucket for the build status
[21:17:38.646] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:17:38.646] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:4:0) after 1m0s
[21:18:38.739] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:4:0)
[21:18:38.739] Timer tick, asking Buildbucket for the build status
[21:18:38.845] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:18:38.845] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:5:0) after 1m0s
[21:19:38.854] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:5:0)
[21:19:38.854] Timer tick, asking Buildbucket for the build status
[21:19:39.072] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:19:39.072] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:6:0) after 1m0s
[21:20:39.176] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:6:0)
[21:20:39.176] Timer tick, asking Buildbucket for the build status
[21:20:39.497] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:20:39.497] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:7:0) after 1m0s
[21:21:39.546] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:7:0)
[21:21:39.546] Timer tick, asking Buildbucket for the build status
[21:21:39.718] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:21:39.718] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:8:0) after 1m0s
[21:22:39.745] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:8:0)
[21:22:39.745] Timer tick, asking Buildbucket for the build status
[21:22:39.880] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:22:39.880] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:9:0) after 1m0s
[21:23:39.906] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:9:0)
[21:23:39.906] Timer tick, asking Buildbucket for the build status
[21:23:40.146] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:23:40.146] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:10:0) after 1m0s
[21:24:40.175] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:10:0)
[21:24:40.175] Timer tick, asking Buildbucket for the build status
[21:24:40.259] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:24:40.259] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:11:0) after 1m0s
[21:25:40.312] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:11:0)
[21:25:40.312] Timer tick, asking Buildbucket for the build status
[21:25:40.512] Build 8870960179358877552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:25:40.512] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:12:0) after 1m0s
[21:26:08.273] Received PubSub notification, asking Buildbucket for the build status
[21:26:08.663] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:40.553] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:12:0)
[21:26:40.553] Timer tick, asking Buildbucket for the build status
[21:26:40.834] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:40.834] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:14:0) after 1m0s
[21:27:40.871] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:14:0)
[21:27:40.871] Timer tick, asking Buildbucket for the build status
[21:27:40.965] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:40.965] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:15:0) after 1m0s
[21:28:41.076] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:15:0)
[21:28:41.076] Timer tick, asking Buildbucket for the build status
[21:28:41.188] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:41.188] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:16:0) after 1m0s
[21:29:41.298] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:16:0)
[21:29:41.298] Timer tick, asking Buildbucket for the build status
[21:29:41.400] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:41.400] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:17:0) after 1m0s
[21:30:41.489] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:17:0)
[21:30:41.489] Timer tick, asking Buildbucket for the build status
[21:30:41.599] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:41.599] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:18:0) after 1m0s
[21:31:41.608] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:18:0)
[21:31:41.608] Timer tick, asking Buildbucket for the build status
[21:31:41.828] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:41.828] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:19:0) after 1m0s
[21:32:41.852] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:19:0)
[21:32:41.852] Timer tick, asking Buildbucket for the build status
[21:32:41.922] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:41.922] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:20:0) after 1m0s
[21:33:41.896] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:20:0)
[21:33:41.896] Timer tick, asking Buildbucket for the build status
[21:33:42.285] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:42.285] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:21:0) after 1m0s
[21:34:42.408] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:21:0)
[21:34:42.408] Timer tick, asking Buildbucket for the build status
[21:34:42.791] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:42.791] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:22:0) after 1m0s
[21:35:42.872] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:22:0)
[21:35:42.872] Timer tick, asking Buildbucket for the build status
[21:35:43.070] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:43.070] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:23:0) after 1m0s
[21:36:43.185] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:23:0)
[21:36:43.185] Timer tick, asking Buildbucket for the build status
[21:36:43.342] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:43.342] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:24:0) after 1m0s
[21:37:43.349] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:24:0)
[21:37:43.349] Timer tick, asking Buildbucket for the build status
[21:37:43.414] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:43.414] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:25:0) after 1m0s
[21:38:43.416] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:25:0)
[21:38:43.416] Timer tick, asking Buildbucket for the build status
[21:38:43.614] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:43.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:26:0) after 1m0s
[21:39:43.641] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:26:0)
[21:39:43.641] Timer tick, asking Buildbucket for the build status
[21:39:43.701] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:43.701] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:27:0) after 1m0s
[21:40:43.850] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:27:0)
[21:40:43.850] Timer tick, asking Buildbucket for the build status
[21:40:43.970] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:43.970] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:28:0) after 1m0s
[21:41:44.058] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:28:0)
[21:41:44.058] Timer tick, asking Buildbucket for the build status
[21:41:44.157] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:44.157] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:29:0) after 1m0s
[21:42:44.279] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:29:0)
[21:42:44.279] Timer tick, asking Buildbucket for the build status
[21:42:44.698] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:44.698] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:30:0) after 1m0s
[21:43:44.730] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:30:0)
[21:43:44.730] Timer tick, asking Buildbucket for the build status
[21:43:44.840] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:44.840] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:31:0) after 1m0s
[21:44:44.840] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:31:0)
[21:44:44.840] Timer tick, asking Buildbucket for the build status
[21:44:44.946] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:44.946] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:32:0) after 1m0s
[21:45:45.012] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:32:0)
[21:45:45.012] Timer tick, asking Buildbucket for the build status
[21:45:45.117] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:45.117] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:33:0) after 1m0s
[21:46:45.199] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:33:0)
[21:46:45.199] Timer tick, asking Buildbucket for the build status
[21:46:45.376] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:45.376] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:34:0) after 1m0s
[21:47:45.462] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:34:0)
[21:47:45.462] Timer tick, asking Buildbucket for the build status
[21:47:45.587] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:45.587] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:35:0) after 1m0s
[21:48:45.632] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:35:0)
[21:48:45.632] Timer tick, asking Buildbucket for the build status
[21:48:45.745] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:45.745] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:36:0) after 1m0s
[21:49:45.868] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:36:0)
[21:49:45.868] Timer tick, asking Buildbucket for the build status
[21:49:46.209] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:46.209] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:37:0) after 1m0s
[21:50:46.260] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:37:0)
[21:50:46.260] Timer tick, asking Buildbucket for the build status
[21:50:46.699] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:46.699] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:38:0) after 1m0s
[21:51:46.736] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:38:0)
[21:51:46.736] Timer tick, asking Buildbucket for the build status
[21:51:46.933] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:46.933] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:39:0) after 1m0s
[21:52:47.001] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:39:0)
[21:52:47.001] Timer tick, asking Buildbucket for the build status
[21:52:47.290] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:47.290] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:40:0) after 1m0s
[21:53:47.359] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:40:0)
[21:53:47.360] Timer tick, asking Buildbucket for the build status
[21:53:47.418] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:47.418] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:41:0) after 1m0s
[21:54:47.462] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:41:0)
[21:54:47.462] Timer tick, asking Buildbucket for the build status
[21:54:47.527] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:47.527] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:42:0) after 1m0s
[21:55:47.626] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:42:0)
[21:55:47.626] Timer tick, asking Buildbucket for the build status
[21:55:47.792] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:47.792] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:43:0) after 1m0s
[21:56:47.838] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:43:0)
[21:56:47.839] Timer tick, asking Buildbucket for the build status
[21:56:48.085] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:48.085] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:44:0) after 1m0s
[21:57:48.156] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:44:0)
[21:57:48.156] Timer tick, asking Buildbucket for the build status
[21:57:48.383] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:48.383] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:45:0) after 1m0s
[21:58:48.437] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:45:0)
[21:58:48.437] Timer tick, asking Buildbucket for the build status
[21:58:48.510] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:48.510] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:46:0) after 1m0s
[21:59:48.569] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:46:0)
[21:59:48.569] Timer tick, asking Buildbucket for the build status
[21:59:48.624] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:48.624] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:47:0) after 1m0s
[22:00:48.702] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:47:0)
[22:00:48.702] Timer tick, asking Buildbucket for the build status
[22:00:48.832] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:48.832] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:48:0) after 1m0s
[22:01:48.917] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:48:0)
[22:01:48.917] Timer tick, asking Buildbucket for the build status
[22:01:48.971] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:48.971] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:49:0) after 1m0s
[22:02:49.031] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:49:0)
[22:02:49.031] Timer tick, asking Buildbucket for the build status
[22:02:49.095] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:49.095] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:50:0) after 1m0s
[22:03:49.167] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:50:0)
[22:03:49.167] Timer tick, asking Buildbucket for the build status
[22:03:49.386] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:49.386] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:51:0) after 1m0s
[22:04:49.439] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:51:0)
[22:04:49.439] Timer tick, asking Buildbucket for the build status
[22:04:49.521] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:49.521] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:52:0) after 1m0s
[22:05:49.617] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:52:0)
[22:05:49.617] Timer tick, asking Buildbucket for the build status
[22:05:50.238] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:50.238] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:53:0) after 1m0s
[22:06:50.275] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:53:0)
[22:06:50.275] Timer tick, asking Buildbucket for the build status
[22:06:50.424] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:50.424] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:54:0) after 1m0s
[22:07:50.566] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:54:0)
[22:07:50.566] Timer tick, asking Buildbucket for the build status
[22:07:50.838] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:50.838] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:55:0) after 1m0s
[22:08:51.003] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:55:0)
[22:08:51.003] Timer tick, asking Buildbucket for the build status
[22:08:51.082] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:51.082] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:56:0) after 1m0s
[22:09:51.152] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:56:0)
[22:09:51.152] Timer tick, asking Buildbucket for the build status
[22:09:51.390] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:51.390] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:57:0) after 1m0s
[22:10:51.438] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:57:0)
[22:10:51.438] Timer tick, asking Buildbucket for the build status
[22:10:51.638] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:51.638] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:58:0) after 1m0s
[22:11:51.707] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:58:0)
[22:11:51.707] Timer tick, asking Buildbucket for the build status
[22:11:51.764] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:51.764] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:59:0) after 1m0s
[22:12:51.774] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:59:0)
[22:12:51.774] Timer tick, asking Buildbucket for the build status
[22:12:51.835] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:51.835] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:60:0) after 1m0s
[22:13:51.934] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:60:0)
[22:13:51.934] Timer tick, asking Buildbucket for the build status
[22:13:52.097] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:52.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:61:0) after 1m0s
[22:14:52.098] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:61:0)
[22:14:52.098] Timer tick, asking Buildbucket for the build status
[22:14:52.375] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:52.375] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:62:0) after 1m0s
[22:15:52.460] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:62:0)
[22:15:52.460] Timer tick, asking Buildbucket for the build status
[22:15:52.739] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:52.739] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:63:0) after 1m0s
[22:16:52.911] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:63:0)
[22:16:52.911] Timer tick, asking Buildbucket for the build status
[22:16:52.972] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:52.972] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:64:0) after 1m0s
[22:17:53.179] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:64:0)
[22:17:53.179] Timer tick, asking Buildbucket for the build status
[22:17:53.378] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:53.378] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:65:0) after 1m0s
[22:18:53.516] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:65:0)
[22:18:53.516] Timer tick, asking Buildbucket for the build status
[22:18:53.584] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:53.584] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:66:0) after 1m0s
[22:19:53.811] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:66:0)
[22:19:53.811] Timer tick, asking Buildbucket for the build status
[22:19:54.052] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:54.052] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:67:0) after 1m0s
[22:20:54.199] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:67:0)
[22:20:54.199] Timer tick, asking Buildbucket for the build status
[22:20:54.353] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:54.353] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:68:0) after 1m0s
[22:21:54.559] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:68:0)
[22:21:54.559] Timer tick, asking Buildbucket for the build status
[22:21:54.912] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:54.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:69:0) after 1m0s
[22:22:55.006] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:69:0)
[22:22:55.006] Timer tick, asking Buildbucket for the build status
[22:22:55.103] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:55.103] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:70:0) after 1m0s
[22:23:55.272] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:70:0)
[22:23:55.272] Timer tick, asking Buildbucket for the build status
[22:23:55.484] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:55.484] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:71:0) after 1m0s
[22:24:55.793] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:71:0)
[22:24:55.793] Timer tick, asking Buildbucket for the build status
[22:24:55.875] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:55.875] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:72:0) after 1m0s
[22:25:55.982] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:72:0)
[22:25:55.982] Timer tick, asking Buildbucket for the build status
[22:25:56.078] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:56.078] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:73:0) after 1m0s
[22:26:56.143] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:73:0)
[22:26:56.143] Timer tick, asking Buildbucket for the build status
[22:26:56.358] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:56.358] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:74:0) after 1m0s
[22:27:56.399] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:74:0)
[22:27:56.399] Timer tick, asking Buildbucket for the build status
[22:27:56.614] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:56.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:75:0) after 1m0s
[22:28:56.683] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:75:0)
[22:28:56.683] Timer tick, asking Buildbucket for the build status
[22:28:56.881] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:56.881] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:76:0) after 1m0s
[22:29:57.020] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:76:0)
[22:29:57.020] Timer tick, asking Buildbucket for the build status
[22:29:57.311] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:57.311] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:77:0) after 1m0s
[22:30:57.519] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:77:0)
[22:30:57.519] Timer tick, asking Buildbucket for the build status
[22:30:57.635] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:57.635] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:78:0) after 1m0s
[22:31:57.710] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:78:0)
[22:31:57.711] Timer tick, asking Buildbucket for the build status
[22:31:57.778] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:57.778] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:79:0) after 1m0s
[22:32:57.929] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:79:0)
[22:32:57.929] Timer tick, asking Buildbucket for the build status
[22:32:57.998] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:57.998] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:80:0) after 1m0s
[22:33:57.995] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:80:0)
[22:33:57.995] Timer tick, asking Buildbucket for the build status
[22:33:58.053] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:58.053] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:81:0) after 1m0s
[22:34:58.082] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:81:0)
[22:34:58.082] Timer tick, asking Buildbucket for the build status
[22:34:58.157] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:58.157] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:82:0) after 1m0s
[22:35:58.280] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:82:0)
[22:35:58.280] Timer tick, asking Buildbucket for the build status
[22:35:58.386] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:58.386] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:83:0) after 1m0s
[22:36:58.542] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:83:0)
[22:36:58.542] Timer tick, asking Buildbucket for the build status
[22:36:58.866] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:58.866] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:84:0) after 1m0s
[22:37:58.984] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:84:0)
[22:37:58.984] Timer tick, asking Buildbucket for the build status
[22:37:59.152] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:59.152] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:85:0) after 1m0s
[22:38:59.390] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:85:0)
[22:38:59.390] Timer tick, asking Buildbucket for the build status
[22:38:59.608] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:59.608] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:86:0) after 1m0s
[22:39:59.671] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:86:0)
[22:39:59.671] Timer tick, asking Buildbucket for the build status
[22:39:59.859] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:59.859] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:87:0) after 1m0s
[22:40:59.919] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:87:0)
[22:40:59.919] Timer tick, asking Buildbucket for the build status
[22:41:00.176] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:00.176] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:88:0) after 1m0s
[22:42:00.237] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:88:0)
[22:42:00.237] Timer tick, asking Buildbucket for the build status
[22:42:00.824] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:00.824] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:89:0) after 1m0s
[22:43:02.402] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:89:0)
[22:43:02.402] Timer tick, asking Buildbucket for the build status
[22:43:02.775] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:02.775] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:90:0) after 1m0s
[22:44:02.857] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:90:0)
[22:44:02.858] Timer tick, asking Buildbucket for the build status
[22:44:03.187] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:03.187] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:91:0) after 1m0s
[22:45:03.226] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:91:0)
[22:45:03.226] Timer tick, asking Buildbucket for the build status
[22:45:03.346] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:03.346] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:92:0) after 1m0s
[22:46:03.376] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:92:0)
[22:46:03.376] Timer tick, asking Buildbucket for the build status
[22:46:03.506] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:03.506] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:93:0) after 1m0s
[22:47:03.554] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:93:0)
[22:47:03.554] Timer tick, asking Buildbucket for the build status
[22:47:04.075] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:04.075] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:94:0) after 1m0s
[22:48:04.143] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:94:0)
[22:48:04.143] Timer tick, asking Buildbucket for the build status
[22:48:04.229] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:04.229] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:95:0) after 1m0s
[22:49:04.279] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:95:0)
[22:49:04.279] Timer tick, asking Buildbucket for the build status
[22:49:04.369] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:04.369] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:96:0) after 1m0s
[22:50:04.467] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:96:0)
[22:50:04.467] Timer tick, asking Buildbucket for the build status
[22:50:04.635] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:04.635] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:97:0) after 1m0s
[22:51:04.752] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:97:0)
[22:51:04.752] Timer tick, asking Buildbucket for the build status
[22:51:05.293] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:05.293] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:98:0) after 1m0s
[22:52:05.379] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:98:0)
[22:52:05.379] Timer tick, asking Buildbucket for the build status
[22:52:05.478] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:05.478] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:99:0) after 1m0s
[22:53:05.515] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:99:0)
[22:53:05.515] Timer tick, asking Buildbucket for the build status
[22:53:05.618] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:05.618] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:100:0) after 1m0s
[22:54:05.668] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:100:0)
[22:54:05.669] Timer tick, asking Buildbucket for the build status
[22:54:05.922] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:05.922] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:101:0) after 1m0s
[22:55:05.986] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:101:0)
[22:55:05.986] Timer tick, asking Buildbucket for the build status
[22:55:06.049] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:06.049] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:102:0) after 1m0s
[22:56:06.071] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:102:0)
[22:56:06.071] Timer tick, asking Buildbucket for the build status
[22:56:06.185] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:06.185] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:103:0) after 1m0s
[22:57:06.285] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:103:0)
[22:57:06.285] Timer tick, asking Buildbucket for the build status
[22:57:06.537] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:06.537] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:104:0) after 1m0s
[22:58:06.637] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:104:0)
[22:58:06.637] Timer tick, asking Buildbucket for the build status
[22:58:07.019] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:07.019] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:105:0) after 1m0s
[22:59:07.104] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:105:0)
[22:59:07.104] Timer tick, asking Buildbucket for the build status
[22:59:07.168] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:07.168] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:106:0) after 1m0s
[23:00:07.217] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:106:0)
[23:00:07.217] Timer tick, asking Buildbucket for the build status
[23:00:07.293] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:07.293] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:107:0) after 1m0s
[23:01:07.689] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:107:0)
[23:01:07.689] Timer tick, asking Buildbucket for the build status
[23:01:08.278] Build 8870960179358877552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:08.278] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9036390243046433136:108:0) after 1m0s
[23:01:51.966] Received PubSub notification, asking Buildbucket for the build status
[23:01:52.111] Build 8870960179358877552: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:01:52.111] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1598396511002665",
"created_by": "project:chromium",
"created_ts": "1598390137290196",
"id": "8870960179358877552",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-21-4fcs\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 4688, \"got_angle_revision\": \"d19c08c9ed8ded0306039af4cdc4a93ce18e3742\", \"got_dawn_revision\": \"c3e3c30b0d7f51064f7247a09b61d208252416b7\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974\", \"got_revision_cp\": \"refs/heads/master@{#801545}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"622558b02e1a5441c579994831a6338ffaf2de5c\", \"got_v8_revision\": \"288014f2f94b4ff0fb0bb160ffac61b7bc3e7739\", \"got_v8_revision_cp\": \"refs/heads/8.7.16@{#1}\", \"got_webrtc_revision\": \"59230836579a7ce0386faebb07c73ac23f31a2b4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31987}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.android\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974\", \"swarm_hashes\": {\"android_browsertests\": \"576fc9ca8ed3c2feebafaca5f5183ead7c87afee\", \"chrome_public_test_apk\": \"c2c91ef63966c0dc3e0c08b3d64db6e55a68b1f4\", \"content_browsertests\": \"736527de56dbe03be827e27faac52a2153611dfc\", \"content_shell_test_apk\": \"7f5a227b9e178ed4700d7835cafbb6d5b600025b\", \"content_unittests\": \"03015bbfb55362501fd55fdc661adcec62d509a9\", \"unit_tests\": \"7a9f0677643d5ccd9903fc2a69935376c9b745ff\"}, \"swarm_hashes_refs/heads/master(at){#801545}_without_patch\": {\"android_browsertests\": \"576fc9ca8ed3c2feebafaca5f5183ead7c87afee\", \"chrome_public_test_apk\": \"c2c91ef63966c0dc3e0c08b3d64db6e55a68b1f4\", \"content_browsertests\": \"736527de56dbe03be827e27faac52a2153611dfc\", \"content_shell_test_apk\": \"7f5a227b9e178ed4700d7835cafbb6d5b600025b\", \"content_unittests\": \"03015bbfb55362501fd55fdc661adcec62d509a9\", \"unit_tests\": \"7a9f0677643d5ccd9903fc2a69935376c9b745ff\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_953e900270162ec95f568ea264af47d43b9a29a15e01ede040ffa4d15b188919_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_afb3a13a9ac26806dacbdf892b44ad95d1cf9306e831af9093db192124098659_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_v2\", \"builder_de45c485d8a81e16b8ff53eb76d94467eed5e11e118465311a13e72e2b141cb1_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-east1-d-8-21-4fcs\"], \"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\": [\"5498-3454aa6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1598390767499801",
"status": "COMPLETED",
"status_changed_ts": "1598396511411999",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/4688",
"builder:android-bfcache-rel",
"buildset:commit/git/d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d992bce23e5a4cc9dbf132b4e48e75b8cb5eb974",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9036390243046433136",
"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/8870960179358877552/+/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:4e404b80c3471610",
"user_agent:luci-scheduler"
],
"updated_ts": "1598396511476472",
"url": "https://ci.chromium.org/b/8870960179358877552",
"utcnow_ts": "1598396512093911"
}
}
[23:01:52.111] Invocation finished in 1h46m17.721039113s with status SUCCEEDED