[18:24:52.228] New invocation is queued and will start shortly
[18:24:53.372] Starting the invocation (attempt 1)
[18:24:53.413] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:24:53.413] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:24:53.413] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9087044686964856288",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"0bee510173d84106b2b72b7d94f0a988956f716d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9087044686964856288",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/0bee510173d84106b2b72b7d94f0a988956f716d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0bee510173d84106b2b72b7d94f0a988956f716d",
"gitiles_ref:refs/heads/master"
]
}
[18:24:55.538] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550082293576311",
"id": "8921614624889942080",
"lease_expiration_ts": "1550226295188300",
"lease_key": "761354276",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0bee510173d84106b2b72b7d94f0a988956f716d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1550082295398631",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/30507",
"builder:Site Isolation Android",
"buildset:commit/git/0bee510173d84106b2b72b7d94f0a988956f716d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0bee510173d84106b2b72b7d94f0a988956f716d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9087044686964856288",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8921614624889942080/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4300ec4b54e4c210",
"user_agent:luci-scheduler"
],
"updated_ts": "1550082295398802",
"url": "https://ci.chromium.org/b/8921614624889942080",
"utcnow_ts": "1550082295518888"
}
}
[18:24:55.538] Task URL: https://ci.chromium.org/b/8921614624889942080
[18:24:55.538] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:2:0) after 1m0s
[18:25:36.740] Received PubSub notification, asking Buildbucket for the build status
[18:25:36.866] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:55.554] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:2:0)
[18:25:55.554] Timer tick, asking Buildbucket for the build status
[18:25:55.714] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:55.714] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:4:0) after 1m0s
[18:26:55.835] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:4:0)
[18:26:55.835] Timer tick, asking Buildbucket for the build status
[18:26:56.497] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:56.497] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:5:0) after 1m0s
[18:27:56.532] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:5:0)
[18:27:56.532] Timer tick, asking Buildbucket for the build status
[18:27:56.577] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:56.577] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:6:0) after 1m0s
[18:28:56.598] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:6:0)
[18:28:56.598] Timer tick, asking Buildbucket for the build status
[18:28:56.668] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:56.668] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:7:0) after 1m0s
[18:29:56.750] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:7:0)
[18:29:56.750] Timer tick, asking Buildbucket for the build status
[18:29:57.125] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:57.125] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:8:0) after 1m0s
[18:30:57.146] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:8:0)
[18:30:57.146] Timer tick, asking Buildbucket for the build status
[18:30:57.224] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:57.224] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:9:0) after 1m0s
[18:31:57.263] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:9:0)
[18:31:57.263] Timer tick, asking Buildbucket for the build status
[18:31:57.482] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:57.482] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:10:0) after 1m0s
[18:32:57.498] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:10:0)
[18:32:57.498] Timer tick, asking Buildbucket for the build status
[18:32:58.117] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:58.117] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:11:0) after 1m0s
[18:33:58.135] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:11:0)
[18:33:58.135] Timer tick, asking Buildbucket for the build status
[18:33:58.384] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:58.384] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:12:0) after 1m0s
[18:34:58.402] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:12:0)
[18:34:58.402] Timer tick, asking Buildbucket for the build status
[18:34:58.591] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:58.591] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:13:0) after 1m0s
[18:35:58.650] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:13:0)
[18:35:58.650] Timer tick, asking Buildbucket for the build status
[18:35:59.055] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:59.055] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:14:0) after 1m0s
[18:36:59.075] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:14:0)
[18:36:59.075] Timer tick, asking Buildbucket for the build status
[18:36:59.200] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:59.201] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:15:0) after 1m0s
[18:37:59.220] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:15:0)
[18:37:59.220] Timer tick, asking Buildbucket for the build status
[18:37:59.627] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:59.627] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:16:0) after 1m0s
[18:38:59.646] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:16:0)
[18:38:59.646] Timer tick, asking Buildbucket for the build status
[18:38:59.774] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:59.774] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:17:0) after 1m0s
[18:39:59.848] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:17:0)
[18:39:59.848] Timer tick, asking Buildbucket for the build status
[18:39:59.998] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:59.998] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:18:0) after 1m0s
[18:41:00.031] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:18:0)
[18:41:00.031] Timer tick, asking Buildbucket for the build status
[18:41:00.214] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:00.215] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:19:0) after 1m0s
[18:42:00.239] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:19:0)
[18:42:00.239] Timer tick, asking Buildbucket for the build status
[18:42:00.294] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:00.294] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:20:0) after 1m0s
[18:43:00.317] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:20:0)
[18:43:00.317] Timer tick, asking Buildbucket for the build status
[18:43:00.377] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:00.377] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:21:0) after 1m0s
[18:44:00.420] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:21:0)
[18:44:00.420] Timer tick, asking Buildbucket for the build status
[18:44:00.680] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:00.680] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:22:0) after 1m0s
[18:45:00.701] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:22:0)
[18:45:00.701] Timer tick, asking Buildbucket for the build status
[18:45:01.142] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:01.142] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:23:0) after 1m0s
[18:46:01.160] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:23:0)
[18:46:01.160] Timer tick, asking Buildbucket for the build status
[18:46:01.233] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:01.233] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:24:0) after 1m0s
[18:47:01.257] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:24:0)
[18:47:01.257] Timer tick, asking Buildbucket for the build status
[18:47:01.912] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:01.912] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:25:0) after 1m0s
[18:48:01.950] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:25:0)
[18:48:01.950] Timer tick, asking Buildbucket for the build status
[18:48:02.008] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:02.008] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:26:0) after 1m0s
[18:49:02.031] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:26:0)
[18:49:02.031] Timer tick, asking Buildbucket for the build status
[18:49:02.424] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:02.424] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:27:0) after 1m0s
[18:50:02.443] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:27:0)
[18:50:02.443] Timer tick, asking Buildbucket for the build status
[18:50:02.885] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:02.885] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:28:0) after 1m0s
[18:51:02.904] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:28:0)
[18:51:02.904] Timer tick, asking Buildbucket for the build status
[18:51:03.246] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:03.247] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:29:0) after 1m0s
[18:52:03.265] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:29:0)
[18:52:03.265] Timer tick, asking Buildbucket for the build status
[18:52:06.612] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:06.612] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:30:0) after 1m0s
[18:53:06.633] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:30:0)
[18:53:06.633] Timer tick, asking Buildbucket for the build status
[18:53:07.320] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:07.320] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:31:0) after 1m0s
[18:54:07.340] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:31:0)
[18:54:07.340] Timer tick, asking Buildbucket for the build status
[18:54:08.264] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:08.264] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:32:0) after 1m0s
[18:55:08.283] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:32:0)
[18:55:08.283] Timer tick, asking Buildbucket for the build status
[18:55:08.391] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:08.391] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:33:0) after 1m0s
[18:56:08.413] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:33:0)
[18:56:08.413] Timer tick, asking Buildbucket for the build status
[18:56:08.973] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:08.973] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:34:0) after 1m0s
[18:57:09.044] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:34:0)
[18:57:09.044] Timer tick, asking Buildbucket for the build status
[18:57:09.596] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:09.596] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:35:0) after 1m0s
[18:58:09.631] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:35:0)
[18:58:09.631] Timer tick, asking Buildbucket for the build status
[18:58:09.766] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:09.766] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:36:0) after 1m0s
[18:59:09.788] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:36:0)
[18:59:09.788] Timer tick, asking Buildbucket for the build status
[18:59:10.023] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:10.023] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:37:0) after 1m0s
[19:00:10.046] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:37:0)
[19:00:10.046] Timer tick, asking Buildbucket for the build status
[19:00:10.184] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:10.184] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:38:0) after 1m0s
[19:01:10.220] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:38:0)
[19:01:10.220] Timer tick, asking Buildbucket for the build status
[19:01:10.327] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:10.327] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:39:0) after 1m0s
[19:02:10.345] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:39:0)
[19:02:10.345] Timer tick, asking Buildbucket for the build status
[19:02:10.408] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:10.408] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:40:0) after 1m0s
[19:03:10.429] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:40:0)
[19:03:10.429] Timer tick, asking Buildbucket for the build status
[19:03:10.604] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:10.604] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:41:0) after 1m0s
[19:04:10.632] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:41:0)
[19:04:10.632] Timer tick, asking Buildbucket for the build status
[19:04:10.730] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:10.730] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:42:0) after 1m0s
[19:05:10.761] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:42:0)
[19:05:10.761] Timer tick, asking Buildbucket for the build status
[19:05:11.057] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:11.057] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:43:0) after 1m0s
[19:06:11.144] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:43:0)
[19:06:11.144] Timer tick, asking Buildbucket for the build status
[19:06:11.697] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:11.697] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:44:0) after 1m0s
[19:07:11.722] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:44:0)
[19:07:11.722] Timer tick, asking Buildbucket for the build status
[19:07:11.989] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:11.989] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:45:0) after 1m0s
[19:08:12.007] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:45:0)
[19:08:12.007] Timer tick, asking Buildbucket for the build status
[19:08:12.417] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:12.417] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:46:0) after 1m0s
[19:09:12.435] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:46:0)
[19:09:12.435] Timer tick, asking Buildbucket for the build status
[19:09:12.811] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:12.811] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:47:0) after 1m0s
[19:10:12.888] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:47:0)
[19:10:12.888] Timer tick, asking Buildbucket for the build status
[19:10:13.206] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:13.206] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:48:0) after 1m0s
[19:11:13.308] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:48:0)
[19:11:13.308] Timer tick, asking Buildbucket for the build status
[19:11:13.661] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:13.661] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:49:0) after 1m0s
[19:12:13.743] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:49:0)
[19:12:13.743] Timer tick, asking Buildbucket for the build status
[19:12:15.313] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:15.313] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:50:0) after 1m0s
[19:13:15.337] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:50:0)
[19:13:15.337] Timer tick, asking Buildbucket for the build status
[19:13:15.477] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:15.477] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:51:0) after 1m0s
[19:14:15.571] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:51:0)
[19:14:15.571] Timer tick, asking Buildbucket for the build status
[19:14:15.853] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:15.853] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:52:0) after 1m0s
[19:15:15.887] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:52:0)
[19:15:15.887] Timer tick, asking Buildbucket for the build status
[19:15:15.989] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:15.989] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:53:0) after 1m0s
[19:16:16.110] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:53:0)
[19:16:16.110] Timer tick, asking Buildbucket for the build status
[19:16:16.857] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:16.857] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:54:0) after 1m0s
[19:17:16.878] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:54:0)
[19:17:16.878] Timer tick, asking Buildbucket for the build status
[19:17:16.959] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:16.959] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:55:0) after 1m0s
[19:18:16.980] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:55:0)
[19:18:16.980] Timer tick, asking Buildbucket for the build status
[19:18:17.482] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:17.482] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:56:0) after 1m0s
[19:19:17.504] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:56:0)
[19:19:17.504] Timer tick, asking Buildbucket for the build status
[19:19:17.558] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:17.558] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:57:0) after 1m0s
[19:20:17.581] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:57:0)
[19:20:17.581] Timer tick, asking Buildbucket for the build status
[19:20:18.483] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:18.483] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:58:0) after 1m0s
[19:21:18.500] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:58:0)
[19:21:18.500] Timer tick, asking Buildbucket for the build status
[19:21:19.989] Build 8921614624889942080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:19.989] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9087044686964856288:59:0) after 1m0s
[19:21:59.893] Received PubSub notification, asking Buildbucket for the build status
[19:22:00.361] Build 8921614624889942080: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[19:22:00.361] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1550085718937712",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1550082293576311",
"failure_reason": "BUILD_FAILURE",
"id": "8921614624889942080",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"0bee510173d84106b2b72b7d94f0a988956f716d\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"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\": [\"4093-289bd80\"], \"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\"]}}, \"ui\": {\"info\": \"Failure site_per_process_components_unittests on Android device Nexus 5X\\nFailure site_per_process_unit_tests on Android device Nexus 5X\\nFailure site_per_process_content_browsertests on Android device Nexus 5X\"}, \"properties\": {\"got_nacl_revision\": \"ff15c51d20785fa51c0ef03ccb480b87299acbeb\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"0bee510173d84106b2b72b7d94f0a988956f716d\", \"recipe\": \"chromium\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_dawn_revision\": \"a594f8fdb4d78c06ae1cf5fa4adbcc1210af9b4d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26626}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#631800}\", \"branch\": \"refs/heads/master\", \"revision\": \"0bee510173d84106b2b72b7d94f0a988956f716d\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Site Isolation Android\", \"got_webrtc_revision\": \"f13c2cd9ee41f4ca572232a4e397b05449474632\", \"mastername\": \"chromium.fyi\", \"swarm_hashes_refs/heads/master(at){#631800}_without_patch\": {\"components_unittests\": \"c6589ab05de5c40b4c809f71adbe00f74b6e0414\", \"unit_tests\": \"3c807f9f989269edbc189a994e5e172d1195b12b\", \"components_browsertests\": \"616a89be5c3204251faa106b91ed00c546799fb7\", \"content_browsertests\": \"42faec0af33a2d8e653c58e9bd34f2f665a78438\", \"content_unittests\": \"940a2f105401e412c3011ee9a41af745cf3a147d\"}, \"got_angle_revision\": \"983e446921946734fe47217c345a8fe2f079319d\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1550082293576311, \"tags\": [\"build_address:luci.chromium.ci/Site Isolation Android/30507\", \"builder:Site Isolation Android\", \"buildset:commit/git/0bee510173d84106b2b72b7d94f0a988956f716d\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0bee510173d84106b2b72b7d94f0a988956f716d\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9087044686964856288\", \"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\": \"8921614624889942080\"}}, \"got_v8_revision\": \"349f90dd44894ff900e5a3740d3a120d5c94321b\", \"got_v8_revision_cp\": \"refs/heads/7.4.160@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 30507, \"$recipe_engine/buildbucket\": {\"build\": {\"tags\": [{\"value\": \"Site Isolation Android\", \"key\": \"builder\"}, {\"value\": \"commit/git/0bee510173d84106b2b72b7d94f0a988956f716d\", \"key\": \"buildset\"}, {\"value\": \"commit/gitiles/chromium.googlesource.com/chromium/src/+/0bee510173d84106b2b72b7d94f0a988956f716d\", \"key\": \"buildset\"}, {\"value\": \"9087044686964856288\", \"key\": \"scheduler_invocation_id\"}, {\"value\": \"chromium/Site Isolation Android\", \"key\": \"scheduler_job_id\"}, {\"value\": \"luci-scheduler\", \"key\": \"user_agent\"}], \"builder\": {\"project\": \"chromium\", \"builder\": \"Site Isolation Android\", \"bucket\": \"ci\"}, \"number\": 30507, \"infra\": {\"buildbucket\": {\"serviceConfigRevision\": \"2acf9ddf085124300131f0a719a64564504c97a6\", \"canary\": true}, \"recipe\": {\"name\": \"chromium\", \"cipdPackage\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}, \"swarming\": {\"hostname\": \"chromium-swarm.appspot.com\"}}, \"createdBy\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"id\": \"8921614624889942080\", \"input\": {\"gitilesCommit\": {\"project\": \"chromium/src\", \"host\": \"chromium.googlesource.com\", \"ref\": \"refs/heads/master\", \"id\": \"0bee510173d84106b2b72b7d94f0a988956f716d\"}}, \"createTime\": \"2019-02-13T18:24:53.576311Z\"}}, \"path_config\": \"generic\", \"swarm_hashes\": {\"components_unittests\": \"c6589ab05de5c40b4c809f71adbe00f74b6e0414\", \"unit_tests\": \"3c807f9f989269edbc189a994e5e172d1195b12b\", \"components_browsertests\": \"616a89be5c3204251faa106b91ed00c546799fb7\", \"content_browsertests\": \"42faec0af33a2d8e653c58e9bd34f2f665a78438\", \"content_unittests\": \"940a2f105401e412c3011ee9a41af745cf3a147d\"}, \"bot_id\": \"swarm2384-c4\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1550082335999129",
"status": "COMPLETED",
"status_changed_ts": "1550085719541819",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/30507",
"builder:Site Isolation Android",
"buildset:commit/git/0bee510173d84106b2b72b7d94f0a988956f716d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0bee510173d84106b2b72b7d94f0a988956f716d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9087044686964856288",
"scheduler_job_id:chromium/Site Isolation Android",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8921614624889942080/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4300ec4b54e4c210",
"user_agent:luci-scheduler"
],
"updated_ts": "1550085719544305",
"url": "https://ci.chromium.org/b/8921614624889942080",
"utcnow_ts": "1550085720350083"
}
}
[19:22:00.361] Invocation finished in 57m8.148043088s with status FAILED