[02:20:40.246] New invocation is queued and will start shortly
[02:20:41.488] Starting the invocation (attempt 1)
[02:20:41.545] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:20:41.545] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:20:41.545] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9046336714298982992",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"918877f7415f70fb5c1ae1b62541ff34a3d02c1a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9046336714298982992",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/918877f7415f70fb5c1ae1b62541ff34a3d02c1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/918877f7415f70fb5c1ae1b62541ff34a3d02c1a",
"gitiles_ref:refs/heads/master"
]
}
[02:20:43.789] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1588904441688850",
"id": "8880906652110690624",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"918877f7415f70fb5c1ae1b62541ff34a3d02c1a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1588904443332166",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/2544",
"builder:android-bfcache-rel",
"buildset:commit/git/918877f7415f70fb5c1ae1b62541ff34a3d02c1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/918877f7415f70fb5c1ae1b62541ff34a3d02c1a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046336714298982992",
"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/8880906652110690624/+/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": "1588904443332391",
"url": "https://ci.chromium.org/b/8880906652110690624",
"utcnow_ts": "1588904443773994"
}
}
[02:20:43.790] Task URL: https://ci.chromium.org/b/8880906652110690624
[02:20:43.790] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:2:0) after 1m0s
[02:21:43.825] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:2:0)
[02:21:43.825] Timer tick, asking Buildbucket for the build status
[02:21:43.944] Build 8880906652110690624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:43.944] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:3:0) after 1m0s
[02:22:39.147] Received PubSub notification, asking Buildbucket for the build status
[02:22:39.342] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:43.964] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:3:0)
[02:22:43.964] Timer tick, asking Buildbucket for the build status
[02:22:44.194] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:44.194] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:5:0) after 1m0s
[02:23:44.219] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:5:0)
[02:23:44.219] Timer tick, asking Buildbucket for the build status
[02:23:45.583] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:45.583] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:6:0) after 1m0s
[02:24:45.650] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:6:0)
[02:24:45.650] Timer tick, asking Buildbucket for the build status
[02:24:46.832] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:46.832] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:7:0) after 1m0s
[02:25:46.875] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:7:0)
[02:25:46.875] Timer tick, asking Buildbucket for the build status
[02:25:47.130] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:47.130] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:8:0) after 1m0s
[02:26:47.376] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:8:0)
[02:26:47.376] Timer tick, asking Buildbucket for the build status
[02:26:47.510] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:47.510] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:9:0) after 1m0s
[02:27:47.646] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:9:0)
[02:27:47.646] Timer tick, asking Buildbucket for the build status
[02:27:47.911] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:47.911] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:10:0) after 1m0s
[02:28:48.039] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:10:0)
[02:28:48.039] Timer tick, asking Buildbucket for the build status
[02:28:48.241] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:48.241] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:11:0) after 1m0s
[02:29:48.272] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:11:0)
[02:29:48.272] Timer tick, asking Buildbucket for the build status
[02:29:48.535] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:48.535] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:12:0) after 1m0s
[02:30:48.608] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:12:0)
[02:30:48.608] Timer tick, asking Buildbucket for the build status
[02:30:48.888] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:48.888] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:13:0) after 1m0s
[02:31:48.899] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:13:0)
[02:31:48.899] Timer tick, asking Buildbucket for the build status
[02:31:49.106] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:49.106] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:14:0) after 1m0s
[02:32:49.227] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:14:0)
[02:32:49.227] Timer tick, asking Buildbucket for the build status
[02:32:49.408] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:49.408] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:15:0) after 1m0s
[02:33:49.452] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:15:0)
[02:33:49.452] Timer tick, asking Buildbucket for the build status
[02:33:49.715] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:49.715] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:16:0) after 1m0s
[02:34:49.735] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:16:0)
[02:34:49.735] Timer tick, asking Buildbucket for the build status
[02:34:49.918] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:49.918] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:17:0) after 1m0s
[02:35:49.974] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:17:0)
[02:35:49.974] Timer tick, asking Buildbucket for the build status
[02:35:50.253] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:50.253] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:18:0) after 1m0s
[02:36:50.296] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:18:0)
[02:36:50.296] Timer tick, asking Buildbucket for the build status
[02:36:50.431] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:50.431] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:19:0) after 1m0s
[02:37:50.566] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:19:0)
[02:37:50.566] Timer tick, asking Buildbucket for the build status
[02:37:51.280] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:51.280] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:20:0) after 1m0s
[02:38:51.301] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:20:0)
[02:38:51.301] Timer tick, asking Buildbucket for the build status
[02:38:51.502] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:51.502] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:21:0) after 1m0s
[02:39:51.527] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:21:0)
[02:39:51.527] Timer tick, asking Buildbucket for the build status
[02:39:51.956] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:51.956] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:22:0) after 1m0s
[02:40:52.003] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:22:0)
[02:40:52.003] Timer tick, asking Buildbucket for the build status
[02:40:52.190] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:52.190] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:23:0) after 1m0s
[02:41:52.179] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:23:0)
[02:41:52.179] Timer tick, asking Buildbucket for the build status
[02:41:52.312] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:52.313] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:24:0) after 1m0s
[02:42:52.341] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:24:0)
[02:42:52.341] Timer tick, asking Buildbucket for the build status
[02:42:52.457] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:52.457] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:25:0) after 1m0s
[02:43:52.455] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:25:0)
[02:43:52.455] Timer tick, asking Buildbucket for the build status
[02:43:52.614] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:52.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:26:0) after 1m0s
[02:44:52.640] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:26:0)
[02:44:52.640] Timer tick, asking Buildbucket for the build status
[02:44:52.855] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:52.855] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:27:0) after 1m0s
[02:45:52.914] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:27:0)
[02:45:52.914] Timer tick, asking Buildbucket for the build status
[02:45:53.176] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:53.176] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:28:0) after 1m0s
[02:46:53.186] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:28:0)
[02:46:53.186] Timer tick, asking Buildbucket for the build status
[02:46:53.510] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:53.510] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:29:0) after 1m0s
[02:47:53.625] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:29:0)
[02:47:53.625] Timer tick, asking Buildbucket for the build status
[02:47:53.738] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:53.738] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:30:0) after 1m0s
[02:48:53.794] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:30:0)
[02:48:53.794] Timer tick, asking Buildbucket for the build status
[02:48:54.041] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:54.041] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:31:0) after 1m0s
[02:49:54.099] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:31:0)
[02:49:54.099] Timer tick, asking Buildbucket for the build status
[02:49:54.407] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:54.408] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:32:0) after 1m0s
[02:50:54.486] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:32:0)
[02:50:54.486] Timer tick, asking Buildbucket for the build status
[02:50:54.705] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:54.705] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:33:0) after 1m0s
[02:51:54.752] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:33:0)
[02:51:54.752] Timer tick, asking Buildbucket for the build status
[02:51:54.893] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:54.893] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:34:0) after 1m0s
[02:52:54.974] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:34:0)
[02:52:54.974] Timer tick, asking Buildbucket for the build status
[02:52:55.229] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:55.229] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:35:0) after 1m0s
[02:53:55.240] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:35:0)
[02:53:55.240] Timer tick, asking Buildbucket for the build status
[02:53:55.392] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:55.392] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:36:0) after 1m0s
[02:54:55.414] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:36:0)
[02:54:55.414] Timer tick, asking Buildbucket for the build status
[02:54:55.961] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:55.961] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:37:0) after 1m0s
[02:55:56.019] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:37:0)
[02:55:56.019] Timer tick, asking Buildbucket for the build status
[02:55:56.435] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:56.435] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:38:0) after 1m0s
[02:56:56.455] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:38:0)
[02:56:56.455] Timer tick, asking Buildbucket for the build status
[02:56:56.774] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:56.774] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:39:0) after 1m0s
[02:57:56.790] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:39:0)
[02:57:56.790] Timer tick, asking Buildbucket for the build status
[02:57:57.376] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:57.376] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:40:0) after 1m0s
[02:58:57.460] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:40:0)
[02:58:57.460] Timer tick, asking Buildbucket for the build status
[02:58:57.581] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:57.581] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:41:0) after 1m0s
[02:59:57.607] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:41:0)
[02:59:57.607] Timer tick, asking Buildbucket for the build status
[02:59:58.222] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:58.222] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:42:0) after 1m0s
[03:00:58.291] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:42:0)
[03:00:58.291] Timer tick, asking Buildbucket for the build status
[03:00:58.503] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:58.503] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:43:0) after 1m0s
[03:01:58.530] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:43:0)
[03:01:58.531] Timer tick, asking Buildbucket for the build status
[03:01:58.636] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:58.636] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:44:0) after 1m0s
[03:02:58.664] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:44:0)
[03:02:58.664] Timer tick, asking Buildbucket for the build status
[03:02:58.888] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:58.888] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:45:0) after 1m0s
[03:03:58.909] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:45:0)
[03:03:58.909] Timer tick, asking Buildbucket for the build status
[03:03:59.088] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:59.088] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:46:0) after 1m0s
[03:04:59.143] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:46:0)
[03:04:59.143] Timer tick, asking Buildbucket for the build status
[03:04:59.610] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:59.610] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:47:0) after 1m0s
[03:05:59.660] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:47:0)
[03:05:59.660] Timer tick, asking Buildbucket for the build status
[03:05:59.892] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:59.892] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:48:0) after 1m0s
[03:06:59.943] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:48:0)
[03:06:59.943] Timer tick, asking Buildbucket for the build status
[03:07:00.369] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:00.369] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:49:0) after 1m0s
[03:08:00.941] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:49:0)
[03:08:00.941] Timer tick, asking Buildbucket for the build status
[03:08:01.231] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:01.231] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:50:0) after 1m0s
[03:09:02.649] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:50:0)
[03:09:02.649] Timer tick, asking Buildbucket for the build status
[03:09:02.903] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:02.903] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:51:0) after 1m0s
[03:10:02.955] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:51:0)
[03:10:02.955] Timer tick, asking Buildbucket for the build status
[03:10:03.089] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:03.089] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:52:0) after 1m0s
[03:11:03.159] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:52:0)
[03:11:03.159] Timer tick, asking Buildbucket for the build status
[03:11:03.336] Build 8880906652110690624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:03.336] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9046336714298982992:53:0) after 1m0s
[03:11:25.082] Received PubSub notification, asking Buildbucket for the build status
[03:11:25.352] Build 8880906652110690624: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:11:25.352] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1588907483028267",
"created_by": "project:chromium",
"created_ts": "1588904441688850",
"failure_reason": "BUILD_FAILURE",
"id": "8880906652110690624",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"918877f7415f70fb5c1ae1b62541ff34a3d02c1a\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- RenderDocumentHostUserDataTest.CrossSiteNavigation\\n\\n- SitePerProcessBrowserTest.NavigateMainFrameToChildSite\\n\\n- RenderDocumentHostUserDataTest.FailedNavigation\\n\\n- All/RenderFrameHostManagerDefaultProcessTest.NavigationRacesWithSitelessCommitInDefaultProcess/1\\n\\n- ...20 more failure(s) (24 total)...\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsTabSwitcher__Instant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsTabSwitcher__NoInstant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsHomepage__Instant_NoReturn\\n\\n- ...80 more failure(s) (83 total)...\\n\\n#### ...1 more test(s)...\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-122-ombe\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 2544, \"got_angle_revision\": \"5b35c7f6ef1aca3d5bd5b169ee7428fd3cd71d9a\", \"got_dawn_revision\": \"351c95a4773a4a4a7fe789bc2ba0558cec0e0c15\", \"got_nacl_revision\": \"08ef20f1933cc724a25911b4da99a9e7355cafa0\", \"got_revision\": \"918877f7415f70fb5c1ae1b62541ff34a3d02c1a\", \"got_revision_cp\": \"refs/heads/master@{#766694}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"2dd864470e310d173d35fa95ca3a14d216734aab\", \"got_v8_revision\": \"a3433d822f603cc0642c0a84bf291b0f90a3c493\", \"got_v8_revision_cp\": \"refs/heads/8.4.316@{#1}\", \"got_webrtc_revision\": \"04e1bab1b324e08b8dec4bf617e2afb13b6bde3b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31185}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.android.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"918877f7415f70fb5c1ae1b62541ff34a3d02c1a\", \"swarm_hashes\": {\"android_browsertests\": \"c7ab4f528e32b22aab925c703a231db699f72260\", \"chrome_public_test_apk\": \"e99ddcb36c2c8b89fd0d274649063e74b433e999\", \"content_browsertests\": \"dd47ce483ba68010d615a92380ae9cc8f911929c\", \"content_shell_test_apk\": \"eaba2736a6a5b3763637525010a1c91ee9aab282\", \"content_unittests\": \"32be873bfb8a97bcab73be1c2f3a581b6fac28ba\", \"unit_tests\": \"e2045fd40359b17efb1578f083232f5a847ce1a0\"}, \"swarm_hashes_refs/heads/master(at){#766694}_without_patch\": {\"android_browsertests\": \"c7ab4f528e32b22aab925c703a231db699f72260\", \"chrome_public_test_apk\": \"e99ddcb36c2c8b89fd0d274649063e74b433e999\", \"content_browsertests\": \"dd47ce483ba68010d615a92380ae9cc8f911929c\", \"content_shell_test_apk\": \"eaba2736a6a5b3763637525010a1c91ee9aab282\", \"content_unittests\": \"32be873bfb8a97bcab73be1c2f3a581b6fac28ba\", \"unit_tests\": \"e2045fd40359b17efb1578f083232f5a847ce1a0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4db0054a83a9843c83efc7245cc2bf7c852e3dccc3641d4850eb70ea2a4c7f0c_v2\", \"builder_8f1f1a811acb8ac7cee91f001f34cb98db55e889611ed2a31914ce7c854c1541_v2\", \"builder_a3249012ab2e105b4f1a10f0dc352b422f692fd701d889292e5c6170d198db4b_v2\", \"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-122-ombe\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5049-d63f53a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- RenderDocumentHostUserDataTest.CrossSiteNavigation\\n\\n- SitePerProcessBrowserTest.NavigateMainFrameToChildSite\\n\\n- RenderDocumentHostUserDataTest.FailedNavigation\\n\\n- All/RenderFrameHostManagerDefaultProcessTest.NavigationRacesWithSitelessCommitInDefaultProcess/1\\n\\n- ...20 more failure(s) (24 total)...\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsTabSwitcher__Instant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsTabSwitcher__NoInstant_NoReturn\\n\\n- org.chromium.chrome.features.start_surface.StartSurfaceTest#testShow_SingleAsHomepage__Instant_NoReturn\\n\\n- ...80 more failure(s) (83 total)...\\n\\n#### ...1 more test(s)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1588904557858557",
"status": "COMPLETED",
"status_changed_ts": "1588904558735145",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/2544",
"builder:android-bfcache-rel",
"buildset:commit/git/918877f7415f70fb5c1ae1b62541ff34a3d02c1a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/918877f7415f70fb5c1ae1b62541ff34a3d02c1a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9046336714298982992",
"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/8880906652110690624/+/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:4c0ae758cb6d3b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1588907484166654",
"url": "https://ci.chromium.org/b/8880906652110690624",
"utcnow_ts": "1588907485324058"
}
}
[03:11:25.352] Invocation finished in 50m45.133661942s with status FAILED