[19:11:59.546] New invocation is queued and will start shortly
[19:12:03.053] Starting the invocation (attempt 1)
[19:12:03.126] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:12:03.126] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:12:03.126] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060587408139714256",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"affba9d8789a983a4ee20f90db3cd5dcf3b73c34\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9060587408139714256",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/affba9d8789a983a4ee20f90db3cd5dcf3b73c34",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/affba9d8789a983a4ee20f90db3cd5dcf3b73c34",
"gitiles_ref:refs/heads/master"
]
}
[19:12:03.993] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575313923334276",
"id": "8895157343484418176",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"affba9d8789a983a4ee20f90db3cd5dcf3b73c34\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575313923694057",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165566",
"builder:Linux Builder (dbg)",
"buildset:commit/git/affba9d8789a983a4ee20f90db3cd5dcf3b73c34",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/affba9d8789a983a4ee20f90db3cd5dcf3b73c34",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060587408139714256",
"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/8895157343484418176/+/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": "1575313923694167",
"url": "https://ci.chromium.org/b/8895157343484418176",
"utcnow_ts": "1575313923981757"
}
}
[19:12:03.993] Task URL: https://ci.chromium.org/b/8895157343484418176
[19:12:03.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:2:0) after 1m0s
[19:13:04.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:2:0)
[19:13:04.208] Timer tick, asking Buildbucket for the build status
[19:13:04.601] Build 8895157343484418176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:13:04.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:3:0) after 1m0s
[19:13:18.905] Received PubSub notification, asking Buildbucket for the build status
[19:13:19.156] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:04.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:3:0)
[19:14:04.654] Timer tick, asking Buildbucket for the build status
[19:14:05.637] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:05.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:5:0) after 1m0s
[19:15:05.678] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:5:0)
[19:15:05.678] Timer tick, asking Buildbucket for the build status
[19:15:05.843] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:05.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:6:0) after 1m0s
[19:16:06.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:6:0)
[19:16:06.029] Timer tick, asking Buildbucket for the build status
[19:16:06.757] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:06.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:7:0) after 1m0s
[19:17:06.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:7:0)
[19:17:06.786] Timer tick, asking Buildbucket for the build status
[19:17:07.051] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:07.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:8:0) after 1m0s
[19:18:07.209] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:8:0)
[19:18:07.209] Timer tick, asking Buildbucket for the build status
[19:18:07.686] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:07.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:9:0) after 1m0s
[19:19:07.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:9:0)
[19:19:07.711] Timer tick, asking Buildbucket for the build status
[19:19:08.032] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:08.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:10:0) after 1m0s
[19:20:08.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:10:0)
[19:20:08.087] Timer tick, asking Buildbucket for the build status
[19:20:08.778] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:08.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:11:0) after 1m0s
[19:21:08.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:11:0)
[19:21:08.875] Timer tick, asking Buildbucket for the build status
[19:21:09.055] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:09.055] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:12:0) after 1m0s
[19:22:09.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:12:0)
[19:22:09.178] Timer tick, asking Buildbucket for the build status
[19:22:09.804] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:09.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:13:0) after 1m0s
[19:23:09.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:13:0)
[19:23:09.822] Timer tick, asking Buildbucket for the build status
[19:23:10.598] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:10.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:14:0) after 1m0s
[19:24:10.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:14:0)
[19:24:10.699] Timer tick, asking Buildbucket for the build status
[19:24:11.793] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:11.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:15:0) after 1m0s
[19:25:11.865] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:15:0)
[19:25:11.865] Timer tick, asking Buildbucket for the build status
[19:25:12.920] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:12.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:16:0) after 1m0s
[19:26:12.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:16:0)
[19:26:12.968] Timer tick, asking Buildbucket for the build status
[19:26:13.147] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:13.147] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:17:0) after 1m0s
[19:27:13.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:17:0)
[19:27:13.390] Timer tick, asking Buildbucket for the build status
[19:27:15.579] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:15.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:18:0) after 1m0s
[19:28:15.962] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:18:0)
[19:28:15.962] Timer tick, asking Buildbucket for the build status
[19:28:16.176] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:16.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:19:0) after 1m0s
[19:29:16.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:19:0)
[19:29:16.385] Timer tick, asking Buildbucket for the build status
[19:29:16.622] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:16.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:20:0) after 1m0s
[19:30:16.687] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:20:0)
[19:30:16.687] Timer tick, asking Buildbucket for the build status
[19:30:16.933] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:16.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:21:0) after 1m0s
[19:31:17.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:21:0)
[19:31:17.076] Timer tick, asking Buildbucket for the build status
[19:31:17.208] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:17.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:22:0) after 1m0s
[19:32:17.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:22:0)
[19:32:17.900] Timer tick, asking Buildbucket for the build status
[19:32:18.205] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:18.206] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:23:0) after 1m0s
[19:33:18.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:23:0)
[19:33:18.603] Timer tick, asking Buildbucket for the build status
[19:33:19.529] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:19.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:24:0) after 1m0s
[19:34:19.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:24:0)
[19:34:19.616] Timer tick, asking Buildbucket for the build status
[19:34:19.945] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:19.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:25:0) after 1m0s
[19:35:19.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:25:0)
[19:35:19.938] Timer tick, asking Buildbucket for the build status
[19:35:21.168] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:21.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:26:0) after 1m0s
[19:36:21.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:26:0)
[19:36:21.187] Timer tick, asking Buildbucket for the build status
[19:36:21.504] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:21.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:27:0) after 1m0s
[19:37:21.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:27:0)
[19:37:21.535] Timer tick, asking Buildbucket for the build status
[19:37:21.974] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:21.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:28:0) after 1m0s
[19:38:21.964] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:28:0)
[19:38:21.964] Timer tick, asking Buildbucket for the build status
[19:38:22.149] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:22.149] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:29:0) after 1m0s
[19:39:22.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:29:0)
[19:39:22.211] Timer tick, asking Buildbucket for the build status
[19:39:22.478] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:22.478] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:30:0) after 1m0s
[19:40:22.917] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:30:0)
[19:40:22.917] Timer tick, asking Buildbucket for the build status
[19:40:26.451] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:26.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:31:0) after 1m0s
[19:41:26.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:31:0)
[19:41:26.989] Timer tick, asking Buildbucket for the build status
[19:41:27.421] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:27.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:32:0) after 1m0s
[19:42:27.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:32:0)
[19:42:27.742] Timer tick, asking Buildbucket for the build status
[19:42:27.969] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:27.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:33:0) after 1m0s
[19:43:28.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:33:0)
[19:43:28.102] Timer tick, asking Buildbucket for the build status
[19:43:28.326] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:28.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:34:0) after 1m0s
[19:44:28.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:34:0)
[19:44:28.415] Timer tick, asking Buildbucket for the build status
[19:44:28.921] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:28.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:35:0) after 1m0s
[19:45:29.190] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:35:0)
[19:45:29.190] Timer tick, asking Buildbucket for the build status
[19:45:29.476] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:29.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:36:0) after 1m0s
[19:46:30.114] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:36:0)
[19:46:30.114] Timer tick, asking Buildbucket for the build status
[19:46:30.497] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:30.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:37:0) after 1m0s
[19:47:30.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:37:0)
[19:47:30.575] Timer tick, asking Buildbucket for the build status
[19:47:30.905] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:30.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:38:0) after 1m0s
[19:48:31.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:38:0)
[19:48:31.066] Timer tick, asking Buildbucket for the build status
[19:48:33.141] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:33.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:39:0) after 1m0s
[19:49:33.626] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:39:0)
[19:49:33.626] Timer tick, asking Buildbucket for the build status
[19:49:33.801] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:33.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:40:0) after 1m0s
[19:50:33.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:40:0)
[19:50:33.823] Timer tick, asking Buildbucket for the build status
[19:50:34.085] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:34.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:41:0) after 1m0s
[19:51:34.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:41:0)
[19:51:34.483] Timer tick, asking Buildbucket for the build status
[19:51:35.811] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:35.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:42:0) after 1m0s
[19:52:35.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:42:0)
[19:52:35.945] Timer tick, asking Buildbucket for the build status
[19:52:37.152] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:37.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:43:0) after 1m0s
[19:53:37.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:43:0)
[19:53:37.258] Timer tick, asking Buildbucket for the build status
[19:53:37.438] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:37.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:44:0) after 1m0s
[19:54:37.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:44:0)
[19:54:37.497] Timer tick, asking Buildbucket for the build status
[19:54:38.072] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:38.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:45:0) after 1m0s
[19:55:38.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:45:0)
[19:55:38.110] Timer tick, asking Buildbucket for the build status
[19:55:38.750] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:38.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:46:0) after 1m0s
[19:56:38.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:46:0)
[19:56:38.985] Timer tick, asking Buildbucket for the build status
[19:56:42.308] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:42.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:47:0) after 1m0s
[19:57:42.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:47:0)
[19:57:42.414] Timer tick, asking Buildbucket for the build status
[19:57:42.830] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:42.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:48:0) after 1m0s
[19:58:42.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:48:0)
[19:58:42.855] Timer tick, asking Buildbucket for the build status
[19:58:43.159] Build 8895157343484418176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:43.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9060587408139714256:49:0) after 1m0s
[19:59:10.046] Received PubSub notification, asking Buildbucket for the build status
[19:59:10.245] Build 8895157343484418176: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:59:10.245] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575316749339519",
"created_by": "project:chromium",
"created_ts": "1575313923334276",
"id": "8895157343484418176",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"affba9d8789a983a4ee20f90db3cd5dcf3b73c34\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-central1-b-8-110-rl1d\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165566, \"got_angle_revision\": \"19f9f41481964be3a22e03a443eb37535a70e598\", \"got_dawn_revision\": \"969df2b3a21c126b2e0015ce2392c135f32a6a08\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"affba9d8789a983a4ee20f90db3cd5dcf3b73c34\", \"got_revision_cp\": \"refs/heads/master@{#720590}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"b64fbfec4dcd3f81c776198641b1fc71ac8d64a4\", \"got_v8_revision\": \"be74b8b6917660e3de1e25875f0a938bedb103cc\", \"got_v8_revision_cp\": \"refs/heads/8.0.424@{#1}\", \"got_webrtc_revision\": \"89313451d8e2338845716b0ab8760ed0552580f9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29962}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"affba9d8789a983a4ee20f90db3cd5dcf3b73c34\", \"swarm_hashes_refs/heads/master(at){#720590}_without_patch\": {\"accessibility_unittests\": \"aa36bd1c28b362d4ea06eb0ceb25a0cb40a08893\", \"angle_unittests\": \"c02be5c6b29ff07646d113564e3f16e6b953496b\", \"app_shell_unittests\": \"297ec4815dddbd222eb5345d38342e1f264a6d35\", \"aura_unittests\": \"23d17ba1fb0815b597c3e59533a4e519b3a58db4\", \"base_unittests\": \"c592897acefc92a3eaf0a279bfd7d90167b9153f\", \"base_util_unittests\": \"9868864ede3a913e6072788dae1647cd9a17d4e2\", \"blink_common_unittests\": \"85422f7a5876921655d9b03adc08bda5ef6d03dc\", \"blink_fuzzer_unittests\": \"000713f259bf33800636aa801b6e27be577de788\", \"blink_heap_unittests\": \"991b5f0863cfbc4d3a6c8a189c1b43330f311b6d\", \"blink_platform_unittests\": \"d14d98e9de7def35e21a69775d29db6dc2bf2784\", \"blink_python_tests\": \"6f52cd7fe7e73fd3df4eac75c3019ff49b1b222f\", \"blink_unittests\": \"e450a2553d795fe15e945cee215de8e4afb7a709\", \"blink_web_tests_exparchive\": \"8edd36a3dcfe48e6b7a178075c6a441809a20c67\", \"boringssl_crypto_tests\": \"028d08d197d41a960efafc2b5e27621db9678e26\", \"boringssl_ssl_tests\": \"c1b62ba504625184bd950b75b81cd938a09a3906\", \"browser_tests\": \"d0d0d644ef877bbb50d116dbdb60b36c0a364409\", \"cacheinvalidation_unittests\": \"6242b3a341a83f0d8e36ddc09ea9b7e01a3873bc\", \"capture_unittests\": \"70e514381c8834acec35cd916dad1a778faf9fe4\", \"cast_unittests\": \"d40a13e24451e1b23330d7d79d5997a6af324f4f\", \"cc_unittests\": \"b8cbcbcd1962c6053eaa7f2232e80da3d1a24055\", \"chrome_app_unittests\": \"f62a9045758f0072eb5ac3e225f4c25aae43c0b7\", \"chromedriver_unittests\": \"ffdb6bccff37a9328599a80f2e2a59b5fbbbabcb\", \"color_unittests\": \"e99ea9850e1f0545b20b92294d538307fd03644c\", \"components_browsertests\": \"c9f16c38915579f5b382c581fd0466424e6a0885\", \"components_unittests\": \"7b48b0032872ec77ddad06bb604e5c4617bbb173\", \"compositor_unittests\": \"4d3042b7d206f07fd217c51fc652377c1f60ce5b\", \"content_browsertests\": \"88582c65d33cb05efa1d24cc3b788fd13bb5ab1c\", \"content_shell_crash_test\": \"cc1c9c42ababf651e5c9513107fe71ea06a883b9\", \"content_unittests\": \"05cebb428eaea994711e272d1e7390f148a2d6c3\", \"crashpad_tests\": \"9bf7daf37f4dbe8550cd13871d79287dd360bc59\", \"cronet_tests\": \"eeb71dc689dbc64d147c7d80a0ed0f586ece9d85\", \"cronet_unittests\": \"d9b028f775485b857b7de7453fe98c4cc3c7d931\", \"crypto_unittests\": \"7e143c62b1d68250dfac5038d5d136e6eb3de2ac\", \"dbus_unittests\": \"254f507a92e5b4183a3c6e220061d4d01a3b907d\", \"device_unittests\": \"736cc14fecfedae57c798148a591f9684b4a6f2e\", \"devtools_lint_check\": \"44c1734b03fc01a212f65b71ea0dedb87667eb65\", \"devtools_type_check\": \"b9c02a23a22c66eaf2d7ac2446048439c472da57\", \"display_unittests\": \"c32bf3ae0abd15fb8d719319ecda59fd9be09303\", \"events_unittests\": \"b495d43f95d98bd57197d0f8c128ce6733c8a9c5\", \"extensions_browsertests\": \"3f561e4ce25f5cb69ac7993531cf1c8f877caa29\", \"extensions_unittests\": \"e9aa165fc3b5ff65794620b373326c29e68eaf49\", \"filesystem_service_unittests\": \"43c28261445830726a211a4862d2eba12719a2df\", \"flatbuffers_unittests\": \"c0f881c722359473554ea3438d382e7082a0e922\", \"gcm_unit_tests\": \"1f5aa6931fa863cbd6ef5b1d2cbf3aaef746b60d\", \"gfx_unittests\": \"beb0c75babdce95f9ceb85c64a3486eb184d38f8\", \"gin_unittests\": \"1adcdbcb15f10928a6adefbba759b57773133ae5\", \"google_apis_unittests\": \"d70aeda5e2955f6ae6cbb9c5d35c184871309043\", \"gpu_unittests\": \"fc2289f8ba1de26ee3aa4982069e44078e908da8\", \"grit_python_unittests\": \"4267cdfe96cbb5881cc25cc5b15aab4b2f28c5f5\", \"gwp_asan_unittests\": \"0c50405724121b8c8c31ffb83915212df4d12180\", \"headless_browsertests\": \"bbbfd2a2ea9cafce7f606bf78d7bddf2e1681073\", \"headless_unittests\": \"e097d55dc95d6e3aba3d13bd97de3fa0135277ed\", \"interactive_ui_tests\": \"173998767b9ed197d556cb523e49bbbff1c40c2d\", \"ipc_tests\": \"4791da2eb5e023177faf4721295ce63bb2d45480\", \"jingle_unittests\": \"22289c6d72d20d66f64b0d652e40854a078482ee\", \"latency_unittests\": \"9ebcc415eef58fe41fbd2ca7f503545f7710dae1\", \"libjingle_xmpp_unittests\": \"ad40f7a811ceac4907c8059d654abcfeab3ce48b\", \"media_blink_unittests\": \"55d20b827d6a4b9b48381cc6daec37be64e49b91\", \"media_service_unittests\": \"dcfeb7a15a96c6ca277ea293f8f4cc3ceb9af86f\", \"media_unittests\": \"3f2d9c0226a924c9ce2f81f4afe8aa4e6effb6ac\", \"message_center_unittests\": \"89808c8f82a173ef05812f7c0a9da134237c2354\", \"metrics_python_tests\": \"8a6723c25f5268d058f45c76c0281b798de13ebe\", \"midi_unittests\": \"3568ca5d68f9282ef94e8e9ef830917068c67da1\", \"mojo_core_unittests\": \"fbf2788f807c836b268fc5b1b291bdd040bf9eab\", \"mojo_unittests\": \"9b32df2ba5cabbace5cb069bd5aed7c76f1a5a69\", \"nacl_helper_nonsfi_unittests\": \"5e2fab327f4e26c28dbb7f3f3c822f3cd3b2d084\", \"nacl_loader_unittests\": \"f68ff7f39313c427124231fa18891c3041972ba6\", \"native_theme_unittests\": \"9f9c2fd21a7bd4e0cbb32865bde2c221279e60bc\", \"net_unittests\": \"44ae1b006bfdfa7199414128d5483a9ffe816636\", \"pdf_unittests\": \"a75b701d0bc855a340e152ef27fdf99cad937edc\", \"perfetto_unittests\": \"817b02fbcac4717f4f36d3357c4375d2d26e167c\", \"ppapi_unittests\": \"d85168d2a1fcd81f3921112e7cd34a0afe87be96\", \"printing_unittests\": \"7cc277fd6c366326f0373a4198779dab9399fcc1\", \"remoting_unittests\": \"d9296e21a5114a204af8a5909c5e4434f060d5d4\", \"sandbox_linux_unittests\": \"983a36377b08d91624c1d4715d03823a596c6c6b\", \"service_manager_unittests\": \"35038e14788f2ef23b4a5e8fa9a26d646effedd1\", \"services_unittests\": \"323651ed3163b14b08a1079d5c726887afb5db66\", \"shell_dialogs_unittests\": \"4262394b0ea948160926c9b0097eeae39cda6acb\", \"skia_unittests\": \"86d15ec86f2d512bd30527fea0aacdd4b869db9f\", \"snapshot_unittests\": \"e46c4e186aca24a10aec565e9688443c00c2640d\", \"sql_unittests\": \"e4369f0f3c921e7cf12890c9ea5642118ab060c4\", \"storage_unittests\": \"af70fc3fb41eed36761aa4641b7d5b8f59bc126b\", \"sync_integration_tests\": \"a61b33415a7ee4603f72d010b2835b36faf11540\", \"telemetry_gpu_unittests\": \"784483f353f5cd714ad65aa566b8abc734028049\", \"telemetry_perf_unittests\": \"64de1ff6f65cfe82ffa5d740f22157471b4f9144\", \"telemetry_unittests\": \"9e23c2e372cd0e7068713742bc38fe4d8ea36235\", \"traffic_annotation_auditor_unittests\": \"b4dc28adcd71ca88cb99078b841402b242ded60b\", \"ui_base_unittests\": \"7dcdfaf87a23f6a1ff6d5614e83023165270b3b2\", \"ui_touch_selection_unittests\": \"0d9d2e55641988ba5943d8f2b1ac4ed42f148050\", \"unit_tests\": \"24bee68038eb1ae6c866e9d4c2b502d79fc0eed9\", \"url_unittests\": \"197fc123fdb4ccde7e880279645482f15e729a32\", \"views_perftests\": \"5675f7be5a9c9624cf235366f55b62834b44d5cd\", \"views_unittests\": \"aad28be355d6831a3db370e301d00792885f4fd0\", \"viz_unittests\": \"5ddf96298a179fd9d9319a4a5298c26c6d27b2f7\", \"vr_common_unittests\": \"f5ca81bbbaa0dcd4ef4b258044374a604035dc11\", \"vr_pixeltests\": \"246738564defaa013fda3d4161038bf815c22805\", \"webdriver_wpt_tests\": \"30d16b6ca8516b1cac8f6d1374d74be01c09462c\", \"weblayer_browsertests\": \"2f0539ea12af92a60bf5dc4d07b5591ea1b31d8a\", \"wm_unittests\": \"d2f7e9befffc716becd3be6f96731585a09123ef\", \"wtf_unittests\": \"4a06f30a5637d611527cd5b2d0f2a52a952190db\", \"xr_browser_tests\": \"19ff723493172ea0cc32d5660d32a7608646b2ac\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_479a9ab4e006ab9f281a30e38952e2c387e86fd61a54f6cd68389780c770d389_v2\", \"builder_9b311965bcdd39b39aa4e18428ed38a374d2d5d9f2ab24593845b266390676f3_v2\", \"builder_c38832248eaa59248ebe0e5d5ae62a6bc955f53f6a99a9c0e5cded93d679f9bc_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-110-rl1d\"], \"image\": [\"chrome-xenial-19112404-1fe53dcaaf2\"], \"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\": [\"4679-6acb960\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1575313997561188",
"status": "COMPLETED",
"status_changed_ts": "1575316749649641",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165566",
"builder:Linux Builder (dbg)",
"buildset:commit/git/affba9d8789a983a4ee20f90db3cd5dcf3b73c34",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/affba9d8789a983a4ee20f90db3cd5dcf3b73c34",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060587408139714256",
"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/8895157343484418176/+/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:48e0d8b9c48bd510",
"user_agent:luci-scheduler"
],
"updated_ts": "1575316749653661",
"url": "https://ci.chromium.org/b/8895157343484418176",
"utcnow_ts": "1575316750231972"
}
}
[19:59:10.245] Invocation finished in 47m10.734662969s with status SUCCEEDED