[19:46:58.968] New invocation is queued and will start shortly
[19:47:00.351] Starting the invocation (attempt 1)
[19:47:00.390] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:47:00.390] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:47:00.390] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9077073854600665312",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"323809f79fca36587a57c4827863430a657e8d93\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9077073854600665312",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/323809f79fca36587a57c4827863430a657e8d93",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/323809f79fca36587a57c4827863430a657e8d93",
"gitiles_ref:refs/heads/master"
]
}
[19:47:03.640] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559591221650824",
"id": "8911643791125613904",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"323809f79fca36587a57c4827863430a657e8d93\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559591223363589",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/34541",
"builder:Site Isolation Android",
"buildset:commit/git/323809f79fca36587a57c4827863430a657e8d93",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/323809f79fca36587a57c4827863430a657e8d93",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077073854600665312",
"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/8911643791125613904/+/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": "1559591223364939",
"url": "https://ci.chromium.org/b/8911643791125613904",
"utcnow_ts": "1559591223626007"
}
}
[19:47:03.640] Task URL: https://ci.chromium.org/b/8911643791125613904
[19:47:03.640] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:2:0) after 1m0s
[19:48:03.705] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:2:0)
[19:48:03.705] Timer tick, asking Buildbucket for the build status
[19:48:03.847] Build 8911643791125613904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:48:03.847] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:3:0) after 1m0s
[19:49:03.932] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:3:0)
[19:49:03.932] Timer tick, asking Buildbucket for the build status
[19:49:04.992] Build 8911643791125613904: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:49:04.992] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:4:0) after 1m0s
[19:49:37.791] Received PubSub notification, asking Buildbucket for the build status
[19:49:38.229] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:05.071] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:4:0)
[19:50:05.071] Timer tick, asking Buildbucket for the build status
[19:50:05.240] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:05.240] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:6:0) after 1m0s
[19:51:05.306] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:6:0)
[19:51:05.306] Timer tick, asking Buildbucket for the build status
[19:51:05.731] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:05.731] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:7:0) after 1m0s
[19:52:05.813] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:7:0)
[19:52:05.813] Timer tick, asking Buildbucket for the build status
[19:52:06.352] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:06.352] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:8:0) after 1m0s
[19:53:06.437] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:8:0)
[19:53:06.437] Timer tick, asking Buildbucket for the build status
[19:53:07.651] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:07.651] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:9:0) after 1m0s
[19:54:07.670] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:9:0)
[19:54:07.670] Timer tick, asking Buildbucket for the build status
[19:54:08.656] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:08.656] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:10:0) after 1m0s
[19:55:08.678] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:10:0)
[19:55:08.678] Timer tick, asking Buildbucket for the build status
[19:55:08.932] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:08.932] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:11:0) after 1m0s
[19:56:08.951] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:11:0)
[19:56:08.951] Timer tick, asking Buildbucket for the build status
[19:56:09.701] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:09.701] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:12:0) after 1m0s
[19:57:09.739] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:12:0)
[19:57:09.739] Timer tick, asking Buildbucket for the build status
[19:57:10.041] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:10.041] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:13:0) after 1m0s
[19:58:10.057] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:13:0)
[19:58:10.057] Timer tick, asking Buildbucket for the build status
[19:58:11.401] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:11.401] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:14:0) after 1m0s
[19:59:11.457] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:14:0)
[19:59:11.457] Timer tick, asking Buildbucket for the build status
[19:59:12.902] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:12.903] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:15:0) after 1m0s
[20:00:12.926] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:15:0)
[20:00:12.926] Timer tick, asking Buildbucket for the build status
[20:00:13.225] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:13.225] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:16:0) after 1m0s
[20:01:13.324] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:16:0)
[20:01:13.324] Timer tick, asking Buildbucket for the build status
[20:01:13.514] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:13.514] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:17:0) after 1m0s
[20:02:13.504] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:17:0)
[20:02:13.504] Timer tick, asking Buildbucket for the build status
[20:02:14.583] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:14.583] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:18:0) after 1m0s
[20:03:14.679] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:18:0)
[20:03:14.679] Timer tick, asking Buildbucket for the build status
[20:03:16.313] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:16.313] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:19:0) after 1m0s
[20:04:16.478] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:19:0)
[20:04:16.478] Timer tick, asking Buildbucket for the build status
[20:04:17.896] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:17.896] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:20:0) after 1m0s
[20:05:18.323] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:20:0)
[20:05:18.323] Timer tick, asking Buildbucket for the build status
[20:05:18.423] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:18.423] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:21:0) after 1m0s
[20:06:18.543] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:21:0)
[20:06:18.543] Timer tick, asking Buildbucket for the build status
[20:06:18.660] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:18.660] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:22:0) after 1m0s
[20:07:18.738] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:22:0)
[20:07:18.738] Timer tick, asking Buildbucket for the build status
[20:07:18.873] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:18.873] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:23:0) after 1m0s
[20:08:19.147] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:23:0)
[20:08:19.147] Timer tick, asking Buildbucket for the build status
[20:08:20.438] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:20.438] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:24:0) after 1m0s
[20:09:20.519] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:24:0)
[20:09:20.519] Timer tick, asking Buildbucket for the build status
[20:09:20.853] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:20.853] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:25:0) after 1m0s
[20:10:21.333] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:25:0)
[20:10:21.333] Timer tick, asking Buildbucket for the build status
[20:10:21.867] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:21.868] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:26:0) after 1m0s
[20:11:21.861] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:26:0)
[20:11:21.861] Timer tick, asking Buildbucket for the build status
[20:11:23.184] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:23.184] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:27:0) after 1m0s
[20:12:23.244] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:27:0)
[20:12:23.244] Timer tick, asking Buildbucket for the build status
[20:12:24.762] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:24.762] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:28:0) after 1m0s
[20:13:24.779] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:28:0)
[20:13:24.779] Timer tick, asking Buildbucket for the build status
[20:13:24.939] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:24.939] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:29:0) after 1m0s
[20:14:24.965] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:29:0)
[20:14:24.965] Timer tick, asking Buildbucket for the build status
[20:14:25.063] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:25.063] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:30:0) after 1m0s
[20:15:25.085] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:30:0)
[20:15:25.085] Timer tick, asking Buildbucket for the build status
[20:15:25.877] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:25.877] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:31:0) after 1m0s
[20:16:25.974] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:31:0)
[20:16:25.974] Timer tick, asking Buildbucket for the build status
[20:16:26.239] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:26.239] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:32:0) after 1m0s
[20:17:26.293] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:32:0)
[20:17:26.293] Timer tick, asking Buildbucket for the build status
[20:17:27.566] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:27.566] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:33:0) after 1m0s
[20:18:27.577] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:33:0)
[20:18:27.577] Timer tick, asking Buildbucket for the build status
[20:18:29.731] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:29.731] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:34:0) after 1m0s
[20:19:29.796] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:34:0)
[20:19:29.796] Timer tick, asking Buildbucket for the build status
[20:19:29.979] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:29.979] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:35:0) after 1m0s
[20:20:30.011] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:35:0)
[20:20:30.011] Timer tick, asking Buildbucket for the build status
[20:20:32.400] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:32.400] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:36:0) after 1m0s
[20:21:32.585] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:36:0)
[20:21:32.585] Timer tick, asking Buildbucket for the build status
[20:21:34.231] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:34.231] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:37:0) after 1m0s
[20:22:34.454] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:37:0)
[20:22:34.454] Timer tick, asking Buildbucket for the build status
[20:22:35.252] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:35.252] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:38:0) after 1m0s
[20:23:35.311] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:38:0)
[20:23:35.311] Timer tick, asking Buildbucket for the build status
[20:23:35.773] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:35.773] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:39:0) after 1m0s
[20:24:35.882] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:39:0)
[20:24:35.882] Timer tick, asking Buildbucket for the build status
[20:24:35.991] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:35.991] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:40:0) after 1m0s
[20:25:36.072] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:40:0)
[20:25:36.072] Timer tick, asking Buildbucket for the build status
[20:25:37.561] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:37.561] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:41:0) after 1m0s
[20:26:37.700] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:41:0)
[20:26:37.700] Timer tick, asking Buildbucket for the build status
[20:26:38.542] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:38.542] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:42:0) after 1m0s
[20:27:38.552] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:42:0)
[20:27:38.552] Timer tick, asking Buildbucket for the build status
[20:27:38.815] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:38.815] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:43:0) after 1m0s
[20:28:38.871] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:43:0)
[20:28:38.871] Timer tick, asking Buildbucket for the build status
[20:28:39.833] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:39.833] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:44:0) after 1m0s
[20:29:40.029] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:44:0)
[20:29:40.029] Timer tick, asking Buildbucket for the build status
[20:29:42.048] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:42.048] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:45:0) after 1m0s
[20:30:42.068] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:45:0)
[20:30:42.068] Timer tick, asking Buildbucket for the build status
[20:30:42.185] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:42.185] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:46:0) after 1m0s
[20:31:42.199] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:46:0)
[20:31:42.199] Timer tick, asking Buildbucket for the build status
[20:31:42.293] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:42.293] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:47:0) after 1m0s
[20:32:42.385] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:47:0)
[20:32:42.385] Timer tick, asking Buildbucket for the build status
[20:32:42.467] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:42.467] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:48:0) after 1m0s
[20:33:42.555] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:48:0)
[20:33:42.555] Timer tick, asking Buildbucket for the build status
[20:33:43.702] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:43.702] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:49:0) after 1m0s
[20:34:43.819] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:49:0)
[20:34:43.819] Timer tick, asking Buildbucket for the build status
[20:34:45.169] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:45.169] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:50:0) after 1m0s
[20:35:45.255] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:50:0)
[20:35:45.255] Timer tick, asking Buildbucket for the build status
[20:35:45.368] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:45.368] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:51:0) after 1m0s
[20:36:45.515] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:51:0)
[20:36:45.515] Timer tick, asking Buildbucket for the build status
[20:36:48.580] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:48.580] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:52:0) after 1m0s
[20:37:48.597] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:52:0)
[20:37:48.597] Timer tick, asking Buildbucket for the build status
[20:37:50.836] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:50.836] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:53:0) after 1m0s
[20:38:50.872] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:53:0)
[20:38:50.872] Timer tick, asking Buildbucket for the build status
[20:38:51.659] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:51.659] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:54:0) after 1m0s
[20:39:51.749] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:54:0)
[20:39:51.749] Timer tick, asking Buildbucket for the build status
[20:39:52.239] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:52.239] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:55:0) after 1m0s
[20:40:52.263] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:55:0)
[20:40:52.263] Timer tick, asking Buildbucket for the build status
[20:40:52.377] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:52.377] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:56:0) after 1m0s
[20:41:52.428] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:56:0)
[20:41:52.428] Timer tick, asking Buildbucket for the build status
[20:41:55.084] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:55.084] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:57:0) after 1m0s
[20:42:55.201] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:57:0)
[20:42:55.201] Timer tick, asking Buildbucket for the build status
[20:42:57.933] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:57.933] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:58:0) after 1m0s
[20:43:57.974] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:58:0)
[20:43:57.974] Timer tick, asking Buildbucket for the build status
[20:43:58.342] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:58.342] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:59:0) after 1m0s
[20:44:58.363] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:59:0)
[20:44:58.363] Timer tick, asking Buildbucket for the build status
[20:45:00.246] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:00.246] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:60:0) after 1m0s
[20:46:00.298] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:60:0)
[20:46:00.298] Timer tick, asking Buildbucket for the build status
[20:46:01.522] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:01.522] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:61:0) after 1m0s
[20:47:01.574] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:61:0)
[20:47:01.575] Timer tick, asking Buildbucket for the build status
[20:47:03.456] Build 8911643791125613904: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:03.456] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9077073854600665312:62:0) after 1m0s
[20:47:31.457] Received PubSub notification, asking Buildbucket for the build status
[20:47:32.742] Build 8911643791125613904: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[20:47:32.742] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559594849284269",
"created_by": "project:chromium",
"created_ts": "1559591221650824",
"failure_reason": "BUILD_FAILURE",
"id": "8911643791125613904",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"323809f79fca36587a57c4827863430a657e8d93\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"4 tests failed: ['site_per_process_components_unittests on Android device Nexus 5X', 'site_per_process_unit_tests on Android device Nexus 5X', 'site_per_process_content_browsertests on Android device Nexus 5X', 'site_per_process_content_unittests on Android device Nexus 5X']\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm2384-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 34541, \"got_angle_revision\": \"4a75741655d330e257b2f20d7404cce1e51ef72e\", \"got_dawn_revision\": \"c2750abd0c62608f0ebed44aae3716257e8dec41\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"323809f79fca36587a57c4827863430a657e8d93\", \"got_revision_cp\": \"refs/heads/master@{#665629}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"d6158eea40c4b8863977f863a26aeb8f423b17b8\", \"got_v8_revision_cp\": \"refs/heads/7.7.6@{#1}\", \"got_webrtc_revision\": \"102b7289a9f2db72f74884a7788605187a2ddfee\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28140}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"323809f79fca36587a57c4827863430a657e8d93\", \"swarm_hashes\": {\"components_browsertests\": \"4585072b45c86abf48cb4e3f639fd914a5f1f59e\", \"components_unittests\": \"542285349fb59bbd965d34fcc4f1070d573459c2\", \"content_browsertests\": \"7ca730d34b3fd6fef995e65688aa1793cab1c791\", \"content_unittests\": \"6fb674667d1d699a24f8e0683b3ba3523e696e7b\", \"unit_tests\": \"314db6abb4af8543498dbd996a078b4a86605d94\"}, \"swarm_hashes_refs/heads/master(at){#665629}_without_patch\": {\"components_browsertests\": \"4585072b45c86abf48cb4e3f639fd914a5f1f59e\", \"components_unittests\": \"542285349fb59bbd965d34fcc4f1070d573459c2\", \"content_browsertests\": \"7ca730d34b3fd6fef995e65688aa1793cab1c791\", \"content_unittests\": \"6fb674667d1d699a24f8e0683b3ba3523e696e7b\", \"unit_tests\": \"314db6abb4af8543498dbd996a078b4a86605d94\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Site Isolation Android\"], \"caches\": [\"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Ivy_Bridge_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm2384-c4\"], \"inside_docker\": [\"0\"], \"kvm\": [\"0\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4316-effbcfc\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-f\"]}}, \"ui\": {\"info\": \"4 tests failed: ['site_per_process_components_unittests on Android device Nexus 5X', 'site_per_process_unit_tests on Android device Nexus 5X', 'site_per_process_content_browsertests on Android device Nexus 5X', 'site_per_process_content_unittests on Android device Nexus 5X']\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1559591376672491",
"status": "COMPLETED",
"status_changed_ts": "1559591377472443",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/34541",
"builder:Site Isolation Android",
"buildset:commit/git/323809f79fca36587a57c4827863430a657e8d93",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/323809f79fca36587a57c4827863430a657e8d93",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9077073854600665312",
"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/8911643791125613904/+/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:4537b344dbddf710",
"user_agent:luci-scheduler"
],
"updated_ts": "1559594850440408",
"url": "https://ci.chromium.org/b/8911643791125613904",
"utcnow_ts": "1559594852718196"
}
}
[20:47:32.742] Invocation finished in 1h0m33.790348719s with status FAILED