[13:56:58.060] New invocation is queued and will start shortly
[13:56:59.169] Starting the invocation (attempt 1)
[13:56:59.202] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:56:59.202] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:56:59.202] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024640232102416464",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9024640232102416464",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784",
"gitiles_ref:refs/heads/master"
]
}
[13:56:59.891] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1609595819273962",
"id": "8859210170167890048",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1609595819766327",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/7048",
"builder:android-bfcache-rel",
"buildset:commit/git/dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024640232102416464",
"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/8859210170167890048/+/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": "1609595819766438",
"url": "https://ci.chromium.org/b/8859210170167890048",
"utcnow_ts": "1609595819883214"
}
}
[13:56:59.891] Task URL: https://ci.chromium.org/b/8859210170167890048
[13:56:59.891] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:2:0) after 1m0s
[13:57:59.912] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:2:0)
[13:57:59.912] Timer tick, asking Buildbucket for the build status
[13:58:00.169] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:58:00.169] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:3:0) after 1m0s
[13:59:00.186] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:3:0)
[13:59:00.186] Timer tick, asking Buildbucket for the build status
[13:59:00.451] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:59:00.451] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:4:0) after 1m0s
[14:00:00.519] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:4:0)
[14:00:00.519] Timer tick, asking Buildbucket for the build status
[14:00:00.583] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:00:00.583] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:5:0) after 1m0s
[14:01:00.614] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:5:0)
[14:01:00.614] Timer tick, asking Buildbucket for the build status
[14:01:00.689] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:01:00.690] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:6:0) after 1m0s
[14:02:00.849] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:6:0)
[14:02:00.849] Timer tick, asking Buildbucket for the build status
[14:02:02.657] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:02:02.657] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:7:0) after 1m0s
[14:03:02.696] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:7:0)
[14:03:02.696] Timer tick, asking Buildbucket for the build status
[14:03:02.768] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:03:02.768] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:8:0) after 1m0s
[14:04:02.837] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:8:0)
[14:04:02.837] Timer tick, asking Buildbucket for the build status
[14:04:03.207] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:03.207] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:9:0) after 1m0s
[14:05:03.225] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:9:0)
[14:05:03.225] Timer tick, asking Buildbucket for the build status
[14:05:03.625] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:03.625] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:10:0) after 1m0s
[14:06:03.663] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:10:0)
[14:06:03.663] Timer tick, asking Buildbucket for the build status
[14:06:03.803] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:06:03.803] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:11:0) after 1m0s
[14:07:03.822] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:11:0)
[14:07:03.822] Timer tick, asking Buildbucket for the build status
[14:07:04.413] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:07:04.413] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:12:0) after 1m0s
[14:08:04.421] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:12:0)
[14:08:04.421] Timer tick, asking Buildbucket for the build status
[14:08:04.486] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:08:04.486] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:13:0) after 1m0s
[14:09:04.512] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:13:0)
[14:09:04.512] Timer tick, asking Buildbucket for the build status
[14:09:04.666] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:09:04.666] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:14:0) after 1m0s
[14:10:04.762] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:14:0)
[14:10:04.762] Timer tick, asking Buildbucket for the build status
[14:10:04.951] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:10:04.951] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:15:0) after 1m0s
[14:11:04.979] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:15:0)
[14:11:04.979] Timer tick, asking Buildbucket for the build status
[14:11:05.487] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:11:05.487] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:16:0) after 1m0s
[14:12:05.625] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:16:0)
[14:12:05.625] Timer tick, asking Buildbucket for the build status
[14:12:05.786] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:12:05.786] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:17:0) after 1m0s
[14:13:05.819] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:17:0)
[14:13:05.819] Timer tick, asking Buildbucket for the build status
[14:13:05.887] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:13:05.887] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:18:0) after 1m0s
[14:14:05.908] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:18:0)
[14:14:05.908] Timer tick, asking Buildbucket for the build status
[14:14:05.997] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:14:05.997] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:19:0) after 1m0s
[14:15:06.062] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:19:0)
[14:15:06.062] Timer tick, asking Buildbucket for the build status
[14:15:06.184] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:15:06.184] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:20:0) after 1m0s
[14:16:06.400] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:20:0)
[14:16:06.400] Timer tick, asking Buildbucket for the build status
[14:16:06.509] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:16:06.509] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:21:0) after 1m0s
[14:17:06.584] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:21:0)
[14:17:06.584] Timer tick, asking Buildbucket for the build status
[14:17:06.686] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:17:06.686] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:22:0) after 1m0s
[14:18:06.942] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:22:0)
[14:18:06.942] Timer tick, asking Buildbucket for the build status
[14:18:07.010] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:18:07.010] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:23:0) after 1m0s
[14:19:07.029] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:23:0)
[14:19:07.029] Timer tick, asking Buildbucket for the build status
[14:19:07.092] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:19:07.092] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:24:0) after 1m0s
[14:20:07.166] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:24:0)
[14:20:07.166] Timer tick, asking Buildbucket for the build status
[14:20:07.560] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:20:07.560] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:25:0) after 1m0s
[14:21:07.728] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:25:0)
[14:21:07.728] Timer tick, asking Buildbucket for the build status
[14:21:08.009] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:21:08.010] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:26:0) after 1m0s
[14:22:08.032] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:26:0)
[14:22:08.032] Timer tick, asking Buildbucket for the build status
[14:22:08.121] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:22:08.121] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:27:0) after 1m0s
[14:23:08.283] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:27:0)
[14:23:08.283] Timer tick, asking Buildbucket for the build status
[14:23:08.370] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:23:08.370] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:28:0) after 1m0s
[14:24:08.487] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:28:0)
[14:24:08.487] Timer tick, asking Buildbucket for the build status
[14:24:08.557] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:24:08.557] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:29:0) after 1m0s
[14:25:08.641] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:29:0)
[14:25:08.641] Timer tick, asking Buildbucket for the build status
[14:25:08.743] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:25:08.743] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:30:0) after 1m0s
[14:26:08.846] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:30:0)
[14:26:08.846] Timer tick, asking Buildbucket for the build status
[14:26:08.944] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:26:08.944] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:31:0) after 1m0s
[14:27:09.015] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:31:0)
[14:27:09.015] Timer tick, asking Buildbucket for the build status
[14:27:09.696] Build 8859210170167890048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:27:09.696] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:32:0) after 1m0s
[14:27:42.717] Received PubSub notification, asking Buildbucket for the build status
[14:27:42.804] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:09.730] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:32:0)
[14:28:09.730] Timer tick, asking Buildbucket for the build status
[14:28:09.829] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:09.830] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:34:0) after 1m0s
[14:29:09.966] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:34:0)
[14:29:09.966] Timer tick, asking Buildbucket for the build status
[14:29:10.060] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:10.060] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:35:0) after 1m0s
[14:30:10.128] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:35:0)
[14:30:10.128] Timer tick, asking Buildbucket for the build status
[14:30:10.189] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:10.189] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:36:0) after 1m0s
[14:31:10.307] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:36:0)
[14:31:10.307] Timer tick, asking Buildbucket for the build status
[14:31:10.391] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:10.391] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:37:0) after 1m0s
[14:32:10.411] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:37:0)
[14:32:10.411] Timer tick, asking Buildbucket for the build status
[14:32:10.520] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:10.520] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:38:0) after 1m0s
[14:33:10.571] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:38:0)
[14:33:10.571] Timer tick, asking Buildbucket for the build status
[14:33:10.643] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:10.643] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:39:0) after 1m0s
[14:34:10.664] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:39:0)
[14:34:10.664] Timer tick, asking Buildbucket for the build status
[14:34:10.914] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:10.914] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:40:0) after 1m0s
[14:35:10.931] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:40:0)
[14:35:10.931] Timer tick, asking Buildbucket for the build status
[14:35:11.031] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:11.031] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:41:0) after 1m0s
[14:36:11.097] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:41:0)
[14:36:11.097] Timer tick, asking Buildbucket for the build status
[14:36:11.205] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:11.205] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:42:0) after 1m0s
[14:37:11.225] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:42:0)
[14:37:11.225] Timer tick, asking Buildbucket for the build status
[14:37:11.638] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:11.638] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:43:0) after 1m0s
[14:38:11.688] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:43:0)
[14:38:11.688] Timer tick, asking Buildbucket for the build status
[14:38:11.761] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:11.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:44:0) after 1m0s
[14:39:11.926] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:44:0)
[14:39:11.926] Timer tick, asking Buildbucket for the build status
[14:39:12.152] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:12.152] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:45:0) after 1m0s
[14:40:12.175] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:45:0)
[14:40:12.175] Timer tick, asking Buildbucket for the build status
[14:40:14.203] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:14.203] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:46:0) after 1m0s
[14:41:14.283] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:46:0)
[14:41:14.283] Timer tick, asking Buildbucket for the build status
[14:41:14.464] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:14.464] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:47:0) after 1m0s
[14:42:14.564] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:47:0)
[14:42:14.564] Timer tick, asking Buildbucket for the build status
[14:42:14.686] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:14.686] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:48:0) after 1m0s
[14:43:14.709] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:48:0)
[14:43:14.709] Timer tick, asking Buildbucket for the build status
[14:43:14.766] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:14.766] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:49:0) after 1m0s
[14:44:14.777] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:49:0)
[14:44:14.777] Timer tick, asking Buildbucket for the build status
[14:44:14.872] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:14.872] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:50:0) after 1m0s
[14:45:14.908] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:50:0)
[14:45:14.908] Timer tick, asking Buildbucket for the build status
[14:45:15.137] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:15.137] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:51:0) after 1m0s
[14:46:15.211] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:51:0)
[14:46:15.211] Timer tick, asking Buildbucket for the build status
[14:46:15.514] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:15.514] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:52:0) after 1m0s
[14:47:15.531] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:52:0)
[14:47:15.531] Timer tick, asking Buildbucket for the build status
[14:47:16.003] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:16.003] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:53:0) after 1m0s
[14:48:16.075] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:53:0)
[14:48:16.075] Timer tick, asking Buildbucket for the build status
[14:48:16.126] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:16.126] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:54:0) after 1m0s
[14:49:16.156] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:54:0)
[14:49:16.156] Timer tick, asking Buildbucket for the build status
[14:49:16.212] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:16.212] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:55:0) after 1m0s
[14:50:16.294] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:55:0)
[14:50:16.294] Timer tick, asking Buildbucket for the build status
[14:50:16.424] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:16.424] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:56:0) after 1m0s
[14:51:16.558] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:56:0)
[14:51:16.558] Timer tick, asking Buildbucket for the build status
[14:51:16.629] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:16.629] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:57:0) after 1m0s
[14:52:16.768] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:57:0)
[14:52:16.768] Timer tick, asking Buildbucket for the build status
[14:52:16.856] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:16.856] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:58:0) after 1m0s
[14:53:16.877] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:58:0)
[14:53:16.877] Timer tick, asking Buildbucket for the build status
[14:53:16.931] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:16.931] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:59:0) after 1m0s
[14:54:18.312] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:59:0)
[14:54:18.312] Timer tick, asking Buildbucket for the build status
[14:54:18.442] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:18.442] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:60:0) after 1m0s
[14:55:18.877] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:60:0)
[14:55:18.877] Timer tick, asking Buildbucket for the build status
[14:55:19.209] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:19.209] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:61:0) after 1m0s
[14:56:19.388] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:61:0)
[14:56:19.388] Timer tick, asking Buildbucket for the build status
[14:56:19.639] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:19.639] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:62:0) after 1m0s
[14:57:19.829] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:62:0)
[14:57:19.829] Timer tick, asking Buildbucket for the build status
[14:57:19.951] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:19.951] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:63:0) after 1m0s
[14:58:20.082] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:63:0)
[14:58:20.082] Timer tick, asking Buildbucket for the build status
[14:58:20.297] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:20.297] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:64:0) after 1m0s
[14:59:20.405] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:64:0)
[14:59:20.405] Timer tick, asking Buildbucket for the build status
[14:59:20.487] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:20.487] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:65:0) after 1m0s
[15:00:20.687] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:65:0)
[15:00:20.687] Timer tick, asking Buildbucket for the build status
[15:00:20.772] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:20.772] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:66:0) after 1m0s
[15:01:20.860] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:66:0)
[15:01:20.860] Timer tick, asking Buildbucket for the build status
[15:01:20.919] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:20.919] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:67:0) after 1m0s
[15:02:20.945] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:67:0)
[15:02:20.945] Timer tick, asking Buildbucket for the build status
[15:02:21.187] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:21.187] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:68:0) after 1m0s
[15:03:21.217] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:68:0)
[15:03:21.217] Timer tick, asking Buildbucket for the build status
[15:03:21.495] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:21.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:69:0) after 1m0s
[15:04:21.515] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:69:0)
[15:04:21.515] Timer tick, asking Buildbucket for the build status
[15:04:21.593] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:21.593] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:70:0) after 1m0s
[15:05:21.665] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:70:0)
[15:05:21.665] Timer tick, asking Buildbucket for the build status
[15:05:21.720] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:21.720] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:71:0) after 1m0s
[15:06:21.795] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:71:0)
[15:06:21.795] Timer tick, asking Buildbucket for the build status
[15:06:21.899] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:21.899] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:72:0) after 1m0s
[15:07:21.920] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:72:0)
[15:07:21.920] Timer tick, asking Buildbucket for the build status
[15:07:22.012] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:22.012] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:73:0) after 1m0s
[15:08:22.086] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:73:0)
[15:08:22.086] Timer tick, asking Buildbucket for the build status
[15:08:22.138] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:22.138] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:74:0) after 1m0s
[15:09:22.140] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:74:0)
[15:09:22.140] Timer tick, asking Buildbucket for the build status
[15:09:22.206] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:22.206] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:75:0) after 1m0s
[15:10:22.233] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:75:0)
[15:10:22.233] Timer tick, asking Buildbucket for the build status
[15:10:22.304] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:22.304] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:76:0) after 1m0s
[15:11:22.371] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:76:0)
[15:11:22.371] Timer tick, asking Buildbucket for the build status
[15:11:22.442] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:22.442] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:77:0) after 1m0s
[15:12:22.479] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:77:0)
[15:12:22.479] Timer tick, asking Buildbucket for the build status
[15:12:22.904] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:22.904] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:78:0) after 1m0s
[15:13:22.929] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:78:0)
[15:13:22.929] Timer tick, asking Buildbucket for the build status
[15:13:22.989] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:22.989] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:79:0) after 1m0s
[15:14:23.036] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:79:0)
[15:14:23.036] Timer tick, asking Buildbucket for the build status
[15:14:23.301] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:23.301] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:80:0) after 1m0s
[15:15:23.375] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:80:0)
[15:15:23.375] Timer tick, asking Buildbucket for the build status
[15:15:23.589] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:23.589] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:81:0) after 1m0s
[15:16:23.658] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:81:0)
[15:16:23.658] Timer tick, asking Buildbucket for the build status
[15:16:23.745] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:23.745] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:82:0) after 1m0s
[15:17:23.795] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:82:0)
[15:17:23.795] Timer tick, asking Buildbucket for the build status
[15:17:24.148] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:24.148] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:83:0) after 1m0s
[15:18:24.167] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:83:0)
[15:18:24.167] Timer tick, asking Buildbucket for the build status
[15:18:24.241] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:24.241] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:84:0) after 1m0s
[15:19:24.275] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:84:0)
[15:19:24.275] Timer tick, asking Buildbucket for the build status
[15:19:24.508] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:24.508] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:85:0) after 1m0s
[15:20:24.530] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:85:0)
[15:20:24.530] Timer tick, asking Buildbucket for the build status
[15:20:24.614] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:24.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:86:0) after 1m0s
[15:21:24.634] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:86:0)
[15:21:24.634] Timer tick, asking Buildbucket for the build status
[15:21:24.690] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:24.690] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:87:0) after 1m0s
[15:22:24.711] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:87:0)
[15:22:24.711] Timer tick, asking Buildbucket for the build status
[15:22:25.009] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:25.009] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:88:0) after 1m0s
[15:23:25.082] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:88:0)
[15:23:25.082] Timer tick, asking Buildbucket for the build status
[15:23:25.189] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:25.189] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:89:0) after 1m0s
[15:24:25.215] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:89:0)
[15:24:25.215] Timer tick, asking Buildbucket for the build status
[15:24:25.277] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:25.277] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:90:0) after 1m0s
[15:25:25.299] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:90:0)
[15:25:25.299] Timer tick, asking Buildbucket for the build status
[15:25:25.373] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:25.373] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:91:0) after 1m0s
[15:26:25.509] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:91:0)
[15:26:25.509] Timer tick, asking Buildbucket for the build status
[15:26:25.967] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:25.967] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:92:0) after 1m0s
[15:27:25.993] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:92:0)
[15:27:25.993] Timer tick, asking Buildbucket for the build status
[15:27:26.494] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:26.494] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:93:0) after 1m0s
[15:28:26.517] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:93:0)
[15:28:26.517] Timer tick, asking Buildbucket for the build status
[15:28:26.576] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:26.576] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:94:0) after 1m0s
[15:29:26.684] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:94:0)
[15:29:26.684] Timer tick, asking Buildbucket for the build status
[15:29:27.030] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:27.030] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:95:0) after 1m0s
[15:30:27.049] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:95:0)
[15:30:27.049] Timer tick, asking Buildbucket for the build status
[15:30:27.115] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:27.115] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:96:0) after 1m0s
[15:31:27.246] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:96:0)
[15:31:27.246] Timer tick, asking Buildbucket for the build status
[15:31:27.349] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:27.349] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:97:0) after 1m0s
[15:32:27.377] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:97:0)
[15:32:27.377] Timer tick, asking Buildbucket for the build status
[15:32:27.503] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:27.503] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:98:0) after 1m0s
[15:33:27.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:98:0)
[15:33:27.525] Timer tick, asking Buildbucket for the build status
[15:33:27.945] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:27.945] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:99:0) after 1m0s
[15:34:27.980] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:99:0)
[15:34:27.980] Timer tick, asking Buildbucket for the build status
[15:34:28.035] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:28.035] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:100:0) after 1m0s
[15:35:28.096] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:100:0)
[15:35:28.096] Timer tick, asking Buildbucket for the build status
[15:35:28.213] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:28.213] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:101:0) after 1m0s
[15:36:28.219] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:101:0)
[15:36:28.219] Timer tick, asking Buildbucket for the build status
[15:36:28.367] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:28.367] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:102:0) after 1m0s
[15:37:28.381] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:102:0)
[15:37:28.381] Timer tick, asking Buildbucket for the build status
[15:37:28.498] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:28.498] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:103:0) after 1m0s
[15:38:28.570] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:103:0)
[15:38:28.570] Timer tick, asking Buildbucket for the build status
[15:38:28.647] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:28.647] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:104:0) after 1m0s
[15:39:28.671] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:104:0)
[15:39:28.671] Timer tick, asking Buildbucket for the build status
[15:39:28.825] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:28.825] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:105:0) after 1m0s
[15:40:28.850] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:105:0)
[15:40:28.850] Timer tick, asking Buildbucket for the build status
[15:40:29.001] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:29.001] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:106:0) after 1m0s
[15:41:29.019] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:106:0)
[15:41:29.019] Timer tick, asking Buildbucket for the build status
[15:41:29.138] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:29.138] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:107:0) after 1m0s
[15:42:29.160] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:107:0)
[15:42:29.160] Timer tick, asking Buildbucket for the build status
[15:42:29.330] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:29.330] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:108:0) after 1m0s
[15:43:29.354] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:108:0)
[15:43:29.354] Timer tick, asking Buildbucket for the build status
[15:43:29.445] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:29.445] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:109:0) after 1m0s
[15:44:29.454] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:109:0)
[15:44:29.454] Timer tick, asking Buildbucket for the build status
[15:44:29.559] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:29.559] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:110:0) after 1m0s
[15:45:29.584] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:110:0)
[15:45:29.584] Timer tick, asking Buildbucket for the build status
[15:45:29.647] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:29.647] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:111:0) after 1m0s
[15:46:29.665] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:111:0)
[15:46:29.665] Timer tick, asking Buildbucket for the build status
[15:46:29.799] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:29.799] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:112:0) after 1m0s
[15:47:29.869] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:112:0)
[15:47:29.869] Timer tick, asking Buildbucket for the build status
[15:47:30.117] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:30.117] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:113:0) after 1m0s
[15:48:30.138] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:113:0)
[15:48:30.138] Timer tick, asking Buildbucket for the build status
[15:48:30.248] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:30.248] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:114:0) after 1m0s
[15:49:30.340] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:114:0)
[15:49:30.340] Timer tick, asking Buildbucket for the build status
[15:49:30.431] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:30.431] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:115:0) after 1m0s
[15:50:30.453] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:115:0)
[15:50:30.453] Timer tick, asking Buildbucket for the build status
[15:50:30.595] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:30.595] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:116:0) after 1m0s
[15:51:30.618] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:116:0)
[15:51:30.618] Timer tick, asking Buildbucket for the build status
[15:51:30.732] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:30.732] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:117:0) after 1m0s
[15:52:30.819] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:117:0)
[15:52:30.819] Timer tick, asking Buildbucket for the build status
[15:52:30.911] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:30.911] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:118:0) after 1m0s
[15:53:30.930] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:118:0)
[15:53:30.930] Timer tick, asking Buildbucket for the build status
[15:53:31.002] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:31.002] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:119:0) after 1m0s
[15:54:31.060] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:119:0)
[15:54:31.060] Timer tick, asking Buildbucket for the build status
[15:54:31.127] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:31.127] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:120:0) after 1m0s
[15:55:31.193] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:120:0)
[15:55:31.193] Timer tick, asking Buildbucket for the build status
[15:55:31.247] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:31.247] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:121:0) after 1m0s
[15:56:31.280] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:121:0)
[15:56:31.280] Timer tick, asking Buildbucket for the build status
[15:56:31.414] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:31.414] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:122:0) after 1m0s
[15:57:31.412] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:122:0)
[15:57:31.412] Timer tick, asking Buildbucket for the build status
[15:57:31.573] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:31.573] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:123:0) after 1m0s
[15:58:31.599] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:123:0)
[15:58:31.599] Timer tick, asking Buildbucket for the build status
[15:58:31.707] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:31.707] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:124:0) after 1m0s
[15:59:31.743] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:124:0)
[15:59:31.743] Timer tick, asking Buildbucket for the build status
[15:59:31.808] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:31.808] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:125:0) after 1m0s
[16:00:31.837] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:125:0)
[16:00:31.837] Timer tick, asking Buildbucket for the build status
[16:00:32.014] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:32.014] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:126:0) after 1m0s
[16:01:32.038] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:126:0)
[16:01:32.038] Timer tick, asking Buildbucket for the build status
[16:01:32.092] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:32.092] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:127:0) after 1m0s
[16:02:32.177] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:127:0)
[16:02:32.177] Timer tick, asking Buildbucket for the build status
[16:02:32.704] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:32.704] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:128:0) after 1m0s
[16:03:32.832] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:128:0)
[16:03:32.832] Timer tick, asking Buildbucket for the build status
[16:03:32.925] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:32.925] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:129:0) after 1m0s
[16:04:32.929] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:129:0)
[16:04:32.929] Timer tick, asking Buildbucket for the build status
[16:04:33.139] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:33.139] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:130:0) after 1m0s
[16:05:33.217] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:130:0)
[16:05:33.217] Timer tick, asking Buildbucket for the build status
[16:05:33.429] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:33.429] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:131:0) after 1m0s
[16:06:33.489] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:131:0)
[16:06:33.489] Timer tick, asking Buildbucket for the build status
[16:06:33.669] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:33.669] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:132:0) after 1m0s
[16:07:33.826] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:132:0)
[16:07:33.826] Timer tick, asking Buildbucket for the build status
[16:07:34.098] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:34.098] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:133:0) after 1m0s
[16:08:34.122] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:133:0)
[16:08:34.122] Timer tick, asking Buildbucket for the build status
[16:08:34.187] Build 8859210170167890048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:34.187] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9024640232102416464:134:0) after 1m0s
[16:09:24.577] Received PubSub notification, asking Buildbucket for the build status
[16:09:24.632] Build 8859210170167890048: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[16:09:24.632] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1609603762943188",
"created_by": "project:chromium",
"created_ts": "1609595819273962",
"failure_reason": "BUILD_FAILURE",
"id": "8859210170167890048",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.browser.omnibox.OmniboxTest#testSecurityIconOnHTTPS\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784\", \"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-7-6p7k\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 7048, \"got_angle_revision\": \"bf02c31bec07a549cc8eea26ad0e63143954643d\", \"got_dawn_revision\": \"86980018b3f2786aeb5ded1220ec94bc927fa6b2\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784\", \"got_revision_cp\": \"refs/heads/master@{#839938}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"ff29e249d3179766a40c9486183559fe3e5c1456\", \"got_v8_revision\": \"a3f2933bb6d06bd7473ccbed77714874e6bf63b3\", \"got_v8_revision_cp\": \"refs/heads/8.9.201@{#1}\", \"got_webrtc_revision\": \"2b87dd7c40c6f8bb4c6e962cd16fbee678e4b0c5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32899}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.android:android-bfcache-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784\", \"swarm_hashes_refs/heads/master(at){#839938}_without_patch\": {\"android_browsertests\": \"dbd1c3f96fcd0f715f355a315faba664d9e30221\", \"chrome_public_test_apk\": \"72c0bb34973cafcc223ed02acedb91eca6a52ad6\", \"content_browsertests\": \"e923e6c6af3f450558922533ccd92ba762695f2e\", \"content_shell_test_apk\": \"ab33012911acddc99d0d75e5ab100d5b0d6be363\", \"content_unittests\": \"30f22aa79a7bbf9065f03974b9d30e32eb6bcfc4\", \"unit_tests\": \"0f5a1f26bcb196bfbc38b4b825c766272e435f2d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_7a9f94695aa83f7478015e01762e75301e67c95c681ec0592232bd343861e191_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_f5610824250c57fc28679fbc8606252c3dbaca731fb7f2a4bebf1e0fc7f48a3a_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-7-6p7k\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.browser.omnibox.OmniboxTest#testSecurityIconOnHTTPS\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1609597661899451",
"status": "COMPLETED",
"status_changed_ts": "1609597662398901",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/7048",
"builder:android-bfcache-rel",
"buildset:commit/git/dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd63459b1f6fcdbfbeec1e8ff527165f7c8b7784",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024640232102416464",
"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/8859210170167890048/+/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:50dc34a0b0e2f610",
"user_agent:luci-scheduler"
],
"updated_ts": "1609603764247650",
"url": "https://ci.chromium.org/b/8859210170167890048",
"utcnow_ts": "1609603764624694"
}
}
[16:09:24.632] Invocation finished in 2h12m26.587204229s with status FAILED