[00:30:34.760] New invocation is queued and will start shortly
[00:30:35.822] Starting the invocation (attempt 1)
[00:30:35.865] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:30:35.865] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:30:35.865] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9084303769561454032",
"parameters_json": "{\"builder_name\":\"Site Isolation Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"9c361fa956c2e0e47414fe42fe9fd357ab6490c4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Site Isolation Android",
"scheduler_invocation_id:9084303769561454032",
"scheduler_job_id:chromium/Site Isolation Android",
"user_agent:luci-scheduler",
"buildset:commit/git/9c361fa956c2e0e47414fe42fe9fd357ab6490c4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9c361fa956c2e0e47414fe42fe9fd357ab6490c4",
"gitiles_ref:refs/heads/master"
]
}
[00:30:37.141] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1552696236003391",
"id": "8918873707595473040",
"lease_expiration_ts": "1552840236820744",
"lease_key": "1371569359",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9c361fa956c2e0e47414fe42fe9fd357ab6490c4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552696236979887",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/31575",
"builder:Site Isolation Android",
"buildset:commit/git/9c361fa956c2e0e47414fe42fe9fd357ab6490c4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9c361fa956c2e0e47414fe42fe9fd357ab6490c4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084303769561454032",
"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/8918873707595473040/+/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:439cb9e2297b0b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1552696236979974",
"url": "https://ci.chromium.org/b/8918873707595473040",
"utcnow_ts": "1552696237131563"
}
}
[00:30:37.141] Task URL: https://ci.chromium.org/b/8918873707595473040
[00:30:37.141] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:2:0) after 1m0s
[00:31:17.993] Received PubSub notification, asking Buildbucket for the build status
[00:31:18.104] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:37.167] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:2:0)
[00:31:37.167] Timer tick, asking Buildbucket for the build status
[00:31:37.305] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:37.305] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:4:0) after 1m0s
[00:32:37.317] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:4:0)
[00:32:37.317] Timer tick, asking Buildbucket for the build status
[00:32:37.443] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:37.443] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:5:0) after 1m0s
[00:33:37.510] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:5:0)
[00:33:37.510] Timer tick, asking Buildbucket for the build status
[00:33:37.616] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:37.616] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:6:0) after 1m0s
[00:34:37.633] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:6:0)
[00:34:37.633] Timer tick, asking Buildbucket for the build status
[00:34:38.032] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:38.032] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:7:0) after 1m0s
[00:35:38.008] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:7:0)
[00:35:38.008] Timer tick, asking Buildbucket for the build status
[00:35:38.217] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:38.217] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:8:0) after 1m0s
[00:36:38.234] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:8:0)
[00:36:38.234] Timer tick, asking Buildbucket for the build status
[00:36:38.322] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:38.322] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:9:0) after 1m0s
[00:37:38.343] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:9:0)
[00:37:38.343] Timer tick, asking Buildbucket for the build status
[00:37:38.822] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:38.822] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:10:0) after 1m0s
[00:38:38.812] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:10:0)
[00:38:38.812] Timer tick, asking Buildbucket for the build status
[00:38:39.604] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:39.604] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:11:0) after 1m0s
[00:39:39.596] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:11:0)
[00:39:39.596] Timer tick, asking Buildbucket for the build status
[00:39:39.761] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:39.761] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:12:0) after 1m0s
[00:40:39.757] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:12:0)
[00:40:39.757] Timer tick, asking Buildbucket for the build status
[00:40:39.883] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:39.883] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:13:0) after 1m0s
[00:41:39.870] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:13:0)
[00:41:39.870] Timer tick, asking Buildbucket for the build status
[00:41:39.996] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:39.996] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:14:0) after 1m0s
[00:42:40.034] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:14:0)
[00:42:40.034] Timer tick, asking Buildbucket for the build status
[00:42:40.182] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:40.182] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:15:0) after 1m0s
[00:43:40.205] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:15:0)
[00:43:40.205] Timer tick, asking Buildbucket for the build status
[00:43:40.422] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:40.422] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:16:0) after 1m0s
[00:44:40.442] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:16:0)
[00:44:40.442] Timer tick, asking Buildbucket for the build status
[00:44:40.914] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:40.914] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:17:0) after 1m0s
[00:45:40.935] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:17:0)
[00:45:40.936] Timer tick, asking Buildbucket for the build status
[00:45:41.106] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:41.106] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:18:0) after 1m0s
[00:46:41.128] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:18:0)
[00:46:41.128] Timer tick, asking Buildbucket for the build status
[00:46:41.887] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:41.887] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:19:0) after 1m0s
[00:47:41.907] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:19:0)
[00:47:41.907] Timer tick, asking Buildbucket for the build status
[00:47:42.035] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:42.035] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:20:0) after 1m0s
[00:48:42.054] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:20:0)
[00:48:42.054] Timer tick, asking Buildbucket for the build status
[00:48:42.413] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:42.413] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:21:0) after 1m0s
[00:49:42.430] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:21:0)
[00:49:42.430] Timer tick, asking Buildbucket for the build status
[00:49:42.535] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:42.535] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:22:0) after 1m0s
[00:50:42.552] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:22:0)
[00:50:42.552] Timer tick, asking Buildbucket for the build status
[00:50:42.691] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:42.691] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:23:0) after 1m0s
[00:51:42.675] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:23:0)
[00:51:42.675] Timer tick, asking Buildbucket for the build status
[00:51:43.790] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:43.790] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:24:0) after 1m0s
[00:52:43.821] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:24:0)
[00:52:43.821] Timer tick, asking Buildbucket for the build status
[00:52:44.237] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:44.237] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:25:0) after 1m0s
[00:53:44.277] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:25:0)
[00:53:44.277] Timer tick, asking Buildbucket for the build status
[00:53:45.564] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:45.564] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:26:0) after 1m0s
[00:54:45.560] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:26:0)
[00:54:45.560] Timer tick, asking Buildbucket for the build status
[00:54:46.174] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:46.174] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:27:0) after 1m0s
[00:55:46.179] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:27:0)
[00:55:46.179] Timer tick, asking Buildbucket for the build status
[00:55:46.570] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:46.570] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:28:0) after 1m0s
[00:56:46.594] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:28:0)
[00:56:46.594] Timer tick, asking Buildbucket for the build status
[00:56:46.694] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:46.694] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:29:0) after 1m0s
[00:57:46.723] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:29:0)
[00:57:46.723] Timer tick, asking Buildbucket for the build status
[00:57:46.890] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:46.890] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:30:0) after 1m0s
[00:58:46.910] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:30:0)
[00:58:46.910] Timer tick, asking Buildbucket for the build status
[00:58:47.057] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:47.057] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:31:0) after 1m0s
[00:59:47.077] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:31:0)
[00:59:47.077] Timer tick, asking Buildbucket for the build status
[00:59:47.796] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:47.796] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:32:0) after 1m0s
[01:00:47.778] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:32:0)
[01:00:47.778] Timer tick, asking Buildbucket for the build status
[01:00:47.891] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:47.891] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:33:0) after 1m0s
[01:01:47.988] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:33:0)
[01:01:47.988] Timer tick, asking Buildbucket for the build status
[01:01:48.713] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:48.713] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:34:0) after 1m0s
[01:02:48.750] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:34:0)
[01:02:48.750] Timer tick, asking Buildbucket for the build status
[01:02:49.009] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:49.009] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:35:0) after 1m0s
[01:03:49.019] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:35:0)
[01:03:49.019] Timer tick, asking Buildbucket for the build status
[01:03:49.229] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:49.229] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:36:0) after 1m0s
[01:04:49.222] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:36:0)
[01:04:49.223] Timer tick, asking Buildbucket for the build status
[01:04:49.317] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:49.317] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:37:0) after 1m0s
[01:05:49.340] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:37:0)
[01:05:49.340] Timer tick, asking Buildbucket for the build status
[01:05:49.465] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:49.465] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:38:0) after 1m0s
[01:06:49.446] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:38:0)
[01:06:49.446] Timer tick, asking Buildbucket for the build status
[01:06:49.877] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:49.877] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:39:0) after 1m0s
[01:07:49.858] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:39:0)
[01:07:49.858] Timer tick, asking Buildbucket for the build status
[01:07:49.961] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:49.961] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:40:0) after 1m0s
[01:08:49.987] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:40:0)
[01:08:49.987] Timer tick, asking Buildbucket for the build status
[01:08:50.500] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:50.500] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:41:0) after 1m0s
[01:09:50.490] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:41:0)
[01:09:50.490] Timer tick, asking Buildbucket for the build status
[01:09:50.692] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:50.692] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:42:0) after 1m0s
[01:10:50.703] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:42:0)
[01:10:50.703] Timer tick, asking Buildbucket for the build status
[01:10:50.809] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:50.809] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:43:0) after 1m0s
[01:11:50.804] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:43:0)
[01:11:50.804] Timer tick, asking Buildbucket for the build status
[01:11:50.907] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:50.907] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:44:0) after 1m0s
[01:12:50.892] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:44:0)
[01:12:50.892] Timer tick, asking Buildbucket for the build status
[01:12:51.019] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:51.019] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:45:0) after 1m0s
[01:13:51.017] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:45:0)
[01:13:51.017] Timer tick, asking Buildbucket for the build status
[01:13:51.297] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:51.297] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:46:0) after 1m0s
[01:14:51.303] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:46:0)
[01:14:51.303] Timer tick, asking Buildbucket for the build status
[01:14:51.584] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:51.584] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:47:0) after 1m0s
[01:15:51.593] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:47:0)
[01:15:51.593] Timer tick, asking Buildbucket for the build status
[01:15:52.401] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:52.401] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:48:0) after 1m0s
[01:16:52.398] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:48:0)
[01:16:52.398] Timer tick, asking Buildbucket for the build status
[01:16:52.662] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:52.662] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:49:0) after 1m0s
[01:17:52.639] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:49:0)
[01:17:52.639] Timer tick, asking Buildbucket for the build status
[01:17:52.936] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:52.936] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:50:0) after 1m0s
[01:18:52.931] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:50:0)
[01:18:52.931] Timer tick, asking Buildbucket for the build status
[01:18:53.291] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:53.291] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:51:0) after 1m0s
[01:19:53.266] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:51:0)
[01:19:53.266] Timer tick, asking Buildbucket for the build status
[01:19:53.370] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:53.370] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:52:0) after 1m0s
[01:20:53.352] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:52:0)
[01:20:53.352] Timer tick, asking Buildbucket for the build status
[01:20:53.668] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:53.668] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:53:0) after 1m0s
[01:21:53.680] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:53:0)
[01:21:53.680] Timer tick, asking Buildbucket for the build status
[01:21:54.193] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:54.193] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:54:0) after 1m0s
[01:22:54.214] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:54:0)
[01:22:54.214] Timer tick, asking Buildbucket for the build status
[01:22:54.698] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:54.698] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:55:0) after 1m0s
[01:23:54.721] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:55:0)
[01:23:54.721] Timer tick, asking Buildbucket for the build status
[01:23:54.882] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:54.882] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:56:0) after 1m0s
[01:24:54.903] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:56:0)
[01:24:54.903] Timer tick, asking Buildbucket for the build status
[01:24:55.033] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:55.033] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:57:0) after 1m0s
[01:25:55.061] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:57:0)
[01:25:55.061] Timer tick, asking Buildbucket for the build status
[01:25:55.199] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:55.199] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:58:0) after 1m0s
[01:26:55.206] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:58:0)
[01:26:55.206] Timer tick, asking Buildbucket for the build status
[01:26:55.317] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:55.317] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:59:0) after 1m0s
[01:27:55.342] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:59:0)
[01:27:55.342] Timer tick, asking Buildbucket for the build status
[01:27:55.452] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:55.452] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:60:0) after 1m0s
[01:28:55.475] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:60:0)
[01:28:55.475] Timer tick, asking Buildbucket for the build status
[01:28:56.510] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:56.510] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:61:0) after 1m0s
[01:29:56.534] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:61:0)
[01:29:56.534] Timer tick, asking Buildbucket for the build status
[01:29:56.650] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:56.650] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:62:0) after 1m0s
[01:30:56.659] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:62:0)
[01:30:56.659] Timer tick, asking Buildbucket for the build status
[01:30:57.119] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:57.119] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:63:0) after 1m0s
[01:31:57.138] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:63:0)
[01:31:57.138] Timer tick, asking Buildbucket for the build status
[01:31:57.614] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:57.614] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:64:0) after 1m0s
[01:32:57.631] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:64:0)
[01:32:57.631] Timer tick, asking Buildbucket for the build status
[01:32:57.926] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:57.926] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:65:0) after 1m0s
[01:33:57.999] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:65:0)
[01:33:57.999] Timer tick, asking Buildbucket for the build status
[01:33:58.084] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:58.084] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:66:0) after 1m0s
[01:34:58.091] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:66:0)
[01:34:58.091] Timer tick, asking Buildbucket for the build status
[01:34:58.843] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:58.843] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:67:0) after 1m0s
[01:35:58.819] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:67:0)
[01:35:58.819] Timer tick, asking Buildbucket for the build status
[01:35:58.972] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:58.972] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:68:0) after 1m0s
[01:36:58.956] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:68:0)
[01:36:58.956] Timer tick, asking Buildbucket for the build status
[01:36:59.096] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:59.096] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:69:0) after 1m0s
[01:37:59.102] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:69:0)
[01:37:59.102] Timer tick, asking Buildbucket for the build status
[01:37:59.325] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:59.325] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:70:0) after 1m0s
[01:38:59.355] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:70:0)
[01:38:59.355] Timer tick, asking Buildbucket for the build status
[01:38:59.547] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:59.547] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:71:0) after 1m0s
[01:39:59.569] Handling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:71:0)
[01:39:59.569] Timer tick, asking Buildbucket for the build status
[01:39:59.690] Build 8918873707595473040: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:59.690] Scheduling timer "check-buildbucket-build-status" (chromium/Site Isolation Android:9084303769561454032:72:0) after 1m0s
[01:40:22.696] Received PubSub notification, asking Buildbucket for the build status
[01:40:23.677] Build 8918873707595473040: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:40:23.677] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1552700421478474",
"created_by": "project:chromium",
"created_ts": "1552696236003391",
"id": "8918873707595473040",
"parameters_json": "{\"builder_name\": \"Site Isolation Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"9c361fa956c2e0e47414fe42fe9fd357ab6490c4\"}}",
"project": "chromium",
"result": "SUCCESS",
"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\": [\"4201-b04f7f8\"], \"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\": \"\"}, \"properties\": {\"got_nacl_revision\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"got_swarming_client_revision\": \"7a61cf37d6a0163f0ec02d495289a1d038e62457\", \"got_revision\": \"9c361fa956c2e0e47414fe42fe9fd357ab6490c4\", \"recipe\": \"chromium\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"got_dawn_revision\": \"931311700c7c4b76a15c23eee8792dda125fb97e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27144}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#641364}\", \"branch\": \"refs/heads/master\", \"swarm_hashes\": {\"components_unittests\": \"62ef9ad8919442e9046e4d31f5d0cadaa62db7dc\", \"components_browsertests\": \"58eb4d1a5ec25f02bc121a86ef66c01f7a56968b\", \"content_browsertests\": \"4916bdcc7e015ee256f5a838ebb5995021a5fb3b\", \"unit_tests\": \"6f55f3f1ab5684ebbb6c41e809de1318de5fe39d\", \"content_unittests\": \"29b156edae821632c16d375f1dcc4da0355d147c\"}, \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Site Isolation Android\", \"got_webrtc_revision\": \"35816cc9a150ad6a350bc18e8fe759f501fa3f73\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"e41882aaf55d0b240020dbe094cdb5475011b0f3\", \"got_v8_revision\": \"1eab45067108b961de4117fde9584b3099e428e3\", \"swarm_hashes_refs/heads/master(at){#641364}_without_patch\": {\"components_unittests\": \"62ef9ad8919442e9046e4d31f5d0cadaa62db7dc\", \"components_browsertests\": \"58eb4d1a5ec25f02bc121a86ef66c01f7a56968b\", \"content_browsertests\": \"4916bdcc7e015ee256f5a838ebb5995021a5fb3b\", \"unit_tests\": \"6f55f3f1ab5684ebbb6c41e809de1318de5fe39d\", \"content_unittests\": \"29b156edae821632c16d375f1dcc4da0355d147c\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 31575, \"got_v8_revision_cp\": \"refs/heads/7.5.54@{#1}\", \"path_config\": \"generic\", \"revision\": \"9c361fa956c2e0e47414fe42fe9fd357ab6490c4\", \"bot_id\": \"swarm2384-c4\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1552696277257882",
"status": "COMPLETED",
"status_changed_ts": "1552700422413799",
"tags": [
"build_address:luci.chromium.ci/Site Isolation Android/31575",
"builder:Site Isolation Android",
"buildset:commit/git/9c361fa956c2e0e47414fe42fe9fd357ab6490c4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9c361fa956c2e0e47414fe42fe9fd357ab6490c4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9084303769561454032",
"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/8918873707595473040/+/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:439cb9e2297b0b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1552700422419942",
"url": "https://ci.chromium.org/b/8918873707595473040",
"utcnow_ts": "1552700423628267"
}
}
[01:40:23.677] Invocation finished in 1h9m48.933600829s with status SUCCEEDED