[16:25:40.138] New invocation is queued and will start shortly
[16:25:41.209] Starting the invocation (attempt 1)
[16:25:41.246] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:25:41.246] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:25:41.246] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051991160484995360",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c8315b5e7e925c9dca831ae6ca8445da8f0c204d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9051991160484995360",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/c8315b5e7e925c9dca831ae6ca8445da8f0c204d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8315b5e7e925c9dca831ae6ca8445da8f0c204d",
"gitiles_ref:refs/heads/master"
]
}
[16:25:42.549] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583511941386246",
"id": "8886561098507339952",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c8315b5e7e925c9dca831ae6ca8445da8f0c204d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583511942335191",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/42340",
"builder:Site Isolation Android",
"buildset:commit/git/c8315b5e7e925c9dca831ae6ca8445da8f0c204d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8315b5e7e925c9dca831ae6ca8445da8f0c204d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051991160484995360",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886561098507339952/+/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": "1583511942335296",
"url": "https://ci.chromium.org/b/8886561098507339952",
"utcnow_ts": "1583511942541717"
}
}
[16:25:42.549] Task URL: https://ci.chromium.org/b/8886561098507339952
[16:25:42.549] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:2:0) after 1m0s
[16:26:42.709] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:2:0)
[16:26:42.709] Timer tick, asking Buildbucket for the build status
[16:26:42.919] Build 8886561098507339952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:26:42.919] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:3:0) after 1m0s
[16:26:58.201] Received PubSub notification, asking Buildbucket for the build status
[16:26:59.094] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:43.367] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:3:0)
[16:27:43.367] Timer tick, asking Buildbucket for the build status
[16:27:43.572] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:43.572] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:5:0) after 1m0s
[16:28:43.635] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:5:0)
[16:28:43.635] Timer tick, asking Buildbucket for the build status
[16:28:43.797] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:43.797] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:6:0) after 1m0s
[16:29:44.037] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:6:0)
[16:29:44.037] Timer tick, asking Buildbucket for the build status
[16:29:44.108] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:44.108] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:7:0) after 1m0s
[16:30:44.169] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:7:0)
[16:30:44.169] Timer tick, asking Buildbucket for the build status
[16:30:44.264] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:44.264] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:8:0) after 1m0s
[16:31:44.441] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:8:0)
[16:31:44.441] Timer tick, asking Buildbucket for the build status
[16:31:44.628] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:44.628] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:9:0) after 1m0s
[16:32:44.807] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:9:0)
[16:32:44.807] Timer tick, asking Buildbucket for the build status
[16:32:45.131] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:45.131] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:10:0) after 1m0s
[16:33:45.150] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:10:0)
[16:33:45.150] Timer tick, asking Buildbucket for the build status
[16:33:45.352] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:45.352] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:11:0) after 1m0s
[16:34:45.386] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:11:0)
[16:34:45.386] Timer tick, asking Buildbucket for the build status
[16:34:45.709] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:45.709] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:12:0) after 1m0s
[16:35:45.806] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:12:0)
[16:35:45.806] Timer tick, asking Buildbucket for the build status
[16:35:45.995] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:45.995] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:13:0) after 1m0s
[16:36:46.014] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:13:0)
[16:36:46.014] Timer tick, asking Buildbucket for the build status
[16:36:46.737] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:46.737] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:14:0) after 1m0s
[16:37:46.735] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:14:0)
[16:37:46.735] Timer tick, asking Buildbucket for the build status
[16:37:46.922] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:46.922] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:15:0) after 1m0s
[16:38:46.966] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:15:0)
[16:38:46.966] Timer tick, asking Buildbucket for the build status
[16:38:47.093] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:47.093] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:16:0) after 1m0s
[16:39:47.177] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:16:0)
[16:39:47.177] Timer tick, asking Buildbucket for the build status
[16:39:47.295] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:47.295] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:17:0) after 1m0s
[16:40:47.363] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:17:0)
[16:40:47.363] Timer tick, asking Buildbucket for the build status
[16:40:47.476] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:47.476] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:18:0) after 1m0s
[16:41:47.512] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:18:0)
[16:41:47.512] Timer tick, asking Buildbucket for the build status
[16:41:48.030] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:48.030] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:19:0) after 1m0s
[16:42:48.026] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:19:0)
[16:42:48.026] Timer tick, asking Buildbucket for the build status
[16:42:48.626] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:48.626] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:20:0) after 1m0s
[16:43:48.643] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:20:0)
[16:43:48.643] Timer tick, asking Buildbucket for the build status
[16:43:49.085] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:49.085] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:21:0) after 1m0s
[16:44:49.116] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:21:0)
[16:44:49.116] Timer tick, asking Buildbucket for the build status
[16:44:49.441] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:49.441] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:22:0) after 1m0s
[16:45:49.465] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:22:0)
[16:45:49.465] Timer tick, asking Buildbucket for the build status
[16:45:49.553] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:49.553] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:23:0) after 1m0s
[16:46:49.563] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:23:0)
[16:46:49.563] Timer tick, asking Buildbucket for the build status
[16:46:50.079] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:50.079] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:24:0) after 1m0s
[16:47:50.161] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:24:0)
[16:47:50.161] Timer tick, asking Buildbucket for the build status
[16:47:50.351] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:50.351] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:25:0) after 1m0s
[16:48:50.368] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:25:0)
[16:48:50.368] Timer tick, asking Buildbucket for the build status
[16:48:50.582] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:50.582] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:26:0) after 1m0s
[16:49:50.747] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:26:0)
[16:49:50.747] Timer tick, asking Buildbucket for the build status
[16:49:50.985] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:50.985] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:27:0) after 1m0s
[16:50:51.005] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:27:0)
[16:50:51.005] Timer tick, asking Buildbucket for the build status
[16:50:51.181] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:51.181] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:28:0) after 1m0s
[16:51:51.219] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:28:0)
[16:51:51.219] Timer tick, asking Buildbucket for the build status
[16:51:51.375] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:51.375] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:29:0) after 1m0s
[16:52:51.377] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:29:0)
[16:52:51.377] Timer tick, asking Buildbucket for the build status
[16:52:51.602] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:51.602] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:30:0) after 1m0s
[16:53:51.671] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:30:0)
[16:53:51.671] Timer tick, asking Buildbucket for the build status
[16:53:51.799] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:51.799] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:31:0) after 1m0s
[16:54:51.791] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:31:0)
[16:54:51.791] Timer tick, asking Buildbucket for the build status
[16:54:52.173] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:52.173] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:32:0) after 1m0s
[16:55:52.266] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:32:0)
[16:55:52.266] Timer tick, asking Buildbucket for the build status
[16:55:52.718] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:52.718] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:33:0) after 1m0s
[16:56:52.767] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:33:0)
[16:56:52.767] Timer tick, asking Buildbucket for the build status
[16:56:54.240] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:54.240] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:34:0) after 1m0s
[16:57:54.334] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:34:0)
[16:57:54.334] Timer tick, asking Buildbucket for the build status
[16:57:54.548] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:54.548] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:35:0) after 1m0s
[16:58:54.657] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:35:0)
[16:58:54.657] Timer tick, asking Buildbucket for the build status
[16:58:54.915] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:54.915] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:36:0) after 1m0s
[16:59:54.924] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:36:0)
[16:59:54.924] Timer tick, asking Buildbucket for the build status
[16:59:55.103] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:55.103] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:37:0) after 1m0s
[17:00:55.236] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:37:0)
[17:00:55.236] Timer tick, asking Buildbucket for the build status
[17:00:55.625] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:55.625] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:38:0) after 1m0s
[17:01:55.751] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:38:0)
[17:01:55.751] Timer tick, asking Buildbucket for the build status
[17:01:55.926] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:55.926] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:39:0) after 1m0s
[17:02:56.011] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:39:0)
[17:02:56.011] Timer tick, asking Buildbucket for the build status
[17:02:56.199] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:56.199] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:40:0) after 1m0s
[17:03:56.215] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:40:0)
[17:03:56.215] Timer tick, asking Buildbucket for the build status
[17:03:56.841] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:56.841] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:41:0) after 1m0s
[17:04:56.911] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:41:0)
[17:04:56.911] Timer tick, asking Buildbucket for the build status
[17:04:57.002] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:57.002] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:42:0) after 1m0s
[17:05:57.107] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:42:0)
[17:05:57.107] Timer tick, asking Buildbucket for the build status
[17:05:57.334] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:57.335] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:43:0) after 1m0s
[17:06:57.581] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:43:0)
[17:06:57.581] Timer tick, asking Buildbucket for the build status
[17:06:57.674] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:57.674] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:44:0) after 1m0s
[17:07:58.000] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:44:0)
[17:07:58.000] Timer tick, asking Buildbucket for the build status
[17:07:58.261] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:58.261] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:45:0) after 1m0s
[17:08:58.463] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:45:0)
[17:08:58.463] Timer tick, asking Buildbucket for the build status
[17:08:58.654] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:58.654] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:46:0) after 1m0s
[17:09:58.904] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:46:0)
[17:09:58.904] Timer tick, asking Buildbucket for the build status
[17:09:59.257] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:59.257] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:47:0) after 1m0s
[17:10:59.456] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:47:0)
[17:10:59.456] Timer tick, asking Buildbucket for the build status
[17:10:59.689] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:59.689] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:48:0) after 1m0s
[17:11:59.800] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:48:0)
[17:11:59.800] Timer tick, asking Buildbucket for the build status
[17:11:59.912] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:59.912] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:49:0) after 1m0s
[17:12:59.966] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:49:0)
[17:12:59.966] Timer tick, asking Buildbucket for the build status
[17:13:00.198] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:00.198] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:50:0) after 1m0s
[17:14:00.303] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:50:0)
[17:14:00.303] Timer tick, asking Buildbucket for the build status
[17:14:00.624] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:00.624] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:51:0) after 1m0s
[17:15:00.673] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:51:0)
[17:15:00.673] Timer tick, asking Buildbucket for the build status
[17:15:00.905] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:00.905] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:52:0) after 1m0s
[17:16:00.883] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:52:0)
[17:16:00.883] Timer tick, asking Buildbucket for the build status
[17:16:01.262] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:01.262] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:53:0) after 1m0s
[17:17:01.286] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:53:0)
[17:17:01.286] Timer tick, asking Buildbucket for the build status
[17:17:01.456] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:01.456] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:54:0) after 1m0s
[17:18:01.515] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:54:0)
[17:18:01.515] Timer tick, asking Buildbucket for the build status
[17:18:02.698] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:02.698] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:55:0) after 1m0s
[17:19:02.746] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:55:0)
[17:19:02.746] Timer tick, asking Buildbucket for the build status
[17:19:03.074] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:03.074] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:56:0) after 1m0s
[17:20:03.101] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:56:0)
[17:20:03.101] Timer tick, asking Buildbucket for the build status
[17:20:03.627] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:03.627] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:57:0) after 1m0s
[17:21:03.673] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:57:0)
[17:21:03.673] Timer tick, asking Buildbucket for the build status
[17:21:03.902] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:03.902] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:58:0) after 1m0s
[17:22:03.958] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:58:0)
[17:22:03.958] Timer tick, asking Buildbucket for the build status
[17:22:04.613] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:04.613] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:59:0) after 1m0s
[17:23:04.622] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:59:0)
[17:23:04.622] Timer tick, asking Buildbucket for the build status
[17:23:05.449] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:05.449] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:60:0) after 1m0s
[17:24:05.467] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:60:0)
[17:24:05.467] Timer tick, asking Buildbucket for the build status
[17:24:05.698] Build 8886561098507339952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:05.698] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9051991160484995360:61:0) after 1m0s
[17:24:40.878] Received PubSub notification, asking Buildbucket for the build status
[17:24:41.059] Build 8886561098507339952: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:24:41.059] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583515480173200",
"created_by": "project:chromium",
"created_ts": "1583511941386246",
"failure_reason": "BUILD_FAILURE",
"id": "8886561098507339952",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c8315b5e7e925c9dca831ae6ca8445da8f0c204d\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**site_per_process_content_browsertests on Android device Nexus 5X** failed because of:\\n\\n- All/BlockedSchemeNavigationBrowserTest.PDF_NavigationFromFrame_TopFrameHasBlockedScheme_Block/1\\n\\n- All/BlockedSchemeNavigationBrowserTest.PDF_NavigationFromFrame_Block/1\"}, \"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-12-mpb3\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 42340, \"got_angle_revision\": \"81cee994e1d2c2b839d3b24439b9f95db01a328f\", \"got_dawn_revision\": \"e3f3e9a80d5f937470aacda7b810a88fc85e8b19\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"c8315b5e7e925c9dca831ae6ca8445da8f0c204d\", \"got_revision_cp\": \"refs/heads/master@{#747730}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"a095711c5d771437d7f9bfcbd78a82062e19c55e\", \"got_v8_revision\": \"d4ed59c4ed609eacc9062bd22ebca409ef7c6d1c\", \"got_v8_revision_cp\": \"refs/heads/8.2.263@{#1}\", \"got_webrtc_revision\": \"8e9fd4857e2eaf85986c135ce0a9f80999e8f5bd\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30703}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c8315b5e7e925c9dca831ae6ca8445da8f0c204d\", \"swarm_hashes\": {\"components_browsertests\": \"600b7e46039e2ade90596d4b4eedbef4a0ab425a\", \"components_unittests\": \"bad2543299d2ef0f321cfbd21941d4812ea7d7e0\", \"content_browsertests\": \"8fe9b31c8f7f2ffd6d23ee7b29488433b187e73f\", \"content_unittests\": \"56abbe92fd4262eeef6df04fb697dc75732fc5da\", \"unit_tests\": \"50dd9aba2bb438ea200607177f04b2845cbf9076\"}, \"swarm_hashes_refs/heads/master(at){#747730}_without_patch\": {\"components_browsertests\": \"600b7e46039e2ade90596d4b4eedbef4a0ab425a\", \"components_unittests\": \"bad2543299d2ef0f321cfbd21941d4812ea7d7e0\", \"content_browsertests\": \"8fe9b31c8f7f2ffd6d23ee7b29488433b187e73f\", \"content_unittests\": \"56abbe92fd4262eeef6df04fb697dc75732fc5da\", \"unit_tests\": \"50dd9aba2bb438ea200607177f04b2845cbf9076\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_3e75b41c9bcf12a22209c03b338cce1fafa12941d3074ed1e1ed2450e6b71594_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_91dc5ce0f7d9a4ba8efbdbb6360d947a001f2754e92adddaf9400582bbdcce50_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_dd987fcd94b516d81fcf1552cd73a9eed370c3dc02cc1a52ddee828f1ab8817d_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-12-mpb3\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"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\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**site_per_process_content_browsertests on Android device Nexus 5X** failed because of:\\n\\n- All/BlockedSchemeNavigationBrowserTest.PDF_NavigationFromFrame_TopFrameHasBlockedScheme_Block/1\\n\\n- All/BlockedSchemeNavigationBrowserTest.PDF_NavigationFromFrame_Block/1\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583512015101081",
"status": "COMPLETED",
"status_changed_ts": "1583512016075226",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/42340",
"builder:Site Isolation Android",
"buildset:commit/git/c8315b5e7e925c9dca831ae6ca8445da8f0c204d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c8315b5e7e925c9dca831ae6ca8445da8f0c204d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051991160484995360",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886561098507339952/+/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:4ac97c3f0113dc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1583515480270225",
"url": "https://ci.chromium.org/b/8886561098507339952",
"utcnow_ts": "1583515481033217"
}
}
[17:24:41.059] Invocation finished in 59m0.942027875s with status FAILED