[03:56:56.638] New invocation is queued and will start shortly
[03:56:57.855] Starting the invocation (attempt 1)
[03:56:57.894] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:56:57.894] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:56:57.894] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020329327945786704",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"3ff6ed0e7a0807227be82f9f88bdd62b047cf9df\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9020329327945786704",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/3ff6ed0e7a0807227be82f9f88bdd62b047cf9df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3ff6ed0e7a0807227be82f9f88bdd62b047cf9df",
"gitiles_ref:refs/heads/master"
]
}
[03:56:58.855] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613707017991814",
"id": "8854899265860975600",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3ff6ed0e7a0807227be82f9f88bdd62b047cf9df\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613707018570333",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/49037",
"builder:Site Isolation Android",
"buildset:commit/git/3ff6ed0e7a0807227be82f9f88bdd62b047cf9df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3ff6ed0e7a0807227be82f9f88bdd62b047cf9df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020329327945786704",
"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/8854899265860975600/+/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": "1613707018570452",
"url": "https://ci.chromium.org/b/8854899265860975600",
"utcnow_ts": "1613707018805807"
}
}
[03:56:58.855] Task URL: https://ci.chromium.org/b/8854899265860975600
[03:56:58.855] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:2:0) after 1m0s
[03:57:58.920] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:2:0)
[03:57:58.920] Timer tick, asking Buildbucket for the build status
[03:57:59.028] Build 8854899265860975600: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:59.028] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:3:0) after 1m0s
[03:58:24.157] Received PubSub notification, asking Buildbucket for the build status
[03:58:24.257] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:59.044] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:3:0)
[03:58:59.044] Timer tick, asking Buildbucket for the build status
[03:58:59.317] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:59.317] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:5:0) after 1m0s
[03:59:59.336] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:5:0)
[03:59:59.336] Timer tick, asking Buildbucket for the build status
[03:59:59.415] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:59.415] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:6:0) after 1m0s
[04:00:59.460] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:6:0)
[04:00:59.460] Timer tick, asking Buildbucket for the build status
[04:00:59.887] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:59.887] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:7:0) after 1m0s
[04:01:59.914] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:7:0)
[04:01:59.914] Timer tick, asking Buildbucket for the build status
[04:02:01.146] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:01.146] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:8:0) after 1m0s
[04:03:01.797] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:8:0)
[04:03:01.797] Timer tick, asking Buildbucket for the build status
[04:03:02.048] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:02.048] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:9:0) after 1m0s
[04:04:02.107] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:9:0)
[04:04:02.107] Timer tick, asking Buildbucket for the build status
[04:04:02.225] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:02.225] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:10:0) after 1m0s
[04:05:02.287] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:10:0)
[04:05:02.288] Timer tick, asking Buildbucket for the build status
[04:05:02.372] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:02.372] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:11:0) after 1m0s
[04:06:02.353] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:11:0)
[04:06:02.353] Timer tick, asking Buildbucket for the build status
[04:06:02.620] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:02.620] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:12:0) after 1m0s
[04:07:02.706] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:12:0)
[04:07:02.706] Timer tick, asking Buildbucket for the build status
[04:07:02.818] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:02.818] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:13:0) after 1m0s
[04:08:02.861] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:13:0)
[04:08:02.861] Timer tick, asking Buildbucket for the build status
[04:08:02.935] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:02.935] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:14:0) after 1m0s
[04:09:02.958] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:14:0)
[04:09:02.959] Timer tick, asking Buildbucket for the build status
[04:09:03.067] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:03.067] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:15:0) after 1m0s
[04:10:03.085] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:15:0)
[04:10:03.086] Timer tick, asking Buildbucket for the build status
[04:10:03.182] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:03.182] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:16:0) after 1m0s
[04:11:03.222] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:16:0)
[04:11:03.222] Timer tick, asking Buildbucket for the build status
[04:11:03.304] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:03.304] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:17:0) after 1m0s
[04:12:03.373] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:17:0)
[04:12:03.373] Timer tick, asking Buildbucket for the build status
[04:12:04.056] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:04.056] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:18:0) after 1m0s
[04:13:04.103] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:18:0)
[04:13:04.103] Timer tick, asking Buildbucket for the build status
[04:13:04.418] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:04.418] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:19:0) after 1m0s
[04:14:04.534] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:19:0)
[04:14:04.534] Timer tick, asking Buildbucket for the build status
[04:14:04.609] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:04.609] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:20:0) after 1m0s
[04:15:04.670] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:20:0)
[04:15:04.670] Timer tick, asking Buildbucket for the build status
[04:15:04.749] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:04.749] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:21:0) after 1m0s
[04:16:04.850] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:21:0)
[04:16:04.850] Timer tick, asking Buildbucket for the build status
[04:16:04.939] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:04.939] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:22:0) after 1m0s
[04:17:04.986] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:22:0)
[04:17:04.986] Timer tick, asking Buildbucket for the build status
[04:17:05.453] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:05.453] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:23:0) after 1m0s
[04:18:05.472] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:23:0)
[04:18:05.472] Timer tick, asking Buildbucket for the build status
[04:18:05.557] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:05.557] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:24:0) after 1m0s
[04:19:05.552] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:24:0)
[04:19:05.552] Timer tick, asking Buildbucket for the build status
[04:19:05.751] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:05.751] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:25:0) after 1m0s
[04:20:05.769] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:25:0)
[04:20:05.769] Timer tick, asking Buildbucket for the build status
[04:20:05.855] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:05.855] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:26:0) after 1m0s
[04:21:05.878] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:26:0)
[04:21:05.878] Timer tick, asking Buildbucket for the build status
[04:21:05.952] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:05.952] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:27:0) after 1m0s
[04:22:06.002] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:27:0)
[04:22:06.002] Timer tick, asking Buildbucket for the build status
[04:22:06.131] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:06.131] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:28:0) after 1m0s
[04:23:06.151] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:28:0)
[04:23:06.151] Timer tick, asking Buildbucket for the build status
[04:23:06.258] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:06.258] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:29:0) after 1m0s
[04:24:06.286] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:29:0)
[04:24:06.286] Timer tick, asking Buildbucket for the build status
[04:24:06.359] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:06.359] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:30:0) after 1m0s
[04:25:06.406] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:30:0)
[04:25:06.406] Timer tick, asking Buildbucket for the build status
[04:25:06.539] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:06.539] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:31:0) after 1m0s
[04:26:06.630] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:31:0)
[04:26:06.630] Timer tick, asking Buildbucket for the build status
[04:26:06.711] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:06.711] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:32:0) after 1m0s
[04:27:06.806] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:32:0)
[04:27:06.806] Timer tick, asking Buildbucket for the build status
[04:27:06.889] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:06.889] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:33:0) after 1m0s
[04:28:06.992] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:33:0)
[04:28:06.992] Timer tick, asking Buildbucket for the build status
[04:28:07.082] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:07.082] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:34:0) after 1m0s
[04:29:07.149] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:34:0)
[04:29:07.149] Timer tick, asking Buildbucket for the build status
[04:29:07.274] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:07.274] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:35:0) after 1m0s
[04:30:07.300] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:35:0)
[04:30:07.300] Timer tick, asking Buildbucket for the build status
[04:30:07.448] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:07.448] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:36:0) after 1m0s
[04:31:07.589] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:36:0)
[04:31:07.589] Timer tick, asking Buildbucket for the build status
[04:31:07.751] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:07.751] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:37:0) after 1m0s
[04:32:07.780] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:37:0)
[04:32:07.780] Timer tick, asking Buildbucket for the build status
[04:32:08.113] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:08.113] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:38:0) after 1m0s
[04:33:08.165] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:38:0)
[04:33:08.165] Timer tick, asking Buildbucket for the build status
[04:33:08.410] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:08.410] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:39:0) after 1m0s
[04:34:08.474] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:39:0)
[04:34:08.474] Timer tick, asking Buildbucket for the build status
[04:34:08.584] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:08.584] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:40:0) after 1m0s
[04:35:08.652] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:40:0)
[04:35:08.652] Timer tick, asking Buildbucket for the build status
[04:35:08.772] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:08.772] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:41:0) after 1m0s
[04:36:08.942] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:41:0)
[04:36:08.942] Timer tick, asking Buildbucket for the build status
[04:36:09.033] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:09.033] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:42:0) after 1m0s
[04:37:09.183] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:42:0)
[04:37:09.183] Timer tick, asking Buildbucket for the build status
[04:37:09.309] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:09.309] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:43:0) after 1m0s
[04:38:09.488] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:43:0)
[04:38:09.488] Timer tick, asking Buildbucket for the build status
[04:38:09.765] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:09.765] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:44:0) after 1m0s
[04:39:09.930] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:44:0)
[04:39:09.930] Timer tick, asking Buildbucket for the build status
[04:39:10.047] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:10.047] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:45:0) after 1m0s
[04:40:10.126] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:45:0)
[04:40:10.126] Timer tick, asking Buildbucket for the build status
[04:40:10.201] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:10.201] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:46:0) after 1m0s
[04:41:10.209] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:46:0)
[04:41:10.209] Timer tick, asking Buildbucket for the build status
[04:41:10.328] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:10.328] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:47:0) after 1m0s
[04:42:10.313] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:47:0)
[04:42:10.313] Timer tick, asking Buildbucket for the build status
[04:42:10.509] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:10.509] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:48:0) after 1m0s
[04:43:10.557] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:48:0)
[04:43:10.557] Timer tick, asking Buildbucket for the build status
[04:43:10.655] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:10.655] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:49:0) after 1m0s
[04:44:10.678] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:49:0)
[04:44:10.678] Timer tick, asking Buildbucket for the build status
[04:44:10.930] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:10.930] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:50:0) after 1m0s
[04:45:11.000] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:50:0)
[04:45:11.000] Timer tick, asking Buildbucket for the build status
[04:45:11.227] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:11.227] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:51:0) after 1m0s
[04:46:11.304] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:51:0)
[04:46:11.304] Timer tick, asking Buildbucket for the build status
[04:46:11.388] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:11.388] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:52:0) after 1m0s
[04:47:11.497] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:52:0)
[04:47:11.497] Timer tick, asking Buildbucket for the build status
[04:47:11.591] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:11.591] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:53:0) after 1m0s
[04:48:11.632] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:53:0)
[04:48:11.632] Timer tick, asking Buildbucket for the build status
[04:48:11.860] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:11.860] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:54:0) after 1m0s
[04:49:11.907] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:54:0)
[04:49:11.907] Timer tick, asking Buildbucket for the build status
[04:49:12.334] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:12.334] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:55:0) after 1m0s
[04:50:12.381] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:55:0)
[04:50:12.381] Timer tick, asking Buildbucket for the build status
[04:50:12.679] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:12.680] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:56:0) after 1m0s
[04:51:12.705] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:56:0)
[04:51:12.705] Timer tick, asking Buildbucket for the build status
[04:51:13.028] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:13.028] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:57:0) after 1m0s
[04:52:13.066] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:57:0)
[04:52:13.066] Timer tick, asking Buildbucket for the build status
[04:52:13.163] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:13.163] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:58:0) after 1m0s
[04:53:13.250] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:58:0)
[04:53:13.250] Timer tick, asking Buildbucket for the build status
[04:53:13.329] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:13.329] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:59:0) after 1m0s
[04:54:13.433] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:59:0)
[04:54:13.433] Timer tick, asking Buildbucket for the build status
[04:54:13.517] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:13.518] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:60:0) after 1m0s
[04:55:13.594] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:60:0)
[04:55:13.594] Timer tick, asking Buildbucket for the build status
[04:55:13.804] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:13.804] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:61:0) after 1m0s
[04:56:13.867] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:61:0)
[04:56:13.867] Timer tick, asking Buildbucket for the build status
[04:56:13.948] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:13.948] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:62:0) after 1m0s
[04:57:13.978] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:62:0)
[04:57:13.978] Timer tick, asking Buildbucket for the build status
[04:57:14.078] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:14.078] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:63:0) after 1m0s
[04:58:14.116] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:63:0)
[04:58:14.116] Timer tick, asking Buildbucket for the build status
[04:58:14.194] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:14.194] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:64:0) after 1m0s
[04:59:14.307] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:64:0)
[04:59:14.307] Timer tick, asking Buildbucket for the build status
[04:59:14.427] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:14.427] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:65:0) after 1m0s
[05:00:16.320] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:65:0)
[05:00:16.320] Timer tick, asking Buildbucket for the build status
[05:00:16.417] Build 8854899265860975600: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:16.417] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9020329327945786704:66:0) after 1m0s
[05:00:28.827] Received PubSub notification, asking Buildbucket for the build status
[05:00:28.939] Build 8854899265860975600: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[05:00:28.939] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613710828482302",
"created_by": "project:chromium",
"created_ts": "1613707017991814",
"failure_reason": "BUILD_FAILURE",
"id": "8854899265860975600",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3ff6ed0e7a0807227be82f9f88bdd62b047cf9df\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 Test Suite(s) failed.\\n\\n**site_per_process_content_browsertests on Android device Nexus 5X** failed because of:\\n\\n- RenderFrameHostImplBrowserTest.ComputeIsolationInfoForNavigationPartyContextExceedMaxSize\\n\\n**site_per_process_content_unittests on Android device Nexus 5X** failed because of:\\n\\n- SiteInstanceTest.DefaultSiteInstanceProperties\\n\\n**site_per_process_content_shell_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.content.browser.webcontents.WebContentsTest#testChildProcessImportance\\n\\n- org.chromium.content.browser.ChildProcessLauncherIntegrationTest#testIntentionalKillToFreeServiceSlot\\n\\n- org.chromium.content.browser.ChildProcessLauncherIntegrationTest#testCrossDomainNavigationDoNotLoseImportance\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"3ff6ed0e7a0807227be82f9f88bdd62b047cf9df\", \"project\": \"chromium/src\"}], \"$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-east1-d-8-113-tuy5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.fyi\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 49037, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"3ff6ed0e7a0807227be82f9f88bdd62b047cf9df\", \"got_revision_cp\": \"refs/heads/master@{#855621}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"3ff6ed0e7a0807227be82f9f88bdd62b047cf9df\", \"swarm_hashes_refs/heads/master(at){#855621}_without_patch\": {\"android_browsertests\": \"9fc3b80f6d514720320606a5edd9c26e7738f034\", \"chrome_public_test_apk\": \"409c78a0c45b0da92f0188a86262784da16e5074\", \"components_browsertests\": \"f74478cfcc2446f952dd15514c2411313337bc0e\", \"components_unittests\": \"a05080b0b890e69d2d26a43926f34d9d8cc0b4b4\", \"content_browsertests\": \"f62549665a0376ee713b21c81053216d200a74a0\", \"content_shell_test_apk\": \"95ab83d46fdf535d76dec834930c3dc63dff9369\", \"content_unittests\": \"d884890436b730f90203f83b68e3da99c3c45d19\", \"unit_tests\": \"8d551db20fa6b980d129b48c2ce287c9b9c180b0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2924decd8bf92d66d12e0f7871729cd28b590c544e302b2201ef1e5b1ad96b76_v2\", \"builder_4a782824ba39c0c6a32b2128ebb0687e83cb58dc0cbed64e2911b02f7893cfe6_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_b624744545b53f30069a9e0f9d655dd80cb0688eb6f8753c5d4d1f02e2478691_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"builder_fdd7de770372258dd0e62a94923a13570b890ab5ae7c622093730be0503c1d22_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-113-tuy5\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"3 Test Suite(s) failed.\\n\\n**site_per_process_content_browsertests on Android device Nexus 5X** failed because of:\\n\\n- RenderFrameHostImplBrowserTest.ComputeIsolationInfoForNavigationPartyContextExceedMaxSize\\n\\n**site_per_process_content_unittests on Android device Nexus 5X** failed because of:\\n\\n- SiteInstanceTest.DefaultSiteInstanceProperties\\n\\n**site_per_process_content_shell_test_apk on Android device Nexus 5X** failed because of:\\n\\n- org.chromium.content.browser.webcontents.WebContentsTest#testChildProcessImportance\\n\\n- org.chromium.content.browser.ChildProcessLauncherIntegrationTest#testIntentionalKillToFreeServiceSlot\\n\\n- org.chromium.content.browser.ChildProcessLauncherIntegrationTest#testCrossDomainNavigationDoNotLoseImportance\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613707103249576",
"status": "COMPLETED",
"status_changed_ts": "1613707103724955",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/49037",
"builder:Site Isolation Android",
"buildset:commit/git/3ff6ed0e7a0807227be82f9f88bdd62b047cf9df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3ff6ed0e7a0807227be82f9f88bdd62b047cf9df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020329327945786704",
"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/8854899265860975600/+/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:51d1408aec4c0210",
"user_agent:luci-scheduler"
],
"updated_ts": "1613710828568630",
"url": "https://ci.chromium.org/b/8854899265860975600",
"utcnow_ts": "1613710828927485"
}
}
[05:00:28.939] Invocation finished in 1h3m32.319772625s with status FAILED