[10:11:48.631] New invocation is queued and will start shortly
[10:11:49.894] Starting the invocation (attempt 1)
[10:11:49.939] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:11:49.939] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:11:49.939] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070405865804666992",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"abc1d6ace739f7b27da0f3e41a1795643b09131d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9070405865804666992",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/abc1d6ace739f7b27da0f3e41a1795643b09131d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abc1d6ace739f7b27da0f3e41a1795643b09131d",
"gitiles_ref:refs/heads/master"
]
}
[10:11:50.876] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565950310129996",
"id": "8904975803564618416",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"abc1d6ace739f7b27da0f3e41a1795643b09131d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565950310707430",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/36286",
"builder:Site Isolation Android",
"buildset:commit/git/abc1d6ace739f7b27da0f3e41a1795643b09131d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abc1d6ace739f7b27da0f3e41a1795643b09131d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070405865804666992",
"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/8904975803564618416/+/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": "1565950310707565",
"url": "https://ci.chromium.org/b/8904975803564618416",
"utcnow_ts": "1565950310867682"
}
}
[10:11:50.876] Task URL: https://ci.chromium.org/b/8904975803564618416
[10:11:50.876] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:2:0) after 1m0s
[10:12:50.940] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:2:0)
[10:12:50.940] Timer tick, asking Buildbucket for the build status
[10:12:51.291] Build 8904975803564618416: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:12:51.291] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:3:0) after 1m0s
[10:12:54.161] Received PubSub notification, asking Buildbucket for the build status
[10:12:54.308] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:51.404] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:3:0)
[10:13:51.404] Timer tick, asking Buildbucket for the build status
[10:13:51.829] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:51.829] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:5:0) after 1m0s
[10:14:51.870] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:5:0)
[10:14:51.870] Timer tick, asking Buildbucket for the build status
[10:14:52.100] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:52.100] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:6:0) after 1m0s
[10:15:52.139] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:6:0)
[10:15:52.139] Timer tick, asking Buildbucket for the build status
[10:15:52.296] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:52.296] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:7:0) after 1m0s
[10:16:52.324] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:7:0)
[10:16:52.324] Timer tick, asking Buildbucket for the build status
[10:16:52.658] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:52.658] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:8:0) after 1m0s
[10:17:52.747] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:8:0)
[10:17:52.747] Timer tick, asking Buildbucket for the build status
[10:17:54.912] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:54.912] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:9:0) after 1m0s
[10:18:55.006] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:9:0)
[10:18:55.006] Timer tick, asking Buildbucket for the build status
[10:18:55.186] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:55.186] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:10:0) after 1m0s
[10:20:00.854] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:10:0)
[10:20:00.854] Timer tick, asking Buildbucket for the build status
[10:20:01.043] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:01.043] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:11:0) after 1m0s
[10:21:01.905] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:11:0)
[10:21:01.905] Timer tick, asking Buildbucket for the build status
[10:21:02.228] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:02.228] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:12:0) after 1m0s
[10:22:02.373] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:12:0)
[10:22:02.373] Timer tick, asking Buildbucket for the build status
[10:22:02.653] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:02.653] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:13:0) after 1m0s
[10:23:02.704] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:13:0)
[10:23:02.704] Timer tick, asking Buildbucket for the build status
[10:23:03.288] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:03.288] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:14:0) after 1m0s
[10:24:03.607] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:14:0)
[10:24:03.607] Timer tick, asking Buildbucket for the build status
[10:24:03.826] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:03.826] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:15:0) after 1m0s
[10:25:03.891] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:15:0)
[10:25:03.891] Timer tick, asking Buildbucket for the build status
[10:25:04.231] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:04.231] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:16:0) after 1m0s
[10:26:04.271] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:16:0)
[10:26:04.271] Timer tick, asking Buildbucket for the build status
[10:26:04.527] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:04.527] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:17:0) after 1m0s
[10:27:04.560] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:17:0)
[10:27:04.560] Timer tick, asking Buildbucket for the build status
[10:27:04.747] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:04.747] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:18:0) after 1m0s
[10:28:04.801] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:18:0)
[10:28:04.801] Timer tick, asking Buildbucket for the build status
[10:28:04.998] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:04.999] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:19:0) after 1m0s
[10:29:05.224] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:19:0)
[10:29:05.224] Timer tick, asking Buildbucket for the build status
[10:29:05.396] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:05.396] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:20:0) after 1m0s
[10:30:05.471] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:20:0)
[10:30:05.471] Timer tick, asking Buildbucket for the build status
[10:30:05.621] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:05.621] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:21:0) after 1m0s
[10:31:05.802] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:21:0)
[10:31:05.802] Timer tick, asking Buildbucket for the build status
[10:31:05.996] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:05.996] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:22:0) after 1m0s
[10:32:06.291] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:22:0)
[10:32:06.291] Timer tick, asking Buildbucket for the build status
[10:32:06.703] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:06.703] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:23:0) after 1m0s
[10:33:06.751] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:23:0)
[10:33:06.751] Timer tick, asking Buildbucket for the build status
[10:33:07.127] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:07.127] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:24:0) after 1m0s
[10:34:10.025] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:24:0)
[10:34:10.025] Timer tick, asking Buildbucket for the build status
[10:34:11.816] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:11.816] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:25:0) after 1m0s
[10:35:14.371] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:25:0)
[10:35:14.371] Timer tick, asking Buildbucket for the build status
[10:35:15.093] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:15.093] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:26:0) after 1m0s
[10:36:15.313] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:26:0)
[10:36:15.313] Timer tick, asking Buildbucket for the build status
[10:36:15.592] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:15.592] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:27:0) after 1m0s
[10:37:15.698] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:27:0)
[10:37:15.698] Timer tick, asking Buildbucket for the build status
[10:37:15.886] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:15.886] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:28:0) after 1m0s
[10:38:15.981] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:28:0)
[10:38:15.981] Timer tick, asking Buildbucket for the build status
[10:38:16.384] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:16.384] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:29:0) after 1m0s
[10:39:16.410] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:29:0)
[10:39:16.410] Timer tick, asking Buildbucket for the build status
[10:39:16.784] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:16.785] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:30:0) after 1m0s
[10:40:16.922] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:30:0)
[10:40:16.922] Timer tick, asking Buildbucket for the build status
[10:40:17.275] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:17.275] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:31:0) after 1m0s
[10:41:17.301] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:31:0)
[10:41:17.301] Timer tick, asking Buildbucket for the build status
[10:41:17.789] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:17.789] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:32:0) after 1m0s
[10:42:17.846] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:32:0)
[10:42:17.846] Timer tick, asking Buildbucket for the build status
[10:42:18.170] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:18.170] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:33:0) after 1m0s
[10:43:18.218] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:33:0)
[10:43:18.218] Timer tick, asking Buildbucket for the build status
[10:43:18.383] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:18.383] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:34:0) after 1m0s
[10:44:18.408] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:34:0)
[10:44:18.408] Timer tick, asking Buildbucket for the build status
[10:44:18.591] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:18.591] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:35:0) after 1m0s
[10:45:18.641] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:35:0)
[10:45:18.641] Timer tick, asking Buildbucket for the build status
[10:45:19.252] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:19.252] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:36:0) after 1m0s
[10:46:19.284] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:36:0)
[10:46:19.284] Timer tick, asking Buildbucket for the build status
[10:46:19.702] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:19.702] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:37:0) after 1m0s
[10:47:19.825] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:37:0)
[10:47:19.825] Timer tick, asking Buildbucket for the build status
[10:47:20.014] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:20.014] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:38:0) after 1m0s
[10:48:20.126] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:38:0)
[10:48:20.126] Timer tick, asking Buildbucket for the build status
[10:48:20.420] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:20.420] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:39:0) after 1m0s
[10:49:20.518] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:39:0)
[10:49:20.518] Timer tick, asking Buildbucket for the build status
[10:49:20.716] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:20.716] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:40:0) after 1m0s
[10:50:20.788] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:40:0)
[10:50:20.788] Timer tick, asking Buildbucket for the build status
[10:50:21.337] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:21.337] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:41:0) after 1m0s
[10:51:21.375] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:41:0)
[10:51:21.375] Timer tick, asking Buildbucket for the build status
[10:51:21.842] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:21.842] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:42:0) after 1m0s
[10:52:21.861] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:42:0)
[10:52:21.861] Timer tick, asking Buildbucket for the build status
[10:52:22.059] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:22.059] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:43:0) after 1m0s
[10:53:22.133] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:43:0)
[10:53:22.133] Timer tick, asking Buildbucket for the build status
[10:53:23.230] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:23.231] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:44:0) after 1m0s
[10:54:23.285] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:44:0)
[10:54:23.285] Timer tick, asking Buildbucket for the build status
[10:54:23.841] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:23.841] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:45:0) after 1m0s
[10:55:23.934] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:45:0)
[10:55:23.934] Timer tick, asking Buildbucket for the build status
[10:55:24.165] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:24.165] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:46:0) after 1m0s
[10:56:24.227] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:46:0)
[10:56:24.227] Timer tick, asking Buildbucket for the build status
[10:56:24.383] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:24.383] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:47:0) after 1m0s
[10:57:24.452] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:47:0)
[10:57:24.452] Timer tick, asking Buildbucket for the build status
[10:57:24.615] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:24.615] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:48:0) after 1m0s
[10:58:24.655] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:48:0)
[10:58:24.655] Timer tick, asking Buildbucket for the build status
[10:58:25.095] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:25.095] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:49:0) after 1m0s
[10:59:25.129] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:49:0)
[10:59:25.129] Timer tick, asking Buildbucket for the build status
[10:59:25.278] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:25.278] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:50:0) after 1m0s
[11:00:25.340] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:50:0)
[11:00:25.340] Timer tick, asking Buildbucket for the build status
[11:00:25.563] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:25.563] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:51:0) after 1m0s
[11:01:25.643] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:51:0)
[11:01:25.643] Timer tick, asking Buildbucket for the build status
[11:01:25.786] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:25.786] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:52:0) after 1m0s
[11:02:25.833] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:52:0)
[11:02:25.833] Timer tick, asking Buildbucket for the build status
[11:02:26.328] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:26.328] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:53:0) after 1m0s
[11:03:26.363] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:53:0)
[11:03:26.363] Timer tick, asking Buildbucket for the build status
[11:03:26.774] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:26.774] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:54:0) after 1m0s
[11:04:26.878] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:54:0)
[11:04:26.878] Timer tick, asking Buildbucket for the build status
[11:04:27.075] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:27.075] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:55:0) after 1m0s
[11:05:27.135] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:55:0)
[11:05:27.135] Timer tick, asking Buildbucket for the build status
[11:05:27.840] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:27.840] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:56:0) after 1m0s
[11:06:27.887] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:56:0)
[11:06:27.887] Timer tick, asking Buildbucket for the build status
[11:06:29.031] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:29.032] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:57:0) after 1m0s
[11:07:29.103] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:57:0)
[11:07:29.103] Timer tick, asking Buildbucket for the build status
[11:07:29.940] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:29.940] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:58:0) after 1m0s
[11:08:30.004] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:58:0)
[11:08:30.004] Timer tick, asking Buildbucket for the build status
[11:08:31.474] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:31.475] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:59:0) after 1m0s
[11:09:31.666] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:59:0)
[11:09:31.666] Timer tick, asking Buildbucket for the build status
[11:09:32.006] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:32.006] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:60:0) after 1m0s
[11:10:32.082] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:60:0)
[11:10:32.082] Timer tick, asking Buildbucket for the build status
[11:10:32.838] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:32.838] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:61:0) after 1m0s
[11:11:32.991] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:61:0)
[11:11:32.991] Timer tick, asking Buildbucket for the build status
[11:11:33.192] Build 8904975803564618416: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:33.192] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070405865804666992:62:0) after 1m0s
[11:11:47.764] Received PubSub notification, asking Buildbucket for the build status
[11:11:47.921] Build 8904975803564618416: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[11:11:47.921] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1565953907065992",
"created_by": "project:chromium",
"created_ts": "1565950310129996",
"failure_reason": "BUILD_FAILURE",
"id": "8904975803564618416",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"abc1d6ace739f7b27da0f3e41a1795643b09131d\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**site_per_process_content_unittests on Android device Nexus 5X** failed because of:\\n\\n- AudioOutputAuthorizationHandlerTest.DoNothing\\n\\n**site_per_process_unit_tests on Android device Nexus 5X** failed because of:\\n\\n- OfflinePageUtilsTest.TestGetCachedOfflinePageSizeAllPagesInRange\"}, \"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-41-pc9e\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 36286, \"got_angle_revision\": \"cdecd97ceefa28409793d04caf873e7b0d0d723c\", \"got_dawn_revision\": \"0b2599c8929ee01bb7d7f0dc77cd81c08c796b40\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"abc1d6ace739f7b27da0f3e41a1795643b09131d\", \"got_revision_cp\": \"refs/heads/master@{#687617}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"2e90534616abb543dabe25726e852b04baba0c7c\", \"got_v8_revision_cp\": \"refs/heads/7.8.111@{#2}\", \"got_webrtc_revision\": \"7c6f74ab0344e9c6201de711d54026e9990b8e6c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28844}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"abc1d6ace739f7b27da0f3e41a1795643b09131d\", \"swarm_hashes\": {\"components_browsertests\": \"0f2657b88a2d7c741a0792f66412be62cc6e99d6\", \"components_unittests\": \"6782d697812bab4be57f76e6fb06d4fec4271660\", \"content_browsertests\": \"4aa7d515410ae2a545ea2c1db1153ae1c7e3f18e\", \"content_unittests\": \"8b7792573a0f90be252e7379696afc29523a26e9\", \"unit_tests\": \"7c2d6489a04b9cf07a29e55b7496511044a64e8e\"}, \"swarm_hashes_refs/heads/master(at){#687617}_without_patch\": {\"components_browsertests\": \"0f2657b88a2d7c741a0792f66412be62cc6e99d6\", \"components_unittests\": \"6782d697812bab4be57f76e6fb06d4fec4271660\", \"content_browsertests\": \"4aa7d515410ae2a545ea2c1db1153ae1c7e3f18e\", \"content_unittests\": \"8b7792573a0f90be252e7379696afc29523a26e9\", \"unit_tests\": \"7c2d6489a04b9cf07a29e55b7496511044a64e8e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1267e646917891f5f926cdb94ab3368f0c9399d68d76518d691afb23f68811c9_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_71ab4550ecc1db180544ee9bd5ebac58222d39ccc6e59d756fcde46903b3067c_v2\", \"builder_7ed5e98f023cd9e0abec02df990f9772adc652ea96b625245e768b064914efaf_v2\", \"builder_859368e171259d521efea13da6023dc28f5117d74d565299fe323cf1e9b3ffc9_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_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-east1-d-8-41-pc9e\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**site_per_process_content_unittests on Android device Nexus 5X** failed because of:\\n\\n- AudioOutputAuthorizationHandlerTest.DoNothing\\n\\n**site_per_process_unit_tests on Android device Nexus 5X** failed because of:\\n\\n- OfflinePageUtilsTest.TestGetCachedOfflinePageSizeAllPagesInRange\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1565950371636433",
"status": "COMPLETED",
"status_changed_ts": "1565950373496094",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/36286",
"builder:Site Isolation Android",
"buildset:commit/git/abc1d6ace739f7b27da0f3e41a1795643b09131d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abc1d6ace739f7b27da0f3e41a1795643b09131d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070405865804666992",
"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/8904975803564618416/+/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:46b2bb026839e410",
"user_agent:luci-scheduler"
],
"updated_ts": "1565953907335707",
"url": "https://ci.chromium.org/b/8904975803564618416",
"utcnow_ts": "1565953907912059"
}
}
[11:11:47.921] Invocation finished in 59m59.312012186s with status FAILED