[07:50:02.513] New invocation is queued and will start shortly
[07:50:03.866] Starting the invocation (attempt 1)
[07:50:03.915] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:50:03.915] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:50:03.915] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070505382090057360",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"5b279d332c0f73c4842644e054a519de10af0f6a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9070505382090057360",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/5b279d332c0f73c4842644e054a519de10af0f6a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b279d332c0f73c4842644e054a519de10af0f6a",
"gitiles_ref:refs/heads/master"
]
}
[07:50:04.973] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565855404362047",
"id": "8905075319473999952",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5b279d332c0f73c4842644e054a519de10af0f6a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565855404814793",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/36263",
"builder:Site Isolation Android",
"buildset:commit/git/5b279d332c0f73c4842644e054a519de10af0f6a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b279d332c0f73c4842644e054a519de10af0f6a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070505382090057360",
"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/8905075319473999952/+/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": "1565855404814977",
"url": "https://ci.chromium.org/b/8905075319473999952",
"utcnow_ts": "1565855404965861"
}
}
[07:50:04.973] Task URL: https://ci.chromium.org/b/8905075319473999952
[07:50:04.973] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:2:0) after 1m0s
[07:50:10.001] Received PubSub notification, asking Buildbucket for the build status
[07:50:10.164] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:05.045] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:2:0)
[07:51:05.045] Timer tick, asking Buildbucket for the build status
[07:51:06.146] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:06.146] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:4:0) after 1m0s
[07:52:06.259] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:4:0)
[07:52:06.259] Timer tick, asking Buildbucket for the build status
[07:52:06.893] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:06.893] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:5:0) after 1m0s
[07:53:06.932] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:5:0)
[07:53:06.932] Timer tick, asking Buildbucket for the build status
[07:53:07.242] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:07.242] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:6:0) after 1m0s
[07:54:07.289] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:6:0)
[07:54:07.289] Timer tick, asking Buildbucket for the build status
[07:54:07.605] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:07.605] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:7:0) after 1m0s
[07:55:07.660] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:7:0)
[07:55:07.660] Timer tick, asking Buildbucket for the build status
[07:55:08.303] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:08.303] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:8:0) after 1m0s
[07:56:08.375] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:8:0)
[07:56:08.376] Timer tick, asking Buildbucket for the build status
[07:56:09.485] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:09.485] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:9:0) after 1m0s
[07:57:09.490] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:9:0)
[07:57:09.490] Timer tick, asking Buildbucket for the build status
[07:57:10.194] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:10.194] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:10:0) after 1m0s
[07:58:10.236] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:10:0)
[07:58:10.236] Timer tick, asking Buildbucket for the build status
[07:58:10.371] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:10.371] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:11:0) after 1m0s
[07:59:10.450] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:11:0)
[07:59:10.450] Timer tick, asking Buildbucket for the build status
[07:59:11.250] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:11.250] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:12:0) after 1m0s
[08:00:11.408] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:12:0)
[08:00:11.408] Timer tick, asking Buildbucket for the build status
[08:00:11.767] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:11.767] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:13:0) after 1m0s
[08:01:11.826] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:13:0)
[08:01:11.826] Timer tick, asking Buildbucket for the build status
[08:01:12.145] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:12.145] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:14:0) after 1m0s
[08:02:12.169] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:14:0)
[08:02:12.169] Timer tick, asking Buildbucket for the build status
[08:02:14.835] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:14.835] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:15:0) after 1m0s
[08:03:14.910] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:15:0)
[08:03:14.910] Timer tick, asking Buildbucket for the build status
[08:03:15.378] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:15.379] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:16:0) after 1m0s
[08:04:15.596] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:16:0)
[08:04:15.596] Timer tick, asking Buildbucket for the build status
[08:04:16.841] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:16.841] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:17:0) after 1m0s
[08:05:16.941] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:17:0)
[08:05:16.941] Timer tick, asking Buildbucket for the build status
[08:05:17.243] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:17.243] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:18:0) after 1m0s
[08:06:17.361] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:18:0)
[08:06:17.362] Timer tick, asking Buildbucket for the build status
[08:06:17.720] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:17.720] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:19:0) after 1m0s
[08:07:17.937] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:19:0)
[08:07:17.937] Timer tick, asking Buildbucket for the build status
[08:07:18.202] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:18.202] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:20:0) after 1m0s
[08:08:18.343] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:20:0)
[08:08:18.343] Timer tick, asking Buildbucket for the build status
[08:08:18.675] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:18.675] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:21:0) after 1m0s
[08:09:18.899] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:21:0)
[08:09:18.899] Timer tick, asking Buildbucket for the build status
[08:09:19.275] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:19.275] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:22:0) after 1m0s
[08:10:19.393] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:22:0)
[08:10:19.393] Timer tick, asking Buildbucket for the build status
[08:10:19.889] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:19.889] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:23:0) after 1m0s
[08:11:19.944] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:23:0)
[08:11:19.944] Timer tick, asking Buildbucket for the build status
[08:11:20.221] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:20.221] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:24:0) after 1m0s
[08:12:20.294] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:24:0)
[08:12:20.294] Timer tick, asking Buildbucket for the build status
[08:12:21.756] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:21.756] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:25:0) after 1m0s
[08:13:21.751] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:25:0)
[08:13:21.751] Timer tick, asking Buildbucket for the build status
[08:13:23.469] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:23.469] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:26:0) after 1m0s
[08:14:23.544] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:26:0)
[08:14:23.544] Timer tick, asking Buildbucket for the build status
[08:14:23.988] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:23.988] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:27:0) after 1m0s
[08:15:24.119] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:27:0)
[08:15:24.119] Timer tick, asking Buildbucket for the build status
[08:15:24.583] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:24.583] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:28:0) after 1m0s
[08:16:24.626] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:28:0)
[08:16:24.626] Timer tick, asking Buildbucket for the build status
[08:16:30.209] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:30.209] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:29:0) after 1m0s
[08:17:30.219] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:29:0)
[08:17:30.219] Timer tick, asking Buildbucket for the build status
[08:17:30.384] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:30.384] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:30:0) after 1m0s
[08:18:30.441] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:30:0)
[08:18:30.441] Timer tick, asking Buildbucket for the build status
[08:18:30.664] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:30.664] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:31:0) after 1m0s
[08:19:30.689] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:31:0)
[08:19:30.689] Timer tick, asking Buildbucket for the build status
[08:19:30.886] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:30.886] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:32:0) after 1m0s
[08:20:31.019] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:32:0)
[08:20:31.019] Timer tick, asking Buildbucket for the build status
[08:20:31.194] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:31.194] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:33:0) after 1m0s
[08:21:31.266] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:33:0)
[08:21:31.266] Timer tick, asking Buildbucket for the build status
[08:21:31.463] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:31.463] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:34:0) after 1m0s
[08:22:31.527] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:34:0)
[08:22:31.527] Timer tick, asking Buildbucket for the build status
[08:22:31.785] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:31.785] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:35:0) after 1m0s
[08:23:31.890] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:35:0)
[08:23:31.890] Timer tick, asking Buildbucket for the build status
[08:23:32.486] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:32.486] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:36:0) after 1m0s
[08:24:32.605] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:36:0)
[08:24:32.605] Timer tick, asking Buildbucket for the build status
[08:24:32.917] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:32.917] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:37:0) after 1m0s
[08:25:32.959] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:37:0)
[08:25:32.959] Timer tick, asking Buildbucket for the build status
[08:25:33.719] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:33.719] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:38:0) after 1m0s
[08:26:33.746] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:38:0)
[08:26:33.746] Timer tick, asking Buildbucket for the build status
[08:26:33.940] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:33.940] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:39:0) after 1m0s
[08:27:34.029] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:39:0)
[08:27:34.029] Timer tick, asking Buildbucket for the build status
[08:27:35.024] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:35.025] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:40:0) after 1m0s
[08:28:35.112] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:40:0)
[08:28:35.112] Timer tick, asking Buildbucket for the build status
[08:28:35.317] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:35.317] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:41:0) after 1m0s
[08:29:35.461] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:41:0)
[08:29:35.461] Timer tick, asking Buildbucket for the build status
[08:29:36.361] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:36.361] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:42:0) after 1m0s
[08:30:36.382] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:42:0)
[08:30:36.382] Timer tick, asking Buildbucket for the build status
[08:30:37.176] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:37.176] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:43:0) after 1m0s
[08:31:37.200] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:43:0)
[08:31:37.200] Timer tick, asking Buildbucket for the build status
[08:31:37.738] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:37.738] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:44:0) after 1m0s
[08:32:37.840] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:44:0)
[08:32:37.840] Timer tick, asking Buildbucket for the build status
[08:32:38.725] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:38.725] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:45:0) after 1m0s
[08:33:38.797] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:45:0)
[08:33:38.797] Timer tick, asking Buildbucket for the build status
[08:33:39.373] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:39.373] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:46:0) after 1m0s
[08:34:39.459] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:46:0)
[08:34:39.459] Timer tick, asking Buildbucket for the build status
[08:34:39.696] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:39.696] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:47:0) after 1m0s
[08:35:39.923] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:47:0)
[08:35:39.923] Timer tick, asking Buildbucket for the build status
[08:35:40.192] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:40.192] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:48:0) after 1m0s
[08:36:40.241] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:48:0)
[08:36:40.241] Timer tick, asking Buildbucket for the build status
[08:36:41.053] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:41.053] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:49:0) after 1m0s
[08:37:41.127] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:49:0)
[08:37:41.127] Timer tick, asking Buildbucket for the build status
[08:37:42.368] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:42.368] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:50:0) after 1m0s
[08:38:42.417] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:50:0)
[08:38:42.417] Timer tick, asking Buildbucket for the build status
[08:38:43.154] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:43.154] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:51:0) after 1m0s
[08:39:43.186] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:51:0)
[08:39:43.186] Timer tick, asking Buildbucket for the build status
[08:39:43.671] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:43.671] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:52:0) after 1m0s
[08:40:43.747] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:52:0)
[08:40:43.747] Timer tick, asking Buildbucket for the build status
[08:40:44.037] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:44.037] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:53:0) after 1m0s
[08:41:44.090] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:53:0)
[08:41:44.090] Timer tick, asking Buildbucket for the build status
[08:41:44.663] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:44.663] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:54:0) after 1m0s
[08:42:44.733] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:54:0)
[08:42:44.734] Timer tick, asking Buildbucket for the build status
[08:42:44.930] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:44.930] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:55:0) after 1m0s
[08:43:45.642] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:55:0)
[08:43:45.642] Timer tick, asking Buildbucket for the build status
[08:43:46.326] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:46.327] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:56:0) after 1m0s
[08:44:46.371] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:56:0)
[08:44:46.371] Timer tick, asking Buildbucket for the build status
[08:44:46.595] Build 8905075319473999952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:46.595] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070505382090057360:57:0) after 1m0s
[08:45:44.319] Received PubSub notification, asking Buildbucket for the build status
[08:45:44.966] Build 8905075319473999952: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:45:44.967] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1565858743474049",
"created_by": "project:chromium",
"created_ts": "1565855404362047",
"failure_reason": "BUILD_FAILURE",
"id": "8905075319473999952",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5b279d332c0f73c4842644e054a519de10af0f6a\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**site_per_process_unit_tests on Android device Nexus 5X** failed because of:\\n\\n- OfflinePageUtilsTest.TestGetCachedOfflinePageSizeAllPagesInRange\"}, \"properties\": {\"$build/goma\": {\"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-83-ehlm\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 36263, \"got_angle_revision\": \"3ea90d609720b7b9b9d05ca094860382f2425294\", \"got_dawn_revision\": \"5f8a8aadb96b5ac0302836de219943178f240c20\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"5b279d332c0f73c4842644e054a519de10af0f6a\", \"got_revision_cp\": \"refs/heads/master@{#687189}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"f46449fa2ba524d041e0977c4c718ebe6df9d435\", \"got_v8_revision_cp\": \"refs/heads/7.8.110@{#1}\", \"got_webrtc_revision\": \"7c6f74ab0344e9c6201de711d54026e9990b8e6c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28844}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"5b279d332c0f73c4842644e054a519de10af0f6a\", \"swarm_hashes\": {\"components_browsertests\": \"a8befc8747041cac9b009240c7f156c722df37bb\", \"components_unittests\": \"a02492c1ca346fb15bb3729d0f747812135ecdfc\", \"content_browsertests\": \"f427df3595a20ee608d11943f52d78eda8ac129d\", \"content_unittests\": \"b7249ffab267c32b416537d280692625eeceae6c\", \"unit_tests\": \"a9134d344665502ff3ac56e6e7fcef863fcd48c3\"}, \"swarm_hashes_refs/heads/master(at){#687189}_without_patch\": {\"components_browsertests\": \"a8befc8747041cac9b009240c7f156c722df37bb\", \"components_unittests\": \"a02492c1ca346fb15bb3729d0f747812135ecdfc\", \"content_browsertests\": \"f427df3595a20ee608d11943f52d78eda8ac129d\", \"content_unittests\": \"b7249ffab267c32b416537d280692625eeceae6c\", \"unit_tests\": \"a9134d344665502ff3ac56e6e7fcef863fcd48c3\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_746f25208a125120dfc7ef61e5ef35531bce9c0f7be870eb0811bf6f56bb01d6_v2\", \"builder_a050691f36f3646c8cc368108f8edcf844a0d1683dc4a3731c64b1c7527ccb94_v2\", \"builder_bc06489a6051aa9ff26f19e198953984e62b042f17a2894081efaf5e8f8aac40_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-83-ehlm\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"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\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**site_per_process_unit_tests on Android device Nexus 5X** failed because of:\\n\\n- OfflinePageUtilsTest.TestGetCachedOfflinePageSizeAllPagesInRange\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1565855408779361",
"status": "COMPLETED",
"status_changed_ts": "1565855409534962",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/36263",
"builder:Site Isolation Android",
"buildset:commit/git/5b279d332c0f73c4842644e054a519de10af0f6a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b279d332c0f73c4842644e054a519de10af0f6a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070505382090057360",
"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/8905075319473999952/+/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:46ad12dc42e28210",
"user_agent:luci-scheduler"
],
"updated_ts": "1565858743779815",
"url": "https://ci.chromium.org/b/8905075319473999952",
"utcnow_ts": "1565858744955517"
}
}
[08:45:44.967] Invocation finished in 55m42.482804791s with status FAILED