[20:57:09.229] New invocation is queued and will start shortly
[20:57:10.361] Starting the invocation (attempt 1)
[20:57:10.403] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:57:10.403] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:57:10.404] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9033039314152869568",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0729852ddc32f78474e9232b3c22437d08df7662\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9033039314152869568",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/0729852ddc32f78474e9232b3c22437d08df7662",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0729852ddc32f78474e9232b3c22437d08df7662",
"gitiles_ref:refs/heads/master"
]
}
[20:57:14.581] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1601585830941525",
"id": "8867609251693608464",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0729852ddc32f78474e9232b3c22437d08df7662\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1601585834156792",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/5298",
"builder:android-bfcache-rel",
"buildset:commit/git/0729852ddc32f78474e9232b3c22437d08df7662",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0729852ddc32f78474e9232b3c22437d08df7662",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9033039314152869568",
"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/8867609251693608464/+/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": "1601585834156974",
"url": "https://ci.chromium.org/b/8867609251693608464",
"utcnow_ts": "1601585834553606"
}
}
[20:57:14.581] Task URL: https://ci.chromium.org/b/8867609251693608464
[20:57:14.581] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:2:0) after 1m0s
[20:58:14.685] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:2:0)
[20:58:14.685] Timer tick, asking Buildbucket for the build status
[20:58:14.824] Build 8867609251693608464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:58:14.824] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:3:0) after 1m0s
[20:59:15.001] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:3:0)
[20:59:15.001] Timer tick, asking Buildbucket for the build status
[20:59:16.350] Build 8867609251693608464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:59:16.350] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:4:0) after 1m0s
[21:00:16.468] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:4:0)
[21:00:16.468] Timer tick, asking Buildbucket for the build status
[21:00:16.920] Build 8867609251693608464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:00:16.920] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:5:0) after 1m0s
[21:01:16.993] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:5:0)
[21:01:16.993] Timer tick, asking Buildbucket for the build status
[21:01:18.236] Build 8867609251693608464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:01:18.236] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:6:0) after 1m0s
[21:02:18.305] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:6:0)
[21:02:18.305] Timer tick, asking Buildbucket for the build status
[21:02:18.425] Build 8867609251693608464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:02:18.425] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:7:0) after 1m0s
[21:03:18.431] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:7:0)
[21:03:18.431] Timer tick, asking Buildbucket for the build status
[21:03:18.697] Build 8867609251693608464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:03:18.697] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:8:0) after 1m0s
[21:04:18.734] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:8:0)
[21:04:18.734] Timer tick, asking Buildbucket for the build status
[21:04:18.843] Build 8867609251693608464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:04:18.843] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:9:0) after 1m0s
[21:05:18.893] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:9:0)
[21:05:18.893] Timer tick, asking Buildbucket for the build status
[21:05:18.999] Build 8867609251693608464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:05:18.999] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:10:0) after 1m0s
[21:06:19.028] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:10:0)
[21:06:19.028] Timer tick, asking Buildbucket for the build status
[21:06:19.153] Build 8867609251693608464: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:06:19.153] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:11:0) after 1m0s
[21:07:08.438] Received PubSub notification, asking Buildbucket for the build status
[21:07:08.591] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:19.181] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:11:0)
[21:07:19.181] Timer tick, asking Buildbucket for the build status
[21:07:19.361] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:19.361] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:13:0) after 1m0s
[21:08:19.383] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:13:0)
[21:08:19.383] Timer tick, asking Buildbucket for the build status
[21:08:19.462] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:19.462] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:14:0) after 1m0s
[21:09:19.467] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:14:0)
[21:09:19.467] Timer tick, asking Buildbucket for the build status
[21:09:19.564] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:19.564] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:15:0) after 1m0s
[21:10:19.606] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:15:0)
[21:10:19.606] Timer tick, asking Buildbucket for the build status
[21:10:19.760] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:19.761] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:16:0) after 1m0s
[21:11:19.855] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:16:0)
[21:11:19.855] Timer tick, asking Buildbucket for the build status
[21:11:19.922] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:19.922] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:17:0) after 1m0s
[21:12:19.980] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:17:0)
[21:12:19.980] Timer tick, asking Buildbucket for the build status
[21:12:20.127] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:20.127] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:18:0) after 1m0s
[21:13:20.197] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:18:0)
[21:13:20.197] Timer tick, asking Buildbucket for the build status
[21:13:20.339] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:20.339] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:19:0) after 1m0s
[21:14:20.397] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:19:0)
[21:14:20.397] Timer tick, asking Buildbucket for the build status
[21:14:20.593] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:20.593] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:20:0) after 1m0s
[21:15:20.603] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:20:0)
[21:15:20.603] Timer tick, asking Buildbucket for the build status
[21:15:20.982] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:20.982] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:21:0) after 1m0s
[21:16:21.058] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:21:0)
[21:16:21.058] Timer tick, asking Buildbucket for the build status
[21:16:21.137] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:21.137] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:22:0) after 1m0s
[21:17:21.280] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:22:0)
[21:17:21.280] Timer tick, asking Buildbucket for the build status
[21:17:21.491] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:21.491] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:23:0) after 1m0s
[21:18:21.519] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:23:0)
[21:18:21.519] Timer tick, asking Buildbucket for the build status
[21:18:21.990] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:21.990] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:24:0) after 1m0s
[21:19:21.997] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:24:0)
[21:19:21.997] Timer tick, asking Buildbucket for the build status
[21:19:22.486] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:22.486] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:25:0) after 1m0s
[21:20:22.561] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:25:0)
[21:20:22.561] Timer tick, asking Buildbucket for the build status
[21:20:22.688] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:22.688] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:26:0) after 1m0s
[21:21:22.666] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:26:0)
[21:21:22.666] Timer tick, asking Buildbucket for the build status
[21:21:22.831] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:22.831] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:27:0) after 1m0s
[21:22:22.815] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:27:0)
[21:22:22.816] Timer tick, asking Buildbucket for the build status
[21:22:22.988] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:22.988] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:28:0) after 1m0s
[21:23:23.096] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:28:0)
[21:23:23.096] Timer tick, asking Buildbucket for the build status
[21:23:23.282] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:23.282] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:29:0) after 1m0s
[21:24:23.338] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:29:0)
[21:24:23.338] Timer tick, asking Buildbucket for the build status
[21:24:23.548] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:23.548] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:30:0) after 1m0s
[21:25:23.556] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:30:0)
[21:25:23.556] Timer tick, asking Buildbucket for the build status
[21:25:23.639] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:23.639] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:31:0) after 1m0s
[21:26:23.663] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:31:0)
[21:26:23.663] Timer tick, asking Buildbucket for the build status
[21:26:23.751] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:23.751] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:32:0) after 1m0s
[21:27:23.790] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:32:0)
[21:27:23.790] Timer tick, asking Buildbucket for the build status
[21:27:24.009] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:24.009] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:33:0) after 1m0s
[21:28:24.048] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:33:0)
[21:28:24.048] Timer tick, asking Buildbucket for the build status
[21:28:24.132] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:24.132] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:34:0) after 1m0s
[21:29:24.150] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:34:0)
[21:29:24.150] Timer tick, asking Buildbucket for the build status
[21:29:24.410] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:24.410] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:35:0) after 1m0s
[21:30:24.392] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:35:0)
[21:30:24.392] Timer tick, asking Buildbucket for the build status
[21:30:24.516] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:24.516] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:36:0) after 1m0s
[21:31:24.539] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:36:0)
[21:31:24.539] Timer tick, asking Buildbucket for the build status
[21:31:24.841] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:24.841] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:37:0) after 1m0s
[21:32:24.881] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:37:0)
[21:32:24.881] Timer tick, asking Buildbucket for the build status
[21:32:25.399] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:25.399] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:38:0) after 1m0s
[21:33:25.442] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:38:0)
[21:33:25.442] Timer tick, asking Buildbucket for the build status
[21:33:25.954] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:25.954] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:39:0) after 1m0s
[21:34:26.026] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:39:0)
[21:34:26.026] Timer tick, asking Buildbucket for the build status
[21:34:26.118] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:26.118] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:40:0) after 1m0s
[21:35:26.165] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:40:0)
[21:35:26.165] Timer tick, asking Buildbucket for the build status
[21:35:26.234] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:26.234] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:41:0) after 1m0s
[21:36:26.261] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:41:0)
[21:36:26.261] Timer tick, asking Buildbucket for the build status
[21:36:26.404] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:26.404] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:42:0) after 1m0s
[21:37:26.441] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:42:0)
[21:37:26.441] Timer tick, asking Buildbucket for the build status
[21:37:26.563] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:26.563] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:43:0) after 1m0s
[21:38:26.562] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:43:0)
[21:38:26.562] Timer tick, asking Buildbucket for the build status
[21:38:26.723] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:26.723] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:44:0) after 1m0s
[21:39:26.699] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:44:0)
[21:39:26.699] Timer tick, asking Buildbucket for the build status
[21:39:26.944] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:26.944] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:45:0) after 1m0s
[21:40:26.967] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:45:0)
[21:40:26.967] Timer tick, asking Buildbucket for the build status
[21:40:27.397] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:27.397] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:46:0) after 1m0s
[21:41:27.581] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:46:0)
[21:41:27.581] Timer tick, asking Buildbucket for the build status
[21:41:27.681] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:27.681] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:47:0) after 1m0s
[21:42:27.678] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:47:0)
[21:42:27.678] Timer tick, asking Buildbucket for the build status
[21:42:28.019] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:28.019] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:48:0) after 1m0s
[21:43:28.066] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:48:0)
[21:43:28.066] Timer tick, asking Buildbucket for the build status
[21:43:30.061] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:30.061] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:49:0) after 1m0s
[21:44:30.162] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:49:0)
[21:44:30.162] Timer tick, asking Buildbucket for the build status
[21:44:30.285] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:30.285] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:50:0) after 1m0s
[21:45:30.343] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:50:0)
[21:45:30.343] Timer tick, asking Buildbucket for the build status
[21:45:30.669] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:30.669] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:51:0) after 1m0s
[21:46:30.731] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:51:0)
[21:46:30.731] Timer tick, asking Buildbucket for the build status
[21:46:30.796] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:30.796] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:52:0) after 1m0s
[21:47:30.803] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:52:0)
[21:47:30.803] Timer tick, asking Buildbucket for the build status
[21:47:30.989] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:30.989] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:53:0) after 1m0s
[21:48:31.046] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:53:0)
[21:48:31.046] Timer tick, asking Buildbucket for the build status
[21:48:31.112] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:31.112] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:54:0) after 1m0s
[21:49:31.118] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:54:0)
[21:49:31.118] Timer tick, asking Buildbucket for the build status
[21:49:31.220] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:31.220] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:55:0) after 1m0s
[21:50:31.252] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:55:0)
[21:50:31.252] Timer tick, asking Buildbucket for the build status
[21:50:31.425] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:31.425] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:56:0) after 1m0s
[21:51:31.551] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:56:0)
[21:51:31.551] Timer tick, asking Buildbucket for the build status
[21:51:31.662] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:31.662] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:57:0) after 1m0s
[21:52:31.697] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:57:0)
[21:52:31.697] Timer tick, asking Buildbucket for the build status
[21:52:31.914] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:31.915] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:58:0) after 1m0s
[21:53:31.973] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:58:0)
[21:53:31.973] Timer tick, asking Buildbucket for the build status
[21:53:32.041] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:32.041] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:59:0) after 1m0s
[21:54:32.122] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:59:0)
[21:54:32.122] Timer tick, asking Buildbucket for the build status
[21:54:32.241] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:32.241] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:60:0) after 1m0s
[21:55:32.341] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:60:0)
[21:55:32.341] Timer tick, asking Buildbucket for the build status
[21:55:35.178] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:35.178] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:61:0) after 1m0s
[21:56:35.181] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:61:0)
[21:56:35.181] Timer tick, asking Buildbucket for the build status
[21:56:35.255] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:35.255] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:62:0) after 1m0s
[21:57:35.324] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:62:0)
[21:57:35.324] Timer tick, asking Buildbucket for the build status
[21:57:36.074] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:36.074] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:63:0) after 1m0s
[21:58:36.055] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:63:0)
[21:58:36.055] Timer tick, asking Buildbucket for the build status
[21:58:36.177] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:36.177] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:64:0) after 1m0s
[21:59:36.209] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:64:0)
[21:59:36.209] Timer tick, asking Buildbucket for the build status
[21:59:36.300] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:36.300] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:65:0) after 1m0s
[22:00:36.316] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:65:0)
[22:00:36.316] Timer tick, asking Buildbucket for the build status
[22:00:36.390] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:36.390] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:66:0) after 1m0s
[22:01:36.434] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:66:0)
[22:01:36.434] Timer tick, asking Buildbucket for the build status
[22:01:36.541] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:36.541] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:67:0) after 1m0s
[22:02:36.563] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:67:0)
[22:02:36.563] Timer tick, asking Buildbucket for the build status
[22:02:36.778] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:36.778] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:68:0) after 1m0s
[22:03:36.824] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:68:0)
[22:03:36.824] Timer tick, asking Buildbucket for the build status
[22:03:37.001] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:37.001] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:69:0) after 1m0s
[22:04:37.073] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:69:0)
[22:04:37.073] Timer tick, asking Buildbucket for the build status
[22:04:37.332] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:37.333] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:70:0) after 1m0s
[22:05:37.379] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:70:0)
[22:05:37.379] Timer tick, asking Buildbucket for the build status
[22:05:37.460] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:37.460] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:71:0) after 1m0s
[22:06:37.487] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:71:0)
[22:06:37.487] Timer tick, asking Buildbucket for the build status
[22:06:37.570] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:37.570] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:72:0) after 1m0s
[22:07:37.660] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:72:0)
[22:07:37.660] Timer tick, asking Buildbucket for the build status
[22:07:37.778] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:37.778] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:73:0) after 1m0s
[22:08:37.834] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:73:0)
[22:08:37.834] Timer tick, asking Buildbucket for the build status
[22:08:37.910] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:37.910] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:74:0) after 1m0s
[22:09:37.997] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:74:0)
[22:09:37.997] Timer tick, asking Buildbucket for the build status
[22:09:38.147] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:38.147] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:75:0) after 1m0s
[22:10:38.193] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:75:0)
[22:10:38.193] Timer tick, asking Buildbucket for the build status
[22:10:38.269] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:38.269] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:76:0) after 1m0s
[22:11:38.371] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:76:0)
[22:11:38.371] Timer tick, asking Buildbucket for the build status
[22:11:38.453] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:38.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:77:0) after 1m0s
[22:12:38.508] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:77:0)
[22:12:38.508] Timer tick, asking Buildbucket for the build status
[22:12:38.806] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:38.806] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:78:0) after 1m0s
[22:13:38.945] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:78:0)
[22:13:38.945] Timer tick, asking Buildbucket for the build status
[22:13:40.873] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:40.873] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:79:0) after 1m0s
[22:14:40.879] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:79:0)
[22:14:40.879] Timer tick, asking Buildbucket for the build status
[22:14:40.973] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:40.973] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:80:0) after 1m0s
[22:15:40.997] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:80:0)
[22:15:40.997] Timer tick, asking Buildbucket for the build status
[22:15:41.083] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:41.084] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:81:0) after 1m0s
[22:16:41.111] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:81:0)
[22:16:41.111] Timer tick, asking Buildbucket for the build status
[22:16:41.240] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:41.240] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:82:0) after 1m0s
[22:17:41.336] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:82:0)
[22:17:41.336] Timer tick, asking Buildbucket for the build status
[22:17:41.642] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:41.642] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:83:0) after 1m0s
[22:18:41.654] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:83:0)
[22:18:41.654] Timer tick, asking Buildbucket for the build status
[22:18:41.742] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:41.742] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:84:0) after 1m0s
[22:19:41.747] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:84:0)
[22:19:41.747] Timer tick, asking Buildbucket for the build status
[22:19:41.840] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:41.840] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:85:0) after 1m0s
[22:20:41.903] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:85:0)
[22:20:41.903] Timer tick, asking Buildbucket for the build status
[22:20:42.097] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:42.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:86:0) after 1m0s
[22:21:42.145] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:86:0)
[22:21:42.145] Timer tick, asking Buildbucket for the build status
[22:21:42.212] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:42.212] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:87:0) after 1m0s
[22:22:42.340] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:87:0)
[22:22:42.340] Timer tick, asking Buildbucket for the build status
[22:22:42.775] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:42.775] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:88:0) after 1m0s
[22:23:42.823] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:88:0)
[22:23:42.823] Timer tick, asking Buildbucket for the build status
[22:23:42.933] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:42.933] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:89:0) after 1m0s
[22:24:42.942] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:89:0)
[22:24:42.942] Timer tick, asking Buildbucket for the build status
[22:24:43.302] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:43.302] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:90:0) after 1m0s
[22:25:43.356] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:90:0)
[22:25:43.356] Timer tick, asking Buildbucket for the build status
[22:25:43.495] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:43.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:91:0) after 1m0s
[22:26:43.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:91:0)
[22:26:43.526] Timer tick, asking Buildbucket for the build status
[22:26:43.721] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:43.721] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:92:0) after 1m0s
[22:27:43.723] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:92:0)
[22:27:43.723] Timer tick, asking Buildbucket for the build status
[22:27:43.863] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:43.863] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:93:0) after 1m0s
[22:28:44.027] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:93:0)
[22:28:44.027] Timer tick, asking Buildbucket for the build status
[22:28:44.146] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:44.146] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:94:0) after 1m0s
[22:29:44.176] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:94:0)
[22:29:44.176] Timer tick, asking Buildbucket for the build status
[22:29:44.291] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:44.291] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:95:0) after 1m0s
[22:30:44.339] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:95:0)
[22:30:44.339] Timer tick, asking Buildbucket for the build status
[22:30:44.496] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:44.496] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:96:0) after 1m0s
[22:31:44.484] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:96:0)
[22:31:44.485] Timer tick, asking Buildbucket for the build status
[22:31:44.543] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:44.543] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:97:0) after 1m0s
[22:32:44.580] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:97:0)
[22:32:44.580] Timer tick, asking Buildbucket for the build status
[22:32:44.758] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:44.758] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:98:0) after 1m0s
[22:33:44.803] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:98:0)
[22:33:44.803] Timer tick, asking Buildbucket for the build status
[22:33:45.015] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:45.015] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:99:0) after 1m0s
[22:34:45.095] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:99:0)
[22:34:45.095] Timer tick, asking Buildbucket for the build status
[22:34:45.321] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:45.321] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:100:0) after 1m0s
[22:35:45.443] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:100:0)
[22:35:45.443] Timer tick, asking Buildbucket for the build status
[22:35:45.522] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:45.522] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:101:0) after 1m0s
[22:36:45.654] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:101:0)
[22:36:45.654] Timer tick, asking Buildbucket for the build status
[22:36:45.733] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:45.733] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:102:0) after 1m0s
[22:37:45.758] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:102:0)
[22:37:45.758] Timer tick, asking Buildbucket for the build status
[22:37:46.037] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:46.038] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:103:0) after 1m0s
[22:38:46.179] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:103:0)
[22:38:46.179] Timer tick, asking Buildbucket for the build status
[22:38:46.392] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:46.393] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:104:0) after 1m0s
[22:39:46.472] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:104:0)
[22:39:46.472] Timer tick, asking Buildbucket for the build status
[22:39:46.619] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:46.619] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:105:0) after 1m0s
[22:40:46.692] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:105:0)
[22:40:46.692] Timer tick, asking Buildbucket for the build status
[22:40:46.833] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:46.833] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:106:0) after 1m0s
[22:41:46.908] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:106:0)
[22:41:46.908] Timer tick, asking Buildbucket for the build status
[22:41:46.973] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:46.973] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:107:0) after 1m0s
[22:42:46.987] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:107:0)
[22:42:46.987] Timer tick, asking Buildbucket for the build status
[22:42:47.272] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:47.272] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:108:0) after 1m0s
[22:43:47.312] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:108:0)
[22:43:47.312] Timer tick, asking Buildbucket for the build status
[22:43:47.467] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:47.467] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:109:0) after 1m0s
[22:44:47.493] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:109:0)
[22:44:47.493] Timer tick, asking Buildbucket for the build status
[22:44:47.573] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:47.573] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:110:0) after 1m0s
[22:45:47.603] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:110:0)
[22:45:47.603] Timer tick, asking Buildbucket for the build status
[22:45:47.679] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:47.679] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:111:0) after 1m0s
[22:46:47.710] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:111:0)
[22:46:47.710] Timer tick, asking Buildbucket for the build status
[22:46:48.009] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:48.009] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:112:0) after 1m0s
[22:47:48.063] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:112:0)
[22:47:48.063] Timer tick, asking Buildbucket for the build status
[22:47:48.783] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:48.783] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:113:0) after 1m0s
[22:48:48.834] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:113:0)
[22:48:48.834] Timer tick, asking Buildbucket for the build status
[22:48:49.020] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:49.020] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:114:0) after 1m0s
[22:49:49.049] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:114:0)
[22:49:49.049] Timer tick, asking Buildbucket for the build status
[22:49:49.148] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:49.148] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:115:0) after 1m0s
[22:50:49.159] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:115:0)
[22:50:49.159] Timer tick, asking Buildbucket for the build status
[22:50:49.339] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:49.339] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:116:0) after 1m0s
[22:51:49.364] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:116:0)
[22:51:49.364] Timer tick, asking Buildbucket for the build status
[22:51:49.428] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:49.428] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:117:0) after 1m0s
[22:52:49.501] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:117:0)
[22:52:49.501] Timer tick, asking Buildbucket for the build status
[22:52:49.730] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:49.730] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:118:0) after 1m0s
[22:53:49.882] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:118:0)
[22:53:49.882] Timer tick, asking Buildbucket for the build status
[22:53:49.994] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:49.994] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:119:0) after 1m0s
[22:54:50.055] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:119:0)
[22:54:50.055] Timer tick, asking Buildbucket for the build status
[22:54:50.216] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:50.216] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:120:0) after 1m0s
[22:55:50.295] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:120:0)
[22:55:50.295] Timer tick, asking Buildbucket for the build status
[22:55:50.541] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:50.541] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:121:0) after 1m0s
[22:56:50.638] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:121:0)
[22:56:50.638] Timer tick, asking Buildbucket for the build status
[22:56:51.032] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:51.032] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:122:0) after 1m0s
[22:57:51.065] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:122:0)
[22:57:51.066] Timer tick, asking Buildbucket for the build status
[22:57:51.524] Build 8867609251693608464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:51.524] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9033039314152869568:123:0) after 1m0s
[22:58:35.260] Received PubSub notification, asking Buildbucket for the build status
[22:58:35.337] Build 8867609251693608464: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:58:35.337] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1601593114603141",
"created_by": "project:chromium",
"created_ts": "1601585830941525",
"failure_reason": "BUILD_FAILURE",
"id": "8867609251693608464",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0729852ddc32f78474e9232b3c22437d08df7662\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 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.contextualsearch.ContextualSearchManagerTest#testLoggedEventId\\n\\n- org.chromium.chrome.browser.contextualsearch.ContextualSearchManagerTest#testAppMenuSuppressedWhenMaximized__enableTranslations\\n\\n- org.chromium.chrome.browser.contextualsearch.ContextualSearchManagerTest#testExpandBeforeSearchTermResolution__enableTranslations\\n\\n- org.chromium.chrome.browser.contextualsearch.ContextualSearchManagerTest#testExpandBeforeSearchTermResolution__enableLongpress\\n\\n- ...12 more failure(s) (16 total)...\\n\\n**bf_cache_unit_tests on Android device Nexus 5** failed because of:\\n\\n- DmServerUploaderTest.ProcessesRecord\\n\\n- ...1 more failure(s) (2 total)...\"}, \"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\": \"0729852ddc32f78474e9232b3c22437d08df7662\", \"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-east1-d-8-27-3yk7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 5298, \"got_angle_revision\": \"64eb64a034cb725baf3dea089f3badbbab77a0be\", \"got_dawn_revision\": \"da5828c06b4c7cbe428283a1516a4fb73d5836be\", \"got_nacl_revision\": \"69a0d6e8affc94187af10e0673592d1b238c6eb0\", \"got_revision\": \"0729852ddc32f78474e9232b3c22437d08df7662\", \"got_revision_cp\": \"refs/heads/master@{#812904}\", \"got_swarming_client_revision\": \"44c13d73156581ea09b9389001e58c23a4b8d70a\", \"got_swiftshader_revision\": \"02818d1fdd05410fa9d3ffa6f9ce313a63d03dcf\", \"got_v8_revision\": \"0d81cd72688512abcbe1601015baee390c484a6a\", \"got_v8_revision_cp\": \"refs/heads/8.7.220@{#1}\", \"got_webrtc_revision\": \"dba4db5668d6dd95475dc4e8aa42de3011b4a15e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32276}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0729852ddc32f78474e9232b3c22437d08df7662\", \"swarm_hashes\": {\"android_browsertests\": \"b18d1587dd9b434ccdf6832da50ab94921036075\", \"chrome_public_test_apk\": \"754ff15164cac6323905282273dbf641108b719b\", \"content_browsertests\": \"68de6e0684ab74bea2c808876b208757d89b9b6b\", \"content_shell_test_apk\": \"b22b0eba03b3f182333df571ec652fdcc08dc7b0\", \"content_unittests\": \"fa0448c5f7460ed024756b4da319371787dd920a\", \"unit_tests\": \"c119fbe50a6c73271fd3232411282a0d56d54012\"}, \"swarm_hashes_refs/heads/master(at){#812904}_without_patch\": {\"android_browsertests\": \"b18d1587dd9b434ccdf6832da50ab94921036075\", \"chrome_public_test_apk\": \"754ff15164cac6323905282273dbf641108b719b\", \"content_browsertests\": \"68de6e0684ab74bea2c808876b208757d89b9b6b\", \"content_shell_test_apk\": \"b22b0eba03b3f182333df571ec652fdcc08dc7b0\", \"content_unittests\": \"fa0448c5f7460ed024756b4da319371787dd920a\", \"unit_tests\": \"c119fbe50a6c73271fd3232411282a0d56d54012\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_7701d7ffc8ab5fe38a709c77d4f18478e80f1a1d01dd8053f239f119334d81d1_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_b224075beee246a5ffe9706a23163fae567137407ac5f1b69c50b4dcd22edd9b_v2\", \"builder_c2cb72df9b5576800da27660aa92911a0b5cae945b8f5ba1b2e88b64dd1a5b42_v2\", \"builder_dd987fcd94b516d81fcf1552cd73a9eed370c3dc02cc1a52ddee828f1ab8817d_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-east1-d-8-27-3yk7\"], \"image\": [\"chrome-xenial-20091600-9ddf7e422ac\"], \"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\": [\"5564-e41b668\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"2 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.contextualsearch.ContextualSearchManagerTest#testLoggedEventId\\n\\n- org.chromium.chrome.browser.contextualsearch.ContextualSearchManagerTest#testAppMenuSuppressedWhenMaximized__enableTranslations\\n\\n- org.chromium.chrome.browser.contextualsearch.ContextualSearchManagerTest#testExpandBeforeSearchTermResolution__enableTranslations\\n\\n- org.chromium.chrome.browser.contextualsearch.ContextualSearchManagerTest#testExpandBeforeSearchTermResolution__enableLongpress\\n\\n- ...12 more failure(s) (16 total)...\\n\\n**bf_cache_unit_tests on Android device Nexus 5** failed because of:\\n\\n- DmServerUploaderTest.ProcessesRecord\\n\\n- ...1 more failure(s) (2 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1601586427623606",
"status": "COMPLETED",
"status_changed_ts": "1601586428160090",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/5298",
"builder:android-bfcache-rel",
"buildset:commit/git/0729852ddc32f78474e9232b3c22437d08df7662",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0729852ddc32f78474e9232b3c22437d08df7662",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9033039314152869568",
"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/8867609251693608464/+/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:4efec5f378b4da10",
"user_agent:luci-scheduler"
],
"updated_ts": "1601593114717403",
"url": "https://ci.chromium.org/b/8867609251693608464",
"utcnow_ts": "1601593115328707"
}
}
[22:58:35.337] Invocation finished in 2h1m26.12527659s with status FAILED