[20:09:06.295] New invocation is queued and will start shortly
[20:09:07.530] Starting the invocation (attempt 1)
[20:09:07.676] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:09:07.676] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:09:07.676] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054604415187901120",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"97bc8736c878996378b74d9454f9d015368d6e3b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9054604415187901120",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/97bc8736c878996378b74d9454f9d015368d6e3b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97bc8736c878996378b74d9454f9d015368d6e3b",
"gitiles_ref:refs/heads/master"
]
}
[20:09:08.864] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1581019748047632",
"id": "8889174352630361872",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97bc8736c878996378b74d9454f9d015368d6e3b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581019748475307",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168313",
"builder:Linux Builder (dbg)",
"buildset:commit/git/97bc8736c878996378b74d9454f9d015368d6e3b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97bc8736c878996378b74d9454f9d015368d6e3b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054604415187901120",
"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/8889174352630361872/+/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": "1581019748475429",
"url": "https://ci.chromium.org/b/8889174352630361872",
"utcnow_ts": "1581019748832792"
}
}
[20:09:08.864] Task URL: https://ci.chromium.org/b/8889174352630361872
[20:09:08.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:2:0) after 1m0s
[20:10:08.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:2:0)
[20:10:08.927] Timer tick, asking Buildbucket for the build status
[20:10:09.417] Build 8889174352630361872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:10:09.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:3:0) after 1m0s
[20:11:09.505] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:3:0)
[20:11:09.505] Timer tick, asking Buildbucket for the build status
[20:11:09.710] Build 8889174352630361872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:11:09.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:4:0) after 1m0s
[20:12:09.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:4:0)
[20:12:09.815] Timer tick, asking Buildbucket for the build status
[20:12:09.973] Build 8889174352630361872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:12:09.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:5:0) after 1m0s
[20:13:10.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:5:0)
[20:13:10.033] Timer tick, asking Buildbucket for the build status
[20:13:10.307] Build 8889174352630361872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:10.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:6:0) after 1m0s
[20:14:10.574] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:6:0)
[20:14:10.574] Timer tick, asking Buildbucket for the build status
[20:14:10.772] Build 8889174352630361872: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:10.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:7:0) after 1m0s
[20:14:17.402] Received PubSub notification, asking Buildbucket for the build status
[20:14:17.571] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:11.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:7:0)
[20:15:11.261] Timer tick, asking Buildbucket for the build status
[20:15:11.920] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:11.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:9:0) after 1m0s
[20:16:12.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:9:0)
[20:16:12.034] Timer tick, asking Buildbucket for the build status
[20:16:12.568] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:12.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:10:0) after 1m0s
[20:17:12.648] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:10:0)
[20:17:12.648] Timer tick, asking Buildbucket for the build status
[20:17:12.977] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:12.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:11:0) after 1m0s
[20:18:13.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:11:0)
[20:18:13.058] Timer tick, asking Buildbucket for the build status
[20:18:13.318] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:13.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:12:0) after 1m0s
[20:19:13.335] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:12:0)
[20:19:13.335] Timer tick, asking Buildbucket for the build status
[20:19:13.738] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:13.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:13:0) after 1m0s
[20:20:13.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:13:0)
[20:20:13.782] Timer tick, asking Buildbucket for the build status
[20:20:14.043] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:14.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:14:0) after 1m0s
[20:21:14.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:14:0)
[20:21:14.128] Timer tick, asking Buildbucket for the build status
[20:21:15.219] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:15.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:15:0) after 1m0s
[20:22:15.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:15:0)
[20:22:15.355] Timer tick, asking Buildbucket for the build status
[20:22:15.786] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:15.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:16:0) after 1m0s
[20:23:15.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:16:0)
[20:23:15.874] Timer tick, asking Buildbucket for the build status
[20:23:16.477] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:16.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:17:0) after 1m0s
[20:24:16.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:17:0)
[20:24:16.644] Timer tick, asking Buildbucket for the build status
[20:24:16.998] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:16.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:18:0) after 1m0s
[20:25:17.033] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:18:0)
[20:25:17.033] Timer tick, asking Buildbucket for the build status
[20:25:17.223] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:17.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:19:0) after 1m0s
[20:26:17.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:19:0)
[20:26:17.274] Timer tick, asking Buildbucket for the build status
[20:26:17.406] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:17.406] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:20:0) after 1m0s
[20:27:17.581] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:20:0)
[20:27:17.581] Timer tick, asking Buildbucket for the build status
[20:27:18.112] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:18.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:21:0) after 1m0s
[20:28:18.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:21:0)
[20:28:18.339] Timer tick, asking Buildbucket for the build status
[20:28:18.513] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:18.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:22:0) after 1m0s
[20:29:18.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:22:0)
[20:29:18.597] Timer tick, asking Buildbucket for the build status
[20:29:19.018] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:19.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:23:0) after 1m0s
[20:30:19.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:23:0)
[20:30:19.137] Timer tick, asking Buildbucket for the build status
[20:30:19.317] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:19.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:24:0) after 1m0s
[20:31:19.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:24:0)
[20:31:19.421] Timer tick, asking Buildbucket for the build status
[20:31:19.617] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:19.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:25:0) after 1m0s
[20:32:19.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:25:0)
[20:32:19.773] Timer tick, asking Buildbucket for the build status
[20:32:19.898] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:19.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:26:0) after 1m0s
[20:33:20.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:26:0)
[20:33:20.082] Timer tick, asking Buildbucket for the build status
[20:33:20.325] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:20.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:27:0) after 1m0s
[20:34:20.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:27:0)
[20:34:20.667] Timer tick, asking Buildbucket for the build status
[20:34:21.250] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:21.250] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:28:0) after 1m0s
[20:35:21.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:28:0)
[20:35:21.429] Timer tick, asking Buildbucket for the build status
[20:35:21.581] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:21.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:29:0) after 1m0s
[20:36:21.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:29:0)
[20:36:21.670] Timer tick, asking Buildbucket for the build status
[20:36:22.402] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:22.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:30:0) after 1m0s
[20:37:22.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:30:0)
[20:37:22.526] Timer tick, asking Buildbucket for the build status
[20:37:23.222] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:23.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:31:0) after 1m0s
[20:38:23.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:31:0)
[20:38:23.289] Timer tick, asking Buildbucket for the build status
[20:38:23.511] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:23.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:32:0) after 1m0s
[20:39:23.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:32:0)
[20:39:23.584] Timer tick, asking Buildbucket for the build status
[20:39:23.919] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:23.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:33:0) after 1m0s
[20:40:23.986] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:33:0)
[20:40:23.986] Timer tick, asking Buildbucket for the build status
[20:40:25.046] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:25.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:34:0) after 1m0s
[20:41:25.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:34:0)
[20:41:25.193] Timer tick, asking Buildbucket for the build status
[20:41:25.391] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:25.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:35:0) after 1m0s
[20:42:25.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:35:0)
[20:42:25.437] Timer tick, asking Buildbucket for the build status
[20:42:25.639] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:25.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:36:0) after 1m0s
[20:43:25.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:36:0)
[20:43:25.785] Timer tick, asking Buildbucket for the build status
[20:43:25.987] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:25.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:37:0) after 1m0s
[20:44:26.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:37:0)
[20:44:26.056] Timer tick, asking Buildbucket for the build status
[20:44:26.202] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:26.202] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:38:0) after 1m0s
[20:45:26.317] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:38:0)
[20:45:26.317] Timer tick, asking Buildbucket for the build status
[20:45:26.608] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:26.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:39:0) after 1m0s
[20:46:26.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:39:0)
[20:46:26.705] Timer tick, asking Buildbucket for the build status
[20:46:27.004] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:27.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:40:0) after 1m0s
[20:47:27.010] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:40:0)
[20:47:27.010] Timer tick, asking Buildbucket for the build status
[20:47:27.593] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:27.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:41:0) after 1m0s
[20:48:27.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:41:0)
[20:48:27.645] Timer tick, asking Buildbucket for the build status
[20:48:28.066] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:28.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:42:0) after 1m0s
[20:49:28.118] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:42:0)
[20:49:28.118] Timer tick, asking Buildbucket for the build status
[20:49:28.636] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:28.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:43:0) after 1m0s
[20:50:28.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:43:0)
[20:50:28.621] Timer tick, asking Buildbucket for the build status
[20:50:29.144] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:29.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:44:0) after 1m0s
[20:51:29.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:44:0)
[20:51:29.228] Timer tick, asking Buildbucket for the build status
[20:51:29.392] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:29.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:45:0) after 1m0s
[20:52:29.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:45:0)
[20:52:29.799] Timer tick, asking Buildbucket for the build status
[20:52:29.993] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:29.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:46:0) after 1m0s
[20:53:30.124] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:46:0)
[20:53:30.124] Timer tick, asking Buildbucket for the build status
[20:53:30.286] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:30.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:47:0) after 1m0s
[20:54:30.401] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:47:0)
[20:54:30.401] Timer tick, asking Buildbucket for the build status
[20:54:30.830] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:30.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:48:0) after 1m0s
[20:55:30.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:48:0)
[20:55:30.901] Timer tick, asking Buildbucket for the build status
[20:55:31.077] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:31.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:49:0) after 1m0s
[20:56:31.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:49:0)
[20:56:31.196] Timer tick, asking Buildbucket for the build status
[20:56:32.063] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:32.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:50:0) after 1m0s
[20:57:32.177] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:50:0)
[20:57:32.177] Timer tick, asking Buildbucket for the build status
[20:57:32.339] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:32.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:51:0) after 1m0s
[20:58:32.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:51:0)
[20:58:32.393] Timer tick, asking Buildbucket for the build status
[20:58:32.834] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:32.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:52:0) after 1m0s
[20:59:32.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:52:0)
[20:59:32.863] Timer tick, asking Buildbucket for the build status
[20:59:33.095] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:33.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:53:0) after 1m0s
[21:00:33.388] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:53:0)
[21:00:33.388] Timer tick, asking Buildbucket for the build status
[21:00:34.462] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:34.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:54:0) after 1m0s
[21:01:34.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:54:0)
[21:01:34.486] Timer tick, asking Buildbucket for the build status
[21:01:34.914] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:34.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:55:0) after 1m0s
[21:02:34.969] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:55:0)
[21:02:34.969] Timer tick, asking Buildbucket for the build status
[21:02:35.298] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:35.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:56:0) after 1m0s
[21:03:35.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:56:0)
[21:03:35.376] Timer tick, asking Buildbucket for the build status
[21:03:36.176] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:36.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:57:0) after 1m0s
[21:04:36.290] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:57:0)
[21:04:36.290] Timer tick, asking Buildbucket for the build status
[21:04:37.361] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:37.361] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:58:0) after 1m0s
[21:05:37.514] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:58:0)
[21:05:37.514] Timer tick, asking Buildbucket for the build status
[21:05:37.704] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:37.704] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:59:0) after 1m0s
[21:06:37.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:59:0)
[21:06:37.723] Timer tick, asking Buildbucket for the build status
[21:06:37.872] Build 8889174352630361872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:37.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:60:0) after 1m0s
[21:07:37.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9054604415187901120:60:0)
[21:07:37.932] Timer tick, asking Buildbucket for the build status
[21:07:38.986] Build 8889174352630361872: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:07:38.986] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1581023256532205",
"created_by": "project:chromium",
"created_ts": "1581019748047632",
"id": "8889174352630361872",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97bc8736c878996378b74d9454f9d015368d6e3b\"}}",
"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-14-1l7j\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168313, \"got_angle_revision\": \"e9dc0201af3af167d21bc0f26bc763e18e82f994\", \"got_dawn_revision\": \"c30635174e125bda00771900089c34751e28faeb\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"97bc8736c878996378b74d9454f9d015368d6e3b\", \"got_revision_cp\": \"refs/heads/master@{#739068}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"dd48b7e2d06e74e1d20da5f43224b4ae99873e64\", \"got_v8_revision\": \"624f9f49e78ad57fc114a50d4d2a97ff3f25a841\", \"got_v8_revision_cp\": \"refs/heads/8.2.25@{#1}\", \"got_webrtc_revision\": \"4f68f5398d7fa3d47c449e99893c9bea07bf7ca2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30473}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"97bc8736c878996378b74d9454f9d015368d6e3b\", \"swarm_hashes_refs/heads/master(at){#739068}_without_patch\": {\"accessibility_unittests\": \"af076a9581c89bc18e47b9b959098e0f5593520a\", \"angle_unittests\": \"28b9bd0ac2824eba0688707bd99b1de1eb2884ae\", \"app_shell_unittests\": \"e56fecf5d200433afcbb295ba0dbb15f6f40c172\", \"aura_unittests\": \"708a034e6b921bfd5d231ce8075ef298d446b318\", \"base_unittests\": \"99a05db00a12907b0e90a07d760ad9e55827c661\", \"base_util_unittests\": \"906910cddb87f4755d82dd435d27747f6c1badb6\", \"blink_common_unittests\": \"aafff1d1a3a19509b4d85c7d4a572779eeec4d00\", \"blink_fuzzer_unittests\": \"1b21bd1c2ce2f7dd87983165c02718c16be4b2e5\", \"blink_heap_unittests\": \"a0c02f0d3ee12d527e34c3973b5ba64036a60c76\", \"blink_platform_unittests\": \"9a0537daba23e6e51318a78b50a20cb5f1b45d08\", \"blink_python_tests\": \"f8d8b254c10de0517d4845f1273def23c4efe79b\", \"blink_unittests\": \"ff426cf302c7c13c55fbe3f0802f789776bc9716\", \"blink_web_tests\": \"36cabb4cca1fbfbe85bd4995ae917749da5ba759\", \"boringssl_crypto_tests\": \"a10a169aa28122b4122bdeb0f64c700c8bf46507\", \"boringssl_ssl_tests\": \"bc5cd69267a8515d9e847f2b03d2067fdabc86ca\", \"browser_tests\": \"a48a500b1cdfa43f8e04140cce70c7590982a468\", \"cacheinvalidation_unittests\": \"f2964eee9064f6349c1800d9577e0d91db078200\", \"capture_unittests\": \"876983ad1f89b4898767d5bfb3ab628f716ebb6d\", \"cast_unittests\": \"4493b643af42b01567369cb2d3c42bc6773fabf7\", \"cc_unittests\": \"d6e6aa536584ef4f48d41c81e902be7a777a4613\", \"chrome_app_unittests\": \"613d7923823297024ad9984fc3e47e44a66426c2\", \"chromedriver_unittests\": \"e85605377af0e05552c7c86f7617c5a415bb1534\", \"components_browsertests\": \"a098da6dbe56b85a391232bbcc3717705dbbe2c2\", \"components_unittests\": \"f7a9fb0ab01c4157e54ffe5382debb3bf5b56120\", \"compositor_unittests\": \"88580c7a89648e766b33b3728207779a6b581ed5\", \"content_browsertests\": \"1d75193f7da76f0f36288e3da478e324abadc956\", \"content_shell_crash_test\": \"376de7c2398d94b878ab5375218439c4bb4fc802\", \"content_unittests\": \"6d8d32d9f456d1ccbf07ced5590f916292579f18\", \"crashpad_tests\": \"51b1d37b0fd48ea4473d84f994fb1d1db7c77bac\", \"cronet_tests\": \"7ce06cf42094dfc1f647fb4ec6036f19a388dd0e\", \"cronet_unittests\": \"c1e91daa72a92e844edefc88bdf1fc708be6e482\", \"crypto_unittests\": \"da018043f50d9d3b7a233d656e6b612f675fb53e\", \"dbus_unittests\": \"7950e48e51f7f1989f606f49f7843e1395ef832d\", \"device_unittests\": \"3cb588ecbe4a996f1272ba65ea28e605e3252176\", \"display_unittests\": \"29c6dc0d3a71e325b9e8abdab3aee1ca1a970f09\", \"events_unittests\": \"c7b7a1d06c379d7bad8df0fc68d611c891a3461b\", \"extensions_browsertests\": \"b02b0c586ecd4abd1d74d0309782dd3817f6ea60\", \"extensions_unittests\": \"ffa17deb67db71cd93d3fa5f2f08e9a2980013c5\", \"filesystem_service_unittests\": \"0cf3d157d8a259c231e514645804148024469a34\", \"flatbuffers_unittests\": \"ca71348ce5934d53fb892115f8e6e8a2436d5e6c\", \"gcm_unit_tests\": \"01466cc10a945aacfe9d95b259ad3c9e6b8798ba\", \"gfx_unittests\": \"1c0f40d04792be3f814dbff6a8b1877b48edec21\", \"gin_unittests\": \"6fe7b5385d64ac9afc5404fca67fea42cec989a4\", \"google_apis_unittests\": \"deea71eb32ea4937ab2ff79fc1e59b1a11c01f7a\", \"gpu_unittests\": \"845646f04244d638952a00916ba84f740b0ea628\", \"grit_python_unittests\": \"fef1b8d37dbc77945832da49380e67c1a64b0e20\", \"gwp_asan_unittests\": \"d7fc741ea7c6bb3421d6034614fc16efa73dab04\", \"headless_browsertests\": \"d03b96d0e346a55ee3bac55b842cdf2235edbdf7\", \"headless_unittests\": \"856136d5b8ef464de876e7243eb3b6bdae9d5f54\", \"interactive_ui_tests\": \"eb7822e419185651ecc7f71aa76ab83daba2f9de\", \"ipc_tests\": \"233ea27f2de7ae067c009d01eceaf11317bd8b35\", \"jingle_unittests\": \"ebb4421e5a7dad98518eaf53f7d3868a7bea26f0\", \"latency_unittests\": \"b87c52c0a0b0b28ebebc71e9db35e3df867053c8\", \"libjingle_xmpp_unittests\": \"5c29d44b245f72bfe6683e5eb7f2be682c8d58a4\", \"media_blink_unittests\": \"25656ed61810eb2a092c1335dc13f569e80f4969\", \"media_service_unittests\": \"cab371245e8477ca545ee1bc8600648a370b6d71\", \"media_unittests\": \"2765883ebc5791de16055d2102fc01015b896734\", \"message_center_unittests\": \"2feadd625b535a90094c42becc31607038262f44\", \"metrics_python_tests\": \"d0946cd3e11a061a766a3a9c056815a3d14797fe\", \"midi_unittests\": \"48768a04acf50b187fca29d09a943e3649e58f79\", \"mojo_core_unittests\": \"aa18c7f183e2d8bdce03bd7e444209f6601b69d4\", \"mojo_unittests\": \"f66bd60fcd4820929a27fd7ac383150b5189280d\", \"nacl_helper_nonsfi_unittests\": \"1245060376498636e2000814a0d299fcbc7fc830\", \"nacl_loader_unittests\": \"eb13d189ab0e2a0a90bdd19c8ba003f5b07cfb16\", \"native_theme_unittests\": \"cab8f5e4c4cd4e40fb662644af8d708984a04c3d\", \"net_unittests\": \"b2e33bb64aa5373ef7daaaf761232a3bb3f0334b\", \"pdf_unittests\": \"75216d08d18410747b9312004bf8471541b5db82\", \"perfetto_unittests\": \"2201a21790dba4c3d09a32d21c7b388914345f20\", \"ppapi_unittests\": \"39041db24a316970690c5da253e3e2c3d274ed09\", \"printing_unittests\": \"ab521073a566f00a2a2ecf309854e544fbdb779e\", \"remoting_unittests\": \"5bb89c64cac9f936617780bb7f89ebd369534c73\", \"sandbox_linux_unittests\": \"d89303ddbeb387c2412b01385e70a65d4e4ea8bd\", \"service_manager_unittests\": \"d02f47088ec85fad88b344ff16558c2ecaa05a64\", \"services_unittests\": \"ccf5d4350aac23ed234e98e850c0f795915c598a\", \"shell_dialogs_unittests\": \"f044ba646dbbe9e5cca7a893ec704f5e7b291a59\", \"skia_unittests\": \"499100b9d30de2c35d72dd794e7dd641cf56feeb\", \"snapshot_unittests\": \"578c7a37276217c51d1da4c54dff83089efd2f37\", \"sql_unittests\": \"1847f8f72ab7a055794377234dd1bd991fb3c652\", \"storage_unittests\": \"4864045ff80fb105a4e4b34bcf8dcd65aa9a2e7f\", \"sync_integration_tests\": \"9ea12d2d02c06999cb9473b657e518ea472fa648\", \"telemetry_gpu_unittests\": \"7d8f955fa0eaa2f805c94b93e1508986c5bcf266\", \"telemetry_perf_unittests\": \"fe804f0fe540b7194bd2f10443737d3950336c22\", \"telemetry_unittests\": \"6acfce52bc3ea63c6044c336b1658c1263296d94\", \"traffic_annotation_auditor_unittests\": \"36e660fbc2ecf08337ceaf6b7413d0640f310add\", \"ui_base_unittests\": \"25ea8a05968b6c0169019078f1d34108f393ba8a\", \"ui_touch_selection_unittests\": \"1b9e2f36ec6a095738adba4aa1afc79e63f39ec5\", \"unit_tests\": \"13314e12cfcc6e3edfa9ebe94a4d06ecbf7630a8\", \"url_unittests\": \"63fc71c4c79689dc09e4d372cfa577e65ad3b90e\", \"views_perftests\": \"705ed3b0a0b84206337f489af073a779c33501e2\", \"views_unittests\": \"ee5274b73615769285dd940ae8b5dd2948d2ca6d\", \"viz_unittests\": \"22142269e67c1eb421bd97b708ed99bd4eb792e8\", \"vr_common_unittests\": \"a324e02766b86703e01789691056742199687379\", \"vr_pixeltests\": \"428ee5ad5bb8eee18de2c1d8af177ce1715259a3\", \"webdriver_wpt_tests\": \"b8d91570e48aa21633bb28c7760b33659591c352\", \"weblayer_browsertests\": \"446791809d7342d838a6b1c101ba5532bac6f5ca\", \"wm_unittests\": \"bbc1a8b686b6d6a7e43cb0c6289683f9a17e8502\", \"wtf_unittests\": \"3452328183122d0f6c2eb05405206572a73c431f\", \"xr_browser_tests\": \"a77684d1d6455a68da83dd29608ee215034ac5a8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_26ee0c713798d591dc066c3b18aba10c428b81e49e5d430ca5b1f8f50ef6f654_v2\", \"builder_40238b720ec4feb1f57c327a3b72021d0e440ababc8fca32fd370c36be82ffcf_v2\", \"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_a050691f36f3646c8cc368108f8edcf844a0d1683dc4a3731c64b1c7527ccb94_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-14-1l7j\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4809-bb2013c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581020054735636",
"status": "COMPLETED",
"status_changed_ts": "1581023256857586",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168313",
"builder:Linux Builder (dbg)",
"buildset:commit/git/97bc8736c878996378b74d9454f9d015368d6e3b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/97bc8736c878996378b74d9454f9d015368d6e3b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054604415187901120",
"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/8889174352630361872/+/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:4a34f061c551a210",
"user_agent:luci-scheduler"
],
"updated_ts": "1581023256861518",
"url": "https://ci.chromium.org/b/8889174352630361872",
"utcnow_ts": "1581023258972238"
}
}
[21:07:38.986] Invocation finished in 58m32.761825256s with status SUCCEEDED