[01:54:31.124] New invocation is queued and will start shortly
[01:54:32.367] Starting the invocation (attempt 1)
[01:54:32.422] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:54:32.422] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:54:32.422] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022964342299509104",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"41f7d42e946c141557ef7a4894b608181daf8798\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9022964342299509104",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/41f7d42e946c141557ef7a4894b608181daf8798",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41f7d42e946c141557ef7a4894b608181daf8798",
"gitiles_ref:refs/heads/master"
]
}
[01:54:34.108] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611194072509245",
"id": "8857534280182940880",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"41f7d42e946c141557ef7a4894b608181daf8798\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611194072981783",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/7373",
"builder:android-bfcache-rel",
"buildset:commit/git/41f7d42e946c141557ef7a4894b608181daf8798",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41f7d42e946c141557ef7a4894b608181daf8798",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022964342299509104",
"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/8857534280182940880/+/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": "1611194072981903",
"url": "https://ci.chromium.org/b/8857534280182940880",
"utcnow_ts": "1611194074097509"
}
}
[01:54:34.108] Task URL: https://ci.chromium.org/b/8857534280182940880
[01:54:34.108] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:2:0) after 1m0s
[01:54:36.325] Received PubSub notification, asking Buildbucket for the build status
[01:54:36.653] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:34.243] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:2:0)
[01:55:34.243] Timer tick, asking Buildbucket for the build status
[01:55:34.350] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:34.350] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:4:0) after 1m0s
[01:56:34.423] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:4:0)
[01:56:34.423] Timer tick, asking Buildbucket for the build status
[01:56:34.528] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:34.528] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:5:0) after 1m0s
[01:57:34.568] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:5:0)
[01:57:34.568] Timer tick, asking Buildbucket for the build status
[01:57:34.632] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:34.632] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:6:0) after 1m0s
[01:58:34.663] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:6:0)
[01:58:34.663] Timer tick, asking Buildbucket for the build status
[01:58:34.803] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:34.803] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:7:0) after 1m0s
[01:59:34.849] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:7:0)
[01:59:34.849] Timer tick, asking Buildbucket for the build status
[01:59:35.044] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:35.044] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:8:0) after 1m0s
[02:00:35.067] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:8:0)
[02:00:35.067] Timer tick, asking Buildbucket for the build status
[02:00:35.390] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:35.390] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:9:0) after 1m0s
[02:01:35.415] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:9:0)
[02:01:35.415] Timer tick, asking Buildbucket for the build status
[02:01:35.523] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:35.523] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:10:0) after 1m0s
[02:02:35.570] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:10:0)
[02:02:35.570] Timer tick, asking Buildbucket for the build status
[02:02:35.636] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:35.636] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:11:0) after 1m0s
[02:03:35.744] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:11:0)
[02:03:35.744] Timer tick, asking Buildbucket for the build status
[02:03:36.178] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:36.178] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:12:0) after 1m0s
[02:04:36.225] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:12:0)
[02:04:36.225] Timer tick, asking Buildbucket for the build status
[02:04:36.680] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:36.680] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:13:0) after 1m0s
[02:05:36.773] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:13:0)
[02:05:36.773] Timer tick, asking Buildbucket for the build status
[02:05:37.238] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:37.238] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:14:0) after 1m0s
[02:06:37.337] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:14:0)
[02:06:37.337] Timer tick, asking Buildbucket for the build status
[02:06:37.800] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:37.800] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:15:0) after 1m0s
[02:07:37.928] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:15:0)
[02:07:37.928] Timer tick, asking Buildbucket for the build status
[02:07:38.035] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:38.035] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:16:0) after 1m0s
[02:08:38.183] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:16:0)
[02:08:38.183] Timer tick, asking Buildbucket for the build status
[02:08:38.583] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:38.583] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:17:0) after 1m0s
[02:09:38.762] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:17:0)
[02:09:38.762] Timer tick, asking Buildbucket for the build status
[02:09:39.292] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:39.292] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:18:0) after 1m0s
[02:10:39.354] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:18:0)
[02:10:39.354] Timer tick, asking Buildbucket for the build status
[02:10:39.416] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:39.416] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:19:0) after 1m0s
[02:11:39.465] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:19:0)
[02:11:39.465] Timer tick, asking Buildbucket for the build status
[02:11:39.536] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:39.536] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:20:0) after 1m0s
[02:12:39.598] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:20:0)
[02:12:39.598] Timer tick, asking Buildbucket for the build status
[02:12:39.670] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:39.670] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:21:0) after 1m0s
[02:13:39.692] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:21:0)
[02:13:39.692] Timer tick, asking Buildbucket for the build status
[02:13:40.008] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:40.008] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:22:0) after 1m0s
[02:14:40.007] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:22:0)
[02:14:40.007] Timer tick, asking Buildbucket for the build status
[02:14:40.132] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:40.132] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:23:0) after 1m0s
[02:15:40.218] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:23:0)
[02:15:40.218] Timer tick, asking Buildbucket for the build status
[02:15:40.284] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:40.284] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:24:0) after 1m0s
[02:16:40.320] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:24:0)
[02:16:40.320] Timer tick, asking Buildbucket for the build status
[02:16:40.381] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:40.381] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:25:0) after 1m0s
[02:17:40.372] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:25:0)
[02:17:40.372] Timer tick, asking Buildbucket for the build status
[02:17:40.428] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:40.428] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:26:0) after 1m0s
[02:18:40.477] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:26:0)
[02:18:40.477] Timer tick, asking Buildbucket for the build status
[02:18:40.542] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:40.542] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:27:0) after 1m0s
[02:19:40.588] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:27:0)
[02:19:40.588] Timer tick, asking Buildbucket for the build status
[02:19:40.894] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:40.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:28:0) after 1m0s
[02:20:40.916] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:28:0)
[02:20:40.917] Timer tick, asking Buildbucket for the build status
[02:20:40.990] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:40.990] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:29:0) after 1m0s
[02:21:41.024] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:29:0)
[02:21:41.024] Timer tick, asking Buildbucket for the build status
[02:21:41.087] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:41.087] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:30:0) after 1m0s
[02:22:41.116] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:30:0)
[02:22:41.116] Timer tick, asking Buildbucket for the build status
[02:22:41.198] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:41.198] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:31:0) after 1m0s
[02:23:41.203] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:31:0)
[02:23:41.203] Timer tick, asking Buildbucket for the build status
[02:23:41.324] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:41.324] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:32:0) after 1m0s
[02:24:41.431] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:32:0)
[02:24:41.431] Timer tick, asking Buildbucket for the build status
[02:24:41.580] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:41.580] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:33:0) after 1m0s
[02:25:41.716] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:33:0)
[02:25:41.716] Timer tick, asking Buildbucket for the build status
[02:25:41.832] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:41.832] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:34:0) after 1m0s
[02:26:41.895] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:34:0)
[02:26:41.895] Timer tick, asking Buildbucket for the build status
[02:26:42.035] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:42.035] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:35:0) after 1m0s
[02:27:42.108] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:35:0)
[02:27:42.108] Timer tick, asking Buildbucket for the build status
[02:27:42.239] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:42.239] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:36:0) after 1m0s
[02:28:42.320] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:36:0)
[02:28:42.320] Timer tick, asking Buildbucket for the build status
[02:28:42.455] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:42.455] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:37:0) after 1m0s
[02:29:42.531] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:37:0)
[02:29:42.531] Timer tick, asking Buildbucket for the build status
[02:29:42.645] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:42.645] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:38:0) after 1m0s
[02:30:42.762] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:38:0)
[02:30:42.762] Timer tick, asking Buildbucket for the build status
[02:30:42.829] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:42.829] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:39:0) after 1m0s
[02:31:42.865] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:39:0)
[02:31:42.865] Timer tick, asking Buildbucket for the build status
[02:31:42.934] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:42.934] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:40:0) after 1m0s
[02:32:43.049] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:40:0)
[02:32:43.049] Timer tick, asking Buildbucket for the build status
[02:32:43.156] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:43.156] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:41:0) after 1m0s
[02:33:43.222] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:41:0)
[02:33:43.222] Timer tick, asking Buildbucket for the build status
[02:33:43.313] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:43.313] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:42:0) after 1m0s
[02:34:43.437] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:42:0)
[02:34:43.437] Timer tick, asking Buildbucket for the build status
[02:34:43.598] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:43.598] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:43:0) after 1m0s
[02:35:43.679] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:43:0)
[02:35:43.679] Timer tick, asking Buildbucket for the build status
[02:35:44.188] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:44.188] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:44:0) after 1m0s
[02:36:44.261] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:44:0)
[02:36:44.261] Timer tick, asking Buildbucket for the build status
[02:36:44.382] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:44.382] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:45:0) after 1m0s
[02:37:44.422] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:45:0)
[02:37:44.422] Timer tick, asking Buildbucket for the build status
[02:37:44.519] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:44.519] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:46:0) after 1m0s
[02:38:44.643] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:46:0)
[02:38:44.643] Timer tick, asking Buildbucket for the build status
[02:38:44.741] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:44.741] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:47:0) after 1m0s
[02:39:44.770] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:47:0)
[02:39:44.770] Timer tick, asking Buildbucket for the build status
[02:39:44.891] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:44.891] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:48:0) after 1m0s
[02:40:44.932] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:48:0)
[02:40:44.932] Timer tick, asking Buildbucket for the build status
[02:40:44.994] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:44.994] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:49:0) after 1m0s
[02:41:45.088] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:49:0)
[02:41:45.088] Timer tick, asking Buildbucket for the build status
[02:41:45.269] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:45.269] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:50:0) after 1m0s
[02:42:45.352] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:50:0)
[02:42:45.353] Timer tick, asking Buildbucket for the build status
[02:42:45.494] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:45.494] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:51:0) after 1m0s
[02:43:45.517] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:51:0)
[02:43:45.517] Timer tick, asking Buildbucket for the build status
[02:43:45.596] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:45.596] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:52:0) after 1m0s
[02:44:45.709] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:52:0)
[02:44:45.709] Timer tick, asking Buildbucket for the build status
[02:44:45.834] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:45.834] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:53:0) after 1m0s
[02:45:45.848] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:53:0)
[02:45:45.848] Timer tick, asking Buildbucket for the build status
[02:45:45.923] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:45.924] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:54:0) after 1m0s
[02:46:45.938] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:54:0)
[02:46:45.938] Timer tick, asking Buildbucket for the build status
[02:46:46.111] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:46.111] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:55:0) after 1m0s
[02:47:46.195] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:55:0)
[02:47:46.196] Timer tick, asking Buildbucket for the build status
[02:47:46.259] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:46.259] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:56:0) after 1m0s
[02:48:46.367] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:56:0)
[02:48:46.367] Timer tick, asking Buildbucket for the build status
[02:48:46.434] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:46.434] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:57:0) after 1m0s
[02:49:46.454] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:57:0)
[02:49:46.454] Timer tick, asking Buildbucket for the build status
[02:49:46.695] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:46.695] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:58:0) after 1m0s
[02:50:46.742] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:58:0)
[02:50:46.742] Timer tick, asking Buildbucket for the build status
[02:50:46.830] Build 8857534280182940880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:46.830] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9022964342299509104:59:0) after 1m0s
[02:51:06.394] Received PubSub notification, asking Buildbucket for the build status
[02:51:06.465] Build 8857534280182940880: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[02:51:06.465] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611197465821829",
"created_by": "project:chromium",
"created_ts": "1611194072509245",
"failure_reason": "BUILD_FAILURE",
"id": "8857534280182940880",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"41f7d42e946c141557ef7a4894b608181daf8798\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceLayoutTest#testGridToTabToOtherFrozen\\n\\n- org.chromium.chrome.browser.infobar.SearchGeolocationDisclosureInfoBarTest#testInfoBarAppears\\n\\n- org.chromium.components.translate.TranslateOptionsTest#testBasicOptionsChanges\\n\\n- org.chromium.chrome.browser.autofill_assistant.AutofillAssistantGenericUiTest#testVerticalExpanders\\n\\n- ...57 more failure(s) (61 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\": \"41f7d42e946c141557ef7a4894b608181daf8798\", \"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-106-efhb\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 7373, \"got_angle_revision\": \"bb3adfa42822d73420ca6a8e96863dcb6a35fc65\", \"got_dawn_revision\": \"762814bd922932d3d9da9b220463b6ce5f167d76\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"41f7d42e946c141557ef7a4894b608181daf8798\", \"got_revision_cp\": \"refs/heads/master@{#845460}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"f9759b6f3a4521d370e66aec8240fcc731cd8fdd\", \"got_v8_revision_cp\": \"refs/heads/9.0.31@{#1}\", \"got_webrtc_revision\": \"0be1846477949c472a7a2bf42134a7bb08570ac4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33046}\", \"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\": \"41f7d42e946c141557ef7a4894b608181daf8798\", \"swarm_hashes_refs/heads/master(at){#845460}_without_patch\": {\"android_browsertests\": \"d507a06553129e6b39606c58169a5d6eb41e4cc8\", \"chrome_public_test_apk\": \"45a4d5ed912bdc70249bb7a9582eaa6ab508e58c\", \"content_browsertests\": \"3838489a31cee00db11f691a0d6f9063398c9ddb\", \"content_shell_test_apk\": \"583dfff75be0d9a1c047a78960068905ec097dec\", \"content_unittests\": \"ab48c66b3663ee5f71599028e286a1703c5e6c1f\", \"unit_tests\": \"5e36350668ebdcdfef36a348a9b6443af7062f8b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_a10052c67097968898fa29710cdaa0ada58a120001760a536a006ca29eefe964_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_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-106-efhb\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceLayoutTest#testGridToTabToOtherFrozen\\n\\n- org.chromium.chrome.browser.infobar.SearchGeolocationDisclosureInfoBarTest#testInfoBarAppears\\n\\n- org.chromium.components.translate.TranslateOptionsTest#testBasicOptionsChanges\\n\\n- org.chromium.chrome.browser.autofill_assistant.AutofillAssistantGenericUiTest#testVerticalExpanders\\n\\n- ...57 more failure(s) (61 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611194075784733",
"status": "COMPLETED",
"status_changed_ts": "1611194076150085",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/7373",
"builder:android-bfcache-rel",
"buildset:commit/git/41f7d42e946c141557ef7a4894b608181daf8798",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/41f7d42e946c141557ef7a4894b608181daf8798",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022964342299509104",
"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/8857534280182940880/+/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:513b780c90ca9010",
"user_agent:luci-scheduler"
],
"updated_ts": "1611197466029647",
"url": "https://ci.chromium.org/b/8857534280182940880",
"utcnow_ts": "1611197466457484"
}
}
[02:51:06.465] Invocation finished in 56m35.357767683s with status FAILED