[02:59:24.618] New invocation is queued and will start shortly
[02:59:25.837] Starting the invocation (attempt 1)
[02:59:25.873] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:59:25.873] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:59:25.873] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9092176342009566240",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"8b37775cd7343d23f71f9b6d065fdd699a1eb97e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9092176342009566240",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"gitiles_ref:refs/heads/master"
]
}
[02:59:27.006] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1545188366013294",
"id": "8926746279877792832",
"lease_expiration_ts": "1545332366643624",
"lease_key": "2044234354",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8b37775cd7343d23f71f9b6d065fdd699a1eb97e\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1545188366866253",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/28412",
"builder:Site Isolation Android",
"buildset:commit/git/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9092176342009566240",
"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/28412",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8926746279877792832",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
"swarming_tag:builder:Site Isolation Android",
"swarming_tag:buildset:commit/git/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"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/8926746279877792832/+/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:9092176342009566240",
"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:a951373af11284d7583d5fd2ca25a760bc744af6",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41dd38e07e963710",
"user_agent:luci-scheduler"
],
"updated_ts": "1545188366866412",
"url": "https://ci.chromium.org/b/8926746279877792832",
"utcnow_ts": "1545188366994499"
}
}
[02:59:27.006] Task URL: https://ci.chromium.org/b/8926746279877792832
[02:59:27.006] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:2:0) after 1m0s
[03:00:06.457] Received PubSub notification, asking Buildbucket for the build status
[03:00:06.502] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:27.023] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:2:0)
[03:00:27.023] Timer tick, asking Buildbucket for the build status
[03:00:27.154] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:27.154] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:4:0) after 1m0s
[03:01:27.173] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:4:0)
[03:01:27.173] Timer tick, asking Buildbucket for the build status
[03:01:27.344] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:27.344] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:5:0) after 1m0s
[03:02:27.366] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:5:0)
[03:02:27.366] Timer tick, asking Buildbucket for the build status
[03:02:27.407] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:27.407] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:6:0) after 1m0s
[03:03:27.433] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:6:0)
[03:03:27.433] Timer tick, asking Buildbucket for the build status
[03:03:27.466] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:27.466] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:7:0) after 1m0s
[03:04:27.518] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:7:0)
[03:04:27.518] Timer tick, asking Buildbucket for the build status
[03:04:27.555] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:27.555] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:8:0) after 1m0s
[03:05:27.574] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:8:0)
[03:05:27.574] Timer tick, asking Buildbucket for the build status
[03:05:27.640] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:27.640] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:9:0) after 1m0s
[03:06:27.657] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:9:0)
[03:06:27.657] Timer tick, asking Buildbucket for the build status
[03:06:27.785] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:27.785] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:10:0) after 1m0s
[03:07:27.802] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:10:0)
[03:07:27.802] Timer tick, asking Buildbucket for the build status
[03:07:27.935] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:27.935] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:11:0) after 1m0s
[03:08:28.050] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:11:0)
[03:08:28.050] Timer tick, asking Buildbucket for the build status
[03:08:28.110] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:28.110] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:12:0) after 1m0s
[03:09:28.168] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:12:0)
[03:09:28.168] Timer tick, asking Buildbucket for the build status
[03:09:28.233] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:28.233] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:13:0) after 1m0s
[03:10:28.348] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:13:0)
[03:10:28.348] Timer tick, asking Buildbucket for the build status
[03:10:28.426] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:28.426] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:14:0) after 1m0s
[03:11:28.448] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:14:0)
[03:11:28.448] Timer tick, asking Buildbucket for the build status
[03:11:28.543] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:28.543] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:15:0) after 1m0s
[03:12:28.564] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:15:0)
[03:12:28.564] Timer tick, asking Buildbucket for the build status
[03:12:28.628] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:28.628] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:16:0) after 1m0s
[03:13:28.645] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:16:0)
[03:13:28.645] Timer tick, asking Buildbucket for the build status
[03:13:28.767] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:28.767] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:17:0) after 1m0s
[03:14:28.848] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:17:0)
[03:14:28.848] Timer tick, asking Buildbucket for the build status
[03:14:28.906] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:28.906] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:18:0) after 1m0s
[03:15:29.044] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:18:0)
[03:15:29.044] Timer tick, asking Buildbucket for the build status
[03:15:29.132] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:29.132] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:19:0) after 1m0s
[03:16:29.150] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:19:0)
[03:16:29.150] Timer tick, asking Buildbucket for the build status
[03:16:29.235] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:29.235] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:20:0) after 1m0s
[03:17:29.257] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:20:0)
[03:17:29.257] Timer tick, asking Buildbucket for the build status
[03:17:29.319] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:29.319] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:21:0) after 1m0s
[03:18:29.340] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:21:0)
[03:18:29.340] Timer tick, asking Buildbucket for the build status
[03:18:29.387] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:29.387] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:22:0) after 1m0s
[03:19:29.416] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:22:0)
[03:19:29.416] Timer tick, asking Buildbucket for the build status
[03:19:29.470] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:29.470] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:23:0) after 1m0s
[03:20:29.489] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:23:0)
[03:20:29.489] Timer tick, asking Buildbucket for the build status
[03:20:29.582] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:29.582] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:24:0) after 1m0s
[03:21:29.604] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:24:0)
[03:21:29.604] Timer tick, asking Buildbucket for the build status
[03:21:29.645] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:29.645] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:25:0) after 1m0s
[03:22:29.665] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:25:0)
[03:22:29.665] Timer tick, asking Buildbucket for the build status
[03:22:29.733] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:29.733] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:26:0) after 1m0s
[03:23:29.768] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:26:0)
[03:23:29.768] Timer tick, asking Buildbucket for the build status
[03:23:29.827] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:29.827] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:27:0) after 1m0s
[03:24:29.844] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:27:0)
[03:24:29.844] Timer tick, asking Buildbucket for the build status
[03:24:29.882] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:29.882] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:28:0) after 1m0s
[03:25:29.925] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:28:0)
[03:25:29.925] Timer tick, asking Buildbucket for the build status
[03:25:29.969] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:29.969] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:29:0) after 1m0s
[03:26:30.008] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:29:0)
[03:26:30.008] Timer tick, asking Buildbucket for the build status
[03:26:30.124] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:30.124] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:30:0) after 1m0s
[03:27:30.154] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:30:0)
[03:27:30.154] Timer tick, asking Buildbucket for the build status
[03:27:30.197] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:30.197] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:31:0) after 1m0s
[03:28:30.221] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:31:0)
[03:28:30.221] Timer tick, asking Buildbucket for the build status
[03:28:30.281] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:30.281] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:32:0) after 1m0s
[03:29:30.308] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:32:0)
[03:29:30.308] Timer tick, asking Buildbucket for the build status
[03:29:30.364] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:30.364] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:33:0) after 1m0s
[03:30:30.385] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:33:0)
[03:30:30.385] Timer tick, asking Buildbucket for the build status
[03:30:30.446] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:30.446] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:34:0) after 1m0s
[03:31:30.466] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:34:0)
[03:31:30.466] Timer tick, asking Buildbucket for the build status
[03:31:30.511] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:30.511] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:35:0) after 1m0s
[03:32:30.532] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:35:0)
[03:32:30.532] Timer tick, asking Buildbucket for the build status
[03:32:30.907] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:30.907] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:36:0) after 1m0s
[03:33:30.931] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:36:0)
[03:33:30.931] Timer tick, asking Buildbucket for the build status
[03:33:31.016] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:31.016] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:37:0) after 1m0s
[03:34:31.039] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:37:0)
[03:34:31.039] Timer tick, asking Buildbucket for the build status
[03:34:31.078] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:31.078] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:38:0) after 1m0s
[03:35:31.096] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:38:0)
[03:35:31.096] Timer tick, asking Buildbucket for the build status
[03:35:31.166] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:31.166] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:39:0) after 1m0s
[03:36:31.186] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:39:0)
[03:36:31.186] Timer tick, asking Buildbucket for the build status
[03:36:31.260] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:31.260] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:40:0) after 1m0s
[03:37:31.302] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:40:0)
[03:37:31.302] Timer tick, asking Buildbucket for the build status
[03:37:31.338] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:31.338] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:41:0) after 1m0s
[03:38:31.361] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:41:0)
[03:38:31.361] Timer tick, asking Buildbucket for the build status
[03:38:31.433] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:31.433] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:42:0) after 1m0s
[03:39:31.504] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:42:0)
[03:39:31.504] Timer tick, asking Buildbucket for the build status
[03:39:31.681] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:31.681] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:43:0) after 1m0s
[03:40:31.701] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:43:0)
[03:40:31.701] Timer tick, asking Buildbucket for the build status
[03:40:31.761] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:31.761] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:44:0) after 1m0s
[03:41:31.785] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:44:0)
[03:41:31.785] Timer tick, asking Buildbucket for the build status
[03:41:31.823] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:31.823] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:45:0) after 1m0s
[03:42:31.864] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:45:0)
[03:42:31.864] Timer tick, asking Buildbucket for the build status
[03:42:31.952] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:31.952] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:46:0) after 1m0s
[03:43:31.989] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:46:0)
[03:43:31.989] Timer tick, asking Buildbucket for the build status
[03:43:32.173] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:32.174] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:47:0) after 1m0s
[03:44:32.172] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:47:0)
[03:44:32.172] Timer tick, asking Buildbucket for the build status
[03:44:32.258] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:32.258] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:48:0) after 1m0s
[03:45:32.275] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:48:0)
[03:45:32.275] Timer tick, asking Buildbucket for the build status
[03:45:32.359] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:32.359] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:49:0) after 1m0s
[03:46:32.377] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:49:0)
[03:46:32.377] Timer tick, asking Buildbucket for the build status
[03:46:32.494] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:32.494] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:50:0) after 1m0s
[03:47:32.511] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:50:0)
[03:47:32.511] Timer tick, asking Buildbucket for the build status
[03:47:32.561] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:32.561] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:51:0) after 1m0s
[03:48:32.582] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:51:0)
[03:48:32.582] Timer tick, asking Buildbucket for the build status
[03:48:32.825] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:32.825] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:52:0) after 1m0s
[03:49:32.847] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:52:0)
[03:49:32.847] Timer tick, asking Buildbucket for the build status
[03:49:32.940] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:32.940] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:53:0) after 1m0s
[03:50:32.959] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:53:0)
[03:50:32.959] Timer tick, asking Buildbucket for the build status
[03:50:33.054] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:33.054] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:54:0) after 1m0s
[03:51:33.081] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:54:0)
[03:51:33.081] Timer tick, asking Buildbucket for the build status
[03:51:33.133] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:33.133] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:55:0) after 1m0s
[03:52:33.155] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:55:0)
[03:52:33.155] Timer tick, asking Buildbucket for the build status
[03:52:33.223] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:33.223] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:56:0) after 1m0s
[03:53:33.244] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:56:0)
[03:53:33.244] Timer tick, asking Buildbucket for the build status
[03:53:33.319] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:33.319] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:57:0) after 1m0s
[03:54:33.341] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:57:0)
[03:54:33.341] Timer tick, asking Buildbucket for the build status
[03:54:33.435] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:33.435] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:58:0) after 1m0s
[03:55:33.459] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:58:0)
[03:55:33.459] Timer tick, asking Buildbucket for the build status
[03:55:33.498] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:33.498] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:59:0) after 1m0s
[03:56:33.525] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:59:0)
[03:56:33.525] Timer tick, asking Buildbucket for the build status
[03:56:33.701] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:33.701] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:60:0) after 1m0s
[03:57:33.719] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:60:0)
[03:57:33.719] Timer tick, asking Buildbucket for the build status
[03:57:33.755] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:33.755] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:61:0) after 1m0s
[03:58:33.776] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:61:0)
[03:58:33.776] Timer tick, asking Buildbucket for the build status
[03:58:33.877] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:33.878] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:62:0) after 1m0s
[03:59:33.922] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:62:0)
[03:59:33.922] Timer tick, asking Buildbucket for the build status
[03:59:34.029] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:34.030] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:63:0) after 1m0s
[04:00:34.050] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:63:0)
[04:00:34.050] Timer tick, asking Buildbucket for the build status
[04:00:34.343] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:34.343] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:64:0) after 1m0s
[04:01:34.368] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:64:0)
[04:01:34.368] Timer tick, asking Buildbucket for the build status
[04:01:34.431] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:34.431] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:65:0) after 1m0s
[04:02:34.460] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:65:0)
[04:02:34.460] Timer tick, asking Buildbucket for the build status
[04:02:34.605] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:34.605] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:66:0) after 1m0s
[04:03:34.626] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:66:0)
[04:03:34.626] Timer tick, asking Buildbucket for the build status
[04:03:34.668] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:34.668] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:67:0) after 1m0s
[04:04:34.689] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:67:0)
[04:04:34.689] Timer tick, asking Buildbucket for the build status
[04:04:34.744] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:34.744] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:68:0) after 1m0s
[04:05:34.766] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:68:0)
[04:05:34.766] Timer tick, asking Buildbucket for the build status
[04:05:34.868] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:34.868] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:69:0) after 1m0s
[04:06:34.888] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:69:0)
[04:06:34.888] Timer tick, asking Buildbucket for the build status
[04:06:34.926] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:34.926] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:70:0) after 1m0s
[04:07:34.951] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:70:0)
[04:07:34.951] Timer tick, asking Buildbucket for the build status
[04:07:35.006] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:35.006] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:71:0) after 1m0s
[04:08:35.026] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:71:0)
[04:08:35.026] Timer tick, asking Buildbucket for the build status
[04:08:35.065] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:35.065] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:72:0) after 1m0s
[04:09:35.089] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:72:0)
[04:09:35.089] Timer tick, asking Buildbucket for the build status
[04:09:35.141] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:35.141] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:73:0) after 1m0s
[04:10:35.181] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:73:0)
[04:10:35.181] Timer tick, asking Buildbucket for the build status
[04:10:35.333] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:35.333] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:74:0) after 1m0s
[04:11:35.365] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:74:0)
[04:11:35.365] Timer tick, asking Buildbucket for the build status
[04:11:35.481] Build 8926746279877792832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:35.481] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9092176342009566240:75:0) after 1m0s
[04:11:36.598] Received PubSub notification, asking Buildbucket for the build status
[04:11:36.661] Build 8926746279877792832: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[04:11:36.661] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1545192695635938",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1545188366013294",
"failure_reason": "BUILD_FAILURE",
"id": "8926746279877792832",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8b37775cd7343d23f71f9b6d065fdd699a1eb97e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure site_per_process_content_browsertests on Android device Nexus 5X\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Site Isolation Android\"], \"kvm\": [\"0\"], \"id\": [\"swarm2384-c4\"], \"server_version\": [\"3945-402d3be\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-f\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Ivy_Bridge_GCE\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"af5947d13e6794eac489365ff58fd45c0dd4ca2a\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"8b37775cd7343d23f71f9b6d065fdd699a1eb97e\", \"recipe\": \"chromium\", \"got_dawn_revision\": \"d23fdd3624d16665a68ab5d0af3efd61bff21260\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26050}\", \"swarm_hashes_refs/heads/master(at){#617713}_without_patch\": {\"components_unittests\": \"0eb450de4da055355d7020432181c05134449e48\", \"unit_tests\": \"095834c5aa6ee6ecdbcfa47b4b87821a15275bbf\", \"components_browsertests\": \"a7dede0aba03d1f4f1b0fed2c63a00ee4c3bf5ab\", \"content_browsertests\": \"76bb5c906059171f52a8febe373810c681cfcf70\", \"content_unittests\": \"366c88e56b637cd732a56e1c1d49666ac531233f\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#617713}\", \"branch\": \"refs/heads/master\", \"revision\": \"8b37775cd7343d23f71f9b6d065fdd699a1eb97e\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Site Isolation Android\", \"got_webrtc_revision\": \"503da9435084305869cda5bfe861bcb103c93d71\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"4638dc9def816e8ee86b09293b8b90519d4a5d9f\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1545188366013294, \"tags\": [\"builder:Site Isolation Android\", \"buildset:commit/git/8b37775cd7343d23f71f9b6d065fdd699a1eb97e\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b37775cd7343d23f71f9b6d065fdd699a1eb97e\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9092176342009566240\", \"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\": \"8926746279877792832\"}}, \"got_v8_revision\": \"d1b761f2f6d5db7ffabdc82a534fcd8f43472c8a\", \"got_v8_revision_cp\": \"refs/heads/7.3.190@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 28412, \"swarm_hashes\": {\"components_unittests\": \"0eb450de4da055355d7020432181c05134449e48\", \"unit_tests\": \"095834c5aa6ee6ecdbcfa47b4b87821a15275bbf\", \"components_browsertests\": \"a7dede0aba03d1f4f1b0fed2c63a00ee4c3bf5ab\", \"content_browsertests\": \"76bb5c906059171f52a8febe373810c681cfcf70\", \"content_unittests\": \"366c88e56b637cd732a56e1c1d49666ac531233f\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2384-c4\", \"got_buildtools_revision\": \"7d88270de197ebe8b439ab5eb57a4a2a0bb810e0\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1545188405422877",
"status": "COMPLETED",
"status_changed_ts": "1545192696294273",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/28412",
"builder:Site Isolation Android",
"buildset:commit/git/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9092176342009566240",
"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/28412",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8926746279877792832",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:daaff082e95b94bec84fa6e440a8b97677d6f76d",
"swarming_tag:builder:Site Isolation Android",
"swarming_tag:buildset:commit/git/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8b37775cd7343d23f71f9b6d065fdd699a1eb97e",
"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/8926746279877792832/+/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:9092176342009566240",
"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:a951373af11284d7583d5fd2ca25a760bc744af6",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:41dd38e07e963710",
"user_agent:luci-scheduler"
],
"updated_ts": "1545192696297116",
"url": "https://ci.chromium.org/b/8926746279877792832",
"utcnow_ts": "1545192696649092"
}
}
[04:11:36.661] Invocation finished in 1h12m12.065442622s with status FAILED