[13:08:11.241] New invocation is queued and will start shortly
[13:08:12.364] Starting the invocation (attempt 1)
[13:08:12.401] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:08:12.405] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:08:12.405] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026727031328624736",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"21027a57af07d3625d2c4f7e8fb1d3e5c33b194c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9026727031328624736",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/21027a57af07d3625d2c4f7e8fb1d3e5c33b194c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21027a57af07d3625d2c4f7e8fb1d3e5c33b194c",
"gitiles_ref:refs/heads/master"
]
}
[13:08:13.259] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607605692540936",
"id": "8861296969297756720",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21027a57af07d3625d2c4f7e8fb1d3e5c33b194c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607605692957832",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/6616",
"builder:android-bfcache-rel",
"buildset:commit/git/21027a57af07d3625d2c4f7e8fb1d3e5c33b194c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21027a57af07d3625d2c4f7e8fb1d3e5c33b194c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026727031328624736",
"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/8861296969297756720/+/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": "1607605692957955",
"url": "https://ci.chromium.org/b/8861296969297756720",
"utcnow_ts": "1607605693251421"
}
}
[13:08:13.259] Task URL: https://ci.chromium.org/b/8861296969297756720
[13:08:13.259] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:2:0) after 1m0s
[13:09:13.308] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:2:0)
[13:09:13.308] Timer tick, asking Buildbucket for the build status
[13:09:13.589] Build 8861296969297756720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:09:13.589] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:3:0) after 1m0s
[13:09:32.216] Received PubSub notification, asking Buildbucket for the build status
[13:09:32.435] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:13.650] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:3:0)
[13:10:13.650] Timer tick, asking Buildbucket for the build status
[13:10:13.780] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:13.781] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:5:0) after 1m0s
[13:11:13.830] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:5:0)
[13:11:13.830] Timer tick, asking Buildbucket for the build status
[13:11:13.941] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:13.941] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:6:0) after 1m0s
[13:12:13.970] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:6:0)
[13:12:13.970] Timer tick, asking Buildbucket for the build status
[13:12:14.152] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:14.152] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:7:0) after 1m0s
[13:13:14.206] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:7:0)
[13:13:14.206] Timer tick, asking Buildbucket for the build status
[13:13:14.338] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:14.338] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:8:0) after 1m0s
[13:14:14.365] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:8:0)
[13:14:14.365] Timer tick, asking Buildbucket for the build status
[13:14:14.503] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:14.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:9:0) after 1m0s
[13:15:14.586] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:9:0)
[13:15:14.586] Timer tick, asking Buildbucket for the build status
[13:15:14.889] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:14.889] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:10:0) after 1m0s
[13:16:14.916] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:10:0)
[13:16:14.916] Timer tick, asking Buildbucket for the build status
[13:16:15.034] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:15.034] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:11:0) after 1m0s
[13:17:15.056] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:11:0)
[13:17:15.057] Timer tick, asking Buildbucket for the build status
[13:17:15.247] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:15.247] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:12:0) after 1m0s
[13:18:15.299] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:12:0)
[13:18:15.299] Timer tick, asking Buildbucket for the build status
[13:18:15.779] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:15.779] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:13:0) after 1m0s
[13:19:15.799] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:13:0)
[13:19:15.799] Timer tick, asking Buildbucket for the build status
[13:19:15.919] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:15.919] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:14:0) after 1m0s
[13:20:15.948] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:14:0)
[13:20:15.948] Timer tick, asking Buildbucket for the build status
[13:20:16.022] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:16.022] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:15:0) after 1m0s
[13:21:16.001] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:15:0)
[13:21:16.001] Timer tick, asking Buildbucket for the build status
[13:21:16.312] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:16.312] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:16:0) after 1m0s
[13:22:16.369] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:16:0)
[13:22:16.369] Timer tick, asking Buildbucket for the build status
[13:22:16.656] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:16.656] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:17:0) after 1m0s
[13:23:16.745] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:17:0)
[13:23:16.745] Timer tick, asking Buildbucket for the build status
[13:23:16.924] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:16.924] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:18:0) after 1m0s
[13:24:17.032] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:18:0)
[13:24:17.032] Timer tick, asking Buildbucket for the build status
[13:24:17.129] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:17.129] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:19:0) after 1m0s
[13:25:17.177] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:19:0)
[13:25:17.177] Timer tick, asking Buildbucket for the build status
[13:25:17.242] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:17.242] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:20:0) after 1m0s
[13:26:17.312] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:20:0)
[13:26:17.312] Timer tick, asking Buildbucket for the build status
[13:26:17.371] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:17.371] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:21:0) after 1m0s
[13:27:17.395] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:21:0)
[13:27:17.395] Timer tick, asking Buildbucket for the build status
[13:27:17.522] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:17.522] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:22:0) after 1m0s
[13:28:17.575] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:22:0)
[13:28:17.575] Timer tick, asking Buildbucket for the build status
[13:28:17.685] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:17.685] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:23:0) after 1m0s
[13:29:17.759] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:23:0)
[13:29:17.759] Timer tick, asking Buildbucket for the build status
[13:29:17.832] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:17.832] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:24:0) after 1m0s
[13:30:17.862] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:24:0)
[13:30:17.862] Timer tick, asking Buildbucket for the build status
[13:30:17.957] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:17.957] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:25:0) after 1m0s
[13:31:18.008] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:25:0)
[13:31:18.008] Timer tick, asking Buildbucket for the build status
[13:31:18.096] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:18.096] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:26:0) after 1m0s
[13:32:18.124] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:26:0)
[13:32:18.124] Timer tick, asking Buildbucket for the build status
[13:32:18.186] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:18.186] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:27:0) after 1m0s
[13:33:18.294] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:27:0)
[13:33:18.294] Timer tick, asking Buildbucket for the build status
[13:33:18.497] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:18.497] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:28:0) after 1m0s
[13:34:18.519] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:28:0)
[13:34:18.520] Timer tick, asking Buildbucket for the build status
[13:34:18.626] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:18.626] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:29:0) after 1m0s
[13:35:18.668] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:29:0)
[13:35:18.668] Timer tick, asking Buildbucket for the build status
[13:35:18.754] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:18.754] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:30:0) after 1m0s
[13:36:18.778] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:30:0)
[13:36:18.778] Timer tick, asking Buildbucket for the build status
[13:36:18.863] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:18.863] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:31:0) after 1m0s
[13:37:18.886] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:31:0)
[13:37:18.886] Timer tick, asking Buildbucket for the build status
[13:37:18.961] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:18.961] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:32:0) after 1m0s
[13:38:18.980] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:32:0)
[13:38:18.980] Timer tick, asking Buildbucket for the build status
[13:38:19.128] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:19.128] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:33:0) after 1m0s
[13:39:19.167] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:33:0)
[13:39:19.167] Timer tick, asking Buildbucket for the build status
[13:39:19.224] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:19.224] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:34:0) after 1m0s
[13:40:19.314] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:34:0)
[13:40:19.314] Timer tick, asking Buildbucket for the build status
[13:40:19.373] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:19.373] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:35:0) after 1m0s
[13:41:19.431] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:35:0)
[13:41:19.431] Timer tick, asking Buildbucket for the build status
[13:41:20.446] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:20.446] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:36:0) after 1m0s
[13:42:20.526] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:36:0)
[13:42:20.526] Timer tick, asking Buildbucket for the build status
[13:42:20.600] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:20.600] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:37:0) after 1m0s
[13:43:20.602] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:37:0)
[13:43:20.602] Timer tick, asking Buildbucket for the build status
[13:43:20.708] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:20.708] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:38:0) after 1m0s
[13:44:20.769] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:38:0)
[13:44:20.769] Timer tick, asking Buildbucket for the build status
[13:44:21.147] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:21.147] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:39:0) after 1m0s
[13:45:21.207] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:39:0)
[13:45:21.207] Timer tick, asking Buildbucket for the build status
[13:45:21.346] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:21.346] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:40:0) after 1m0s
[13:46:21.434] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:40:0)
[13:46:21.434] Timer tick, asking Buildbucket for the build status
[13:46:21.544] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:21.544] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:41:0) after 1m0s
[13:47:21.675] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:41:0)
[13:47:21.675] Timer tick, asking Buildbucket for the build status
[13:47:21.791] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:21.791] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:42:0) after 1m0s
[13:48:21.791] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:42:0)
[13:48:21.791] Timer tick, asking Buildbucket for the build status
[13:48:21.959] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:21.959] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:43:0) after 1m0s
[13:49:22.016] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:43:0)
[13:49:22.016] Timer tick, asking Buildbucket for the build status
[13:49:22.150] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:22.150] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:44:0) after 1m0s
[13:50:22.201] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:44:0)
[13:50:22.201] Timer tick, asking Buildbucket for the build status
[13:50:22.274] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:22.274] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:45:0) after 1m0s
[13:51:22.347] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:45:0)
[13:51:22.347] Timer tick, asking Buildbucket for the build status
[13:51:22.474] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:22.474] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:46:0) after 1m0s
[13:52:22.567] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:46:0)
[13:52:22.567] Timer tick, asking Buildbucket for the build status
[13:52:22.642] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:22.642] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:47:0) after 1m0s
[13:53:22.686] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:47:0)
[13:53:22.686] Timer tick, asking Buildbucket for the build status
[13:53:22.870] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:22.870] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:48:0) after 1m0s
[13:54:22.956] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:48:0)
[13:54:22.956] Timer tick, asking Buildbucket for the build status
[13:54:23.158] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:23.158] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:49:0) after 1m0s
[13:55:23.181] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:49:0)
[13:55:23.181] Timer tick, asking Buildbucket for the build status
[13:55:23.292] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:23.292] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:50:0) after 1m0s
[13:56:23.316] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:50:0)
[13:56:23.316] Timer tick, asking Buildbucket for the build status
[13:56:23.752] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:23.752] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:51:0) after 1m0s
[13:57:23.768] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:51:0)
[13:57:23.768] Timer tick, asking Buildbucket for the build status
[13:57:23.856] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:23.856] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:52:0) after 1m0s
[13:58:23.879] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:52:0)
[13:58:23.879] Timer tick, asking Buildbucket for the build status
[13:58:24.407] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:24.407] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:53:0) after 1m0s
[13:59:24.498] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:53:0)
[13:59:24.499] Timer tick, asking Buildbucket for the build status
[13:59:24.599] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:24.599] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:54:0) after 1m0s
[14:00:24.638] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:54:0)
[14:00:24.638] Timer tick, asking Buildbucket for the build status
[14:00:25.001] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:25.001] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:55:0) after 1m0s
[14:01:25.065] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:55:0)
[14:01:25.065] Timer tick, asking Buildbucket for the build status
[14:01:25.143] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:25.143] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:56:0) after 1m0s
[14:02:25.301] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:56:0)
[14:02:25.301] Timer tick, asking Buildbucket for the build status
[14:02:25.430] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:25.430] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:57:0) after 1m0s
[14:03:25.471] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:57:0)
[14:03:25.471] Timer tick, asking Buildbucket for the build status
[14:03:25.568] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:25.568] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:58:0) after 1m0s
[14:04:25.654] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:58:0)
[14:04:25.654] Timer tick, asking Buildbucket for the build status
[14:04:25.759] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:25.759] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:59:0) after 1m0s
[14:05:25.827] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:59:0)
[14:05:25.827] Timer tick, asking Buildbucket for the build status
[14:05:25.943] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:25.943] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:60:0) after 1m0s
[14:06:26.033] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:60:0)
[14:06:26.033] Timer tick, asking Buildbucket for the build status
[14:06:26.104] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:26.104] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:61:0) after 1m0s
[14:07:26.185] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:61:0)
[14:07:26.185] Timer tick, asking Buildbucket for the build status
[14:07:26.255] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:26.255] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:62:0) after 1m0s
[14:08:26.336] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:62:0)
[14:08:26.337] Timer tick, asking Buildbucket for the build status
[14:08:26.448] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:26.448] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:63:0) after 1m0s
[14:09:26.544] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:63:0)
[14:09:26.544] Timer tick, asking Buildbucket for the build status
[14:09:26.617] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:26.617] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:64:0) after 1m0s
[14:10:26.693] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:64:0)
[14:10:26.693] Timer tick, asking Buildbucket for the build status
[14:10:26.801] Build 8861296969297756720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:26.801] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9026727031328624736:65:0) after 1m0s
[14:10:49.108] Received PubSub notification, asking Buildbucket for the build status
[14:10:49.413] Build 8861296969297756720: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[14:10:49.413] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607609448576452",
"created_by": "project:chromium",
"created_ts": "1607605692540936",
"failure_reason": "BUILD_FAILURE",
"id": "8861296969297756720",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21027a57af07d3625d2c4f7e8fb1d3e5c33b194c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 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.keyboard_accessory.all_passwords_bottom_sheet.AllPasswordsBottomSheetViewTest#testCredentialsChangedByModel\\n\\n**bf_cache_content_shell_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.content.browser.MediaSessionTest#testVideoStopsIfLostFocus\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- MediaSessionBrowserTest.MultiplePlayersPlayPause\\n\\n- MediaSessionBrowserTest.SimplePlayPause\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$build/goma.jobs\", \"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"21027a57af07d3625d2c4f7e8fb1d3e5c33b194c\", \"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-90-fsn8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 6616, \"got_angle_revision\": \"55b7f38f9036cc5d6b12cd77d56350799653efea\", \"got_dawn_revision\": \"29fd62989338a0d5812bc654a3afee6dc684bfc4\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"21027a57af07d3625d2c4f7e8fb1d3e5c33b194c\", \"got_revision_cp\": \"refs/heads/master@{#835630}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"d94a77b304f4fcb503ea037be3e5d7f2a371c4b6\", \"got_v8_revision\": \"7e546be6b2f61eb429d51abb78e973f7f623f62f\", \"got_v8_revision_cp\": \"refs/heads/8.9.126@{#1}\", \"got_webrtc_revision\": \"d7808f1c464a07c8f1e2f97ec7ee92fda998d590\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32804}\", \"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\": \"21027a57af07d3625d2c4f7e8fb1d3e5c33b194c\", \"swarm_hashes_refs/heads/master(at){#835630}_without_patch\": {\"android_browsertests\": \"9958d3405349513704fff53188bdb4fa865939ea\", \"chrome_public_test_apk\": \"00d84c967ca88690ccba2cc02c43d1ce75a8f503\", \"content_browsertests\": \"e6c00a4164df31a0a8c8253936589057775466b6\", \"content_shell_test_apk\": \"d40885d311822a3ea98b6f88e006d250fd329b3f\", \"content_unittests\": \"0390a6981e2cf6ab111d3371cf5706e08ceec768\", \"unit_tests\": \"68087824e3468ef1633e788817e7f7bd2b1af151\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_573c606f18492d6cde6d25a02b12203725732038b1c2909b0b80126d2afb25c2_v2\", \"builder_6ce0efae7132fe8ed0fd2e62adc5ba9342c3a2d5840b43c14152c2007d6a5024_v2\", \"builder_847b8249ec8334f5a90b5e0f1190646f2316bd1dfca5c1d0952633ff4ae3048f_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-90-fsn8\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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\": \"3 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.keyboard_accessory.all_passwords_bottom_sheet.AllPasswordsBottomSheetViewTest#testCredentialsChangedByModel\\n\\n**bf_cache_content_shell_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.content.browser.MediaSessionTest#testVideoStopsIfLostFocus\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- MediaSessionBrowserTest.MultiplePlayersPlayPause\\n\\n- MediaSessionBrowserTest.SimplePlayPause\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607605771521358",
"status": "COMPLETED",
"status_changed_ts": "1607605771838438",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/6616",
"builder:android-bfcache-rel",
"buildset:commit/git/21027a57af07d3625d2c4f7e8fb1d3e5c33b194c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21027a57af07d3625d2c4f7e8fb1d3e5c33b194c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026727031328624736",
"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/8861296969297756720/+/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:506595b3f8157010",
"user_agent:luci-scheduler"
],
"updated_ts": "1607609448673646",
"url": "https://ci.chromium.org/b/8861296969297756720",
"utcnow_ts": "1607609449390733"
}
}
[14:10:49.413] Invocation finished in 1h2m38.194359807s with status FAILED