[21:37:40.399] New invocation is queued and will start shortly
[21:37:42.194] Starting the invocation (attempt 1)
[21:37:42.224] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:37:42.224] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:37:42.224] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9106692098568322032",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"d162903a9361717c7229b369dd9638b9fdd1fa49\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9106692098568322032",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/d162903a9361717c7229b369dd9638b9fdd1fa49",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d162903a9361717c7229b369dd9638b9fdd1fa49",
"gitiles_ref:refs/heads/master"
]
}
[21:37:45.009] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1531345062322610",
"id": "8941262035889294112",
"lease_expiration_ts": "1531406264746070",
"lease_key": "2105553186",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d162903a9361717c7229b369dd9638b9fdd1fa49\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1531345064926120",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/22996",
"builder:Site Isolation Android",
"buildset:commit/git/d162903a9361717c7229b369dd9638b9fdd1fa49",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d162903a9361717c7229b369dd9638b9fdd1fa49",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9106692098568322032",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_dimension:builder:Site Isolation Android",
"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/22996",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8941262035889294112",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:Site Isolation Android",
"swarming_tag:buildset:commit/git/d162903a9361717c7229b369dd9638b9fdd1fa49",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d162903a9361717c7229b369dd9638b9fdd1fa49",
"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/8941262035889294112/+/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:9106692098568322032",
"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:efcba11e64e8cb823f27a6c802876d9c4592ef00",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3ea418da53532a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1531345064926230",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Site Isolation Android/22996",
"utcnow_ts": "1531345064995760"
}
}
[21:37:45.009] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Site Isolation Android/22996
[21:37:45.009] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:2:0) after 1m0s
[21:38:18.510] Received PubSub notification, asking Buildbucket for the build status
[21:38:18.586] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:45.027] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:2:0)
[21:38:45.027] Timer tick, asking Buildbucket for the build status
[21:38:45.150] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:45.150] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:4:0) after 1m0s
[21:39:45.169] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:4:0)
[21:39:45.169] Timer tick, asking Buildbucket for the build status
[21:39:45.291] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:45.291] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:5:0) after 1m0s
[21:40:45.325] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:5:0)
[21:40:45.325] Timer tick, asking Buildbucket for the build status
[21:40:45.359] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:45.359] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:6:0) after 1m0s
[21:41:45.376] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:6:0)
[21:41:45.376] Timer tick, asking Buildbucket for the build status
[21:41:45.413] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:45.413] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:7:0) after 1m0s
[21:42:45.429] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:7:0)
[21:42:45.429] Timer tick, asking Buildbucket for the build status
[21:42:45.465] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:45.465] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:8:0) after 1m0s
[21:43:45.483] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:8:0)
[21:43:45.483] Timer tick, asking Buildbucket for the build status
[21:43:45.516] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:45.517] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:9:0) after 1m0s
[21:44:45.546] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:9:0)
[21:44:45.546] Timer tick, asking Buildbucket for the build status
[21:44:45.689] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:45.689] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:10:0) after 1m0s
[21:45:45.710] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:10:0)
[21:45:45.710] Timer tick, asking Buildbucket for the build status
[21:45:45.764] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:45.764] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:11:0) after 1m0s
[21:46:45.783] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:11:0)
[21:46:45.783] Timer tick, asking Buildbucket for the build status
[21:46:45.857] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:45.857] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:12:0) after 1m0s
[21:47:45.876] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:12:0)
[21:47:45.876] Timer tick, asking Buildbucket for the build status
[21:47:45.921] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:45.921] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:13:0) after 1m0s
[21:48:45.941] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:13:0)
[21:48:45.941] Timer tick, asking Buildbucket for the build status
[21:48:46.000] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:46.000] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:14:0) after 1m0s
[21:49:46.024] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:14:0)
[21:49:46.024] Timer tick, asking Buildbucket for the build status
[21:49:46.347] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:46.347] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:15:0) after 1m0s
[21:50:46.503] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:15:0)
[21:50:46.503] Timer tick, asking Buildbucket for the build status
[21:50:46.700] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:46.700] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:16:0) after 1m0s
[21:51:46.817] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:16:0)
[21:51:46.817] Timer tick, asking Buildbucket for the build status
[21:51:46.865] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:46.865] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:17:0) after 1m0s
[21:52:46.896] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:17:0)
[21:52:46.896] Timer tick, asking Buildbucket for the build status
[21:52:46.971] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:46.971] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:18:0) after 1m0s
[21:53:46.988] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:18:0)
[21:53:46.988] Timer tick, asking Buildbucket for the build status
[21:53:47.031] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:47.031] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:19:0) after 1m0s
[21:54:47.050] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:19:0)
[21:54:47.050] Timer tick, asking Buildbucket for the build status
[21:54:47.109] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:47.109] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:20:0) after 1m0s
[21:55:47.126] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:20:0)
[21:55:47.126] Timer tick, asking Buildbucket for the build status
[21:55:47.194] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:47.194] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:21:0) after 1m0s
[21:56:47.288] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:21:0)
[21:56:47.288] Timer tick, asking Buildbucket for the build status
[21:56:47.428] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:47.428] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:22:0) after 1m0s
[21:57:47.447] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:22:0)
[21:57:47.447] Timer tick, asking Buildbucket for the build status
[21:57:47.478] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:47.478] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:23:0) after 1m0s
[21:58:47.556] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:23:0)
[21:58:47.556] Timer tick, asking Buildbucket for the build status
[21:58:47.762] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:47.762] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:24:0) after 1m0s
[21:59:47.795] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:24:0)
[21:59:47.795] Timer tick, asking Buildbucket for the build status
[21:59:47.832] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:47.832] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:25:0) after 1m0s
[22:00:47.848] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:25:0)
[22:00:47.848] Timer tick, asking Buildbucket for the build status
[22:00:47.929] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:47.929] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:26:0) after 1m0s
[22:01:47.946] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:26:0)
[22:01:47.946] Timer tick, asking Buildbucket for the build status
[22:01:47.986] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:47.986] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:27:0) after 1m0s
[22:02:48.001] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:27:0)
[22:02:48.001] Timer tick, asking Buildbucket for the build status
[22:02:48.050] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:48.050] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:28:0) after 1m0s
[22:03:48.071] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:28:0)
[22:03:48.071] Timer tick, asking Buildbucket for the build status
[22:03:48.140] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:48.140] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:29:0) after 1m0s
[22:04:48.160] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:29:0)
[22:04:48.160] Timer tick, asking Buildbucket for the build status
[22:04:48.300] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:48.300] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:30:0) after 1m0s
[22:05:48.433] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:30:0)
[22:05:48.433] Timer tick, asking Buildbucket for the build status
[22:05:48.484] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:48.484] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:31:0) after 1m0s
[22:06:48.504] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:31:0)
[22:06:48.505] Timer tick, asking Buildbucket for the build status
[22:06:48.603] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:48.603] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:32:0) after 1m0s
[22:07:48.623] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:32:0)
[22:07:48.623] Timer tick, asking Buildbucket for the build status
[22:07:48.781] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:48.781] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:33:0) after 1m0s
[22:08:48.802] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:33:0)
[22:08:48.802] Timer tick, asking Buildbucket for the build status
[22:08:48.831] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:48.831] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:34:0) after 1m0s
[22:09:48.850] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:34:0)
[22:09:48.850] Timer tick, asking Buildbucket for the build status
[22:09:48.908] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:48.908] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:35:0) after 1m0s
[22:10:48.928] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:35:0)
[22:10:48.928] Timer tick, asking Buildbucket for the build status
[22:10:49.229] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:49.229] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:36:0) after 1m0s
[22:11:49.250] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:36:0)
[22:11:49.250] Timer tick, asking Buildbucket for the build status
[22:11:49.330] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:49.330] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:37:0) after 1m0s
[22:12:49.349] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:37:0)
[22:12:49.349] Timer tick, asking Buildbucket for the build status
[22:12:49.418] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:49.418] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:38:0) after 1m0s
[22:13:49.437] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:38:0)
[22:13:49.437] Timer tick, asking Buildbucket for the build status
[22:13:49.478] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:49.478] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:39:0) after 1m0s
[22:14:49.498] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:39:0)
[22:14:49.498] Timer tick, asking Buildbucket for the build status
[22:14:49.537] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:49.537] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:40:0) after 1m0s
[22:15:49.568] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:40:0)
[22:15:49.574] Timer tick, asking Buildbucket for the build status
[22:15:49.641] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:49.641] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:41:0) after 1m0s
[22:16:49.662] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:41:0)
[22:16:49.662] Timer tick, asking Buildbucket for the build status
[22:16:49.740] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:49.740] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:42:0) after 1m0s
[22:17:49.854] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:42:0)
[22:17:49.854] Timer tick, asking Buildbucket for the build status
[22:17:49.888] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:49.888] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:43:0) after 1m0s
[22:18:50.101] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:43:0)
[22:18:50.101] Timer tick, asking Buildbucket for the build status
[22:18:50.135] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:50.135] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:44:0) after 1m0s
[22:19:50.161] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:44:0)
[22:19:50.161] Timer tick, asking Buildbucket for the build status
[22:19:50.673] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:50.673] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:45:0) after 1m0s
[22:20:50.694] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:45:0)
[22:20:50.694] Timer tick, asking Buildbucket for the build status
[22:20:50.806] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:50.806] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:46:0) after 1m0s
[22:21:50.828] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:46:0)
[22:21:50.828] Timer tick, asking Buildbucket for the build status
[22:21:50.866] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:50.866] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:47:0) after 1m0s
[22:22:50.887] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:47:0)
[22:22:50.887] Timer tick, asking Buildbucket for the build status
[22:22:51.106] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:51.106] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:48:0) after 1m0s
[22:23:51.149] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:48:0)
[22:23:51.149] Timer tick, asking Buildbucket for the build status
[22:23:51.260] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:51.260] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:49:0) after 1m0s
[22:24:51.290] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:49:0)
[22:24:51.290] Timer tick, asking Buildbucket for the build status
[22:24:51.323] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:51.323] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:50:0) after 1m0s
[22:25:51.409] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:50:0)
[22:25:51.409] Timer tick, asking Buildbucket for the build status
[22:25:51.497] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:51.497] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:51:0) after 1m0s
[22:26:51.522] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:51:0)
[22:26:51.522] Timer tick, asking Buildbucket for the build status
[22:26:51.564] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:51.564] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:52:0) after 1m0s
[22:27:51.591] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:52:0)
[22:27:51.591] Timer tick, asking Buildbucket for the build status
[22:27:51.631] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:51.631] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:53:0) after 1m0s
[22:28:51.652] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:53:0)
[22:28:51.652] Timer tick, asking Buildbucket for the build status
[22:28:51.718] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:51.718] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:54:0) after 1m0s
[22:29:51.745] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:54:0)
[22:29:51.745] Timer tick, asking Buildbucket for the build status
[22:29:51.912] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:51.912] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:55:0) after 1m0s
[22:30:51.932] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:55:0)
[22:30:51.932] Timer tick, asking Buildbucket for the build status
[22:30:51.972] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:51.972] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:56:0) after 1m0s
[22:31:51.993] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:56:0)
[22:31:51.993] Timer tick, asking Buildbucket for the build status
[22:31:53.170] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:53.170] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:57:0) after 1m0s
[22:32:53.188] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:57:0)
[22:32:53.188] Timer tick, asking Buildbucket for the build status
[22:32:53.231] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:53.231] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:58:0) after 1m0s
[22:33:53.252] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:58:0)
[22:33:53.252] Timer tick, asking Buildbucket for the build status
[22:33:53.332] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:53.332] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:59:0) after 1m0s
[22:34:53.355] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:59:0)
[22:34:53.355] Timer tick, asking Buildbucket for the build status
[22:34:53.446] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:53.446] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:60:0) after 1m0s
[22:35:53.552] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:60:0)
[22:35:53.553] Timer tick, asking Buildbucket for the build status
[22:35:53.627] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:53.627] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:61:0) after 1m0s
[22:36:53.705] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:61:0)
[22:36:53.705] Timer tick, asking Buildbucket for the build status
[22:36:53.884] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:53.884] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:62:0) after 1m0s
[22:37:54.048] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:62:0)
[22:37:54.048] Timer tick, asking Buildbucket for the build status
[22:37:54.236] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:54.236] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:63:0) after 1m0s
[22:38:54.267] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:63:0)
[22:38:54.267] Timer tick, asking Buildbucket for the build status
[22:38:54.361] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:54.361] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:64:0) after 1m0s
[22:39:54.380] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:64:0)
[22:39:54.380] Timer tick, asking Buildbucket for the build status
[22:39:54.706] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:54.706] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:65:0) after 1m0s
[22:40:54.728] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:65:0)
[22:40:54.728] Timer tick, asking Buildbucket for the build status
[22:40:54.767] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:54.767] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:66:0) after 1m0s
[22:41:54.786] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:66:0)
[22:41:54.786] Timer tick, asking Buildbucket for the build status
[22:41:54.830] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:54.830] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:67:0) after 1m0s
[22:42:54.861] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:67:0)
[22:42:54.861] Timer tick, asking Buildbucket for the build status
[22:42:54.914] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:54.914] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:68:0) after 1m0s
[22:43:54.936] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:68:0)
[22:43:54.936] Timer tick, asking Buildbucket for the build status
[22:43:55.008] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:55.008] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:69:0) after 1m0s
[22:44:55.028] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:69:0)
[22:44:55.028] Timer tick, asking Buildbucket for the build status
[22:44:55.110] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:55.110] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:70:0) after 1m0s
[22:45:55.133] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:70:0)
[22:45:55.134] Timer tick, asking Buildbucket for the build status
[22:45:55.181] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:55.182] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:71:0) after 1m0s
[22:46:55.294] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:71:0)
[22:46:55.294] Timer tick, asking Buildbucket for the build status
[22:46:55.327] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:55.327] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:72:0) after 1m0s
[22:47:55.365] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:72:0)
[22:47:55.365] Timer tick, asking Buildbucket for the build status
[22:47:55.438] Build 8941262035889294112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:55.438] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9106692098568322032:73:0) after 1m0s
[22:48:36.777] Received PubSub notification, asking Buildbucket for the build status
[22:48:36.835] Build 8941262035889294112: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:48:36.835] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1531349313848580",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1531345062322610",
"failure_reason": "BUILD_FAILURE",
"id": "8941262035889294112",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d162903a9361717c7229b369dd9638b9fdd1fa49\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure site_per_process_components_unittests on Android device Nexus 5X\\nFailure site_per_process_content_browsertests on Android device Nexus 5X\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"failure\": {\"failure\": {\"step\": \"\"}, \"humanReason\": \"2 tests failed: ['site_per_process_components_unittests on Android device Nexus 5X', 'site_per_process_content_browsertests on Android device Nexus 5X']\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"chromium\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8941262035889294112/+/annotations\"}, \"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\": [\"3675-21ffa58\"], \"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\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"0ba35b21089a442dd4f25c35fd571d46cb4aa199\", \"got_swarming_client_revision\": \"9a518d097dca20b7b00ce3bdfc5d418ccc79893a\", \"got_revision\": \"d162903a9361717c7229b369dd9638b9fdd1fa49\", \"recipe\": \"chromium\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23896}\", \"swarm_hashes_refs/heads/master(at){#574343}_without_patch\": {\"components_unittests\": \"3704696f6dcc3b0a6501438592b2b3eed14b843e\", \"components_browsertests\": \"d396b8ba74c4867ec711fc78e454c17714ed42c6\", \"content_browsertests\": \"8e3dad82cf3f03f2be5b3ffe37050d9b27c0ec1f\", \"content_unittests\": \"a23725efbb5fd0c871c949495e2e8b5b98707296\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#574343}\", \"branch\": \"refs/heads/master\", \"revision\": \"d162903a9361717c7229b369dd9638b9fdd1fa49\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Site Isolation Android\", \"got_webrtc_revision\": \"ef43aafcf5953845b71840e14c94942d60c541c1\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"89ef177f94753a91d7ec12aa58a5b06df2c12f0f\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1531345062322610, \"tags\": [\"builder:Site Isolation Android\", \"buildset:commit/git/d162903a9361717c7229b369dd9638b9fdd1fa49\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d162903a9361717c7229b369dd9638b9fdd1fa49\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9106692098568322032\", \"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\": \"8941262035889294112\"}}, \"got_v8_revision\": \"8dc93fc4fa1ec6d0501d982679ce93efc383d3b8\", \"got_v8_revision_cp\": \"refs/heads/6.9.351@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 22996, \"swarm_hashes\": {\"components_unittests\": \"3704696f6dcc3b0a6501438592b2b3eed14b843e\", \"components_browsertests\": \"d396b8ba74c4867ec711fc78e454c17714ed42c6\", \"content_browsertests\": \"8e3dad82cf3f03f2be5b3ffe37050d9b27c0ec1f\", \"content_unittests\": \"a23725efbb5fd0c871c949495e2e8b5b98707296\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2384-c4\", \"got_buildtools_revision\": \"0dd5c6f980d22be96b728155249df2da355989d9\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1531345093398640",
"status": "COMPLETED",
"status_changed_ts": "1531349316247580",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/22996",
"builder:Site Isolation Android",
"buildset:commit/git/d162903a9361717c7229b369dd9638b9fdd1fa49",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d162903a9361717c7229b369dd9638b9fdd1fa49",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9106692098568322032",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_dimension:builder:Site Isolation Android",
"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/22996",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8941262035889294112",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:Site Isolation Android",
"swarming_tag:buildset:commit/git/d162903a9361717c7229b369dd9638b9fdd1fa49",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d162903a9361717c7229b369dd9638b9fdd1fa49",
"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/8941262035889294112/+/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:9106692098568322032",
"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:efcba11e64e8cb823f27a6c802876d9c4592ef00",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3ea418da53532a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1531349316250670",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Site Isolation Android/22996",
"utcnow_ts": "1531349316815880"
}
}
[22:48:36.835] Invocation finished in 1h10m56.451545011s with status FAILED