[12:47:46.154] New invocation is queued and will start shortly
[12:47:47.235] Starting the invocation (attempt 1)
[12:47:47.271] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:47:47.271] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:47:47.272] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070214859793700880",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"77948441ad0a6ec4c6e9ffbf52c88bf26bad4383\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9070214859793700880",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/77948441ad0a6ec4c6e9ffbf52c88bf26bad4383",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/77948441ad0a6ec4c6e9ffbf52c88bf26bad4383",
"gitiles_ref:refs/heads/master"
]
}
[12:47:48.338] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1566132467585120",
"id": "8904784797627547440",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"77948441ad0a6ec4c6e9ffbf52c88bf26bad4383\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566132468014867",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/36326",
"builder:Site Isolation Android",
"buildset:commit/git/77948441ad0a6ec4c6e9ffbf52c88bf26bad4383",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/77948441ad0a6ec4c6e9ffbf52c88bf26bad4383",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070214859793700880",
"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/8904784797627547440/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1566132468014984",
"url": "https://ci.chromium.org/b/8904784797627547440",
"utcnow_ts": "1566132468324339"
}
}
[12:47:48.338] Task URL: https://ci.chromium.org/b/8904784797627547440
[12:47:48.338] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:2:0) after 1m0s
[12:48:22.817] Received PubSub notification, asking Buildbucket for the build status
[12:48:23.979] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:54.312] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:2:0)
[12:48:54.312] Timer tick, asking Buildbucket for the build status
[12:48:55.326] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:55.326] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:4:0) after 1m0s
[12:49:55.589] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:4:0)
[12:49:55.589] Timer tick, asking Buildbucket for the build status
[12:49:56.185] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:56.185] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:5:0) after 1m0s
[12:50:56.207] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:5:0)
[12:50:56.207] Timer tick, asking Buildbucket for the build status
[12:50:56.348] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:56.348] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:6:0) after 1m0s
[12:51:56.375] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:6:0)
[12:51:56.375] Timer tick, asking Buildbucket for the build status
[12:51:56.529] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:56.529] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:7:0) after 1m0s
[12:52:56.556] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:7:0)
[12:52:56.556] Timer tick, asking Buildbucket for the build status
[12:52:56.729] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:56.729] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:8:0) after 1m0s
[12:53:56.783] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:8:0)
[12:53:56.783] Timer tick, asking Buildbucket for the build status
[12:53:57.165] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:57.165] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:9:0) after 1m0s
[12:54:57.188] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:9:0)
[12:54:57.188] Timer tick, asking Buildbucket for the build status
[12:54:57.339] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:57.339] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:10:0) after 1m0s
[12:55:57.360] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:10:0)
[12:55:57.360] Timer tick, asking Buildbucket for the build status
[12:55:57.517] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:57.517] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:11:0) after 1m0s
[12:56:57.541] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:11:0)
[12:56:57.541] Timer tick, asking Buildbucket for the build status
[12:56:57.729] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:57.729] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:12:0) after 1m0s
[12:57:57.755] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:12:0)
[12:57:57.755] Timer tick, asking Buildbucket for the build status
[12:57:58.358] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:58.358] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:13:0) after 1m0s
[12:58:58.448] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:13:0)
[12:58:58.448] Timer tick, asking Buildbucket for the build status
[12:58:58.839] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:58.839] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:14:0) after 1m0s
[12:59:58.900] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:14:0)
[12:59:58.900] Timer tick, asking Buildbucket for the build status
[12:59:59.566] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:59.566] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:15:0) after 1m0s
[13:00:59.588] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:15:0)
[13:00:59.588] Timer tick, asking Buildbucket for the build status
[13:00:59.766] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:59.766] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:16:0) after 1m0s
[13:01:59.798] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:16:0)
[13:01:59.798] Timer tick, asking Buildbucket for the build status
[13:01:59.963] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:59.963] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:17:0) after 1m0s
[13:02:59.936] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:17:0)
[13:02:59.936] Timer tick, asking Buildbucket for the build status
[13:03:00.084] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:00.084] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:18:0) after 1m0s
[13:04:00.114] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:18:0)
[13:04:00.114] Timer tick, asking Buildbucket for the build status
[13:04:00.249] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:00.249] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:19:0) after 1m0s
[13:05:00.271] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:19:0)
[13:05:00.271] Timer tick, asking Buildbucket for the build status
[13:05:00.714] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:00.714] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:20:0) after 1m0s
[13:06:00.786] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:20:0)
[13:06:00.786] Timer tick, asking Buildbucket for the build status
[13:06:01.323] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:01.323] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:21:0) after 1m0s
[13:07:01.355] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:21:0)
[13:07:01.355] Timer tick, asking Buildbucket for the build status
[13:07:01.518] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:01.518] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:22:0) after 1m0s
[13:08:01.900] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:22:0)
[13:08:01.900] Timer tick, asking Buildbucket for the build status
[13:08:02.813] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:02.813] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:23:0) after 1m0s
[13:09:02.999] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:23:0)
[13:09:02.999] Timer tick, asking Buildbucket for the build status
[13:09:03.147] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:03.147] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:24:0) after 1m0s
[13:10:03.400] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:24:0)
[13:10:03.401] Timer tick, asking Buildbucket for the build status
[13:10:03.585] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:03.585] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:25:0) after 1m0s
[13:11:03.711] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:25:0)
[13:11:03.711] Timer tick, asking Buildbucket for the build status
[13:11:03.902] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:03.902] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:26:0) after 1m0s
[13:12:04.012] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:26:0)
[13:12:04.012] Timer tick, asking Buildbucket for the build status
[13:12:04.179] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:04.179] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:27:0) after 1m0s
[13:13:04.238] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:27:0)
[13:13:04.238] Timer tick, asking Buildbucket for the build status
[13:13:04.383] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:04.383] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:28:0) after 1m0s
[13:14:04.409] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:28:0)
[13:14:04.409] Timer tick, asking Buildbucket for the build status
[13:14:04.789] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:04.789] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:29:0) after 1m0s
[13:15:04.898] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:29:0)
[13:15:04.898] Timer tick, asking Buildbucket for the build status
[13:15:05.051] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:05.051] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:30:0) after 1m0s
[13:16:05.336] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:30:0)
[13:16:05.336] Timer tick, asking Buildbucket for the build status
[13:16:05.554] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:05.554] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:31:0) after 1m0s
[13:17:05.600] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:31:0)
[13:17:05.600] Timer tick, asking Buildbucket for the build status
[13:17:05.924] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:05.924] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:32:0) after 1m0s
[13:18:06.178] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:32:0)
[13:18:06.178] Timer tick, asking Buildbucket for the build status
[13:18:06.505] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:06.505] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:33:0) after 1m0s
[13:19:06.872] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:33:0)
[13:19:06.872] Timer tick, asking Buildbucket for the build status
[13:19:07.032] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:07.032] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:34:0) after 1m0s
[13:20:07.184] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:34:0)
[13:20:07.184] Timer tick, asking Buildbucket for the build status
[13:20:07.336] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:07.336] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:35:0) after 1m0s
[13:21:07.362] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:35:0)
[13:21:07.362] Timer tick, asking Buildbucket for the build status
[13:21:07.575] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:07.575] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:36:0) after 1m0s
[13:22:07.621] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:36:0)
[13:22:07.621] Timer tick, asking Buildbucket for the build status
[13:22:07.893] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:07.893] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:37:0) after 1m0s
[13:23:08.024] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:37:0)
[13:23:08.024] Timer tick, asking Buildbucket for the build status
[13:23:09.458] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:09.458] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:38:0) after 1m0s
[13:24:09.517] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:38:0)
[13:24:09.517] Timer tick, asking Buildbucket for the build status
[13:24:09.658] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:09.658] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:39:0) after 1m0s
[13:25:09.656] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:39:0)
[13:25:09.656] Timer tick, asking Buildbucket for the build status
[13:25:10.259] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:10.259] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:40:0) after 1m0s
[13:26:10.379] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:40:0)
[13:26:10.379] Timer tick, asking Buildbucket for the build status
[13:26:10.759] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:10.759] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:41:0) after 1m0s
[13:27:10.835] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:41:0)
[13:27:10.835] Timer tick, asking Buildbucket for the build status
[13:27:11.833] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:11.833] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:42:0) after 1m0s
[13:28:11.939] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:42:0)
[13:28:11.939] Timer tick, asking Buildbucket for the build status
[13:28:12.614] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:12.614] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:43:0) after 1m0s
[13:29:12.648] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:43:0)
[13:29:12.648] Timer tick, asking Buildbucket for the build status
[13:29:12.852] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:12.852] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:44:0) after 1m0s
[13:30:13.041] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:44:0)
[13:30:13.041] Timer tick, asking Buildbucket for the build status
[13:30:13.349] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:13.349] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:45:0) after 1m0s
[13:31:13.471] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:45:0)
[13:31:13.471] Timer tick, asking Buildbucket for the build status
[13:31:13.826] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:13.826] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:46:0) after 1m0s
[13:32:13.948] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:46:0)
[13:32:13.948] Timer tick, asking Buildbucket for the build status
[13:32:14.154] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:14.154] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:47:0) after 1m0s
[13:33:14.184] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:47:0)
[13:33:14.184] Timer tick, asking Buildbucket for the build status
[13:33:14.340] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:14.340] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:48:0) after 1m0s
[13:34:14.476] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:48:0)
[13:34:14.476] Timer tick, asking Buildbucket for the build status
[13:34:19.844] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:19.845] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:49:0) after 1m0s
[13:35:19.879] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:49:0)
[13:35:19.879] Timer tick, asking Buildbucket for the build status
[13:35:20.170] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:20.170] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:50:0) after 1m0s
[13:36:20.195] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:50:0)
[13:36:20.195] Timer tick, asking Buildbucket for the build status
[13:36:21.098] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:21.098] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:51:0) after 1m0s
[13:37:21.171] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:51:0)
[13:37:21.171] Timer tick, asking Buildbucket for the build status
[13:37:21.444] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:21.444] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:52:0) after 1m0s
[13:38:21.477] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:52:0)
[13:38:21.477] Timer tick, asking Buildbucket for the build status
[13:38:21.813] Build 8904784797627547440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:21.813] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9070214859793700880:53:0) after 1m0s
[13:38:49.164] Received PubSub notification, asking Buildbucket for the build status
[13:38:49.762] Build 8904784797627547440: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[13:38:49.762] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1566135528399552",
"created_by": "project:chromium",
"created_ts": "1566132467585120",
"failure_reason": "BUILD_FAILURE",
"id": "8904784797627547440",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"77948441ad0a6ec4c6e9ffbf52c88bf26bad4383\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**site_per_process_unit_tests on Android device Nexus 5X** failed because of:\\n\\n- OfflinePageUtilsTest.TestGetCachedOfflinePageSizeAllPagesInRange\"}, \"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-81-aolj\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 36326, \"got_angle_revision\": \"265fdf0c5fd6b1e28a54c18ca40a8461c7f449a7\", \"got_dawn_revision\": \"ee3de1e1f3da2386197a2c586304deb263890a35\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"77948441ad0a6ec4c6e9ffbf52c88bf26bad4383\", \"got_revision_cp\": \"refs/heads/master@{#687965}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"7b861aca66ea8080a32eba6217f8833cdcc32a09\", \"got_v8_revision_cp\": \"refs/heads/7.8.113@{#1}\", \"got_webrtc_revision\": \"f5e5d250bc85616e74487f8330ed8d99cc9cf84f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28880}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"77948441ad0a6ec4c6e9ffbf52c88bf26bad4383\", \"swarm_hashes\": {\"components_browsertests\": \"9b30ef669d38782f6c9f3bfedb578dc73d4ed96d\", \"components_unittests\": \"4cc7d35a05ae52152090b55df08bfb9322a6a643\", \"content_browsertests\": \"65a044f36ee34b8a82ea7068fd8f4d7d71a3a5f7\", \"content_unittests\": \"044d117b831cde31943543dd53133a7171ee2f31\", \"unit_tests\": \"acad942dadafe4d208bded967c53449e3e648f91\"}, \"swarm_hashes_refs/heads/master(at){#687965}_without_patch\": {\"components_browsertests\": \"9b30ef669d38782f6c9f3bfedb578dc73d4ed96d\", \"components_unittests\": \"4cc7d35a05ae52152090b55df08bfb9322a6a643\", \"content_browsertests\": \"65a044f36ee34b8a82ea7068fd8f4d7d71a3a5f7\", \"content_unittests\": \"044d117b831cde31943543dd53133a7171ee2f31\", \"unit_tests\": \"acad942dadafe4d208bded967c53449e3e648f91\"}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**site_per_process_unit_tests on Android device Nexus 5X** failed because of:\\n\\n- OfflinePageUtilsTest.TestGetCachedOfflinePageSizeAllPagesInRange\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1566132501890689",
"status": "COMPLETED",
"status_changed_ts": "1566132468014867",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/36326",
"builder:Site Isolation Android",
"buildset:commit/git/77948441ad0a6ec4c6e9ffbf52c88bf26bad4383",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/77948441ad0a6ec4c6e9ffbf52c88bf26bad4383",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070214859793700880",
"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/8904784797627547440/+/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:46bd9683c1064110",
"user_agent:luci-scheduler"
],
"updated_ts": "1566135528687346",
"url": "https://ci.chromium.org/b/8904784797627547440",
"utcnow_ts": "1566135529742770"
}
}
[13:38:49.762] Invocation finished in 51m3.626478207s with status FAILED