[20:43:50.108] New invocation is queued and will start shortly
[20:43:51.695] Starting the invocation (attempt 1)
[20:43:51.736] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:43:51.736] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:43:51.736] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9096458028571926816",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b45e18271c52163724ff43cdc854a90ad3a1e157\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9096458028571926816",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/b45e18271c52163724ff43cdc854a90ad3a1e157",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b45e18271c52163724ff43cdc854a90ad3a1e157",
"gitiles_ref:refs/heads/master"
]
}
[20:43:53.261] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541105031909595",
"id": "8931027966019131024",
"lease_expiration_ts": "1541249032914010",
"lease_key": "23093879",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b45e18271c52163724ff43cdc854a90ad3a1e157\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1541105033148177",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/26826",
"builder:Site Isolation Android",
"buildset:commit/git/b45e18271c52163724ff43cdc854a90ad3a1e157",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b45e18271c52163724ff43cdc854a90ad3a1e157",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9096458028571926816",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_dimension:builder:Site Isolation Android",
"swarming_dimension:caches:builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Site Isolation Android/26826",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8931027966019131024",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Site Isolation Android",
"swarming_tag:buildset:commit/git/b45e18271c52163724ff43cdc854a90ad3a1e157",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b45e18271c52163724ff43cdc854a90ad3a1e157",
"swarming_tag:caches:builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8931027966019131024/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9096458028571926816",
"swarming_tag:scheduler_job_id:chromium/Site Isolation Android",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:4c74591f83d51eee87212a27a708a1470b1d81be",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40e9d62624e70610",
"user_agent:luci-scheduler"
],
"updated_ts": "1541105033148299",
"url": "https://ci.chromium.org/b/8931027966019131024",
"utcnow_ts": "1541105033243883"
}
}
[20:43:53.261] Task URL: https://ci.chromium.org/b/8931027966019131024
[20:43:53.261] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:2:0) after 1m0s
[20:44:30.860] Received PubSub notification, asking Buildbucket for the build status
[20:44:30.894] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:53.282] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:2:0)
[20:44:53.282] Timer tick, asking Buildbucket for the build status
[20:44:53.314] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:53.314] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:4:0) after 1m0s
[20:45:53.332] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:4:0)
[20:45:53.332] Timer tick, asking Buildbucket for the build status
[20:45:53.367] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:53.367] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:5:0) after 1m0s
[20:46:53.400] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:5:0)
[20:46:53.400] Timer tick, asking Buildbucket for the build status
[20:46:53.513] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:53.513] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:6:0) after 1m0s
[20:47:53.544] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:6:0)
[20:47:53.544] Timer tick, asking Buildbucket for the build status
[20:47:53.586] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:53.586] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:7:0) after 1m0s
[20:48:53.665] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:7:0)
[20:48:53.665] Timer tick, asking Buildbucket for the build status
[20:48:53.719] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:53.719] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:8:0) after 1m0s
[20:49:53.754] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:8:0)
[20:49:53.754] Timer tick, asking Buildbucket for the build status
[20:49:53.836] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:53.836] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:9:0) after 1m0s
[20:50:53.925] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:9:0)
[20:50:53.925] Timer tick, asking Buildbucket for the build status
[20:50:53.993] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:53.993] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:10:0) after 1m0s
[20:51:54.013] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:10:0)
[20:51:54.013] Timer tick, asking Buildbucket for the build status
[20:51:54.101] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:54.101] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:11:0) after 1m0s
[20:52:54.120] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:11:0)
[20:52:54.120] Timer tick, asking Buildbucket for the build status
[20:52:54.160] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:54.160] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:12:0) after 1m0s
[20:53:54.194] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:12:0)
[20:53:54.194] Timer tick, asking Buildbucket for the build status
[20:53:54.349] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:54.349] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:13:0) after 1m0s
[20:54:54.369] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:13:0)
[20:54:54.369] Timer tick, asking Buildbucket for the build status
[20:54:54.455] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:54.455] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:14:0) after 1m0s
[20:55:54.499] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:14:0)
[20:55:54.499] Timer tick, asking Buildbucket for the build status
[20:55:54.573] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:54.573] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:15:0) after 1m0s
[20:56:54.622] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:15:0)
[20:56:54.622] Timer tick, asking Buildbucket for the build status
[20:56:54.675] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:54.675] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:16:0) after 1m0s
[20:57:54.695] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:16:0)
[20:57:54.695] Timer tick, asking Buildbucket for the build status
[20:57:54.880] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:54.880] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:17:0) after 1m0s
[20:58:54.905] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:17:0)
[20:58:54.905] Timer tick, asking Buildbucket for the build status
[20:58:54.944] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:54.944] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:18:0) after 1m0s
[20:59:54.983] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:18:0)
[20:59:54.983] Timer tick, asking Buildbucket for the build status
[20:59:55.024] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:55.024] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:19:0) after 1m0s
[21:00:55.052] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:19:0)
[21:00:55.052] Timer tick, asking Buildbucket for the build status
[21:00:55.091] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:55.091] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:20:0) after 1m0s
[21:01:55.131] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:20:0)
[21:01:55.131] Timer tick, asking Buildbucket for the build status
[21:01:55.206] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:55.206] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:21:0) after 1m0s
[21:02:55.236] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:21:0)
[21:02:55.236] Timer tick, asking Buildbucket for the build status
[21:02:55.273] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:55.273] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:22:0) after 1m0s
[21:03:55.324] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:22:0)
[21:03:55.324] Timer tick, asking Buildbucket for the build status
[21:03:55.428] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:55.428] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:23:0) after 1m0s
[21:04:55.450] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:23:0)
[21:04:55.450] Timer tick, asking Buildbucket for the build status
[21:04:55.500] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:55.500] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:24:0) after 1m0s
[21:05:55.519] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:24:0)
[21:05:55.519] Timer tick, asking Buildbucket for the build status
[21:05:55.606] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:55.606] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:25:0) after 1m0s
[21:06:55.689] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:25:0)
[21:06:55.689] Timer tick, asking Buildbucket for the build status
[21:06:55.785] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:55.785] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:26:0) after 1m0s
[21:07:55.820] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:26:0)
[21:07:55.820] Timer tick, asking Buildbucket for the build status
[21:07:55.861] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:55.861] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:27:0) after 1m0s
[21:08:55.881] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:27:0)
[21:08:55.881] Timer tick, asking Buildbucket for the build status
[21:08:55.954] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:55.954] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:28:0) after 1m0s
[21:09:56.000] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:28:0)
[21:09:56.000] Timer tick, asking Buildbucket for the build status
[21:09:56.032] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:56.032] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:29:0) after 1m0s
[21:10:56.058] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:29:0)
[21:10:56.058] Timer tick, asking Buildbucket for the build status
[21:10:56.130] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:56.130] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:30:0) after 1m0s
[21:11:56.149] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:30:0)
[21:11:56.149] Timer tick, asking Buildbucket for the build status
[21:11:56.394] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:56.394] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:31:0) after 1m0s
[21:12:56.795] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:31:0)
[21:12:56.795] Timer tick, asking Buildbucket for the build status
[21:12:56.834] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:56.834] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:32:0) after 1m0s
[21:13:56.854] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:32:0)
[21:13:56.854] Timer tick, asking Buildbucket for the build status
[21:13:56.901] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:56.901] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:33:0) after 1m0s
[21:14:56.920] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:33:0)
[21:14:56.920] Timer tick, asking Buildbucket for the build status
[21:14:56.990] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:56.990] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:34:0) after 1m0s
[21:15:57.023] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:34:0)
[21:15:57.023] Timer tick, asking Buildbucket for the build status
[21:15:57.083] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:57.083] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:35:0) after 1m0s
[21:16:57.106] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:35:0)
[21:16:57.106] Timer tick, asking Buildbucket for the build status
[21:16:57.212] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:57.212] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:36:0) after 1m0s
[21:17:57.233] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:36:0)
[21:17:57.233] Timer tick, asking Buildbucket for the build status
[21:17:57.279] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:57.279] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:37:0) after 1m0s
[21:18:57.321] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:37:0)
[21:18:57.321] Timer tick, asking Buildbucket for the build status
[21:18:57.387] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:57.387] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:38:0) after 1m0s
[21:19:57.425] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:38:0)
[21:19:57.425] Timer tick, asking Buildbucket for the build status
[21:19:57.505] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:57.505] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:39:0) after 1m0s
[21:20:57.570] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:39:0)
[21:20:57.570] Timer tick, asking Buildbucket for the build status
[21:20:57.607] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:57.607] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:40:0) after 1m0s
[21:21:57.714] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:40:0)
[21:21:57.714] Timer tick, asking Buildbucket for the build status
[21:21:57.844] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:57.844] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:41:0) after 1m0s
[21:22:57.875] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:41:0)
[21:22:57.875] Timer tick, asking Buildbucket for the build status
[21:22:57.998] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:57.998] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:42:0) after 1m0s
[21:23:58.021] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:42:0)
[21:23:58.021] Timer tick, asking Buildbucket for the build status
[21:23:58.067] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:58.067] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:43:0) after 1m0s
[21:24:58.093] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:43:0)
[21:24:58.093] Timer tick, asking Buildbucket for the build status
[21:24:58.154] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:58.154] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:44:0) after 1m0s
[21:25:58.176] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:44:0)
[21:25:58.176] Timer tick, asking Buildbucket for the build status
[21:25:58.213] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:58.213] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:45:0) after 1m0s
[21:26:58.328] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:45:0)
[21:26:58.328] Timer tick, asking Buildbucket for the build status
[21:26:58.439] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:58.439] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:46:0) after 1m0s
[21:27:58.476] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:46:0)
[21:27:58.476] Timer tick, asking Buildbucket for the build status
[21:27:58.536] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:58.536] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:47:0) after 1m0s
[21:28:58.559] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:47:0)
[21:28:58.559] Timer tick, asking Buildbucket for the build status
[21:28:58.637] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:58.637] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:48:0) after 1m0s
[21:29:58.688] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:48:0)
[21:29:58.688] Timer tick, asking Buildbucket for the build status
[21:29:58.848] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:58.848] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:49:0) after 1m0s
[21:30:58.872] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:49:0)
[21:30:58.872] Timer tick, asking Buildbucket for the build status
[21:30:58.934] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:58.934] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:50:0) after 1m0s
[21:31:58.959] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:50:0)
[21:31:58.959] Timer tick, asking Buildbucket for the build status
[21:31:58.994] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:58.994] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:51:0) after 1m0s
[21:32:59.036] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:51:0)
[21:32:59.036] Timer tick, asking Buildbucket for the build status
[21:32:59.071] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:59.071] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:52:0) after 1m0s
[21:33:59.093] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:52:0)
[21:33:59.093] Timer tick, asking Buildbucket for the build status
[21:33:59.271] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:59.271] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:53:0) after 1m0s
[21:34:59.293] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:53:0)
[21:34:59.293] Timer tick, asking Buildbucket for the build status
[21:34:59.326] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:59.326] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:54:0) after 1m0s
[21:35:59.346] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:54:0)
[21:35:59.346] Timer tick, asking Buildbucket for the build status
[21:35:59.427] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:59.427] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:55:0) after 1m0s
[21:36:59.447] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:55:0)
[21:36:59.447] Timer tick, asking Buildbucket for the build status
[21:36:59.537] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:59.537] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:56:0) after 1m0s
[21:37:59.566] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:56:0)
[21:37:59.566] Timer tick, asking Buildbucket for the build status
[21:37:59.611] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:59.611] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:57:0) after 1m0s
[21:38:59.633] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:57:0)
[21:38:59.633] Timer tick, asking Buildbucket for the build status
[21:38:59.682] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:59.682] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:58:0) after 1m0s
[21:39:59.714] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:58:0)
[21:39:59.714] Timer tick, asking Buildbucket for the build status
[21:39:59.750] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:59.750] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:59:0) after 1m0s
[21:40:59.780] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:59:0)
[21:40:59.780] Timer tick, asking Buildbucket for the build status
[21:40:59.827] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:59.827] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:60:0) after 1m0s
[21:41:59.896] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:60:0)
[21:41:59.896] Timer tick, asking Buildbucket for the build status
[21:41:59.931] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:59.931] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:61:0) after 1m0s
[21:42:59.953] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:61:0)
[21:42:59.953] Timer tick, asking Buildbucket for the build status
[21:42:59.988] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:59.988] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:62:0) after 1m0s
[21:44:00.014] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:62:0)
[21:44:00.014] Timer tick, asking Buildbucket for the build status
[21:44:00.114] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:00.114] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:63:0) after 1m0s
[21:45:00.281] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:63:0)
[21:45:00.281] Timer tick, asking Buildbucket for the build status
[21:45:00.386] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:00.386] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:64:0) after 1m0s
[21:46:00.411] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:64:0)
[21:46:00.411] Timer tick, asking Buildbucket for the build status
[21:46:00.491] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:00.491] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:65:0) after 1m0s
[21:47:00.574] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:65:0)
[21:47:00.574] Timer tick, asking Buildbucket for the build status
[21:47:00.618] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:00.618] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:66:0) after 1m0s
[21:48:00.659] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:66:0)
[21:48:00.659] Timer tick, asking Buildbucket for the build status
[21:48:00.733] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:00.733] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:67:0) after 1m0s
[21:49:00.755] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:67:0)
[21:49:00.755] Timer tick, asking Buildbucket for the build status
[21:49:00.812] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:00.812] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:68:0) after 1m0s
[21:50:00.846] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:68:0)
[21:50:00.846] Timer tick, asking Buildbucket for the build status
[21:50:00.910] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:00.910] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:69:0) after 1m0s
[21:51:00.932] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:69:0)
[21:51:00.932] Timer tick, asking Buildbucket for the build status
[21:51:00.976] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:00.976] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:70:0) after 1m0s
[21:52:01.003] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:70:0)
[21:52:01.003] Timer tick, asking Buildbucket for the build status
[21:52:01.162] Build 8931027966019131024: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:01.162] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9096458028571926816:71:0) after 1m0s
[21:52:49.671] Received PubSub notification, asking Buildbucket for the build status
[21:52:49.713] Build 8931027966019131024: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:52:49.713] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1541109168772632",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541105031909595",
"failure_reason": "BUILD_FAILURE",
"id": "8931027966019131024",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b45e18271c52163724ff43cdc854a90ad3a1e157\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure site_per_process_browser_tests on Android device Nexus 5X\\nFailure site_per_process_components_unittests on Android device Nexus 5X\\nFailure site_per_process_content_browsertests on Android device Nexus 5X\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Site Isolation Android\"], \"kvm\": [\"0\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Ivy_Bridge_GCE\"], \"server_version\": [\"3817-6aedaff\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-f\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm2384-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_53430d7efc3ad929037f71672025ccdda55c326c6584332dc243dc68e9bcf29c_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"f78187ab77127de42555afe0ad410bebde6ac6a5\", \"got_revision\": \"b45e18271c52163724ff43cdc854a90ad3a1e157\", \"recipe\": \"chromium\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25472}\", \"swarm_hashes_refs/heads/master(at){#604695}_without_patch\": {\"components_browsertests\": \"c415567701c907e9d5fb6147327ca358b3f2abbb\", \"browser_tests\": \"b414bd391df1b53d785147a51b2593cbb500a0fb\", \"unit_tests\": \"f57adf1bae03d1241190571252728846eeefcf4b\", \"content_unittests\": \"79145f9f0cd948c21c2a35b46b611c7b69d0bf07\", \"content_browsertests\": \"e104f821dcdbf07ebfbedeb0144bcf72db99fa9d\", \"components_unittests\": \"09907c5387afa7144cdf0177b675e95a1b66051a\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#604695}\", \"branch\": \"refs/heads/master\", \"revision\": \"b45e18271c52163724ff43cdc854a90ad3a1e157\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Site Isolation Android\", \"got_webrtc_revision\": \"189013bef9937c102d978f637a5dc2fb9ba4b0d1\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"2197dc5290522549f5c9421b48d4eb547f4068e2\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1541105031909595, \"tags\": [\"builder:Site Isolation Android\", \"buildset:commit/git/b45e18271c52163724ff43cdc854a90ad3a1e157\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b45e18271c52163724ff43cdc854a90ad3a1e157\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9096458028571926816\", \"scheduler_job_id:chromium/Site Isolation Android\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8931027966019131024\"}}, \"got_v8_revision\": \"17a4d82212b2d38e03ba273cf05f9ba15ba36975\", \"got_v8_revision_cp\": \"refs/heads/7.2.214@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 26826, \"swarm_hashes\": {\"components_browsertests\": \"c415567701c907e9d5fb6147327ca358b3f2abbb\", \"browser_tests\": \"b414bd391df1b53d785147a51b2593cbb500a0fb\", \"unit_tests\": \"f57adf1bae03d1241190571252728846eeefcf4b\", \"content_unittests\": \"79145f9f0cd948c21c2a35b46b611c7b69d0bf07\", \"content_browsertests\": \"e104f821dcdbf07ebfbedeb0144bcf72db99fa9d\", \"components_unittests\": \"09907c5387afa7144cdf0177b675e95a1b66051a\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2384-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1541105069926836",
"status": "COMPLETED",
"status_changed_ts": "1541109169238309",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/26826",
"builder:Site Isolation Android",
"buildset:commit/git/b45e18271c52163724ff43cdc854a90ad3a1e157",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b45e18271c52163724ff43cdc854a90ad3a1e157",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9096458028571926816",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_dimension:builder:Site Isolation Android",
"swarming_dimension:caches:builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Site Isolation Android/26826",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8931027966019131024",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Site Isolation Android",
"swarming_tag:buildset:commit/git/b45e18271c52163724ff43cdc854a90ad3a1e157",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b45e18271c52163724ff43cdc854a90ad3a1e157",
"swarming_tag:caches:builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8931027966019131024/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9096458028571926816",
"swarming_tag:scheduler_job_id:chromium/Site Isolation Android",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:4c74591f83d51eee87212a27a708a1470b1d81be",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40e9d62624e70610",
"user_agent:luci-scheduler"
],
"updated_ts": "1541109169239843",
"url": "https://ci.chromium.org/b/8931027966019131024",
"utcnow_ts": "1541109169700416"
}
}
[21:52:49.713] Invocation finished in 1h8m59.621902393s with status FAILED