[21:58:58.725] New invocation is queued and will start shortly
[21:59:00.451] Starting the invocation (attempt 1)
[21:59:00.490] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:59:00.490] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:59:00.490] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051879593476167328",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a09061ddf5e67034061ed5c011f80dfc18c85431\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9051879593476167328",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/a09061ddf5e67034061ed5c011f80dfc18c85431",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a09061ddf5e67034061ed5c011f80dfc18c85431",
"gitiles_ref:refs/heads/master"
]
}
[21:59:01.569] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1583618340588494",
"id": "8886449530857810720",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a09061ddf5e67034061ed5c011f80dfc18c85431\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583618341313766",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169461",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a09061ddf5e67034061ed5c011f80dfc18c85431",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a09061ddf5e67034061ed5c011f80dfc18c85431",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051879593476167328",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886449530857810720/+/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": "1583618341313921",
"url": "https://ci.chromium.org/b/8886449530857810720",
"utcnow_ts": "1583618341543184"
}
}
[21:59:01.569] Task URL: https://ci.chromium.org/b/8886449530857810720
[21:59:01.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:2:0) after 1m0s
[22:00:08.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:2:0)
[22:00:08.008] Timer tick, asking Buildbucket for the build status
[22:00:08.125] Build 8886449530857810720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:00:08.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:3:0) after 1m0s
[22:01:08.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:3:0)
[22:01:08.867] Timer tick, asking Buildbucket for the build status
[22:01:09.293] Build 8886449530857810720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:01:09.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:4:0) after 1m0s
[22:02:09.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:4:0)
[22:02:09.516] Timer tick, asking Buildbucket for the build status
[22:02:09.608] Build 8886449530857810720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:09.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:5:0) after 1m0s
[22:03:09.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:5:0)
[22:03:09.794] Timer tick, asking Buildbucket for the build status
[22:03:10.082] Build 8886449530857810720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:03:10.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:6:0) after 1m0s
[22:03:15.011] Received PubSub notification, asking Buildbucket for the build status
[22:03:15.131] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:10.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:6:0)
[22:04:10.209] Timer tick, asking Buildbucket for the build status
[22:04:10.430] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:10.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:8:0) after 1m0s
[22:05:10.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:8:0)
[22:05:10.639] Timer tick, asking Buildbucket for the build status
[22:05:11.051] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:11.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:9:0) after 1m0s
[22:06:11.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:9:0)
[22:06:11.092] Timer tick, asking Buildbucket for the build status
[22:06:11.251] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:11.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:10:0) after 1m0s
[22:07:11.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:10:0)
[22:07:11.280] Timer tick, asking Buildbucket for the build status
[22:07:11.582] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:11.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:11:0) after 1m0s
[22:08:11.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:11:0)
[22:08:11.620] Timer tick, asking Buildbucket for the build status
[22:08:11.893] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:11.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:12:0) after 1m0s
[22:09:12.054] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:12:0)
[22:09:12.054] Timer tick, asking Buildbucket for the build status
[22:09:12.268] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:12.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:13:0) after 1m0s
[22:10:12.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:13:0)
[22:10:12.295] Timer tick, asking Buildbucket for the build status
[22:10:12.576] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:12.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:14:0) after 1m0s
[22:11:12.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:14:0)
[22:11:12.687] Timer tick, asking Buildbucket for the build status
[22:11:13.103] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:13.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:15:0) after 1m0s
[22:12:13.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:15:0)
[22:12:13.155] Timer tick, asking Buildbucket for the build status
[22:12:13.411] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:13.411] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:16:0) after 1m0s
[22:13:13.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:16:0)
[22:13:13.492] Timer tick, asking Buildbucket for the build status
[22:13:13.725] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:13.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:17:0) after 1m0s
[22:14:13.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:17:0)
[22:14:13.764] Timer tick, asking Buildbucket for the build status
[22:14:13.973] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:13.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:18:0) after 1m0s
[22:15:14.133] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:18:0)
[22:15:14.133] Timer tick, asking Buildbucket for the build status
[22:15:14.294] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:14.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:19:0) after 1m0s
[22:16:14.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:19:0)
[22:16:14.318] Timer tick, asking Buildbucket for the build status
[22:16:14.475] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:14.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:20:0) after 1m0s
[22:17:14.598] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:20:0)
[22:17:14.599] Timer tick, asking Buildbucket for the build status
[22:17:14.862] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:14.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:21:0) after 1m0s
[22:18:14.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:21:0)
[22:18:14.968] Timer tick, asking Buildbucket for the build status
[22:18:15.121] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:15.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:22:0) after 1m0s
[22:19:15.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:22:0)
[22:19:15.147] Timer tick, asking Buildbucket for the build status
[22:19:15.346] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:15.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:23:0) after 1m0s
[22:20:15.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:23:0)
[22:20:15.420] Timer tick, asking Buildbucket for the build status
[22:20:15.594] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:15.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:24:0) after 1m0s
[22:21:15.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:24:0)
[22:21:15.670] Timer tick, asking Buildbucket for the build status
[22:21:15.800] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:15.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:25:0) after 1m0s
[22:22:15.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:25:0)
[22:22:15.824] Timer tick, asking Buildbucket for the build status
[22:22:15.916] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:15.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:26:0) after 1m0s
[22:23:16.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:26:0)
[22:23:16.016] Timer tick, asking Buildbucket for the build status
[22:23:16.130] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:16.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:27:0) after 1m0s
[22:24:16.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:27:0)
[22:24:16.193] Timer tick, asking Buildbucket for the build status
[22:24:16.397] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:16.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:28:0) after 1m0s
[22:25:16.427] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:28:0)
[22:25:16.427] Timer tick, asking Buildbucket for the build status
[22:25:16.606] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:16.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:29:0) after 1m0s
[22:26:16.866] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:29:0)
[22:26:16.866] Timer tick, asking Buildbucket for the build status
[22:26:17.154] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:17.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:30:0) after 1m0s
[22:27:17.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:30:0)
[22:27:17.240] Timer tick, asking Buildbucket for the build status
[22:27:17.367] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:17.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:31:0) after 1m0s
[22:28:17.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:31:0)
[22:28:17.593] Timer tick, asking Buildbucket for the build status
[22:28:17.960] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:17.960] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:32:0) after 1m0s
[22:29:18.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:32:0)
[22:29:18.105] Timer tick, asking Buildbucket for the build status
[22:29:18.372] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:18.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:33:0) after 1m0s
[22:30:18.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:33:0)
[22:30:18.424] Timer tick, asking Buildbucket for the build status
[22:30:18.756] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:18.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:34:0) after 1m0s
[22:31:19.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:34:0)
[22:31:19.015] Timer tick, asking Buildbucket for the build status
[22:31:19.816] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:19.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:35:0) after 1m0s
[22:32:19.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:35:0)
[22:32:19.871] Timer tick, asking Buildbucket for the build status
[22:32:19.996] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:19.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:36:0) after 1m0s
[22:33:20.089] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:36:0)
[22:33:20.089] Timer tick, asking Buildbucket for the build status
[22:33:20.184] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:20.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:37:0) after 1m0s
[22:34:20.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:37:0)
[22:34:20.210] Timer tick, asking Buildbucket for the build status
[22:34:20.402] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:20.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:38:0) after 1m0s
[22:35:20.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:38:0)
[22:35:20.435] Timer tick, asking Buildbucket for the build status
[22:35:20.633] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:20.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:39:0) after 1m0s
[22:36:20.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:39:0)
[22:36:20.679] Timer tick, asking Buildbucket for the build status
[22:36:21.250] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:21.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:40:0) after 1m0s
[22:37:21.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:40:0)
[22:37:21.261] Timer tick, asking Buildbucket for the build status
[22:37:21.461] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:21.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:41:0) after 1m0s
[22:38:21.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:41:0)
[22:38:21.480] Timer tick, asking Buildbucket for the build status
[22:38:21.612] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:21.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:42:0) after 1m0s
[22:39:21.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:42:0)
[22:39:21.610] Timer tick, asking Buildbucket for the build status
[22:39:21.706] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:21.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:43:0) after 1m0s
[22:40:21.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:43:0)
[22:40:21.727] Timer tick, asking Buildbucket for the build status
[22:40:21.864] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:21.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:44:0) after 1m0s
[22:41:21.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:44:0)
[22:41:21.863] Timer tick, asking Buildbucket for the build status
[22:41:22.651] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:22.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:45:0) after 1m0s
[22:42:22.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:45:0)
[22:42:22.649] Timer tick, asking Buildbucket for the build status
[22:42:22.766] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:22.766] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:46:0) after 1m0s
[22:43:22.824] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:46:0)
[22:43:22.824] Timer tick, asking Buildbucket for the build status
[22:43:23.172] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:23.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:47:0) after 1m0s
[22:44:23.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:47:0)
[22:44:23.231] Timer tick, asking Buildbucket for the build status
[22:44:23.413] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:23.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:48:0) after 1m0s
[22:45:23.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:48:0)
[22:45:23.443] Timer tick, asking Buildbucket for the build status
[22:45:23.728] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:23.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:49:0) after 1m0s
[22:46:23.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:49:0)
[22:46:23.795] Timer tick, asking Buildbucket for the build status
[22:46:25.381] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:25.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:50:0) after 1m0s
[22:47:25.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:50:0)
[22:47:25.454] Timer tick, asking Buildbucket for the build status
[22:47:25.624] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:25.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:51:0) after 1m0s
[22:48:25.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:51:0)
[22:48:25.727] Timer tick, asking Buildbucket for the build status
[22:48:25.840] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:25.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:52:0) after 1m0s
[22:49:25.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:52:0)
[22:49:25.941] Timer tick, asking Buildbucket for the build status
[22:49:26.367] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:26.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:53:0) after 1m0s
[22:50:26.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:53:0)
[22:50:26.415] Timer tick, asking Buildbucket for the build status
[22:50:26.541] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:26.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:54:0) after 1m0s
[22:51:26.611] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:54:0)
[22:51:26.611] Timer tick, asking Buildbucket for the build status
[22:51:27.641] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:27.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:55:0) after 1m0s
[22:52:27.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:55:0)
[22:52:27.753] Timer tick, asking Buildbucket for the build status
[22:52:27.957] Build 8886449530857810720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:27.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9051879593476167328:56:0) after 1m0s
[22:53:24.061] Received PubSub notification, asking Buildbucket for the build status
[22:53:24.163] Build 8886449530857810720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:53:24.163] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1583621599244524",
"created_by": "project:chromium",
"created_ts": "1583618340588494",
"id": "8886449530857810720",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a09061ddf5e67034061ed5c011f80dfc18c85431\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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-77-0cv6\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169461, \"got_angle_revision\": \"0c9b6abde90cbf6fd88fe4d86c2d66ef145607b5\", \"got_dawn_revision\": \"7d20b4450182b8e25dfd315019623d7a746cc290\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"a09061ddf5e67034061ed5c011f80dfc18c85431\", \"got_revision_cp\": \"refs/heads/master@{#748028}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"b44162fdbb25996e4710026007bc98b7201f2a1d\", \"got_v8_revision\": \"d4ed59c4ed609eacc9062bd22ebca409ef7c6d1c\", \"got_v8_revision_cp\": \"refs/heads/8.2.263@{#1}\", \"got_webrtc_revision\": \"04f7bfc4192f5ce444b312afd287203ea53c99b6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30715}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a09061ddf5e67034061ed5c011f80dfc18c85431\", \"swarm_hashes_refs/heads/master(at){#748028}_without_patch\": {\"accessibility_unittests\": \"a5d4052a3b359b0931de6ea8d6500d9be1cdbd61\", \"angle_unittests\": \"45194364ea91926f73c6bd75caf450b3820a3589\", \"app_shell_unittests\": \"056294492a20bab6a7ab3ca6c085a004b8a3385a\", \"aura_unittests\": \"6772e63d59e5d7ab50cf3e7db8b31c03b831ad23\", \"base_unittests\": \"b7e933210fed63af9c9f66cf75c793580e74a388\", \"base_util_unittests\": \"d1e8abfec817fd1252468e11a55764aa9ce19038\", \"blink_common_unittests\": \"340cd63677163b7fbbbd4ee142a36967b5ac2c5c\", \"blink_fuzzer_unittests\": \"87ed2462608f0394e0d5ddab3c30983d66b7d4e1\", \"blink_heap_unittests\": \"9590834ef0cb91d162de288a26d13bddd7cd0ee7\", \"blink_platform_unittests\": \"1416e40c2213ac2c999f54c01e4c58cc6d9a06bd\", \"blink_python_tests\": \"0292db2a2aab85c1d3140a4898b35b3e6a28eac3\", \"blink_unittests\": \"31f2049a83eb48e4f9ee92377c595f3d2e3e8d0b\", \"blink_web_tests\": \"82e418813b0d3606a9c8a222c389c5af6a6ca8a4\", \"boringssl_crypto_tests\": \"d8fd1d98548abcd6eea92e26c9b328f46483c656\", \"boringssl_ssl_tests\": \"18ac8c64ead4b9984b07a3717efdc103e8e7577e\", \"browser_tests\": \"c751b6839cc538989df66167c6732a28e7f1b1b8\", \"cacheinvalidation_unittests\": \"58369ddf2e000614d6142c7d62bda777dd1726ad\", \"capture_unittests\": \"1a0ca73e9a7c9594a180db8762f5bd93adaf75d7\", \"cast_unittests\": \"fd6c2acdf7942e3fd5362ba0b38ed714cc7e4444\", \"cc_unittests\": \"cb45be48764f5c19eed54554e2019a4c3d776a7c\", \"chrome_app_unittests\": \"14255e2c1590de56994bc673de6a7b44f623ea1f\", \"chromedriver_unittests\": \"f08eccae265f265243b1e6dbab1df16fe4584be3\", \"components_browsertests\": \"55264db059a48690e7feea40483f59bc5233a2f8\", \"components_unittests\": \"1aab97a1cd5471687d9c71ff482c5ace3f39fb63\", \"compositor_unittests\": \"6846efdebbea2b781f01d93300adef6a00a6a49d\", \"content_browsertests\": \"d124a1804713e3b1d488b59c18aea2666779d5cb\", \"content_shell_crash_test\": \"0e8c849d73531b18cdf10e39759623ddd3ee5be9\", \"content_unittests\": \"2d92e10c0d6931d37ed2b5d272b93eea8644b2cf\", \"crashpad_tests\": \"3f75bf2d1ed713ca0b910503d14f6cf5baf08dff\", \"cronet_tests\": \"b4e0ba8b9739accbd92eeda6f40e2b4c7d25471c\", \"cronet_unittests\": \"31640ccd5acdfb3cc6f365653ca67772f75b2986\", \"crypto_unittests\": \"be512070d9ae9c13b8b6f99438d55c093a4b3706\", \"dbus_unittests\": \"fc36b049d8a3277bc0d60262795af238002c1f43\", \"device_unittests\": \"9217fb6b6fac62a563b7963e66c1214d7e225fee\", \"display_unittests\": \"42c230d06f2cd46b88caf49a65884ac9d0589f9a\", \"events_unittests\": \"d772662eb5f68233746071e357c7df426baaccf0\", \"extensions_browsertests\": \"71b1662f3de7495e3672bd542c7024d6f1216b94\", \"extensions_unittests\": \"cdfd8a76c7eb661fc0b3a505a6547c8723665739\", \"filesystem_service_unittests\": \"04be635beefa0afe34fc2f4c646ea55ad2aa2094\", \"flatbuffers_unittests\": \"050844e0d26621703adfe93dfd2f97054fb85d6c\", \"gcm_unit_tests\": \"560cb8de432aa237b31425fb8a038138ddef692d\", \"gfx_unittests\": \"ed4aee243b1108ac30571c0ad05e176eda031519\", \"gin_unittests\": \"6c1fffe1d429a06ab9ad798b3fa5463d37aac5c8\", \"google_apis_unittests\": \"d5fac437b9d3ed633bd5226cdc0f695d05dc0a88\", \"gpu_unittests\": \"d72d745afe97d160ae7bd51f8dc996c503cc7738\", \"grit_python_unittests\": \"300ea8455288eab00cd459e887bd99a4f6468e8a\", \"gwp_asan_unittests\": \"2fa735098a4f4332e2aee433c11a089a09296de2\", \"headless_browsertests\": \"9a30f62531a1e2ff334b497346bfede63d7bb76a\", \"headless_unittests\": \"4811fa88024913385eb3e7381274f14ca5efdd5c\", \"interactive_ui_tests\": \"0d3744c0a745c04ffc281beb1ebdaee16d5f8f47\", \"ipc_tests\": \"2297ddd83d0a04c528074dca03b7191a016f9190\", \"jingle_unittests\": \"248983bacd28aab86312585a35f60b114b180b4a\", \"latency_unittests\": \"0246b4b3de570b7fb5b55d3893d2ce56ee3aecfb\", \"libjingle_xmpp_unittests\": \"5f7031b7b57b5256e75eb512e38ea8d956db3653\", \"media_blink_unittests\": \"53f1704479f1a5517539ef6d68f9f3dfda51a12a\", \"media_service_unittests\": \"0046485c5073e6555e4111f76ca4d123a166f6dd\", \"media_unittests\": \"986e702f5203a6d87d2e3fadb4a8675a6c943324\", \"message_center_unittests\": \"10556353599ba1cebf3c40b4f6aa0504923061ab\", \"metrics_python_tests\": \"4ba74b2560929665bc4def3a2dc4d01d81cd9534\", \"midi_unittests\": \"3c4a31d2316270f531dee1a0d761a6188b74b816\", \"mojo_core_unittests\": \"5cddb676170a6268e3432f328830ff89eeedc0de\", \"mojo_unittests\": \"35596215611f9e4bac8669f789b41ae028cb1fc5\", \"nacl_helper_nonsfi_unittests\": \"dffc5670f5c4d9c24684ed48258df2aa0159eb2c\", \"nacl_loader_unittests\": \"c237c0e8a17ee549edda295347c143f111f1ff4b\", \"native_theme_unittests\": \"ffccea6383a600d1e638a3ab2b84e93a2ae633b4\", \"net_unittests\": \"9fa6a61dc5aa9af7924f22b7a13411b575b2dac8\", \"pdf_unittests\": \"6c90f65fdc47164060d3d09f6768a1be90a78870\", \"perfetto_unittests\": \"19ea90905cbab47c939d0ec2307ead3efe4c228b\", \"ppapi_unittests\": \"9cf5ff80d0a7696857a7d82efa7404a96f7b6147\", \"printing_unittests\": \"3af941f03810803036c041fd874b68faa5cb4d76\", \"remoting_unittests\": \"4cc04ce65b95f062360d7a4309ec8ae6f5c4451d\", \"sandbox_linux_unittests\": \"36496d61bd43c286c7a27b2989c477e02860ebc1\", \"service_manager_unittests\": \"f13fb89a8ea30755debb22a616981000d70525b0\", \"services_unittests\": \"8092296f92cb99d015934fe2880151afbb54577e\", \"shell_dialogs_unittests\": \"39eeecc5260bc67c21fb391cfb21eeaaef722079\", \"skia_unittests\": \"fb1c1560f7ecda0cf037087298812ca32ab9682b\", \"snapshot_unittests\": \"95115ac9d40798e2e7b038dc116c152fffa346b1\", \"sql_unittests\": \"6ea2542f55f247260649ec666d661ccbc1291eee\", \"storage_unittests\": \"992de18ba5d4f074e4e4e8760b35882b060bf6b3\", \"sync_integration_tests\": \"f97f7eb3e32db48045411d94303df5eb6142fe91\", \"telemetry_gpu_unittests\": \"cffa2e329d1e8206c025ef8f706dcc53bf99c2e3\", \"telemetry_perf_unittests\": \"fa1bfd0ec0df208abfcffa0015b7c97282242c00\", \"telemetry_unittests\": \"ffe991ba427a916ec2fea7b12f57f3bc1de8d156\", \"traffic_annotation_auditor_unittests\": \"c2755bf5dfd0d18deb17497d5e6659f7d2844727\", \"ui_base_unittests\": \"68a0e9f17908b6b1fc59f6a5aa17ecfdc9b6579b\", \"ui_touch_selection_unittests\": \"82193e73653e75eb5e43eec90d51cb528ff0cd56\", \"unit_tests\": \"c93cfc53eef1922c7bda505ff1a80d4b2491f04c\", \"url_unittests\": \"59f0943d15f26240adda93da5aed529b5af663d2\", \"views_perftests\": \"b5fd17dd946cefdac9d351e39e38c9d4b4b0bad4\", \"views_unittests\": \"5e9eb4cd3515baedbef8d6fccdc87ba33ea965a6\", \"viz_unittests\": \"9231acdce35474db17543905e80212900be5f38b\", \"vr_common_unittests\": \"527750c619c2c5024e7947da41ddcc2d53ff6b96\", \"vr_pixeltests\": \"c3c3a1f1a88e11ccb4ca40e7b3ddd189f42976f5\", \"webdriver_wpt_tests\": \"eb83b97ec6f8da189d54aafd7ce656b5f8ce5fe3\", \"weblayer_browsertests\": \"1859241c8aa084f0d69aff8716aea3b6ebdcf482\", \"wm_unittests\": \"17fecd4057835041b2708b22466f1a384c158c51\", \"wtf_unittests\": \"18306cd9b10245421daa1ccc89ee0c86e459b8e9\", \"xr_browser_tests\": \"a4b817004c813d5bd5a7e14c0f18d06c5399c717\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_71ab4550ecc1db180544ee9bd5ebac58222d39ccc6e59d756fcde46903b3067c_v2\", \"builder_b388131f0fa9c382582f3d9f703e881c3c8067eb20dc1a07ab0cfa192d8814bc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-77-0cv6\"], \"image\": [\"chrome-xenial-20030100-2bddf837f90\"], \"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\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583618594068918",
"status": "COMPLETED",
"status_changed_ts": "1583621599607584",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169461",
"builder:Linux Builder (dbg)",
"buildset:commit/git/a09061ddf5e67034061ed5c011f80dfc18c85431",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a09061ddf5e67034061ed5c011f80dfc18c85431",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051879593476167328",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886449530857810720/+/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:4acfd3c3e35fb410",
"user_agent:luci-scheduler"
],
"updated_ts": "1583621599612206",
"url": "https://ci.chromium.org/b/8886449530857810720",
"utcnow_ts": "1583621604150911"
}
}
[22:53:24.163] Invocation finished in 54m25.456129678s with status SUCCEEDED