[23:07:32.137] New invocation is queued and will start shortly
[23:07:33.419] Starting the invocation (attempt 1)
[23:07:33.457] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:07:33.460] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:07:33.460] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9043268568444597152",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0bb8a7d43d347dacf9a9dffd3cceb49886826c5c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9043268568444597152",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/0bb8a7d43d347dacf9a9dffd3cceb49886826c5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0bb8a7d43d347dacf9a9dffd3cceb49886826c5c",
"gitiles_ref:refs/heads/master"
]
}
[23:07:34.315] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1591830453551203",
"id": "8877838506295531664",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0bb8a7d43d347dacf9a9dffd3cceb49886826c5c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1591830454047799",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/44693",
"builder:Site Isolation Android",
"buildset:commit/git/0bb8a7d43d347dacf9a9dffd3cceb49886826c5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0bb8a7d43d347dacf9a9dffd3cceb49886826c5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043268568444597152",
"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/8877838506295531664/+/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": "1591830454048113",
"url": "https://ci.chromium.org/b/8877838506295531664",
"utcnow_ts": "1591830454267104"
}
}
[23:07:34.315] Task URL: https://ci.chromium.org/b/8877838506295531664
[23:07:34.315] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:2:0) after 1m0s
[23:08:34.402] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:2:0)
[23:08:34.402] Timer tick, asking Buildbucket for the build status
[23:08:34.548] Build 8877838506295531664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:08:34.548] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:3:0) after 1m0s
[23:09:05.550] Received PubSub notification, asking Buildbucket for the build status
[23:09:05.657] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:34.589] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:3:0)
[23:09:34.589] Timer tick, asking Buildbucket for the build status
[23:09:34.962] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:34.962] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:5:0) after 1m0s
[23:10:34.985] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:5:0)
[23:10:34.985] Timer tick, asking Buildbucket for the build status
[23:10:35.171] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:35.171] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:6:0) after 1m0s
[23:11:35.191] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:6:0)
[23:11:35.191] Timer tick, asking Buildbucket for the build status
[23:11:35.541] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:35.541] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:7:0) after 1m0s
[23:12:35.629] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:7:0)
[23:12:35.629] Timer tick, asking Buildbucket for the build status
[23:12:36.214] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:36.214] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:8:0) after 1m0s
[23:13:36.238] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:8:0)
[23:13:36.238] Timer tick, asking Buildbucket for the build status
[23:13:36.678] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:36.678] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:9:0) after 1m0s
[23:14:36.764] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:9:0)
[23:14:36.764] Timer tick, asking Buildbucket for the build status
[23:14:37.162] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:37.162] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:10:0) after 1m0s
[23:15:37.258] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:10:0)
[23:15:37.258] Timer tick, asking Buildbucket for the build status
[23:15:37.446] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:37.446] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:11:0) after 1m0s
[23:16:37.516] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:11:0)
[23:16:37.516] Timer tick, asking Buildbucket for the build status
[23:16:37.762] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:37.762] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:12:0) after 1m0s
[23:17:37.891] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:12:0)
[23:17:37.891] Timer tick, asking Buildbucket for the build status
[23:17:38.172] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:38.172] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:13:0) after 1m0s
[23:18:38.206] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:13:0)
[23:18:38.206] Timer tick, asking Buildbucket for the build status
[23:18:38.357] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:38.357] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:14:0) after 1m0s
[23:19:38.405] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:14:0)
[23:19:38.406] Timer tick, asking Buildbucket for the build status
[23:19:38.554] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:38.554] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:15:0) after 1m0s
[23:20:39.358] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:15:0)
[23:20:39.358] Timer tick, asking Buildbucket for the build status
[23:20:39.655] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:39.655] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:16:0) after 1m0s
[23:21:40.091] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:16:0)
[23:21:40.091] Timer tick, asking Buildbucket for the build status
[23:21:41.014] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:41.014] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:17:0) after 1m0s
[23:22:41.490] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:17:0)
[23:22:41.490] Timer tick, asking Buildbucket for the build status
[23:22:42.427] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:42.427] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:18:0) after 1m0s
[23:23:42.823] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:18:0)
[23:23:42.823] Timer tick, asking Buildbucket for the build status
[23:23:43.178] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:43.178] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:19:0) after 1m0s
[23:24:43.271] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:19:0)
[23:24:43.271] Timer tick, asking Buildbucket for the build status
[23:24:43.503] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:43.503] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:20:0) after 1m0s
[23:25:43.535] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:20:0)
[23:25:43.535] Timer tick, asking Buildbucket for the build status
[23:25:43.952] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:43.952] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:21:0) after 1m0s
[23:26:44.003] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:21:0)
[23:26:44.003] Timer tick, asking Buildbucket for the build status
[23:26:44.599] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:44.599] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:22:0) after 1m0s
[23:27:44.665] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:22:0)
[23:27:44.665] Timer tick, asking Buildbucket for the build status
[23:27:44.832] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:44.832] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:23:0) after 1m0s
[23:28:44.855] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:23:0)
[23:28:44.855] Timer tick, asking Buildbucket for the build status
[23:28:45.014] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:45.014] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:24:0) after 1m0s
[23:29:45.111] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:24:0)
[23:29:45.111] Timer tick, asking Buildbucket for the build status
[23:29:45.307] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:45.307] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:25:0) after 1m0s
[23:30:45.557] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:25:0)
[23:30:45.557] Timer tick, asking Buildbucket for the build status
[23:30:46.703] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:46.703] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:26:0) after 1m0s
[23:31:46.877] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:26:0)
[23:31:46.877] Timer tick, asking Buildbucket for the build status
[23:31:47.514] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:47.514] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:27:0) after 1m0s
[23:32:47.564] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:27:0)
[23:32:47.564] Timer tick, asking Buildbucket for the build status
[23:32:47.886] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:47.886] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:28:0) after 1m0s
[23:33:47.952] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:28:0)
[23:33:47.952] Timer tick, asking Buildbucket for the build status
[23:33:48.316] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:48.316] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:29:0) after 1m0s
[23:34:48.338] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:29:0)
[23:34:48.338] Timer tick, asking Buildbucket for the build status
[23:34:48.558] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:48.558] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:30:0) after 1m0s
[23:35:48.743] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:30:0)
[23:35:48.743] Timer tick, asking Buildbucket for the build status
[23:35:48.937] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:48.937] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:31:0) after 1m0s
[23:36:49.026] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:31:0)
[23:36:49.026] Timer tick, asking Buildbucket for the build status
[23:36:49.304] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:49.304] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:32:0) after 1m0s
[23:37:49.498] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:32:0)
[23:37:49.498] Timer tick, asking Buildbucket for the build status
[23:37:49.851] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:49.851] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:33:0) after 1m0s
[23:38:49.870] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:33:0)
[23:38:49.870] Timer tick, asking Buildbucket for the build status
[23:38:50.174] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:50.174] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:34:0) after 1m0s
[23:39:50.260] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:34:0)
[23:39:50.260] Timer tick, asking Buildbucket for the build status
[23:39:50.569] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:50.569] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:35:0) after 1m0s
[23:40:50.619] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:35:0)
[23:40:50.619] Timer tick, asking Buildbucket for the build status
[23:40:50.801] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:50.801] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:36:0) after 1m0s
[23:41:50.915] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:36:0)
[23:41:50.915] Timer tick, asking Buildbucket for the build status
[23:41:51.079] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:51.079] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:37:0) after 1m0s
[23:42:51.121] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:37:0)
[23:42:51.121] Timer tick, asking Buildbucket for the build status
[23:42:51.278] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:51.278] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:38:0) after 1m0s
[23:43:51.300] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:38:0)
[23:43:51.300] Timer tick, asking Buildbucket for the build status
[23:43:51.489] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:51.489] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:39:0) after 1m0s
[23:44:51.528] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:39:0)
[23:44:51.528] Timer tick, asking Buildbucket for the build status
[23:44:51.826] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:51.826] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:40:0) after 1m0s
[23:45:51.881] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:40:0)
[23:45:51.881] Timer tick, asking Buildbucket for the build status
[23:45:52.048] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:52.048] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:41:0) after 1m0s
[23:46:52.067] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:41:0)
[23:46:52.067] Timer tick, asking Buildbucket for the build status
[23:46:52.537] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:52.537] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:42:0) after 1m0s
[23:47:53.205] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:42:0)
[23:47:53.205] Timer tick, asking Buildbucket for the build status
[23:47:53.731] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:53.731] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:43:0) after 1m0s
[23:48:53.736] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:43:0)
[23:48:53.736] Timer tick, asking Buildbucket for the build status
[23:48:54.002] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:54.002] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:44:0) after 1m0s
[23:49:54.151] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:44:0)
[23:49:54.151] Timer tick, asking Buildbucket for the build status
[23:49:54.576] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:54.576] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:45:0) after 1m0s
[23:50:54.801] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:45:0)
[23:50:54.801] Timer tick, asking Buildbucket for the build status
[23:50:54.959] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:54.959] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:46:0) after 1m0s
[23:51:55.067] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:46:0)
[23:51:55.067] Timer tick, asking Buildbucket for the build status
[23:51:55.596] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:55.596] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:47:0) after 1m0s
[23:52:55.744] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:47:0)
[23:52:55.744] Timer tick, asking Buildbucket for the build status
[23:52:57.200] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:57.200] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:48:0) after 1m0s
[23:53:57.345] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:48:0)
[23:53:57.345] Timer tick, asking Buildbucket for the build status
[23:53:57.591] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:57.591] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:49:0) after 1m0s
[23:54:57.670] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:49:0)
[23:54:57.670] Timer tick, asking Buildbucket for the build status
[23:54:57.845] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:57.845] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:50:0) after 1m0s
[23:55:57.976] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:50:0)
[23:55:57.976] Timer tick, asking Buildbucket for the build status
[23:55:58.159] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:58.159] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:51:0) after 1m0s
[23:56:58.370] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:51:0)
[23:56:58.370] Timer tick, asking Buildbucket for the build status
[23:56:58.571] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:58.571] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:52:0) after 1m0s
[23:58:00.888] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:52:0)
[23:58:00.888] Timer tick, asking Buildbucket for the build status
[23:58:01.303] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:01.303] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:53:0) after 1m0s
[23:59:03.016] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:53:0)
[23:59:03.016] Timer tick, asking Buildbucket for the build status
[23:59:03.530] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:03.530] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:54:0) after 1m0s
[00:00:03.552] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:54:0)
[00:00:03.552] Timer tick, asking Buildbucket for the build status
[00:00:04.138] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:04.138] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:55:0) after 1m0s
[00:01:04.189] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:55:0)
[00:01:04.189] Timer tick, asking Buildbucket for the build status
[00:01:04.378] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:04.378] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:56:0) after 1m0s
[00:02:04.459] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:56:0)
[00:02:04.459] Timer tick, asking Buildbucket for the build status
[00:02:04.950] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:04.950] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:57:0) after 1m0s
[00:03:04.972] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:57:0)
[00:03:04.972] Timer tick, asking Buildbucket for the build status
[00:03:06.278] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:06.278] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:58:0) after 1m0s
[00:04:06.434] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:58:0)
[00:04:06.434] Timer tick, asking Buildbucket for the build status
[00:04:06.645] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:06.645] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:59:0) after 1m0s
[00:05:06.826] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:59:0)
[00:05:06.826] Timer tick, asking Buildbucket for the build status
[00:05:07.295] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:07.295] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:60:0) after 1m0s
[00:06:07.336] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:60:0)
[00:06:07.336] Timer tick, asking Buildbucket for the build status
[00:06:07.728] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:07.728] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:61:0) after 1m0s
[00:07:07.717] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:61:0)
[00:07:07.717] Timer tick, asking Buildbucket for the build status
[00:07:07.844] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:07.844] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:62:0) after 1m0s
[00:08:07.922] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:62:0)
[00:08:07.922] Timer tick, asking Buildbucket for the build status
[00:08:08.155] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:08.155] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:63:0) after 1m0s
[00:09:08.208] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:63:0)
[00:09:08.208] Timer tick, asking Buildbucket for the build status
[00:09:08.430] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:08.430] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:64:0) after 1m0s
[00:10:08.561] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:64:0)
[00:10:08.561] Timer tick, asking Buildbucket for the build status
[00:10:08.747] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:08.747] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:65:0) after 1m0s
[00:11:08.910] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:65:0)
[00:11:08.910] Timer tick, asking Buildbucket for the build status
[00:11:09.075] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:09.075] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:66:0) after 1m0s
[00:12:09.084] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:66:0)
[00:12:09.084] Timer tick, asking Buildbucket for the build status
[00:12:09.307] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:09.307] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:67:0) after 1m0s
[00:13:09.368] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:67:0)
[00:13:09.368] Timer tick, asking Buildbucket for the build status
[00:13:09.596] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:09.596] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:68:0) after 1m0s
[00:14:09.625] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:68:0)
[00:14:09.625] Timer tick, asking Buildbucket for the build status
[00:14:09.777] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:09.777] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:69:0) after 1m0s
[00:15:09.789] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:69:0)
[00:15:09.789] Timer tick, asking Buildbucket for the build status
[00:15:10.037] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:10.037] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:70:0) after 1m0s
[00:16:10.071] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:70:0)
[00:16:10.071] Timer tick, asking Buildbucket for the build status
[00:16:10.466] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:10.466] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:71:0) after 1m0s
[00:17:10.564] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:71:0)
[00:17:10.564] Timer tick, asking Buildbucket for the build status
[00:17:12.000] Build 8877838506295531664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:12.000] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9043268568444597152:72:0) after 1m0s
[00:17:14.435] Received PubSub notification, asking Buildbucket for the build status
[00:17:14.540] Build 8877838506295531664: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:17:14.540] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1591834632041297",
"created_by": "project:chromium",
"created_ts": "1591830453551203",
"failure_reason": "BUILD_FAILURE",
"id": "8877838506295531664",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0bb8a7d43d347dacf9a9dffd3cceb49886826c5c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"5 Test Suite(s) failed.\\n\\n**site_per_process_components_unittests on Android device Nexus 5X** failed because of:\\n\\n- UkmServiceTest.PurgeExtensionDataFromUnsentLogStore\\n\\n**site_per_process_chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.omnibox.LocationBarLayoutTest#testOmniboxSearchEngineLogo_ntp\\n\\n- org.chromium.chrome.browser.omnibox.LocationBarLayoutTest#testOmniboxSearchEngineLogo_ntpIncognito_nonGoogle\\n\\n- org.chromium.chrome.browser.autofill_assistant.AutofillAssistantCollectUserDataIntegrationTest#testEnterPayment\\n\\n- org.chromium.chrome.browser.tasks.tab_management.TabGridIphTest#testDismissIphItem\\n\\n- ...2 more failure(s) (6 total)...\\n\\n#### ...3 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-30-ja7x\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 44693, \"got_angle_revision\": \"277f64ca79c3dfba5933afbda1b88b83de376310\", \"got_dawn_revision\": \"18992f7be95aadcb428fc33cf7092d36755bd8f4\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"0bb8a7d43d347dacf9a9dffd3cceb49886826c5c\", \"got_revision_cp\": \"refs/heads/master@{#777158}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"e3eb327e8c3c724a415fa4d5f4805f2e281f4760\", \"got_v8_revision\": \"aa617c8af8379f45c2641402b2f4445a79822015\", \"got_v8_revision_cp\": \"refs/heads/8.5.136@{#1}\", \"got_webrtc_revision\": \"0fd1ef135c8492dd5886e9163126a193c6151706\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31490}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0bb8a7d43d347dacf9a9dffd3cceb49886826c5c\", \"swarm_hashes\": {\"android_browsertests\": \"f49ce87e128a806faa67065f0aa3afa5c01a9510\", \"chrome_public_test_apk\": \"c2443fd3f360b0ccc2593022e62a94da358b7a52\", \"components_browsertests\": \"08ce7a41ec4e9aa6b960cd5014243c8eaabb27c4\", \"components_unittests\": \"19cdb91fc402cecb92249f7bb634d50b7a7f30b4\", \"content_browsertests\": \"d91921a3dd81a2dd91b9a7da7a43cbd188d678b6\", \"content_shell_test_apk\": \"51f1a7a1b4e2b27e6a13e83488657e9ee00ac098\", \"content_unittests\": \"d4b8793b81abaffcc58d606c61b2932fd7979f7f\", \"unit_tests\": \"9a0da7035caf64a87f20ceb59559e4e91e060103\"}, \"swarm_hashes_refs/heads/master(at){#777158}_without_patch\": {\"android_browsertests\": \"f49ce87e128a806faa67065f0aa3afa5c01a9510\", \"chrome_public_test_apk\": \"c2443fd3f360b0ccc2593022e62a94da358b7a52\", \"components_browsertests\": \"08ce7a41ec4e9aa6b960cd5014243c8eaabb27c4\", \"components_unittests\": \"19cdb91fc402cecb92249f7bb634d50b7a7f30b4\", \"content_browsertests\": \"d91921a3dd81a2dd91b9a7da7a43cbd188d678b6\", \"content_shell_test_apk\": \"51f1a7a1b4e2b27e6a13e83488657e9ee00ac098\", \"content_unittests\": \"d4b8793b81abaffcc58d606c61b2932fd7979f7f\", \"unit_tests\": \"9a0da7035caf64a87f20ceb59559e4e91e060103\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_49b2c59a41dab71fb2bba5f6f8a4efb56888b0948fbb2a1ad8fa728b25e0dc17_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_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-30-ja7x\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5190-b7dcd03\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"5 Test Suite(s) failed.\\n\\n**site_per_process_components_unittests on Android device Nexus 5X** failed because of:\\n\\n- UkmServiceTest.PurgeExtensionDataFromUnsentLogStore\\n\\n**site_per_process_chrome_public_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.chrome.browser.omnibox.LocationBarLayoutTest#testOmniboxSearchEngineLogo_ntp\\n\\n- org.chromium.chrome.browser.omnibox.LocationBarLayoutTest#testOmniboxSearchEngineLogo_ntpIncognito_nonGoogle\\n\\n- org.chromium.chrome.browser.autofill_assistant.AutofillAssistantCollectUserDataIntegrationTest#testEnterPayment\\n\\n- org.chromium.chrome.browser.tasks.tab_management.TabGridIphTest#testDismissIphItem\\n\\n- ...2 more failure(s) (6 total)...\\n\\n#### ...3 more test(s)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1591830542156092",
"status": "COMPLETED",
"status_changed_ts": "1591830544781308",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/44693",
"builder:Site Isolation Android",
"buildset:commit/git/0bb8a7d43d347dacf9a9dffd3cceb49886826c5c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0bb8a7d43d347dacf9a9dffd3cceb49886826c5c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9043268568444597152",
"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/8877838506295531664/+/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:4cb94ea98cfe8910",
"user_agent:luci-scheduler"
],
"updated_ts": "1591834633634699",
"url": "https://ci.chromium.org/b/8877838506295531664",
"utcnow_ts": "1591834634529157"
}
}
[00:17:14.540] Invocation finished in 1h9m42.422587884s with status FAILED