[19:52:33.095] New invocation is queued and will start shortly
[19:52:36.399] Starting the invocation (attempt 1)
[19:52:36.459] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:52:36.459] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:52:36.459] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059044707933767648",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059044707933767648",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1",
"gitiles_ref:refs/heads/master"
]
}
[19:52:37.724] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1576785156666694",
"id": "8893614643521933152",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576785157399583",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166325",
"builder:Linux Builder (dbg)",
"buildset:commit/git/86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059044707933767648",
"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/8893614643521933152/+/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": "1576785157399726",
"url": "https://ci.chromium.org/b/8893614643521933152",
"utcnow_ts": "1576785157704028"
}
}
[19:52:37.724] Task URL: https://ci.chromium.org/b/8893614643521933152
[19:52:37.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:2:0) after 1m0s
[19:53:37.867] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:2:0)
[19:53:37.867] Timer tick, asking Buildbucket for the build status
[19:53:38.740] Build 8893614643521933152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:53:38.740] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:3:0) after 1m0s
[19:54:38.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:3:0)
[19:54:38.870] Timer tick, asking Buildbucket for the build status
[19:54:41.308] Build 8893614643521933152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:54:41.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:4:0) after 1m0s
[19:55:41.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:4:0)
[19:55:41.331] Timer tick, asking Buildbucket for the build status
[19:55:41.603] Build 8893614643521933152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:55:41.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:5:0) after 1m0s
[19:56:41.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:5:0)
[19:56:41.843] Timer tick, asking Buildbucket for the build status
[19:56:42.444] Build 8893614643521933152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:56:42.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:6:0) after 1m0s
[19:57:42.445] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:6:0)
[19:57:42.445] Timer tick, asking Buildbucket for the build status
[19:57:42.741] Build 8893614643521933152: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:42.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:7:0) after 1m0s
[19:58:04.565] Received PubSub notification, asking Buildbucket for the build status
[19:58:05.235] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:42.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:7:0)
[19:58:42.977] Timer tick, asking Buildbucket for the build status
[19:58:43.125] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:43.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:9:0) after 1m0s
[19:59:43.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:9:0)
[19:59:43.711] Timer tick, asking Buildbucket for the build status
[19:59:44.355] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:44.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:10:0) after 1m0s
[20:00:44.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:10:0)
[20:00:44.642] Timer tick, asking Buildbucket for the build status
[20:00:47.507] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:47.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:11:0) after 1m0s
[20:01:47.948] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:11:0)
[20:01:47.948] Timer tick, asking Buildbucket for the build status
[20:01:48.805] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:48.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:12:0) after 1m0s
[20:02:48.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:12:0)
[20:02:48.958] Timer tick, asking Buildbucket for the build status
[20:02:50.708] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:50.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:13:0) after 1m0s
[20:03:50.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:13:0)
[20:03:50.993] Timer tick, asking Buildbucket for the build status
[20:03:51.260] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:51.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:14:0) after 1m0s
[20:04:51.370] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:14:0)
[20:04:51.370] Timer tick, asking Buildbucket for the build status
[20:04:53.485] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:53.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:15:0) after 1m0s
[20:05:53.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:15:0)
[20:05:53.903] Timer tick, asking Buildbucket for the build status
[20:05:55.952] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:55.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:16:0) after 1m0s
[20:06:56.225] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:16:0)
[20:06:56.225] Timer tick, asking Buildbucket for the build status
[20:06:56.662] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:56.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:17:0) after 1m0s
[20:07:56.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:17:0)
[20:07:56.740] Timer tick, asking Buildbucket for the build status
[20:07:57.883] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:57.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:18:0) after 1m0s
[20:08:58.302] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:18:0)
[20:08:58.302] Timer tick, asking Buildbucket for the build status
[20:08:58.674] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:58.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:19:0) after 1m0s
[20:09:59.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:19:0)
[20:09:59.077] Timer tick, asking Buildbucket for the build status
[20:10:01.117] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:01.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:20:0) after 1m0s
[20:11:01.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:20:0)
[20:11:01.558] Timer tick, asking Buildbucket for the build status
[20:11:01.743] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:01.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:21:0) after 1m0s
[20:12:01.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:21:0)
[20:12:01.804] Timer tick, asking Buildbucket for the build status
[20:12:03.060] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:03.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:22:0) after 1m0s
[20:13:03.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:22:0)
[20:13:03.215] Timer tick, asking Buildbucket for the build status
[20:13:03.453] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:03.453] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:23:0) after 1m0s
[20:14:03.485] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:23:0)
[20:14:03.485] Timer tick, asking Buildbucket for the build status
[20:14:03.862] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:03.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:24:0) after 1m0s
[20:15:03.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:24:0)
[20:15:03.857] Timer tick, asking Buildbucket for the build status
[20:15:04.485] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:04.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:25:0) after 1m0s
[20:16:04.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:25:0)
[20:16:04.534] Timer tick, asking Buildbucket for the build status
[20:16:06.188] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:06.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:26:0) after 1m0s
[20:17:06.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:26:0)
[20:17:06.420] Timer tick, asking Buildbucket for the build status
[20:17:06.825] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:06.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:27:0) after 1m0s
[20:18:06.900] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:27:0)
[20:18:06.900] Timer tick, asking Buildbucket for the build status
[20:18:07.346] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:07.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:28:0) after 1m0s
[20:19:07.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:28:0)
[20:19:07.393] Timer tick, asking Buildbucket for the build status
[20:19:07.583] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:07.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:29:0) after 1m0s
[20:20:07.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:29:0)
[20:20:07.605] Timer tick, asking Buildbucket for the build status
[20:20:07.938] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:07.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:30:0) after 1m0s
[20:21:08.045] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:30:0)
[20:21:08.045] Timer tick, asking Buildbucket for the build status
[20:21:09.749] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:09.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:31:0) after 1m0s
[20:22:10.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:31:0)
[20:22:10.007] Timer tick, asking Buildbucket for the build status
[20:22:10.426] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:10.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:32:0) after 1m0s
[20:23:10.664] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:32:0)
[20:23:10.664] Timer tick, asking Buildbucket for the build status
[20:23:10.975] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:10.975] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:33:0) after 1m0s
[20:24:11.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:33:0)
[20:24:11.064] Timer tick, asking Buildbucket for the build status
[20:24:11.348] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:11.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:34:0) after 1m0s
[20:25:11.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:34:0)
[20:25:11.399] Timer tick, asking Buildbucket for the build status
[20:25:12.174] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:12.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:35:0) after 1m0s
[20:26:12.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:35:0)
[20:26:12.234] Timer tick, asking Buildbucket for the build status
[20:26:12.810] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:12.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:36:0) after 1m0s
[20:27:12.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:36:0)
[20:27:12.854] Timer tick, asking Buildbucket for the build status
[20:27:13.408] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:13.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:37:0) after 1m0s
[20:28:13.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:37:0)
[20:28:13.487] Timer tick, asking Buildbucket for the build status
[20:28:13.947] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:13.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:38:0) after 1m0s
[20:29:14.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:38:0)
[20:29:14.062] Timer tick, asking Buildbucket for the build status
[20:29:15.104] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:15.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:39:0) after 1m0s
[20:30:15.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:39:0)
[20:30:15.149] Timer tick, asking Buildbucket for the build status
[20:30:15.425] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:15.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:40:0) after 1m0s
[20:31:15.554] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:40:0)
[20:31:15.554] Timer tick, asking Buildbucket for the build status
[20:31:15.722] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:15.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:41:0) after 1m0s
[20:32:15.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:41:0)
[20:32:15.807] Timer tick, asking Buildbucket for the build status
[20:32:16.307] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:16.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:42:0) after 1m0s
[20:33:16.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:42:0)
[20:33:16.490] Timer tick, asking Buildbucket for the build status
[20:33:16.929] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:16.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:43:0) after 1m0s
[20:34:16.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:43:0)
[20:34:16.930] Timer tick, asking Buildbucket for the build status
[20:34:17.114] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:17.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:44:0) after 1m0s
[20:35:17.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:44:0)
[20:35:17.171] Timer tick, asking Buildbucket for the build status
[20:35:18.423] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:18.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:45:0) after 1m0s
[20:36:18.473] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:45:0)
[20:36:18.473] Timer tick, asking Buildbucket for the build status
[20:36:19.479] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:19.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:46:0) after 1m0s
[20:37:19.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:46:0)
[20:37:19.546] Timer tick, asking Buildbucket for the build status
[20:37:20.000] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:20.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:47:0) after 1m0s
[20:38:20.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:47:0)
[20:38:20.036] Timer tick, asking Buildbucket for the build status
[20:38:21.929] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:21.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:48:0) after 1m0s
[20:39:21.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:48:0)
[20:39:21.939] Timer tick, asking Buildbucket for the build status
[20:39:23.503] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:23.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:49:0) after 1m0s
[20:40:23.635] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:49:0)
[20:40:23.635] Timer tick, asking Buildbucket for the build status
[20:40:23.981] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:23.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:50:0) after 1m0s
[20:41:24.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:50:0)
[20:41:24.023] Timer tick, asking Buildbucket for the build status
[20:41:24.784] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:24.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:51:0) after 1m0s
[20:42:24.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:51:0)
[20:42:24.841] Timer tick, asking Buildbucket for the build status
[20:42:24.995] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:24.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:52:0) after 1m0s
[20:43:25.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:52:0)
[20:43:25.005] Timer tick, asking Buildbucket for the build status
[20:43:25.831] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:25.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:53:0) after 1m0s
[20:44:25.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:53:0)
[20:44:25.928] Timer tick, asking Buildbucket for the build status
[20:44:26.509] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:26.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:54:0) after 1m0s
[20:45:26.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:54:0)
[20:45:26.566] Timer tick, asking Buildbucket for the build status
[20:45:27.752] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:27.752] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:55:0) after 1m0s
[20:46:27.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:55:0)
[20:46:27.847] Timer tick, asking Buildbucket for the build status
[20:46:28.065] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:28.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:56:0) after 1m0s
[20:47:28.096] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:56:0)
[20:47:28.096] Timer tick, asking Buildbucket for the build status
[20:47:28.550] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:28.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:57:0) after 1m0s
[20:48:28.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:57:0)
[20:48:28.591] Timer tick, asking Buildbucket for the build status
[20:48:29.182] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:29.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:58:0) after 1m0s
[20:49:29.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:58:0)
[20:49:29.226] Timer tick, asking Buildbucket for the build status
[20:49:29.532] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:29.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:59:0) after 1m0s
[20:50:29.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:59:0)
[20:50:29.575] Timer tick, asking Buildbucket for the build status
[20:50:30.573] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:30.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:60:0) after 1m0s
[20:51:30.615] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:60:0)
[20:51:30.615] Timer tick, asking Buildbucket for the build status
[20:51:30.783] Build 8893614643521933152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:30.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059044707933767648:61:0) after 1m0s
[20:51:34.128] Received PubSub notification, asking Buildbucket for the build status
[20:51:35.131] Build 8893614643521933152: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:51:35.131] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1576788693152571",
"created_by": "project:chromium",
"created_ts": "1576785156666694",
"id": "8893614643521933152",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1\"}}",
"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-east1-d-8-29-1uuk\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166325, \"got_angle_revision\": \"9dec123fec9908218289aa6a787dbbdab0774fe1\", \"got_dawn_revision\": \"5217ad51c5214162d3cb289922657df976931b73\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1\", \"got_revision_cp\": \"refs/heads/master@{#726477}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"6d3c7f5526ec0c5cf1b8fb13e3bf9b587d33b002\", \"got_v8_revision\": \"0340c9455dd7f850c9a9e00ee04a8cec6f7fda99\", \"got_v8_revision_cp\": \"refs/heads/8.1.57@{#1}\", \"got_webrtc_revision\": \"768c5f438cad7b65a05f8a9fe79d4049329e5475\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30108}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1\", \"swarm_hashes_refs/heads/master(at){#726477}_without_patch\": {\"accessibility_unittests\": \"3060c7f1151ffd4c2eaae025454cbab9d5e59be3\", \"angle_unittests\": \"ea1ce0096b302c2c7a30a2f668caf0e0db7b19a2\", \"app_shell_unittests\": \"3cff3833d026896c9654e5ba91d09d8ac35914d2\", \"aura_unittests\": \"8e295e8438ce9896ad1005ddff8b0c2da046cd84\", \"base_unittests\": \"8b0e8fd793e3042e3c5c352e23ab7e42902d63e0\", \"base_util_unittests\": \"a5bf9ca465a858508cae379cb333a083d084ce61\", \"blink_common_unittests\": \"b8be5fd996bf7345ac922bc928dc77299c649560\", \"blink_fuzzer_unittests\": \"464264abb99c3278d19317e8fb27d2bb198ff35e\", \"blink_heap_unittests\": \"9af2d38759559efbc8961acff324d4f65539fe10\", \"blink_platform_unittests\": \"45a29617e9b2d57d456a2ad8e3fd59aaee1822e7\", \"blink_python_tests\": \"e21a341a3a0c979bd4db2e7f498b7d3e0891776f\", \"blink_unittests\": \"519da50f16ec19a31f1cc8bb80b042bdc8a5d1d0\", \"blink_web_tests\": \"bf359831cc13c277932706187dfc0e4a8db68de6\", \"boringssl_crypto_tests\": \"c63eff6fdf4d79424bd684b6d67439361532e37a\", \"boringssl_ssl_tests\": \"1b42190b7a482e4c20940dd0a0a2d1f07da21e61\", \"browser_tests\": \"b294ad7b063543e527ff5066f21c189a2ba4068a\", \"cacheinvalidation_unittests\": \"817f8dd056c4b7cd0796356471dae58914321824\", \"capture_unittests\": \"36c48374c479858a76d656b37cabb3da6feb23bf\", \"cast_unittests\": \"8bfff3adcc5565e17b3f3839b937f648bba6face\", \"cc_unittests\": \"2ceea4eb38ebb0745efd21e6d42de247fd981f54\", \"chrome_app_unittests\": \"9913de6c109d3eb601ef2939e3b6be407480f641\", \"chromedriver_unittests\": \"d3601428d6a85cbc242fec9eed902ef3a9657e21\", \"components_browsertests\": \"e4e2ca7c7966f9b97b9c8689a9b0c6de935d0504\", \"components_unittests\": \"708221073a3fb296f05e1d87ca9f3deb0cba2bd5\", \"compositor_unittests\": \"e72ff52d43dc1cec768e1d96826ecca9f0fcca1b\", \"content_browsertests\": \"4e14cf2a7b0e778f69239d16037cefc7089fb180\", \"content_shell_crash_test\": \"6a5941b0b2b429954bc8db0a91f46a9a0e48ff9c\", \"content_unittests\": \"2fadda60dded226c74c78624376b617ac71e1007\", \"crashpad_tests\": \"6394904028fe1dcbf321d69c3252292548cf00d6\", \"cronet_tests\": \"69923a450972dd17765c5a8b57cdebb612dd5fb9\", \"cronet_unittests\": \"b6c19240b49b49a22e3fa6effa11af5a2c59708a\", \"crypto_unittests\": \"8bf4543d8c2eca814919334792cc6a803b89dadc\", \"dbus_unittests\": \"aa10c14dff307a2d4fdc793792657b5e85beda9d\", \"device_unittests\": \"2d5cd350697a769af931c497ce0c317cc466e845\", \"devtools_lint_check\": \"1e724d1e500a3cdd217efd63448889b2e3f9bde9\", \"devtools_type_check\": \"4245b02832dbe4008379865352d3cd92cda81485\", \"display_unittests\": \"03d2366c34e9785bb6fb2ef31f33aba2dc2c5e54\", \"events_unittests\": \"733400508174dd44a83c0353dccba0124a2bea84\", \"extensions_browsertests\": \"8782ad45a98c8e915af2e7d436216296e536dd98\", \"extensions_unittests\": \"8dd3b8e8a168ffe40dbacf8e970b7a17a3739c79\", \"filesystem_service_unittests\": \"2d3335b5171c61ee43ab832d1cee35a823a0cf86\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"1b32eafa16e3d5c73bcc4a3810b775ef106ae452\", \"gfx_unittests\": \"fe8b4adbf064f9fdf368e40e3671bbcf2cc25b6d\", \"gin_unittests\": \"ae25a28258ac429d16ddf49c614d44ed26b5ce79\", \"google_apis_unittests\": \"aa2a4affe129d23f2ed9abf750d7f9b0e9662aab\", \"gpu_unittests\": \"dbf34527837bc385044579c5ab5eff7a983f85c5\", \"grit_python_unittests\": \"25dff9ef6327c596609d376409bc1d0e605b6d43\", \"gwp_asan_unittests\": \"b212aa41a345c97e8ec2946a96ae1db6e9e69325\", \"headless_browsertests\": \"473fbac1d116252da3eeedc7b904cef041e2a239\", \"headless_unittests\": \"37b93b69504f7d74bec0c7f0af6851b1a505a36e\", \"interactive_ui_tests\": \"14ab6e98c7fcc34aaec2e0099c22c5cff8371890\", \"ipc_tests\": \"a38a8c58bdcc98521d9f40903955892dcd6ea169\", \"jingle_unittests\": \"9e980f0d4b4108366a4d1756fe311b89f687722a\", \"latency_unittests\": \"7b74c7aac5d7990598c9c57a30f3d25b794346e9\", \"libjingle_xmpp_unittests\": \"a441ef8714a9b7fc8763fb149dc623fa84a797c7\", \"media_blink_unittests\": \"c18bfecc26e551b7936f2aac5dedf82889b5146e\", \"media_service_unittests\": \"cfa80e314766af678140e59034c26c5fb9ae9110\", \"media_unittests\": \"74fe391e4bac86df0c97c68b876f3075bc07a4f6\", \"message_center_unittests\": \"130307a156b38da4388fe6cf8b1f41e50edf9cd4\", \"metrics_python_tests\": \"3c575ed77509eac9792c3d7b3de524d632657af6\", \"midi_unittests\": \"e5a070a220a14b1d8e1134802594c46bbc08e496\", \"mojo_core_unittests\": \"21ccb9bf43dfffd2033f386965ba5efb9baea686\", \"mojo_unittests\": \"1fe283d6adcdf0979701ee2ddeccdb2efb8380dc\", \"nacl_helper_nonsfi_unittests\": \"2f67ec06c6469a8fb1f0bc7e8528ed638fe30f1b\", \"nacl_loader_unittests\": \"0455407141dc9b9c356774975c00ae7749954861\", \"native_theme_unittests\": \"a30188b8c025342a48f83ea8d2217e92e4179bb2\", \"net_unittests\": \"42e7c9f24b12e4fc76d7b68612481cf8fd4e9bea\", \"pdf_unittests\": \"af11d79bcc60512bcb31d94fed1b77a429c1c474\", \"perfetto_unittests\": \"a7e12b56f67d2bb74bb1b16138c295203bf5d689\", \"ppapi_unittests\": \"1e41c60361305f36dba88cd574535aa669a44458\", \"printing_unittests\": \"a44f187494b8689b07fab72fe4c69fa868df860e\", \"remoting_unittests\": \"2aeebeeac2538719dcfb4d0e297e2c20c584ba79\", \"sandbox_linux_unittests\": \"730fd807c9ee6d36b992c1cade89c1482a74e0ac\", \"service_manager_unittests\": \"2015f8bbf1501a7252e7f00892570be2d51a6a30\", \"services_unittests\": \"f69810dbddcd49492e9e508153dbaa1079874882\", \"shell_dialogs_unittests\": \"7cd882aceceeb277f1d2032016a3bf594caa7a71\", \"skia_unittests\": \"5481f9def06c7785da1d58af1437226f0cc82f70\", \"snapshot_unittests\": \"54248fdaa622e72816294fdeb39e6dbd4c645fab\", \"sql_unittests\": \"e23def6c284229e04a8f73c4bb8b3f81cd596baa\", \"storage_unittests\": \"daf2705bacb38032bfb88d5e3900ddc5d3813068\", \"sync_integration_tests\": \"e5b2a178fe53b44adefcd540f7bef858e281c9e2\", \"telemetry_gpu_unittests\": \"6b2123b9a41dfd0dfd9bdcc2f99aae58caace9df\", \"telemetry_perf_unittests\": \"6bfc242980782d1573ab58d4ae93b7e0bedc3e07\", \"telemetry_unittests\": \"428e8f3bcc6834250c92eb79a69436f662473815\", \"traffic_annotation_auditor_unittests\": \"a4bccde9a84344ca8e8194831b44beff5bf00d5b\", \"ui_base_unittests\": \"d441fbb7b34c6bb6f1ed406dec684b7e2cbe2d8f\", \"ui_touch_selection_unittests\": \"ede5100e3aa291be416363e83a27c3535b8fdfb4\", \"unit_tests\": \"a74178800dd4a630437b2eeefacd708268e1cb34\", \"url_unittests\": \"0b1650a7ce5bb2e3183de1933ef3d44cf1c6dfb6\", \"views_perftests\": \"02188a1d32135fff0cfdc9c413d877fbebc79c5f\", \"views_unittests\": \"dc952838779357f338b25ce02ad5e077913d7ff0\", \"viz_unittests\": \"5a984939eba0dde9d76ed2fa2e33cf7ea1115ecd\", \"vr_common_unittests\": \"3cb4dc5cddceacef308c17e84103fecd60261753\", \"vr_pixeltests\": \"0f8c4bc3867b6bce616f51cb662031de23aeba46\", \"webdriver_wpt_tests\": \"e7c8d9f66bda961440b03d2dbe46bc9a66c40ebe\", \"weblayer_browsertests\": \"220c9ed1250255461bf9d64aff18f08572ca5aec\", \"wm_unittests\": \"a375324c617eeb81416578798135c206a8c57482\", \"wtf_unittests\": \"cc9a55b90e354ccbe786ba9636c454d3e1636566\", \"xr_browser_tests\": \"94ba9255f70de01dff838e17442c707d33569332\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_279625ee090c361ea8cf031374b7b020d1191c526e0ef1068ab634999c69ee70_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_e4464922e5c60bddfcc3d01cfc511ef7f4a711bded636fa98c66f03a573264ee_v2\", \"builder_e5bbff72983945f6847543519ce1052420cedd06fb8495f4080bfa2e6bcfd13f_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-east1-d-8-29-1uuk\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576785483423559",
"status": "COMPLETED",
"status_changed_ts": "1576788693492320",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166325",
"builder:Linux Builder (dbg)",
"buildset:commit/git/86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/86dd14c86ba7b9335bf9ce656974c2ef63e6d6a1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059044707933767648",
"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/8893614643521933152/+/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:49388a1f2a0a2b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1576788693496437",
"url": "https://ci.chromium.org/b/8893614643521933152",
"utcnow_ts": "1576788695102295"
}
}
[20:51:35.131] Invocation finished in 59m2.055345368s with status SUCCEEDED