[20:30:28.833] New invocation is queued and will start shortly
[20:30:30.292] Starting the invocation (attempt 1)
[20:30:30.488] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:30:30.488] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:30:30.488] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059767097378095408",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d0a042a13f94d703847ef613e5c8f37cc1bca2bb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9059767097378095408",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/d0a042a13f94d703847ef613e5c8f37cc1bca2bb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0a042a13f94d703847ef613e5c8f37cc1bca2bb",
"gitiles_ref:refs/heads/master"
]
}
[20:30:32.191] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576096230765115",
"id": "8894337034687895632",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0a042a13f94d703847ef613e5c8f37cc1bca2bb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576096231688790",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/39770",
"builder:Site Isolation Android",
"buildset:commit/git/d0a042a13f94d703847ef613e5c8f37cc1bca2bb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0a042a13f94d703847ef613e5c8f37cc1bca2bb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059767097378095408",
"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/8894337034687895632/+/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": "1576096231689000",
"url": "https://ci.chromium.org/b/8894337034687895632",
"utcnow_ts": "1576096232173048"
}
}
[20:30:32.191] Task URL: https://ci.chromium.org/b/8894337034687895632
[20:30:32.191] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:2:0) after 1m0s
[20:31:32.488] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:2:0)
[20:31:32.488] Timer tick, asking Buildbucket for the build status
[20:31:32.975] Build 8894337034687895632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:31:32.975] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:3:0) after 1m0s
[20:31:45.048] Received PubSub notification, asking Buildbucket for the build status
[20:31:45.573] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:33.025] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:3:0)
[20:32:33.025] Timer tick, asking Buildbucket for the build status
[20:32:34.093] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:34.093] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:5:0) after 1m0s
[20:33:34.278] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:5:0)
[20:33:34.278] Timer tick, asking Buildbucket for the build status
[20:33:35.102] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:35.102] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:6:0) after 1m0s
[20:34:35.324] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:6:0)
[20:34:35.324] Timer tick, asking Buildbucket for the build status
[20:34:35.808] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:35.808] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:7:0) after 1m0s
[20:35:35.854] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:7:0)
[20:35:35.854] Timer tick, asking Buildbucket for the build status
[20:35:36.158] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:36.158] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:8:0) after 1m0s
[20:36:36.242] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:8:0)
[20:36:36.242] Timer tick, asking Buildbucket for the build status
[20:36:37.731] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:37.731] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:9:0) after 1m0s
[20:37:37.981] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:9:0)
[20:37:37.981] Timer tick, asking Buildbucket for the build status
[20:37:38.846] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:38.846] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:10:0) after 1m0s
[20:38:38.994] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:10:0)
[20:38:38.994] Timer tick, asking Buildbucket for the build status
[20:38:39.244] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:39.244] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:11:0) after 1m0s
[20:39:39.271] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:11:0)
[20:39:39.271] Timer tick, asking Buildbucket for the build status
[20:39:39.561] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:39.561] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:12:0) after 1m0s
[20:40:39.687] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:12:0)
[20:40:39.687] Timer tick, asking Buildbucket for the build status
[20:40:40.222] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:40.222] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:13:0) after 1m0s
[20:41:40.445] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:13:0)
[20:41:40.445] Timer tick, asking Buildbucket for the build status
[20:41:40.752] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:40.752] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:14:0) after 1m0s
[20:42:40.900] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:14:0)
[20:42:40.900] Timer tick, asking Buildbucket for the build status
[20:42:41.411] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:41.411] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:15:0) after 1m0s
[20:43:41.642] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:15:0)
[20:43:41.642] Timer tick, asking Buildbucket for the build status
[20:43:42.505] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:42.505] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:16:0) after 1m0s
[20:44:42.628] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:16:0)
[20:44:42.628] Timer tick, asking Buildbucket for the build status
[20:44:43.797] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:43.797] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:17:0) after 1m0s
[20:45:44.076] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:17:0)
[20:45:44.076] Timer tick, asking Buildbucket for the build status
[20:45:44.746] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:44.746] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:18:0) after 1m0s
[20:46:44.811] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:18:0)
[20:46:44.811] Timer tick, asking Buildbucket for the build status
[20:46:45.021] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:45.021] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:19:0) after 1m0s
[20:47:45.268] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:19:0)
[20:47:45.268] Timer tick, asking Buildbucket for the build status
[20:47:45.491] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:45.491] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:20:0) after 1m0s
[20:48:45.714] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:20:0)
[20:48:45.714] Timer tick, asking Buildbucket for the build status
[20:48:49.152] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:49.152] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:21:0) after 1m0s
[20:49:49.267] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:21:0)
[20:49:49.267] Timer tick, asking Buildbucket for the build status
[20:49:49.730] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:49.730] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:22:0) after 1m0s
[20:50:49.733] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:22:0)
[20:50:49.733] Timer tick, asking Buildbucket for the build status
[20:50:50.173] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:50.173] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:23:0) after 1m0s
[20:51:50.292] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:23:0)
[20:51:50.292] Timer tick, asking Buildbucket for the build status
[20:51:50.574] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:50.574] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:24:0) after 1m0s
[20:52:50.690] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:24:0)
[20:52:50.690] Timer tick, asking Buildbucket for the build status
[20:52:50.916] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:50.916] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:25:0) after 1m0s
[20:53:51.004] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:25:0)
[20:53:51.004] Timer tick, asking Buildbucket for the build status
[20:53:51.302] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:51.302] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:26:0) after 1m0s
[20:54:51.388] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:26:0)
[20:54:51.388] Timer tick, asking Buildbucket for the build status
[20:54:51.992] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:51.992] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:27:0) after 1m0s
[20:55:52.075] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:27:0)
[20:55:52.075] Timer tick, asking Buildbucket for the build status
[20:55:52.385] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:52.385] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:28:0) after 1m0s
[20:56:52.447] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:28:0)
[20:56:52.447] Timer tick, asking Buildbucket for the build status
[20:56:52.932] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:52.932] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:29:0) after 1m0s
[20:57:52.997] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:29:0)
[20:57:52.997] Timer tick, asking Buildbucket for the build status
[20:57:53.438] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:53.438] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:30:0) after 1m0s
[20:58:53.581] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:30:0)
[20:58:53.581] Timer tick, asking Buildbucket for the build status
[20:58:53.760] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:53.760] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:31:0) after 1m0s
[20:59:53.858] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:31:0)
[20:59:53.858] Timer tick, asking Buildbucket for the build status
[20:59:56.001] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:56.001] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:32:0) after 1m0s
[21:00:56.096] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:32:0)
[21:00:56.096] Timer tick, asking Buildbucket for the build status
[21:00:56.381] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:56.381] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:33:0) after 1m0s
[21:01:56.534] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:33:0)
[21:01:56.534] Timer tick, asking Buildbucket for the build status
[21:01:56.684] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:56.684] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:34:0) after 1m0s
[21:02:56.859] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:34:0)
[21:02:56.860] Timer tick, asking Buildbucket for the build status
[21:02:57.113] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:57.113] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:35:0) after 1m0s
[21:03:57.312] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:35:0)
[21:03:57.312] Timer tick, asking Buildbucket for the build status
[21:03:57.545] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:57.545] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:36:0) after 1m0s
[21:04:57.634] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:36:0)
[21:04:57.634] Timer tick, asking Buildbucket for the build status
[21:04:57.919] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:57.919] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:37:0) after 1m0s
[21:05:58.015] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:37:0)
[21:05:58.015] Timer tick, asking Buildbucket for the build status
[21:05:58.260] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:58.260] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:38:0) after 1m0s
[21:06:58.294] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:38:0)
[21:06:58.294] Timer tick, asking Buildbucket for the build status
[21:06:59.048] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:59.048] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:39:0) after 1m0s
[21:07:59.112] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:39:0)
[21:07:59.112] Timer tick, asking Buildbucket for the build status
[21:07:59.349] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:59.349] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:40:0) after 1m0s
[21:08:59.410] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:40:0)
[21:08:59.410] Timer tick, asking Buildbucket for the build status
[21:08:59.768] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:59.768] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:41:0) after 1m0s
[21:09:59.861] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:41:0)
[21:09:59.861] Timer tick, asking Buildbucket for the build status
[21:10:00.489] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:00.489] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:42:0) after 1m0s
[21:11:00.628] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:42:0)
[21:11:00.629] Timer tick, asking Buildbucket for the build status
[21:11:01.735] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:01.735] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:43:0) after 1m0s
[21:12:01.799] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:43:0)
[21:12:01.799] Timer tick, asking Buildbucket for the build status
[21:12:02.014] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:02.014] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:44:0) after 1m0s
[21:13:02.049] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:44:0)
[21:13:02.049] Timer tick, asking Buildbucket for the build status
[21:13:02.599] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:02.599] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:45:0) after 1m0s
[21:14:02.700] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:45:0)
[21:14:02.700] Timer tick, asking Buildbucket for the build status
[21:14:05.365] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:05.365] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:46:0) after 1m0s
[21:15:05.445] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:46:0)
[21:15:05.445] Timer tick, asking Buildbucket for the build status
[21:15:05.727] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:05.727] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:47:0) after 1m0s
[21:16:05.871] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:47:0)
[21:16:05.871] Timer tick, asking Buildbucket for the build status
[21:16:06.464] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:06.464] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:48:0) after 1m0s
[21:17:06.539] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:48:0)
[21:17:06.539] Timer tick, asking Buildbucket for the build status
[21:17:06.687] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:06.687] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:49:0) after 1m0s
[21:18:06.892] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:49:0)
[21:18:06.892] Timer tick, asking Buildbucket for the build status
[21:18:07.189] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:07.189] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:50:0) after 1m0s
[21:19:07.467] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:50:0)
[21:19:07.467] Timer tick, asking Buildbucket for the build status
[21:19:08.170] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:08.170] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:51:0) after 1m0s
[21:20:08.205] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:51:0)
[21:20:08.205] Timer tick, asking Buildbucket for the build status
[21:20:08.392] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:08.392] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:52:0) after 1m0s
[21:21:08.427] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:52:0)
[21:21:08.428] Timer tick, asking Buildbucket for the build status
[21:21:08.590] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:08.590] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:53:0) after 1m0s
[21:22:08.675] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:53:0)
[21:22:08.675] Timer tick, asking Buildbucket for the build status
[21:22:08.814] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:08.814] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:54:0) after 1m0s
[21:23:08.803] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:54:0)
[21:23:08.803] Timer tick, asking Buildbucket for the build status
[21:23:09.029] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:09.029] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:55:0) after 1m0s
[21:24:09.131] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:55:0)
[21:24:09.131] Timer tick, asking Buildbucket for the build status
[21:24:09.635] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:09.635] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:56:0) after 1m0s
[21:25:09.859] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:56:0)
[21:25:09.859] Timer tick, asking Buildbucket for the build status
[21:25:10.804] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:10.804] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:57:0) after 1m0s
[21:26:10.893] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:57:0)
[21:26:10.893] Timer tick, asking Buildbucket for the build status
[21:26:11.169] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:11.169] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:58:0) after 1m0s
[21:27:11.248] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:58:0)
[21:27:11.248] Timer tick, asking Buildbucket for the build status
[21:27:11.521] Build 8894337034687895632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:11.522] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9059767097378095408:59:0) after 1m0s
[21:27:12.599] Received PubSub notification, asking Buildbucket for the build status
[21:27:12.709] Build 8894337034687895632: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:27:12.710] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576099631941287",
"created_by": "project:chromium",
"created_ts": "1576096230765115",
"failure_reason": "BUILD_FAILURE",
"id": "8894337034687895632",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0a042a13f94d703847ef613e5c8f37cc1bca2bb\"}}",
"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\": {\"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-67-s6jb\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 39770, \"got_angle_revision\": \"4ad8b55ef4274c730788fe3d42e6ebc27095ca6e\", \"got_dawn_revision\": \"280b96ea8de35e145be4878ca53b6eecf7f38e67\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"d0a042a13f94d703847ef613e5c8f37cc1bca2bb\", \"got_revision_cp\": \"refs/heads/master@{#723950}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"d684c7fdd3e18e1c2cb8c9b76bab80327d089398\", \"got_v8_revision\": \"99201c7be24457c993b6fe23280830d2cec6153c\", \"got_v8_revision_cp\": \"refs/heads/8.1.16@{#1}\", \"got_webrtc_revision\": \"75bc75ccef59caeeeecdeac83426565efddb6780\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30064}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d0a042a13f94d703847ef613e5c8f37cc1bca2bb\", \"swarm_hashes\": {\"components_browsertests\": \"befda76cd1fb184e191c330c9f66f74d3ea483e8\", \"components_unittests\": \"f9e10d258282d00113a01131183374eb45e6c561\", \"content_browsertests\": \"a11420a7c073e7bf9ddb5d216e6702429f30b53d\", \"content_unittests\": \"aa1b902a75575d3b87eeb0dee66df0a07770beb0\", \"unit_tests\": \"18106e41ae92e5182c910df1349cc14c7b17828b\"}, \"swarm_hashes_refs/heads/master(at){#723950}_without_patch\": {\"components_browsertests\": \"befda76cd1fb184e191c330c9f66f74d3ea483e8\", \"components_unittests\": \"f9e10d258282d00113a01131183374eb45e6c561\", \"content_browsertests\": \"a11420a7c073e7bf9ddb5d216e6702429f30b53d\", \"content_unittests\": \"aa1b902a75575d3b87eeb0dee66df0a07770beb0\", \"unit_tests\": \"18106e41ae92e5182c910df1349cc14c7b17828b\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_349392596e0d17d3422c55529f4e230875f36ec061130c176581539a4c7cd365_v2\", \"builder_4735eb974b804f74efeb4253a3690e62eb4b060f1d311c87e54f3b58924ad1a2_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_v2\", \"builder_b9373cfdcc5f43b5e07cc4931fc34027757a424c7183ae2b31ae65ec7718ca12_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-67-s6jb\"], \"image\": [\"chrome-xenial-19120100-f3a09baa543\"], \"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\": [\"4709-f2c88b6\"], \"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": "1576096304157020",
"status": "COMPLETED",
"status_changed_ts": "1576096304780606",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/39770",
"builder:Site Isolation Android",
"buildset:commit/git/d0a042a13f94d703847ef613e5c8f37cc1bca2bb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0a042a13f94d703847ef613e5c8f37cc1bca2bb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059767097378095408",
"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/8894337034687895632/+/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:490f798f5c49d210",
"user_agent:luci-scheduler"
],
"updated_ts": "1576099632165418",
"url": "https://ci.chromium.org/b/8894337034687895632",
"utcnow_ts": "1576099632701086"
}
}
[21:27:12.710] Invocation finished in 56m43.89396741s with status FAILED