[14:20:03.300] New invocation is queued and will start shortly
[14:20:04.992] Starting the invocation (attempt 1)
[14:20:05.045] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:20:05.046] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:20:05.046] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9063414281195828912",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"63a3c6155255eb6d0bf9635e89821d3b274c8a9a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9063414281195828912",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/63a3c6155255eb6d0bf9635e89821d3b274c8a9a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63a3c6155255eb6d0bf9635e89821d3b274c8a9a",
"gitiles_ref:refs/heads/master"
]
}
[14:20:06.431] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1572618005646993",
"id": "8897984218070151936",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"63a3c6155255eb6d0bf9635e89821d3b274c8a9a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1572618006303889",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/38405",
"builder:Site Isolation Android",
"buildset:commit/git/63a3c6155255eb6d0bf9635e89821d3b274c8a9a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63a3c6155255eb6d0bf9635e89821d3b274c8a9a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063414281195828912",
"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/8897984218070151936/+/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": "1572618006304051",
"url": "https://ci.chromium.org/b/8897984218070151936",
"utcnow_ts": "1572618006422639"
}
}
[14:20:06.431] Task URL: https://ci.chromium.org/b/8897984218070151936
[14:20:06.431] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:2:0) after 1m0s
[14:21:06.543] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:2:0)
[14:21:06.543] Timer tick, asking Buildbucket for the build status
[14:21:07.838] Build 8897984218070151936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:21:07.839] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:3:0) after 1m0s
[14:22:07.893] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:3:0)
[14:22:07.893] Timer tick, asking Buildbucket for the build status
[14:22:08.124] Build 8897984218070151936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:22:08.124] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:4:0) after 1m0s
[14:23:08.228] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:4:0)
[14:23:08.228] Timer tick, asking Buildbucket for the build status
[14:23:08.513] Build 8897984218070151936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:23:08.513] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:5:0) after 1m0s
[14:24:08.549] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:5:0)
[14:24:08.549] Timer tick, asking Buildbucket for the build status
[14:24:08.855] Build 8897984218070151936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:24:08.855] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:6:0) after 1m0s
[14:25:07.971] Received PubSub notification, asking Buildbucket for the build status
[14:25:08.423] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:08.900] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:6:0)
[14:25:08.900] Timer tick, asking Buildbucket for the build status
[14:25:09.094] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:09.094] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:8:0) after 1m0s
[14:26:09.155] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:8:0)
[14:26:09.155] Timer tick, asking Buildbucket for the build status
[14:26:10.001] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:10.001] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:9:0) after 1m0s
[14:27:10.172] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:9:0)
[14:27:10.172] Timer tick, asking Buildbucket for the build status
[14:27:10.387] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:10.387] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:10:0) after 1m0s
[14:28:10.485] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:10:0)
[14:28:10.485] Timer tick, asking Buildbucket for the build status
[14:28:10.786] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:10.786] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:11:0) after 1m0s
[14:29:10.872] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:11:0)
[14:29:10.872] Timer tick, asking Buildbucket for the build status
[14:29:11.029] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:11.029] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:12:0) after 1m0s
[14:30:11.121] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:12:0)
[14:30:11.121] Timer tick, asking Buildbucket for the build status
[14:30:11.323] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:11.323] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:13:0) after 1m0s
[14:31:11.558] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:13:0)
[14:31:11.558] Timer tick, asking Buildbucket for the build status
[14:31:11.920] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:11.920] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:14:0) after 1m0s
[14:32:11.920] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:14:0)
[14:32:11.920] Timer tick, asking Buildbucket for the build status
[14:32:12.427] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:12.427] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:15:0) after 1m0s
[14:33:12.590] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:15:0)
[14:33:12.590] Timer tick, asking Buildbucket for the build status
[14:33:13.038] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:13.038] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:16:0) after 1m0s
[14:34:13.222] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:16:0)
[14:34:13.222] Timer tick, asking Buildbucket for the build status
[14:34:13.758] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:13.758] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:17:0) after 1m0s
[14:35:13.802] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:17:0)
[14:35:13.802] Timer tick, asking Buildbucket for the build status
[14:35:14.390] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:14.390] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:18:0) after 1m0s
[14:36:14.481] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:18:0)
[14:36:14.481] Timer tick, asking Buildbucket for the build status
[14:36:14.702] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:14.702] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:19:0) after 1m0s
[14:37:14.877] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:19:0)
[14:37:14.877] Timer tick, asking Buildbucket for the build status
[14:37:15.117] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:15.117] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:20:0) after 1m0s
[14:38:15.111] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:20:0)
[14:38:15.111] Timer tick, asking Buildbucket for the build status
[14:38:15.866] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:15.867] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:21:0) after 1m0s
[14:39:15.843] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:21:0)
[14:39:15.843] Timer tick, asking Buildbucket for the build status
[14:39:15.973] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:15.973] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:22:0) after 1m0s
[14:40:15.963] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:22:0)
[14:40:15.963] Timer tick, asking Buildbucket for the build status
[14:40:16.590] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:16.590] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:23:0) after 1m0s
[14:41:16.615] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:23:0)
[14:41:16.615] Timer tick, asking Buildbucket for the build status
[14:41:16.963] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:16.964] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:24:0) after 1m0s
[14:42:17.003] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:24:0)
[14:42:17.003] Timer tick, asking Buildbucket for the build status
[14:42:17.305] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:17.305] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:25:0) after 1m0s
[14:43:17.332] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:25:0)
[14:43:17.332] Timer tick, asking Buildbucket for the build status
[14:43:17.510] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:17.510] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:26:0) after 1m0s
[14:44:17.642] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:26:0)
[14:44:17.642] Timer tick, asking Buildbucket for the build status
[14:44:18.067] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:18.067] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:27:0) after 1m0s
[14:45:18.155] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:27:0)
[14:45:18.155] Timer tick, asking Buildbucket for the build status
[14:45:18.689] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:18.689] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:28:0) after 1m0s
[14:46:18.783] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:28:0)
[14:46:18.783] Timer tick, asking Buildbucket for the build status
[14:46:18.962] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:18.962] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:29:0) after 1m0s
[14:47:18.976] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:29:0)
[14:47:18.976] Timer tick, asking Buildbucket for the build status
[14:47:19.383] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:19.383] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:30:0) after 1m0s
[14:48:19.457] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:30:0)
[14:48:19.457] Timer tick, asking Buildbucket for the build status
[14:48:19.591] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:19.591] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:31:0) after 1m0s
[14:49:19.592] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:31:0)
[14:49:19.592] Timer tick, asking Buildbucket for the build status
[14:49:19.924] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:19.924] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:32:0) after 1m0s
[14:50:19.986] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:32:0)
[14:50:19.986] Timer tick, asking Buildbucket for the build status
[14:50:20.282] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:20.282] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:33:0) after 1m0s
[14:51:20.366] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:33:0)
[14:51:20.366] Timer tick, asking Buildbucket for the build status
[14:51:20.642] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:20.642] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:34:0) after 1m0s
[14:52:20.756] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:34:0)
[14:52:20.756] Timer tick, asking Buildbucket for the build status
[14:52:21.432] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:21.434] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:35:0) after 1m0s
[14:53:21.497] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:35:0)
[14:53:21.497] Timer tick, asking Buildbucket for the build status
[14:53:22.517] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:22.517] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:36:0) after 1m0s
[14:54:22.577] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:36:0)
[14:54:22.577] Timer tick, asking Buildbucket for the build status
[14:54:22.895] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:22.895] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:37:0) after 1m0s
[14:55:22.965] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:37:0)
[14:55:22.965] Timer tick, asking Buildbucket for the build status
[14:55:25.899] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:25.899] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:38:0) after 1m0s
[14:56:25.973] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:38:0)
[14:56:25.973] Timer tick, asking Buildbucket for the build status
[14:56:26.790] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:26.790] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:39:0) after 1m0s
[14:57:27.046] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:39:0)
[14:57:27.046] Timer tick, asking Buildbucket for the build status
[14:57:27.297] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:27.297] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:40:0) after 1m0s
[14:58:27.432] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:40:0)
[14:58:27.432] Timer tick, asking Buildbucket for the build status
[14:58:27.891] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:27.892] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:41:0) after 1m0s
[14:59:27.976] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:41:0)
[14:59:27.976] Timer tick, asking Buildbucket for the build status
[14:59:28.274] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:28.274] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:42:0) after 1m0s
[15:00:28.299] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:42:0)
[15:00:28.299] Timer tick, asking Buildbucket for the build status
[15:00:28.582] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:28.582] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:43:0) after 1m0s
[15:01:28.684] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:43:0)
[15:01:28.684] Timer tick, asking Buildbucket for the build status
[15:01:29.601] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:29.601] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:44:0) after 1m0s
[15:02:29.687] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:44:0)
[15:02:29.687] Timer tick, asking Buildbucket for the build status
[15:02:29.988] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:29.988] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:45:0) after 1m0s
[15:03:30.014] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:45:0)
[15:03:30.014] Timer tick, asking Buildbucket for the build status
[15:03:30.271] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:30.271] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:46:0) after 1m0s
[15:04:30.348] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:46:0)
[15:04:30.348] Timer tick, asking Buildbucket for the build status
[15:04:30.544] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:30.544] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:47:0) after 1m0s
[15:05:30.691] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:47:0)
[15:05:30.691] Timer tick, asking Buildbucket for the build status
[15:05:30.985] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:30.985] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:48:0) after 1m0s
[15:06:31.076] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:48:0)
[15:06:31.077] Timer tick, asking Buildbucket for the build status
[15:06:31.536] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:31.536] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:49:0) after 1m0s
[15:07:31.582] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:49:0)
[15:07:31.582] Timer tick, asking Buildbucket for the build status
[15:07:31.870] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:31.870] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:50:0) after 1m0s
[15:08:31.903] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:50:0)
[15:08:31.903] Timer tick, asking Buildbucket for the build status
[15:08:32.112] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:32.112] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:51:0) after 1m0s
[15:09:32.252] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:51:0)
[15:09:32.252] Timer tick, asking Buildbucket for the build status
[15:09:33.262] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:33.262] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:52:0) after 1m0s
[15:10:33.388] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:52:0)
[15:10:33.388] Timer tick, asking Buildbucket for the build status
[15:10:35.891] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:35.891] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:53:0) after 1m0s
[15:11:36.022] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:53:0)
[15:11:36.023] Timer tick, asking Buildbucket for the build status
[15:11:36.536] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:36.536] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:54:0) after 1m0s
[15:12:36.674] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:54:0)
[15:12:36.675] Timer tick, asking Buildbucket for the build status
[15:12:36.906] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:36.906] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:55:0) after 1m0s
[15:13:36.964] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:55:0)
[15:13:36.964] Timer tick, asking Buildbucket for the build status
[15:13:37.848] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:37.848] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:56:0) after 1m0s
[15:14:37.882] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:56:0)
[15:14:37.882] Timer tick, asking Buildbucket for the build status
[15:14:38.734] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:38.734] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:57:0) after 1m0s
[15:15:38.799] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:57:0)
[15:15:38.800] Timer tick, asking Buildbucket for the build status
[15:15:39.052] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:39.052] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:58:0) after 1m0s
[15:16:39.082] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:58:0)
[15:16:39.082] Timer tick, asking Buildbucket for the build status
[15:16:41.250] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:41.250] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:59:0) after 1m0s
[15:17:41.307] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:59:0)
[15:17:41.307] Timer tick, asking Buildbucket for the build status
[15:17:41.451] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:41.451] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:60:0) after 1m0s
[15:18:41.598] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:60:0)
[15:18:41.598] Timer tick, asking Buildbucket for the build status
[15:18:42.499] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:42.499] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:61:0) after 1m0s
[15:19:42.564] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:61:0)
[15:19:42.564] Timer tick, asking Buildbucket for the build status
[15:19:42.847] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:42.847] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:62:0) after 1m0s
[15:20:42.886] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:62:0)
[15:20:42.886] Timer tick, asking Buildbucket for the build status
[15:20:43.246] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:43.246] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:63:0) after 1m0s
[15:21:43.309] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:63:0)
[15:21:43.309] Timer tick, asking Buildbucket for the build status
[15:21:44.514] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:44.514] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:64:0) after 1m0s
[15:22:44.506] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:64:0)
[15:22:44.506] Timer tick, asking Buildbucket for the build status
[15:22:44.724] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:44.724] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:65:0) after 1m0s
[15:23:44.754] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:65:0)
[15:23:44.754] Timer tick, asking Buildbucket for the build status
[15:23:45.003] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:45.003] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:66:0) after 1m0s
[15:24:45.040] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:66:0)
[15:24:45.040] Timer tick, asking Buildbucket for the build status
[15:24:45.468] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:45.468] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:67:0) after 1m0s
[15:25:45.652] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:67:0)
[15:25:45.652] Timer tick, asking Buildbucket for the build status
[15:25:45.865] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:45.865] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:68:0) after 1m0s
[15:26:45.853] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:68:0)
[15:26:45.853] Timer tick, asking Buildbucket for the build status
[15:26:46.966] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:46.966] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:69:0) after 1m0s
[15:27:47.127] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:69:0)
[15:27:47.127] Timer tick, asking Buildbucket for the build status
[15:27:47.305] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:47.305] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:70:0) after 1m0s
[15:28:47.331] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:70:0)
[15:28:47.331] Timer tick, asking Buildbucket for the build status
[15:28:47.878] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:47.878] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:71:0) after 1m0s
[15:29:47.965] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:71:0)
[15:29:47.965] Timer tick, asking Buildbucket for the build status
[15:29:48.203] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:48.203] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:72:0) after 1m0s
[15:30:48.299] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:72:0)
[15:30:48.299] Timer tick, asking Buildbucket for the build status
[15:30:48.500] Build 8897984218070151936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:48.500] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9063414281195828912:73:0) after 1m0s
[15:31:36.162] Received PubSub notification, asking Buildbucket for the build status
[15:31:36.600] Build 8897984218070151936: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:31:36.600] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1572622295176678",
"created_by": "project:chromium",
"created_ts": "1572618005646993",
"id": "8897984218070151936",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"63a3c6155255eb6d0bf9635e89821d3b274c8a9a\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"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-central1-b-8-33-nb1k\", \"branch\": \"refs/heads/master\", \"buildername\": \"Site Isolation Android\", \"buildnumber\": 38405, \"got_angle_revision\": \"076fae01016528aa58a8af7ea817a922d297cc53\", \"got_dawn_revision\": \"fb03935bedd72b13db08f8bdb6f48e70d9f56b5d\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"63a3c6155255eb6d0bf9635e89821d3b274c8a9a\", \"got_revision_cp\": \"refs/heads/master@{#711692}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"b1ae70fb44e8c526a58c0ff0f523c95b8db0694b\", \"got_v8_revision_cp\": \"refs/heads/8.0.132@{#1}\", \"got_webrtc_revision\": \"3ce44a3540695ef8a55c2182758380d908bb4bf3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29671}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"63a3c6155255eb6d0bf9635e89821d3b274c8a9a\", \"swarm_hashes\": {\"components_browsertests\": \"7696323d371ca54a8b9454b240cb6d83d1af83de\", \"components_unittests\": \"a7e0d1eeca182f538370518bbfaa19b1c49d4ccb\", \"content_browsertests\": \"916ee0051cdc326d004a325caf505ccb152aaddb\", \"content_unittests\": \"247c09fc9930764c2f4f69a1d82c4862e5e2f2a4\", \"unit_tests\": \"cd2929837c148bf50a0a5050e26de26805ea2e48\"}, \"swarm_hashes_refs/heads/master(at){#711692}_without_patch\": {\"components_browsertests\": \"7696323d371ca54a8b9454b240cb6d83d1af83de\", \"components_unittests\": \"a7e0d1eeca182f538370518bbfaa19b1c49d4ccb\", \"content_browsertests\": \"916ee0051cdc326d004a325caf505ccb152aaddb\", \"content_unittests\": \"247c09fc9930764c2f4f69a1d82c4862e5e2f2a4\", \"unit_tests\": \"cd2929837c148bf50a0a5050e26de26805ea2e48\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_3bf707d1b446788136c41d64acb82cee4aa2d917a27590c71f5c82080b1ff0d2_v2\", \"builder_3e8184a1360bfb98b7c6c72727fe26f3a8bcb752f0d76877864d3d038eafa276_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_859368e171259d521efea13da6023dc28f5117d74d565299fe323cf1e9b3ffc9_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-33-nb1k\"], \"image\": [\"chrome-xenial-19102400-d35fedf5a0d\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4621-f8a5b1c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1572618306310298",
"status": "COMPLETED",
"status_changed_ts": "1572622295631771",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/38405",
"builder:Site Isolation Android",
"buildset:commit/git/63a3c6155255eb6d0bf9635e89821d3b274c8a9a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/63a3c6155255eb6d0bf9635e89821d3b274c8a9a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9063414281195828912",
"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/8897984218070151936/+/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:4840283c47b51d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1572622295640956",
"url": "https://ci.chromium.org/b/8897984218070151936",
"utcnow_ts": "1572622296573550"
}
}
[15:31:36.600] Invocation finished in 1h11m33.319427087s with status SUCCEEDED