[19:32:14.846] New invocation is queued and will start shortly
[19:32:16.053] Starting the invocation (attempt 1)
[19:32:16.136] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:32:16.136] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:32:16.136] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069555233458749728",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b4699f36a8cd84d9dddda0266f6dcf8254889b54\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9069555233458749728",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/b4699f36a8cd84d9dddda0266f6dcf8254889b54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4699f36a8cd84d9dddda0266f6dcf8254889b54",
"gitiles_ref:refs/heads/master"
]
}
[19:32:17.542] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1566761536556980",
"id": "8904125171002447968",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b4699f36a8cd84d9dddda0266f6dcf8254889b54\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566761537136395",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/36497",
"builder:Site Isolation Android",
"buildset:commit/git/b4699f36a8cd84d9dddda0266f6dcf8254889b54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4699f36a8cd84d9dddda0266f6dcf8254889b54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069555233458749728",
"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/8904125171002447968/+/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": "1566761537136489",
"url": "https://ci.chromium.org/b/8904125171002447968",
"utcnow_ts": "1566761537531220"
}
}
[19:32:17.542] Task URL: https://ci.chromium.org/b/8904125171002447968
[19:32:17.542] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:2:0) after 1m0s
[19:33:11.927] Received PubSub notification, asking Buildbucket for the build status
[19:33:12.233] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:25.410] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:2:0)
[19:33:25.410] Timer tick, asking Buildbucket for the build status
[19:33:25.843] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:25.843] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:4:0) after 1m0s
[19:34:25.864] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:4:0)
[19:34:25.864] Timer tick, asking Buildbucket for the build status
[19:34:26.067] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:26.067] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:5:0) after 1m0s
[19:35:26.161] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:5:0)
[19:35:26.161] Timer tick, asking Buildbucket for the build status
[19:35:26.399] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:26.399] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:6:0) after 1m0s
[19:36:26.442] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:6:0)
[19:36:26.442] Timer tick, asking Buildbucket for the build status
[19:36:26.951] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:26.951] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:7:0) after 1m0s
[19:37:26.982] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:7:0)
[19:37:26.982] Timer tick, asking Buildbucket for the build status
[19:37:27.133] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:27.133] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:8:0) after 1m0s
[19:38:27.168] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:8:0)
[19:38:27.168] Timer tick, asking Buildbucket for the build status
[19:38:27.356] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:27.356] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:9:0) after 1m0s
[19:39:27.510] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:9:0)
[19:39:27.510] Timer tick, asking Buildbucket for the build status
[19:39:27.785] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:27.785] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:10:0) after 1m0s
[19:40:27.876] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:10:0)
[19:40:27.876] Timer tick, asking Buildbucket for the build status
[19:40:28.034] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:28.034] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:11:0) after 1m0s
[19:41:28.093] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:11:0)
[19:41:28.093] Timer tick, asking Buildbucket for the build status
[19:41:29.369] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:29.369] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:12:0) after 1m0s
[19:42:29.441] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:12:0)
[19:42:29.441] Timer tick, asking Buildbucket for the build status
[19:42:29.651] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:29.651] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:13:0) after 1m0s
[19:43:29.672] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:13:0)
[19:43:29.672] Timer tick, asking Buildbucket for the build status
[19:43:29.860] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:29.861] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:14:0) after 1m0s
[19:44:29.940] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:14:0)
[19:44:29.940] Timer tick, asking Buildbucket for the build status
[19:44:30.216] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:30.216] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:15:0) after 1m0s
[19:45:30.294] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:15:0)
[19:45:30.294] Timer tick, asking Buildbucket for the build status
[19:45:31.026] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:31.026] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:16:0) after 1m0s
[19:46:31.046] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:16:0)
[19:46:31.046] Timer tick, asking Buildbucket for the build status
[19:46:31.210] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:31.210] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:17:0) after 1m0s
[19:47:31.241] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:17:0)
[19:47:31.241] Timer tick, asking Buildbucket for the build status
[19:47:31.843] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:31.843] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:18:0) after 1m0s
[19:48:31.983] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:18:0)
[19:48:31.983] Timer tick, asking Buildbucket for the build status
[19:48:32.200] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:32.200] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:19:0) after 1m0s
[19:49:32.287] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:19:0)
[19:49:32.287] Timer tick, asking Buildbucket for the build status
[19:49:33.994] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:33.994] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:20:0) after 1m0s
[19:50:34.916] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:20:0)
[19:50:34.916] Timer tick, asking Buildbucket for the build status
[19:50:35.536] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:35.536] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:21:0) after 1m0s
[19:51:35.536] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:21:0)
[19:51:35.536] Timer tick, asking Buildbucket for the build status
[19:51:35.701] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:35.701] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:22:0) after 1m0s
[19:52:35.887] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:22:0)
[19:52:35.887] Timer tick, asking Buildbucket for the build status
[19:52:36.106] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:36.106] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:23:0) after 1m0s
[19:53:36.201] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:23:0)
[19:53:36.201] Timer tick, asking Buildbucket for the build status
[19:53:36.355] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:36.355] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:24:0) after 1m0s
[19:54:36.369] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:24:0)
[19:54:36.369] Timer tick, asking Buildbucket for the build status
[19:54:36.555] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:36.555] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:25:0) after 1m0s
[19:55:36.729] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:25:0)
[19:55:36.729] Timer tick, asking Buildbucket for the build status
[19:55:36.959] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:36.959] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:26:0) after 1m0s
[19:56:36.983] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:26:0)
[19:56:36.983] Timer tick, asking Buildbucket for the build status
[19:56:37.180] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:37.180] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:27:0) after 1m0s
[19:57:37.217] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:27:0)
[19:57:37.217] Timer tick, asking Buildbucket for the build status
[19:57:37.447] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:37.447] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:28:0) after 1m0s
[19:58:37.518] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:28:0)
[19:58:37.518] Timer tick, asking Buildbucket for the build status
[19:58:38.066] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:38.066] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:29:0) after 1m0s
[19:59:38.087] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:29:0)
[19:59:38.087] Timer tick, asking Buildbucket for the build status
[19:59:38.270] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:38.270] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:30:0) after 1m0s
[20:00:38.342] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:30:0)
[20:00:38.342] Timer tick, asking Buildbucket for the build status
[20:00:38.872] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:38.872] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:31:0) after 1m0s
[20:01:38.947] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:31:0)
[20:01:38.947] Timer tick, asking Buildbucket for the build status
[20:01:39.598] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:39.598] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:32:0) after 1m0s
[20:02:39.622] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:32:0)
[20:02:39.622] Timer tick, asking Buildbucket for the build status
[20:02:39.998] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:39.998] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:33:0) after 1m0s
[20:03:40.044] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:33:0)
[20:03:40.044] Timer tick, asking Buildbucket for the build status
[20:03:40.523] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:40.523] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:34:0) after 1m0s
[20:04:40.560] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:34:0)
[20:04:40.560] Timer tick, asking Buildbucket for the build status
[20:04:41.300] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:41.300] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:35:0) after 1m0s
[20:05:41.323] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:35:0)
[20:05:41.323] Timer tick, asking Buildbucket for the build status
[20:05:41.896] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:41.896] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:36:0) after 1m0s
[20:06:41.889] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:36:0)
[20:06:41.890] Timer tick, asking Buildbucket for the build status
[20:06:42.308] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:42.309] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:37:0) after 1m0s
[20:07:42.335] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:37:0)
[20:07:42.335] Timer tick, asking Buildbucket for the build status
[20:07:42.714] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:42.715] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:38:0) after 1m0s
[20:08:42.816] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:38:0)
[20:08:42.816] Timer tick, asking Buildbucket for the build status
[20:08:42.942] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:42.942] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:39:0) after 1m0s
[20:09:42.966] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:39:0)
[20:09:42.966] Timer tick, asking Buildbucket for the build status
[20:09:43.115] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:43.115] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:40:0) after 1m0s
[20:10:43.158] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:40:0)
[20:10:43.158] Timer tick, asking Buildbucket for the build status
[20:10:43.823] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:43.823] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:41:0) after 1m0s
[20:11:43.927] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:41:0)
[20:11:43.927] Timer tick, asking Buildbucket for the build status
[20:11:44.160] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:44.160] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:42:0) after 1m0s
[20:12:44.185] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:42:0)
[20:12:44.185] Timer tick, asking Buildbucket for the build status
[20:12:44.532] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:44.532] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:43:0) after 1m0s
[20:13:44.761] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:43:0)
[20:13:44.761] Timer tick, asking Buildbucket for the build status
[20:13:45.121] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:45.121] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:44:0) after 1m0s
[20:14:45.207] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:44:0)
[20:14:45.207] Timer tick, asking Buildbucket for the build status
[20:14:45.602] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:45.602] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:45:0) after 1m0s
[20:15:45.803] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:45:0)
[20:15:45.803] Timer tick, asking Buildbucket for the build status
[20:15:46.404] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:46.404] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:46:0) after 1m0s
[20:16:46.800] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:46:0)
[20:16:46.800] Timer tick, asking Buildbucket for the build status
[20:16:47.383] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:47.383] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:47:0) after 1m0s
[20:17:47.640] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:47:0)
[20:17:47.640] Timer tick, asking Buildbucket for the build status
[20:17:48.204] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:48.204] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:48:0) after 1m0s
[20:18:48.415] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:48:0)
[20:18:48.415] Timer tick, asking Buildbucket for the build status
[20:18:48.606] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:48.606] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:49:0) after 1m0s
[20:19:48.902] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:49:0)
[20:19:48.902] Timer tick, asking Buildbucket for the build status
[20:19:49.339] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:49.339] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:50:0) after 1m0s
[20:20:49.858] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:50:0)
[20:20:49.858] Timer tick, asking Buildbucket for the build status
[20:20:50.157] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:50.157] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:51:0) after 1m0s
[20:21:50.786] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:51:0)
[20:21:50.786] Timer tick, asking Buildbucket for the build status
[20:21:51.477] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:51.477] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:52:0) after 1m0s
[20:22:51.508] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:52:0)
[20:22:51.508] Timer tick, asking Buildbucket for the build status
[20:22:51.691] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:51.691] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:53:0) after 1m0s
[20:23:51.812] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:53:0)
[20:23:51.812] Timer tick, asking Buildbucket for the build status
[20:23:52.242] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:52.242] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:54:0) after 1m0s
[20:24:52.249] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:54:0)
[20:24:52.249] Timer tick, asking Buildbucket for the build status
[20:24:52.419] Build 8904125171002447968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:52.419] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9069555233458749728:55:0) after 1m0s
[20:25:08.343] Received PubSub notification, asking Buildbucket for the build status
[20:25:08.839] Build 8904125171002447968: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:25:08.839] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566764707874625",
"created_by": "project:chromium",
"created_ts": "1566761536556980",
"failure_reason": "BUILD_FAILURE",
"id": "8904125171002447968",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b4699f36a8cd84d9dddda0266f6dcf8254889b54\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\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-central1-b-8-136-n7a3\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 36497, \"got_angle_revision\": \"3c6b2e1613c844f7265895de5611c0528641d501\", \"got_dawn_revision\": \"25cc723823e3aa9bf6d7edfcd308bb82ab05b0fc\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"b4699f36a8cd84d9dddda0266f6dcf8254889b54\", \"got_revision_cp\": \"refs/heads/master@{#690241}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"40ba72e3195abfa78729d496ed5cc951d5941174\", \"got_v8_revision_cp\": \"refs/heads/7.8.189@{#1}\", \"got_webrtc_revision\": \"a2dae38ee7729ec1d6fcb7d22b7a597c627ad81a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28937}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b4699f36a8cd84d9dddda0266f6dcf8254889b54\", \"swarm_hashes\": {\"components_browsertests\": \"7ebea338946c3e940f2634240f1e00b1143f8417\", \"components_unittests\": \"4b28bdcfc37df9498d15f97270f9554038dc7682\", \"content_browsertests\": \"5ce2c92e3f893c910fbaf07fd7dd743974683ad2\", \"content_unittests\": \"a575fc63690394a5a57cf9e15c956e103cbdd482\", \"unit_tests\": \"b5cbc8118f7e6e1f70f701d815feda53682f9732\"}, \"swarm_hashes_refs/heads/master(at){#690241}_without_patch\": {\"components_browsertests\": \"7ebea338946c3e940f2634240f1e00b1143f8417\", \"components_unittests\": \"4b28bdcfc37df9498d15f97270f9554038dc7682\", \"content_browsertests\": \"5ce2c92e3f893c910fbaf07fd7dd743974683ad2\", \"content_unittests\": \"a575fc63690394a5a57cf9e15c956e103cbdd482\", \"unit_tests\": \"b5cbc8118f7e6e1f70f701d815feda53682f9732\"}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\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": "1566761575090335",
"status": "COMPLETED",
"status_changed_ts": "1566761537136395",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/36497",
"builder:Site Isolation Android",
"buildset:commit/git/b4699f36a8cd84d9dddda0266f6dcf8254889b54",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4699f36a8cd84d9dddda0266f6dcf8254889b54",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069555233458749728",
"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/8904125171002447968/+/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:46e3155c92559e10",
"user_agent:luci-scheduler"
],
"updated_ts": "1566764707997599",
"url": "https://ci.chromium.org/b/8904125171002447968",
"utcnow_ts": "1566764708831719"
}
}
[20:25:08.839] Invocation finished in 52m54.009104126s with status FAILED