[21:44:18.533] New invocation is queued and will start shortly
[21:44:19.651] Starting the invocation (attempt 1)
[21:44:19.720] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:44:19.720] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:44:19.720] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054054843617650240",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9d5503a46953fa99163b9d96bcd9a91b4268d8af\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9054054843617650240",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/9d5503a46953fa99163b9d96bcd9a91b4268d8af",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d5503a46953fa99163b9d96bcd9a91b4268d8af",
"gitiles_ref:refs/heads/master"
]
}
[21:44:20.469] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581543859888776",
"id": "8888624781532848832",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9d5503a46953fa99163b9d96bcd9a91b4268d8af\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581543860338601",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/41668",
"builder:Site Isolation Android",
"buildset:commit/git/9d5503a46953fa99163b9d96bcd9a91b4268d8af",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d5503a46953fa99163b9d96bcd9a91b4268d8af",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054054843617650240",
"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/8888624781532848832/+/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": "1581543860338715",
"url": "https://ci.chromium.org/b/8888624781532848832",
"utcnow_ts": "1581543860461420"
}
}
[21:44:20.469] Task URL: https://ci.chromium.org/b/8888624781532848832
[21:44:20.469] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:2:0) after 1m0s
[21:45:20.519] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:2:0)
[21:45:20.519] Timer tick, asking Buildbucket for the build status
[21:45:20.857] Build 8888624781532848832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:45:20.857] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:3:0) after 1m0s
[21:46:20.890] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:3:0)
[21:46:20.890] Timer tick, asking Buildbucket for the build status
[21:46:21.021] Build 8888624781532848832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:46:21.021] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:4:0) after 1m0s
[21:47:21.064] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:4:0)
[21:47:21.064] Timer tick, asking Buildbucket for the build status
[21:47:21.891] Build 8888624781532848832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:47:21.891] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:5:0) after 1m0s
[21:48:21.989] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:5:0)
[21:48:21.989] Timer tick, asking Buildbucket for the build status
[21:48:22.132] Build 8888624781532848832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:48:22.132] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:6:0) after 1m0s
[21:49:22.186] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:6:0)
[21:49:22.186] Timer tick, asking Buildbucket for the build status
[21:49:22.337] Build 8888624781532848832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[21:49:22.337] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:7:0) after 1m0s
[21:49:46.394] Received PubSub notification, asking Buildbucket for the build status
[21:49:46.509] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:22.357] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:7:0)
[21:50:22.357] Timer tick, asking Buildbucket for the build status
[21:50:22.794] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:22.794] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:9:0) after 1m0s
[21:51:22.815] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:9:0)
[21:51:22.815] Timer tick, asking Buildbucket for the build status
[21:51:23.046] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:23.046] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:10:0) after 1m0s
[21:52:23.101] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:10:0)
[21:52:23.101] Timer tick, asking Buildbucket for the build status
[21:52:23.700] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:23.700] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:11:0) after 1m0s
[21:53:23.724] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:11:0)
[21:53:23.725] Timer tick, asking Buildbucket for the build status
[21:53:23.913] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:23.913] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:12:0) after 1m0s
[21:54:24.034] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:12:0)
[21:54:24.034] Timer tick, asking Buildbucket for the build status
[21:54:24.895] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:24.896] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:13:0) after 1m0s
[21:55:24.954] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:13:0)
[21:55:24.954] Timer tick, asking Buildbucket for the build status
[21:55:25.404] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:25.404] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:14:0) after 1m0s
[21:56:25.421] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:14:0)
[21:56:25.421] Timer tick, asking Buildbucket for the build status
[21:56:25.773] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:25.773] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:15:0) after 1m0s
[21:57:25.828] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:15:0)
[21:57:25.828] Timer tick, asking Buildbucket for the build status
[21:57:25.985] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:25.985] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:16:0) after 1m0s
[21:58:25.985] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:16:0)
[21:58:25.985] Timer tick, asking Buildbucket for the build status
[21:58:26.158] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:26.158] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:17:0) after 1m0s
[21:59:26.156] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:17:0)
[21:59:26.156] Timer tick, asking Buildbucket for the build status
[21:59:26.455] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:26.456] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:18:0) after 1m0s
[22:00:26.504] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:18:0)
[22:00:26.504] Timer tick, asking Buildbucket for the build status
[22:00:26.646] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:26.646] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:19:0) after 1m0s
[22:01:26.687] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:19:0)
[22:01:26.687] Timer tick, asking Buildbucket for the build status
[22:01:26.864] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:26.864] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:20:0) after 1m0s
[22:02:26.881] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:20:0)
[22:02:26.881] Timer tick, asking Buildbucket for the build status
[22:02:27.208] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:27.208] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:21:0) after 1m0s
[22:03:27.236] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:21:0)
[22:03:27.236] Timer tick, asking Buildbucket for the build status
[22:03:27.411] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:27.411] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:22:0) after 1m0s
[22:04:27.461] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:22:0)
[22:04:27.461] Timer tick, asking Buildbucket for the build status
[22:04:27.654] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:27.654] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:23:0) after 1m0s
[22:05:27.727] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:23:0)
[22:05:27.727] Timer tick, asking Buildbucket for the build status
[22:05:28.374] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:28.374] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:24:0) after 1m0s
[22:06:28.379] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:24:0)
[22:06:28.379] Timer tick, asking Buildbucket for the build status
[22:06:28.952] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:28.952] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:25:0) after 1m0s
[22:07:28.971] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:25:0)
[22:07:28.972] Timer tick, asking Buildbucket for the build status
[22:07:29.141] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:29.141] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:26:0) after 1m0s
[22:08:29.164] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:26:0)
[22:08:29.164] Timer tick, asking Buildbucket for the build status
[22:08:29.759] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:29.759] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:27:0) after 1m0s
[22:09:29.755] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:27:0)
[22:09:29.755] Timer tick, asking Buildbucket for the build status
[22:09:29.937] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:29.937] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:28:0) after 1m0s
[22:10:29.992] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:28:0)
[22:10:29.992] Timer tick, asking Buildbucket for the build status
[22:10:30.154] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:30.154] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:29:0) after 1m0s
[22:11:30.212] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:29:0)
[22:11:30.212] Timer tick, asking Buildbucket for the build status
[22:11:30.386] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:30.386] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:30:0) after 1m0s
[22:12:30.459] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:30:0)
[22:12:30.459] Timer tick, asking Buildbucket for the build status
[22:12:30.801] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:30.801] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:31:0) after 1m0s
[22:13:30.843] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:31:0)
[22:13:30.843] Timer tick, asking Buildbucket for the build status
[22:13:31.711] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:31.712] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:32:0) after 1m0s
[22:14:31.800] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:32:0)
[22:14:31.800] Timer tick, asking Buildbucket for the build status
[22:14:32.022] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:32.022] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:33:0) after 1m0s
[22:15:32.064] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:33:0)
[22:15:32.064] Timer tick, asking Buildbucket for the build status
[22:15:34.264] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:34.264] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:34:0) after 1m0s
[22:16:34.305] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:34:0)
[22:16:34.305] Timer tick, asking Buildbucket for the build status
[22:16:34.657] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:34.657] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:35:0) after 1m0s
[22:17:34.706] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:35:0)
[22:17:34.706] Timer tick, asking Buildbucket for the build status
[22:17:35.234] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:35.234] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:36:0) after 1m0s
[22:18:35.269] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:36:0)
[22:18:35.269] Timer tick, asking Buildbucket for the build status
[22:18:35.474] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:35.474] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:37:0) after 1m0s
[22:19:35.495] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:37:0)
[22:19:35.495] Timer tick, asking Buildbucket for the build status
[22:19:35.644] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:35.644] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:38:0) after 1m0s
[22:20:35.673] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:38:0)
[22:20:35.673] Timer tick, asking Buildbucket for the build status
[22:20:35.858] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:35.858] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:39:0) after 1m0s
[22:21:35.900] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:39:0)
[22:21:35.901] Timer tick, asking Buildbucket for the build status
[22:21:36.032] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:36.032] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:40:0) after 1m0s
[22:22:36.059] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:40:0)
[22:22:36.059] Timer tick, asking Buildbucket for the build status
[22:22:36.215] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:36.215] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:41:0) after 1m0s
[22:23:36.258] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:41:0)
[22:23:36.258] Timer tick, asking Buildbucket for the build status
[22:23:36.447] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:36.447] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:42:0) after 1m0s
[22:24:36.508] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:42:0)
[22:24:36.508] Timer tick, asking Buildbucket for the build status
[22:24:36.709] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:36.709] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:43:0) after 1m0s
[22:25:36.726] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:43:0)
[22:25:36.726] Timer tick, asking Buildbucket for the build status
[22:25:37.095] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:37.095] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:44:0) after 1m0s
[22:26:37.119] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:44:0)
[22:26:37.119] Timer tick, asking Buildbucket for the build status
[22:26:37.519] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:37.519] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:45:0) after 1m0s
[22:27:37.522] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:45:0)
[22:27:37.522] Timer tick, asking Buildbucket for the build status
[22:27:37.804] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:37.804] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:46:0) after 1m0s
[22:28:37.857] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:46:0)
[22:28:37.857] Timer tick, asking Buildbucket for the build status
[22:28:38.711] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:38.711] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:47:0) after 1m0s
[22:29:38.786] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:47:0)
[22:29:38.786] Timer tick, asking Buildbucket for the build status
[22:29:39.057] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:39.057] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:48:0) after 1m0s
[22:30:39.156] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:48:0)
[22:30:39.156] Timer tick, asking Buildbucket for the build status
[22:30:39.790] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:39.790] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:49:0) after 1m0s
[22:31:39.805] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:49:0)
[22:31:39.805] Timer tick, asking Buildbucket for the build status
[22:31:44.162] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:44.162] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:50:0) after 1m0s
[22:32:44.212] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:50:0)
[22:32:44.212] Timer tick, asking Buildbucket for the build status
[22:32:44.435] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:44.435] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:51:0) after 1m0s
[22:33:44.454] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:51:0)
[22:33:44.454] Timer tick, asking Buildbucket for the build status
[22:33:44.774] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:44.774] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:52:0) after 1m0s
[22:34:44.770] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:52:0)
[22:34:44.770] Timer tick, asking Buildbucket for the build status
[22:34:45.005] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:45.005] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:53:0) after 1m0s
[22:35:45.048] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:53:0)
[22:35:45.048] Timer tick, asking Buildbucket for the build status
[22:35:45.171] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:45.171] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:54:0) after 1m0s
[22:36:45.190] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:54:0)
[22:36:45.190] Timer tick, asking Buildbucket for the build status
[22:36:45.403] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:45.403] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:55:0) after 1m0s
[22:37:45.405] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:55:0)
[22:37:45.405] Timer tick, asking Buildbucket for the build status
[22:37:45.976] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:45.976] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:56:0) after 1m0s
[22:38:45.994] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:56:0)
[22:38:45.994] Timer tick, asking Buildbucket for the build status
[22:38:46.505] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:46.505] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:57:0) after 1m0s
[22:39:46.614] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:57:0)
[22:39:46.614] Timer tick, asking Buildbucket for the build status
[22:39:46.912] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:46.912] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:58:0) after 1m0s
[22:40:46.928] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:58:0)
[22:40:46.928] Timer tick, asking Buildbucket for the build status
[22:40:47.323] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:47.323] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:59:0) after 1m0s
[22:41:47.346] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:59:0)
[22:41:47.346] Timer tick, asking Buildbucket for the build status
[22:41:47.518] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:47.518] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:60:0) after 1m0s
[22:42:47.555] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:60:0)
[22:42:47.555] Timer tick, asking Buildbucket for the build status
[22:42:48.034] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:48.034] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:61:0) after 1m0s
[22:43:48.091] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:61:0)
[22:43:48.091] Timer tick, asking Buildbucket for the build status
[22:43:48.233] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:48.234] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:62:0) after 1m0s
[22:44:48.260] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:62:0)
[22:44:48.260] Timer tick, asking Buildbucket for the build status
[22:44:48.405] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:48.405] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:63:0) after 1m0s
[22:45:48.597] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:63:0)
[22:45:48.597] Timer tick, asking Buildbucket for the build status
[22:45:49.021] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:49.021] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:64:0) after 1m0s
[22:46:49.155] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:64:0)
[22:46:49.155] Timer tick, asking Buildbucket for the build status
[22:46:49.302] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:49.303] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:65:0) after 1m0s
[22:47:49.308] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:65:0)
[22:47:49.308] Timer tick, asking Buildbucket for the build status
[22:47:50.002] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:50.002] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:66:0) after 1m0s
[22:48:50.132] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:66:0)
[22:48:50.132] Timer tick, asking Buildbucket for the build status
[22:48:50.298] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:50.298] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:67:0) after 1m0s
[22:49:50.360] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:67:0)
[22:49:50.360] Timer tick, asking Buildbucket for the build status
[22:49:50.779] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:50.779] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:68:0) after 1m0s
[22:50:50.823] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:68:0)
[22:50:50.823] Timer tick, asking Buildbucket for the build status
[22:50:51.126] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:51.126] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:69:0) after 1m0s
[22:51:51.202] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:69:0)
[22:51:51.202] Timer tick, asking Buildbucket for the build status
[22:51:51.339] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:51.339] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:70:0) after 1m0s
[22:52:51.465] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:70:0)
[22:52:51.465] Timer tick, asking Buildbucket for the build status
[22:52:51.634] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:51.634] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:71:0) after 1m0s
[22:53:51.650] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:71:0)
[22:53:51.650] Timer tick, asking Buildbucket for the build status
[22:53:51.888] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:51.888] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:72:0) after 1m0s
[22:54:51.914] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:72:0)
[22:54:51.914] Timer tick, asking Buildbucket for the build status
[22:54:52.103] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:52.103] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:73:0) after 1m0s
[22:55:52.231] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:73:0)
[22:55:52.231] Timer tick, asking Buildbucket for the build status
[22:55:53.448] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:53.448] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:74:0) after 1m0s
[22:56:53.533] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:74:0)
[22:56:53.533] Timer tick, asking Buildbucket for the build status
[22:56:55.604] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:55.604] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:75:0) after 1m0s
[22:57:55.671] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:75:0)
[22:57:55.671] Timer tick, asking Buildbucket for the build status
[22:57:55.966] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:55.966] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:76:0) after 1m0s
[22:58:56.000] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:76:0)
[22:58:56.000] Timer tick, asking Buildbucket for the build status
[22:58:56.189] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:56.189] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:77:0) after 1m0s
[22:59:56.272] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:77:0)
[22:59:56.272] Timer tick, asking Buildbucket for the build status
[22:59:57.911] Build 8888624781532848832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:57.911] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054054843617650240:78:0) after 1m0s
[23:00:35.684] Received PubSub notification, asking Buildbucket for the build status
[23:00:35.814] Build 8888624781532848832: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[23:00:35.814] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581548434702741",
"created_by": "project:chromium",
"created_ts": "1581543859888776",
"failure_reason": "BUILD_FAILURE",
"id": "8888624781532848832",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9d5503a46953fa99163b9d96bcd9a91b4268d8af\"}}",
"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-31-to6m\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 41668, \"got_angle_revision\": \"92b00ca882637cfaff897e689dcc50fa20c31143\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"9d5503a46953fa99163b9d96bcd9a91b4268d8af\", \"got_revision_cp\": \"refs/heads/master@{#740832}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"d5a2a597ceb4168edb48401c7a0ca650dd60c5aa\", \"got_v8_revision\": \"f4ae4cac20bc22d93b35b3effd92074a3546252f\", \"got_v8_revision_cp\": \"refs/heads/8.2.63@{#1}\", \"got_webrtc_revision\": \"d4c3c3a454215b21f02d2a772a729b4c87d6b33e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30486}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9d5503a46953fa99163b9d96bcd9a91b4268d8af\", \"swarm_hashes\": {\"components_browsertests\": \"55c7fa54ecdab432d3d8d4a75cd20b5d71d3923f\", \"components_unittests\": \"4d3202787f754b9de513dd12415b6eca2ab18525\", \"content_browsertests\": \"40393418af39fab9bba29b2d1ad7200839ae613a\", \"content_unittests\": \"a3903892cb58fc0240ffee28acd483dd2b438dc8\", \"unit_tests\": \"fedc8d5145b413e0f11445df97afca0dd5e60058\"}, \"swarm_hashes_refs/heads/master(at){#740832}_without_patch\": {\"components_browsertests\": \"55c7fa54ecdab432d3d8d4a75cd20b5d71d3923f\", \"components_unittests\": \"4d3202787f754b9de513dd12415b6eca2ab18525\", \"content_browsertests\": \"40393418af39fab9bba29b2d1ad7200839ae613a\", \"content_unittests\": \"a3903892cb58fc0240ffee28acd483dd2b438dc8\", \"unit_tests\": \"fedc8d5145b413e0f11445df97afca0dd5e60058\"}}, \"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": "1581544185957294",
"status": "COMPLETED",
"status_changed_ts": "1581543860338601",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/41668",
"builder:Site Isolation Android",
"buildset:commit/git/9d5503a46953fa99163b9d96bcd9a91b4268d8af",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9d5503a46953fa99163b9d96bcd9a91b4268d8af",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054054843617650240",
"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/8888624781532848832/+/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:4a542db27906b310",
"user_agent:luci-scheduler"
],
"updated_ts": "1581548435062193",
"url": "https://ci.chromium.org/b/8888624781532848832",
"utcnow_ts": "1581548435804185"
}
}
[23:00:35.814] Invocation finished in 1h16m17.298411058s with status FAILED