[07:14:04.577] New invocation is queued and will start shortly
[07:14:05.655] Starting the invocation (attempt 1)
[07:14:05.685] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:14:05.685] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:14:05.685] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054743772683393856",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3d5c30f36e3a00c7c05dcac763206c0b19511ea0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9054743772683393856",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/3d5c30f36e3a00c7c05dcac763206c0b19511ea0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3d5c30f36e3a00c7c05dcac763206c0b19511ea0",
"gitiles_ref:refs/heads/master"
]
}
[07:14:06.375] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580886845837188",
"id": "8889313710697407456",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3d5c30f36e3a00c7c05dcac763206c0b19511ea0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580886846223879",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/41448",
"builder:Site Isolation Android",
"buildset:commit/git/3d5c30f36e3a00c7c05dcac763206c0b19511ea0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3d5c30f36e3a00c7c05dcac763206c0b19511ea0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054743772683393856",
"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/8889313710697407456/+/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": "1580886846224030",
"url": "https://ci.chromium.org/b/8889313710697407456",
"utcnow_ts": "1580886846367625"
}
}
[07:14:06.375] Task URL: https://ci.chromium.org/b/8889313710697407456
[07:14:06.375] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:2:0) after 1m0s
[07:15:06.439] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:2:0)
[07:15:06.439] Timer tick, asking Buildbucket for the build status
[07:15:06.629] Build 8889313710697407456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:06.629] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:3:0) after 1m0s
[07:16:06.667] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:3:0)
[07:16:06.667] Timer tick, asking Buildbucket for the build status
[07:16:06.835] Build 8889313710697407456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:16:06.835] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:4:0) after 1m0s
[07:17:06.902] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:4:0)
[07:17:06.902] Timer tick, asking Buildbucket for the build status
[07:17:07.174] Build 8889313710697407456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:07.174] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:5:0) after 1m0s
[07:18:07.162] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:5:0)
[07:18:07.162] Timer tick, asking Buildbucket for the build status
[07:18:07.406] Build 8889313710697407456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:07.406] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:6:0) after 1m0s
[07:19:07.581] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:6:0)
[07:19:07.581] Timer tick, asking Buildbucket for the build status
[07:19:07.760] Build 8889313710697407456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:19:07.760] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:7:0) after 1m0s
[07:19:20.305] Received PubSub notification, asking Buildbucket for the build status
[07:19:23.217] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:07.842] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:7:0)
[07:20:07.842] Timer tick, asking Buildbucket for the build status
[07:20:08.236] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:08.236] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:9:0) after 1m0s
[07:21:08.469] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:9:0)
[07:21:08.469] Timer tick, asking Buildbucket for the build status
[07:21:08.601] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:08.601] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:10:0) after 1m0s
[07:22:08.614] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:10:0)
[07:22:08.614] Timer tick, asking Buildbucket for the build status
[07:22:08.819] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:08.819] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:11:0) after 1m0s
[07:23:08.899] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:11:0)
[07:23:08.899] Timer tick, asking Buildbucket for the build status
[07:23:09.771] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:09.771] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:12:0) after 1m0s
[07:24:10.061] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:12:0)
[07:24:10.061] Timer tick, asking Buildbucket for the build status
[07:24:10.684] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:10.684] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:13:0) after 1m0s
[07:25:10.725] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:13:0)
[07:25:10.725] Timer tick, asking Buildbucket for the build status
[07:25:12.197] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:12.197] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:14:0) after 1m0s
[07:26:12.231] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:14:0)
[07:26:12.231] Timer tick, asking Buildbucket for the build status
[07:26:12.451] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:12.451] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:15:0) after 1m0s
[07:27:12.504] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:15:0)
[07:27:12.504] Timer tick, asking Buildbucket for the build status
[07:27:13.098] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:13.098] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:16:0) after 1m0s
[07:28:13.198] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:16:0)
[07:28:13.198] Timer tick, asking Buildbucket for the build status
[07:28:13.404] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:13.405] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:17:0) after 1m0s
[07:29:13.489] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:17:0)
[07:29:13.489] Timer tick, asking Buildbucket for the build status
[07:29:13.699] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:13.699] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:18:0) after 1m0s
[07:30:13.885] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:18:0)
[07:30:13.885] Timer tick, asking Buildbucket for the build status
[07:30:14.372] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:14.372] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:19:0) after 1m0s
[07:31:14.423] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:19:0)
[07:31:14.423] Timer tick, asking Buildbucket for the build status
[07:31:14.816] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:14.816] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:20:0) after 1m0s
[07:32:14.899] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:20:0)
[07:32:14.899] Timer tick, asking Buildbucket for the build status
[07:32:15.328] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:15.328] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:21:0) after 1m0s
[07:33:15.414] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:21:0)
[07:33:15.414] Timer tick, asking Buildbucket for the build status
[07:33:16.102] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:16.102] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:22:0) after 1m0s
[07:34:16.130] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:22:0)
[07:34:16.130] Timer tick, asking Buildbucket for the build status
[07:34:16.290] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:16.290] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:23:0) after 1m0s
[07:35:16.453] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:23:0)
[07:35:16.453] Timer tick, asking Buildbucket for the build status
[07:35:17.143] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:17.143] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:24:0) after 1m0s
[07:36:17.318] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:24:0)
[07:36:17.318] Timer tick, asking Buildbucket for the build status
[07:36:17.624] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:17.624] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:25:0) after 1m0s
[07:37:17.688] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:25:0)
[07:37:17.688] Timer tick, asking Buildbucket for the build status
[07:37:18.075] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:18.075] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:26:0) after 1m0s
[07:38:18.146] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:26:0)
[07:38:18.146] Timer tick, asking Buildbucket for the build status
[07:38:18.380] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:18.380] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:27:0) after 1m0s
[07:39:18.401] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:27:0)
[07:39:18.401] Timer tick, asking Buildbucket for the build status
[07:39:18.799] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:18.799] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:28:0) after 1m0s
[07:40:18.858] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:28:0)
[07:40:18.858] Timer tick, asking Buildbucket for the build status
[07:40:19.041] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:19.041] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:29:0) after 1m0s
[07:41:19.169] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:29:0)
[07:41:19.169] Timer tick, asking Buildbucket for the build status
[07:41:19.340] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:19.340] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:30:0) after 1m0s
[07:42:19.401] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:30:0)
[07:42:19.401] Timer tick, asking Buildbucket for the build status
[07:42:19.558] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:19.558] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:31:0) after 1m0s
[07:43:19.627] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:31:0)
[07:43:19.627] Timer tick, asking Buildbucket for the build status
[07:43:20.705] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:20.705] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:32:0) after 1m0s
[07:44:20.725] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:32:0)
[07:44:20.725] Timer tick, asking Buildbucket for the build status
[07:44:23.842] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:23.842] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:33:0) after 1m0s
[07:45:23.880] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:33:0)
[07:45:23.880] Timer tick, asking Buildbucket for the build status
[07:45:24.116] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:24.116] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:34:0) after 1m0s
[07:46:24.165] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:34:0)
[07:46:24.165] Timer tick, asking Buildbucket for the build status
[07:46:26.827] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:26.827] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:35:0) after 1m0s
[07:47:26.881] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:35:0)
[07:47:26.881] Timer tick, asking Buildbucket for the build status
[07:47:27.173] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:27.173] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:36:0) after 1m0s
[07:48:27.249] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:36:0)
[07:48:27.249] Timer tick, asking Buildbucket for the build status
[07:48:27.435] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:27.435] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:37:0) after 1m0s
[07:49:27.499] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:37:0)
[07:49:27.499] Timer tick, asking Buildbucket for the build status
[07:49:27.954] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:27.954] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:38:0) after 1m0s
[07:50:28.024] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:38:0)
[07:50:28.024] Timer tick, asking Buildbucket for the build status
[07:50:28.775] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:28.775] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:39:0) after 1m0s
[07:51:28.800] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:39:0)
[07:51:28.800] Timer tick, asking Buildbucket for the build status
[07:51:29.907] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:29.907] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:40:0) after 1m0s
[07:52:29.928] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:40:0)
[07:52:29.928] Timer tick, asking Buildbucket for the build status
[07:52:30.104] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:30.104] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:41:0) after 1m0s
[07:53:30.167] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:41:0)
[07:53:30.167] Timer tick, asking Buildbucket for the build status
[07:53:30.340] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:30.340] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:42:0) after 1m0s
[07:54:30.326] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:42:0)
[07:54:30.326] Timer tick, asking Buildbucket for the build status
[07:54:30.548] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:30.548] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:43:0) after 1m0s
[07:55:30.565] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:43:0)
[07:55:30.565] Timer tick, asking Buildbucket for the build status
[07:55:30.720] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:30.720] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:44:0) after 1m0s
[07:56:30.755] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:44:0)
[07:56:30.755] Timer tick, asking Buildbucket for the build status
[07:56:31.626] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:31.626] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:45:0) after 1m0s
[07:57:31.659] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:45:0)
[07:57:31.659] Timer tick, asking Buildbucket for the build status
[07:57:32.152] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:32.152] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:46:0) after 1m0s
[07:58:32.286] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:46:0)
[07:58:32.286] Timer tick, asking Buildbucket for the build status
[07:58:33.074] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:33.074] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:47:0) after 1m0s
[07:59:33.113] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:47:0)
[07:59:33.113] Timer tick, asking Buildbucket for the build status
[07:59:33.286] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:33.286] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:48:0) after 1m0s
[08:00:33.305] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:48:0)
[08:00:33.305] Timer tick, asking Buildbucket for the build status
[08:00:36.042] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:36.042] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:49:0) after 1m0s
[08:01:36.159] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:49:0)
[08:01:36.159] Timer tick, asking Buildbucket for the build status
[08:01:37.714] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:37.714] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:50:0) after 1m0s
[08:02:37.732] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:50:0)
[08:02:37.732] Timer tick, asking Buildbucket for the build status
[08:02:38.119] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:38.119] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:51:0) after 1m0s
[08:03:38.153] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:51:0)
[08:03:38.153] Timer tick, asking Buildbucket for the build status
[08:03:38.321] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:38.322] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:52:0) after 1m0s
[08:04:38.365] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:52:0)
[08:04:38.365] Timer tick, asking Buildbucket for the build status
[08:04:38.608] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:38.608] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:53:0) after 1m0s
[08:05:38.662] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:53:0)
[08:05:38.662] Timer tick, asking Buildbucket for the build status
[08:05:39.003] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:39.003] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:54:0) after 1m0s
[08:06:39.038] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:54:0)
[08:06:39.038] Timer tick, asking Buildbucket for the build status
[08:06:39.244] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:39.244] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:55:0) after 1m0s
[08:07:39.374] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:55:0)
[08:07:39.374] Timer tick, asking Buildbucket for the build status
[08:07:39.660] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:39.660] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:56:0) after 1m0s
[08:08:39.818] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:56:0)
[08:08:39.818] Timer tick, asking Buildbucket for the build status
[08:08:40.198] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:40.198] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:57:0) after 1m0s
[08:09:40.428] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:57:0)
[08:09:40.428] Timer tick, asking Buildbucket for the build status
[08:09:40.637] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:40.637] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:58:0) after 1m0s
[08:10:41.006] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:58:0)
[08:10:41.006] Timer tick, asking Buildbucket for the build status
[08:10:41.975] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:41.975] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:59:0) after 1m0s
[08:11:42.142] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:59:0)
[08:11:42.142] Timer tick, asking Buildbucket for the build status
[08:11:42.689] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:42.689] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:60:0) after 1m0s
[08:12:42.742] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:60:0)
[08:12:42.742] Timer tick, asking Buildbucket for the build status
[08:12:42.901] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:42.901] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:61:0) after 1m0s
[08:13:43.014] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:61:0)
[08:13:43.015] Timer tick, asking Buildbucket for the build status
[08:13:43.634] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:43.634] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:62:0) after 1m0s
[08:14:43.757] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:62:0)
[08:14:43.757] Timer tick, asking Buildbucket for the build status
[08:14:44.063] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:44.063] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:63:0) after 1m0s
[08:15:44.103] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:63:0)
[08:15:44.103] Timer tick, asking Buildbucket for the build status
[08:15:44.312] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:44.312] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:64:0) after 1m0s
[08:16:44.393] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:64:0)
[08:16:44.393] Timer tick, asking Buildbucket for the build status
[08:16:45.152] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:45.152] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:65:0) after 1m0s
[08:17:45.210] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:65:0)
[08:17:45.210] Timer tick, asking Buildbucket for the build status
[08:17:45.561] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:45.561] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:66:0) after 1m0s
[08:18:45.702] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:66:0)
[08:18:45.702] Timer tick, asking Buildbucket for the build status
[08:18:45.910] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:45.910] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:67:0) after 1m0s
[08:19:46.039] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:67:0)
[08:19:46.039] Timer tick, asking Buildbucket for the build status
[08:19:46.578] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:46.578] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:68:0) after 1m0s
[08:20:46.607] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:68:0)
[08:20:46.607] Timer tick, asking Buildbucket for the build status
[08:20:46.904] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:46.904] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:69:0) after 1m0s
[08:21:47.041] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:69:0)
[08:21:47.041] Timer tick, asking Buildbucket for the build status
[08:21:47.259] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:47.259] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:70:0) after 1m0s
[08:22:47.316] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:70:0)
[08:22:47.316] Timer tick, asking Buildbucket for the build status
[08:22:48.181] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:48.181] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:71:0) after 1m0s
[08:23:48.191] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:71:0)
[08:23:48.191] Timer tick, asking Buildbucket for the build status
[08:23:48.353] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:48.353] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:72:0) after 1m0s
[08:24:48.381] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:72:0)
[08:24:48.381] Timer tick, asking Buildbucket for the build status
[08:24:49.095] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:49.095] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:73:0) after 1m0s
[08:25:49.183] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:73:0)
[08:25:49.183] Timer tick, asking Buildbucket for the build status
[08:25:49.337] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:49.337] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:74:0) after 1m0s
[08:26:49.385] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:74:0)
[08:26:49.385] Timer tick, asking Buildbucket for the build status
[08:26:49.589] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:49.589] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:75:0) after 1m0s
[08:27:49.645] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:75:0)
[08:27:49.645] Timer tick, asking Buildbucket for the build status
[08:27:49.935] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:49.935] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:76:0) after 1m0s
[08:28:49.990] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:76:0)
[08:28:49.990] Timer tick, asking Buildbucket for the build status
[08:28:50.255] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:50.255] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:77:0) after 1m0s
[08:29:50.343] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:77:0)
[08:29:50.343] Timer tick, asking Buildbucket for the build status
[08:29:51.533] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:51.533] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:78:0) after 1m0s
[08:30:51.617] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:78:0)
[08:30:51.617] Timer tick, asking Buildbucket for the build status
[08:30:51.774] Build 8889313710697407456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:51.774] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9054743772683393856:79:0) after 1m0s
[08:30:57.351] Received PubSub notification, asking Buildbucket for the build status
[08:30:57.479] Build 8889313710697407456: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[08:30:57.479] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580891456926080",
"created_by": "project:chromium",
"created_ts": "1580886845837188",
"failure_reason": "BUILD_FAILURE",
"id": "8889313710697407456",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3d5c30f36e3a00c7c05dcac763206c0b19511ea0\"}}",
"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-117-c29i\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 41448, \"got_angle_revision\": \"d8c4b5fb80d417343b52273515e046a37eda7138\", \"got_dawn_revision\": \"47b15048a1fab6c360dc1594764506224655752b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"3d5c30f36e3a00c7c05dcac763206c0b19511ea0\", \"got_revision_cp\": \"refs/heads/master@{#738477}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8e8e1d0dd7292440b803b95bc0832589520f784d\", \"got_v8_revision\": \"6a299ca22c90f754154373c733ad70261ffa7e86\", \"got_v8_revision_cp\": \"refs/heads/8.2.9@{#1}\", \"got_webrtc_revision\": \"0f6bcd18b2ef109850c6430fa0d474688571da5f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30455}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3d5c30f36e3a00c7c05dcac763206c0b19511ea0\", \"swarm_hashes\": {\"components_browsertests\": \"8154bfe4ec2d7f08910144992cbf22ddcfe4907d\", \"components_unittests\": \"baa46ce0931c9bd6813b2714fb57c10c1e943a81\", \"content_browsertests\": \"216154442cf59c7053d8fc543b5c288aaa833ec9\", \"content_unittests\": \"b1f35ff5e299a6021be05509c3a3be08b345ab9f\", \"unit_tests\": \"4ef3a6935c94b68e84a34370f942be6ef20ca432\"}, \"swarm_hashes_refs/heads/master(at){#738477}_without_patch\": {\"components_browsertests\": \"8154bfe4ec2d7f08910144992cbf22ddcfe4907d\", \"components_unittests\": \"baa46ce0931c9bd6813b2714fb57c10c1e943a81\", \"content_browsertests\": \"216154442cf59c7053d8fc543b5c288aaa833ec9\", \"content_unittests\": \"b1f35ff5e299a6021be05509c3a3be08b345ab9f\", \"unit_tests\": \"4ef3a6935c94b68e84a34370f942be6ef20ca432\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_0f0f2920b57dc7c027977ee87520a3ddbf7f87ddb2741f9160320f85fd7d4389_v2\", \"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_b9c3693fc2545c15d2b05658613aaabe013e89ffda116be9a8beaa7c527588c2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-117-c29i\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4809-bb2013c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**site_per_process_content_browsertests on Android device Nexus 5X** failed because of:\\n\\n- All/BlockedSchemeNavigationBrowserTest.PDF_NavigationFromFrame_TopFrameHasBlockedScheme_Block/1\\n\\n- All/BlockedSchemeNavigationBrowserTest.PDF_NavigationFromFrame_Block/1\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580887159213437",
"status": "COMPLETED",
"status_changed_ts": "1580887159932557",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/41448",
"builder:Site Isolation Android",
"buildset:commit/git/3d5c30f36e3a00c7c05dcac763206c0b19511ea0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3d5c30f36e3a00c7c05dcac763206c0b19511ea0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054743772683393856",
"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/8889313710697407456/+/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:4a2d04753fffe610",
"user_agent:luci-scheduler"
],
"updated_ts": "1580891457019522",
"url": "https://ci.chromium.org/b/8889313710697407456",
"utcnow_ts": "1580891457470322"
}
}
[08:30:57.480] Invocation finished in 1h16m52.919961161s with status FAILED