[19:53:19.116] New invocation is queued and will start shortly
[19:53:20.196] Starting the invocation (attempt 1)
[19:53:20.235] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:53:20.235] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:53:20.235] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021175127719224720",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bf9e263a5af9f8b8bbbc118d70a9de3db966b917\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021175127719224720",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/bf9e263a5af9f8b8bbbc118d70a9de3db966b917",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bf9e263a5af9f8b8bbbc118d70a9de3db966b917",
"gitiles_ref:refs/heads/master"
]
}
[19:53:21.086] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612900400389038",
"id": "8855745065719453728",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bf9e263a5af9f8b8bbbc118d70a9de3db966b917\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612900400955658",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180430",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bf9e263a5af9f8b8bbbc118d70a9de3db966b917",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bf9e263a5af9f8b8bbbc118d70a9de3db966b917",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021175127719224720",
"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/8855745065719453728/+/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": "1612900400955805",
"url": "https://ci.chromium.org/b/8855745065719453728",
"utcnow_ts": "1612900401078181"
}
}
[19:53:21.086] Task URL: https://ci.chromium.org/b/8855745065719453728
[19:53:21.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:2:0) after 1m0s
[19:53:53.692] Received PubSub notification, asking Buildbucket for the build status
[19:53:53.868] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:21.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:2:0)
[19:54:21.143] Timer tick, asking Buildbucket for the build status
[19:54:21.270] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:21.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:4:0) after 1m0s
[19:55:21.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:4:0)
[19:55:21.329] Timer tick, asking Buildbucket for the build status
[19:55:21.518] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:21.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:5:0) after 1m0s
[19:56:21.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:5:0)
[19:56:21.700] Timer tick, asking Buildbucket for the build status
[19:56:21.861] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:21.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:6:0) after 1m0s
[19:57:22.187] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:6:0)
[19:57:22.187] Timer tick, asking Buildbucket for the build status
[19:57:22.331] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:22.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:7:0) after 1m0s
[19:58:22.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:7:0)
[19:58:22.551] Timer tick, asking Buildbucket for the build status
[19:58:22.677] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:22.677] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:8:0) after 1m0s
[19:59:22.696] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:8:0)
[19:59:22.696] Timer tick, asking Buildbucket for the build status
[19:59:23.232] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:23.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:9:0) after 1m0s
[20:00:23.363] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:9:0)
[20:00:23.363] Timer tick, asking Buildbucket for the build status
[20:00:24.327] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:24.327] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:10:0) after 1m0s
[20:01:24.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:10:0)
[20:01:24.300] Timer tick, asking Buildbucket for the build status
[20:01:24.728] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:24.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:11:0) after 1m0s
[20:02:24.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:11:0)
[20:02:24.778] Timer tick, asking Buildbucket for the build status
[20:02:25.353] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:25.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:12:0) after 1m0s
[20:03:25.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:12:0)
[20:03:25.378] Timer tick, asking Buildbucket for the build status
[20:03:25.700] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:25.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:13:0) after 1m0s
[20:04:25.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:13:0)
[20:04:25.727] Timer tick, asking Buildbucket for the build status
[20:04:25.789] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:25.789] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:14:0) after 1m0s
[20:05:25.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:14:0)
[20:05:25.899] Timer tick, asking Buildbucket for the build status
[20:05:26.317] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:26.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:15:0) after 1m0s
[20:06:26.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:15:0)
[20:06:26.347] Timer tick, asking Buildbucket for the build status
[20:06:26.473] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:26.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:16:0) after 1m0s
[20:07:26.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:16:0)
[20:07:26.536] Timer tick, asking Buildbucket for the build status
[20:07:26.974] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:26.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:17:0) after 1m0s
[20:08:27.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:17:0)
[20:08:27.000] Timer tick, asking Buildbucket for the build status
[20:08:27.123] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:27.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:18:0) after 1m0s
[20:09:27.215] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:18:0)
[20:09:27.215] Timer tick, asking Buildbucket for the build status
[20:09:27.522] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:27.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:19:0) after 1m0s
[20:10:27.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:19:0)
[20:10:27.739] Timer tick, asking Buildbucket for the build status
[20:10:27.816] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:27.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:20:0) after 1m0s
[20:11:27.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:20:0)
[20:11:27.870] Timer tick, asking Buildbucket for the build status
[20:11:27.961] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:27.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:21:0) after 1m0s
[20:12:28.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:21:0)
[20:12:28.333] Timer tick, asking Buildbucket for the build status
[20:12:28.733] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:28.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:22:0) after 1m0s
[20:13:28.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:22:0)
[20:13:28.847] Timer tick, asking Buildbucket for the build status
[20:13:29.690] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:29.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:23:0) after 1m0s
[20:14:29.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:23:0)
[20:14:29.738] Timer tick, asking Buildbucket for the build status
[20:14:30.086] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:30.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:24:0) after 1m0s
[20:15:30.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:24:0)
[20:15:30.294] Timer tick, asking Buildbucket for the build status
[20:15:30.446] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:30.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:25:0) after 1m0s
[20:16:30.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:25:0)
[20:16:30.758] Timer tick, asking Buildbucket for the build status
[20:16:30.910] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:30.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:26:0) after 1m0s
[20:17:31.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:26:0)
[20:17:31.108] Timer tick, asking Buildbucket for the build status
[20:17:31.177] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:31.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:27:0) after 1m0s
[20:18:31.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:27:0)
[20:18:31.418] Timer tick, asking Buildbucket for the build status
[20:18:31.518] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:31.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:28:0) after 1m0s
[20:19:31.622] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:28:0)
[20:19:31.622] Timer tick, asking Buildbucket for the build status
[20:19:31.703] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:31.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:29:0) after 1m0s
[20:20:32.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:29:0)
[20:20:32.077] Timer tick, asking Buildbucket for the build status
[20:20:32.305] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:32.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:30:0) after 1m0s
[20:21:32.442] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:30:0)
[20:21:32.442] Timer tick, asking Buildbucket for the build status
[20:21:32.660] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:32.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:31:0) after 1m0s
[20:22:32.894] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:31:0)
[20:22:32.894] Timer tick, asking Buildbucket for the build status
[20:22:32.972] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:32.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:32:0) after 1m0s
[20:23:33.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:32:0)
[20:23:33.032] Timer tick, asking Buildbucket for the build status
[20:23:33.508] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:33.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:33:0) after 1m0s
[20:24:33.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:33:0)
[20:24:33.801] Timer tick, asking Buildbucket for the build status
[20:24:33.900] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:33.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:34:0) after 1m0s
[20:25:34.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:34:0)
[20:25:34.146] Timer tick, asking Buildbucket for the build status
[20:25:34.330] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:34.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:35:0) after 1m0s
[20:26:34.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:35:0)
[20:26:34.409] Timer tick, asking Buildbucket for the build status
[20:26:34.491] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:34.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:36:0) after 1m0s
[20:27:34.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:36:0)
[20:27:34.679] Timer tick, asking Buildbucket for the build status
[20:27:34.887] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:34.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:37:0) after 1m0s
[20:28:35.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:37:0)
[20:28:35.219] Timer tick, asking Buildbucket for the build status
[20:28:35.379] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:35.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:38:0) after 1m0s
[20:29:35.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:38:0)
[20:29:35.709] Timer tick, asking Buildbucket for the build status
[20:29:35.829] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:35.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:39:0) after 1m0s
[20:30:35.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:39:0)
[20:30:35.940] Timer tick, asking Buildbucket for the build status
[20:30:36.066] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:36.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:40:0) after 1m0s
[20:31:36.226] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:40:0)
[20:31:36.226] Timer tick, asking Buildbucket for the build status
[20:31:36.979] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:36.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:41:0) after 1m0s
[20:32:36.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:41:0)
[20:32:36.968] Timer tick, asking Buildbucket for the build status
[20:32:38.248] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:38.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:42:0) after 1m0s
[20:33:38.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:42:0)
[20:33:38.337] Timer tick, asking Buildbucket for the build status
[20:33:38.439] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:38.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:43:0) after 1m0s
[20:34:38.429] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:43:0)
[20:34:38.429] Timer tick, asking Buildbucket for the build status
[20:34:38.587] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:38.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:44:0) after 1m0s
[20:35:38.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:44:0)
[20:35:38.709] Timer tick, asking Buildbucket for the build status
[20:35:38.837] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:38.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:45:0) after 1m0s
[20:36:38.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:45:0)
[20:36:38.871] Timer tick, asking Buildbucket for the build status
[20:36:39.086] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:39.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:46:0) after 1m0s
[20:37:39.158] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:46:0)
[20:37:39.158] Timer tick, asking Buildbucket for the build status
[20:37:39.291] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:39.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:47:0) after 1m0s
[20:38:39.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:47:0)
[20:38:39.289] Timer tick, asking Buildbucket for the build status
[20:38:39.778] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:39.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:48:0) after 1m0s
[20:39:39.886] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:48:0)
[20:39:39.886] Timer tick, asking Buildbucket for the build status
[20:39:40.134] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:40.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:49:0) after 1m0s
[20:40:40.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:49:0)
[20:40:40.167] Timer tick, asking Buildbucket for the build status
[20:40:40.543] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:40.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:50:0) after 1m0s
[20:41:40.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:50:0)
[20:41:40.560] Timer tick, asking Buildbucket for the build status
[20:41:40.778] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:40.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:51:0) after 1m0s
[20:42:41.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:51:0)
[20:42:41.119] Timer tick, asking Buildbucket for the build status
[20:42:41.959] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:41.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:52:0) after 1m0s
[20:43:42.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:52:0)
[20:43:42.418] Timer tick, asking Buildbucket for the build status
[20:43:43.232] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:43.232] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:53:0) after 1m0s
[20:44:43.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:53:0)
[20:44:43.723] Timer tick, asking Buildbucket for the build status
[20:44:43.857] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:43.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:54:0) after 1m0s
[20:45:43.877] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:54:0)
[20:45:43.878] Timer tick, asking Buildbucket for the build status
[20:45:44.158] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:44.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:55:0) after 1m0s
[20:46:44.376] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:55:0)
[20:46:44.376] Timer tick, asking Buildbucket for the build status
[20:46:46.886] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:46.886] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:56:0) after 1m0s
[20:47:47.690] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:56:0)
[20:47:47.690] Timer tick, asking Buildbucket for the build status
[20:47:47.783] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:47.783] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:57:0) after 1m0s
[20:48:48.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:57:0)
[20:48:48.247] Timer tick, asking Buildbucket for the build status
[20:48:48.536] Build 8855745065719453728: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:48.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021175127719224720:58:0) after 1m0s
[20:49:35.073] Received PubSub notification, asking Buildbucket for the build status
[20:49:35.248] Build 8855745065719453728: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:49:35.248] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612903773815486",
"created_by": "project:chromium",
"created_ts": "1612900400389038",
"id": "8855745065719453728",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bf9e263a5af9f8b8bbbc118d70a9de3db966b917\"}}",
"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\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"bf9e263a5af9f8b8bbbc118d70a9de3db966b917\", \"project\": \"chromium/src\"}], \"$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-68-2v8w\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180430, \"got_angle_revision\": \"b7d441e662a1839b941b1ddd6ca04f68aecfbabc\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"bf9e263a5af9f8b8bbbc118d70a9de3db966b917\", \"got_revision_cp\": \"refs/heads/master@{#852313}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"aba242b50921817e2575589bc95206e2c3f4bd33\", \"got_v8_revision\": \"c369eee9f5827733bc6784843744c4ac8a9bea0b\", \"got_v8_revision_cp\": \"refs/heads/9.0.147@{#1}\", \"got_webrtc_revision\": \"54ea85c2cd3a2cb1b8f440a71aa9676a9b88135c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33190}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bf9e263a5af9f8b8bbbc118d70a9de3db966b917\", \"swarm_hashes_refs/heads/master(at){#852313}_without_patch\": {\"absl_hardening_tests\": \"7860913d81d41b9d378ccf511f2b9f9e8a74d935\", \"accessibility_unittests\": \"de9e7732b478fbbbbfa923e12f0c9165d2ae7bd7\", \"angle_unittests\": \"3a666e86079cbddbef6b0c1fbea50118385c82bd\", \"app_shell_unittests\": \"f799c3c89f61ae5f782c3bfc705216e93f6ad7f6\", \"aura_unittests\": \"0736ad83428feceb017457912d48efca23c9f6f2\", \"base_unittests\": \"015821f3280a08b3600e6d622810732c8bce70d1\", \"base_util_unittests\": \"3360f1a96e12fbeda817e7ec90df750f412ce462\", \"blink_common_unittests\": \"6db9c4d13e9d1fe48fb05aec215feeceb76fbc4d\", \"blink_fuzzer_unittests\": \"65a62a5a448d80f28fe97d16ae36696cb897958c\", \"blink_heap_unittests\": \"56dbce9a0e916ed7963a1f3fea74336c0d4324cd\", \"blink_platform_unittests\": \"2c73454e9d1ab6bcfa4332871a51f745dd6493f3\", \"blink_python_tests\": \"5afb6c08a8ff366b154181212445a13e49a73bd4\", \"blink_unittests\": \"b4627b02901211e5403dc8543e21b90789f757f1\", \"blink_web_tests\": \"43dbd9442f9e873aa311f859dec7f3a4d53ecd17\", \"boringssl_crypto_tests\": \"f262b4bd69bb4bc44163637eb63480b85be7686d\", \"boringssl_ssl_tests\": \"e8d3db9c74d4682d1b55a49dd98c3297bdb07f78\", \"browser_tests\": \"07b9b015f73b43e67abedd6243b745eaab336013\", \"capture_unittests\": \"83a6f4ad844080fc8a4f717a9dc028d4140e0850\", \"cast_unittests\": \"8519a349c78c1be9be4cc76ded5f9a7acb03212b\", \"cc_unittests\": \"77a59248295c5c8e1639c818d378a259a2af8a00\", \"chrome_app_unittests\": \"f7cb6e1649c965572134a9b8250e54a02aa6874b\", \"chromedriver_unittests\": \"d71004a84ebd875b2ef09bdbf878e6d4d29280b7\", \"components_browsertests\": \"286c0d4079e12dd3f6eb2dc5e7ac7f1594d70f02\", \"components_unittests\": \"8d0b7f0753a17e5d9ba790486568e3b4f938a8a5\", \"compositor_unittests\": \"630dc3b5914f595f5e526b958feaef0aea3337aa\", \"content_browsertests\": \"6d43620e1680172fb42e674bf872c0437e70e448\", \"content_shell_crash_test\": \"4b9a82e66bd3c26c6a07776d9ad25c5ee895f6c1\", \"content_unittests\": \"5ee84c69d692438cc443c2564e5f276e5fc640c2\", \"crashpad_tests\": \"854b63f4f8f8e44532427d0e0cd505af24314100\", \"cronet_tests\": \"175fa21ce7125b7bc6d05d548816f585174cba3f\", \"cronet_unittests\": \"0ff51a4b51608862b7568870c379dcae7d7564a0\", \"crypto_unittests\": \"2a686f53fc183630169739b05216b5664201179e\", \"dbus_unittests\": \"e945fccf2c6c21b37a61202ecfe96d3489c17fed\", \"device_unittests\": \"446f507113c908d88a6c187cdeb541bc083ee010\", \"display_unittests\": \"44d4c0bfa58e51e938783788d589f285eae65115\", \"events_unittests\": \"f676ff08eb12e5026777988f7dcb3006de47cbe4\", \"extensions_browsertests\": \"bce205c12a948c9d7647ad118037f772936cb751\", \"extensions_unittests\": \"7f8d68dd0069a82d65cb3fb6dea70acad505797e\", \"filesystem_service_unittests\": \"54c03b48c68406f5239b5ce6e59af384e05f5ba3\", \"flatbuffers_unittests\": \"58976a0c9ae5674987a52610b5f40e2c6cc5fd08\", \"gcm_unit_tests\": \"5a5761315fbceda014aa108dec37b22740f407cf\", \"gfx_unittests\": \"ec5185b091fcea8c942078681ea3be529bfd8dff\", \"gin_unittests\": \"b985e50229a7f759a1be611223deb3a0afdf8d33\", \"google_apis_unittests\": \"1f33b6b048f9f6c05baf0b4ef214320e966ee0d2\", \"gpu_unittests\": \"b5d85c8dad0953c568fcb9c2dc767f26ccfc325a\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"c4f156ceef09f9404e97b40e11070acac90afdb0\", \"headless_browsertests\": \"37a20a26b5461a9355c99e96f778f334aa2c2c59\", \"headless_unittests\": \"87eb7f6cf55e8ffddc4f9efbb8f62adc66d21e32\", \"interactive_ui_tests\": \"1e990bcca51ebb40375a0a9a892e5948c2bb4798\", \"ipc_tests\": \"35cf409390b7a5dcbdba2d8588f183f465b08b74\", \"jingle_unittests\": \"c8ee5ca448e9dd2d57085afb1aaa7ab302d55435\", \"latency_unittests\": \"f224970ac6342b00a921f4867fdd71ec6ae42f79\", \"libjingle_xmpp_unittests\": \"0ea4864667ba1c91c308c325df64ffc89dbf0ded\", \"liburlpattern_unittests\": \"7638e91b88638c27753f6eef5a7d70b96ac4ee4d\", \"media_blink_unittests\": \"190015b96087574f0d8b9da3dadf7368df3f70bd\", \"media_unittests\": \"9769456a712fa89310879d59b2a0dbdbe4dfa027\", \"message_center_unittests\": \"56876fb361c9b5f2b9bc67203d2a12932cf4d9a0\", \"metrics_python_tests\": \"6ad025fdb943762e568dc93f0a3acdf75fdb784d\", \"midi_unittests\": \"2cba9f014dbafbddbcda30c46445a034834fd38c\", \"mojo_core_unittests\": \"0e5f66f24591be0caf3ebcc28d6760048ce8c4de\", \"mojo_unittests\": \"83cacad1ba9f36dda6798273e37dec0a83de0c38\", \"nacl_helper_nonsfi_unittests\": \"3fca56d0a49292b5f72754643f8f6e723bba80c5\", \"nacl_loader_unittests\": \"11d605e4ed8f3cec825b275b219879a4815e8628\", \"native_theme_unittests\": \"1175b85a2c1d5e0a97a5f7aa0ac03fb8abb10171\", \"net_unittests\": \"2c3f1b3c4ff6a80ff30644f487129ba3e502b4ef\", \"openscreen_unittests\": \"f70a53e2c07fe13e596b9679cebb48f0c258a53d\", \"pdf_unittests\": \"2107475fca6c9cfce5d8074be5d09efdc8f06b7d\", \"perfetto_unittests\": \"3ce2c810be753506c31032b664f4dc21927c9a67\", \"ppapi_unittests\": \"a5ed43cdfe89d092999f69720a0c2ec65de6105a\", \"printing_unittests\": \"0381ed7a1153f51023aa1a055f71ab22d0006f33\", \"remoting_unittests\": \"c6d1458d5614ef9503912be996891ca9292e51ec\", \"sandbox_linux_unittests\": \"6f8a7443364b8da816eb2f27e7e9ea679d9f34c2\", \"service_manager_unittests\": \"93171664d9ef13a4ccf4405163cdeea5eb18b160\", \"services_unittests\": \"9e33250dce6819859f0a9aa0ae89414a406636cf\", \"shell_dialogs_unittests\": \"545414ddf9b326da6eff62d6e0f209fc1293dbae\", \"skia_unittests\": \"83f0a11b433f1532bd8abe1a9d9fd8cc1be8de75\", \"snapshot_unittests\": \"29ae60df026b3de55e481ee3cdf3871cb1d5535e\", \"sql_unittests\": \"2869581cfdf89cd5bac5bc31820d0ed905d9e9c7\", \"storage_unittests\": \"c70ad9145523d1347d34f0c12246366a923ab28a\", \"sync_integration_tests\": \"c18c12d8e6bfbbe3a1c3c5897f1226b38c4b7604\", \"telemetry_gpu_unittests\": \"58a6e31cac9124e6678b6670aab236594f82b5a3\", \"telemetry_perf_unittests\": \"43ec80c9c18315f9683fa002cedbb733ab12b536\", \"telemetry_unittests\": \"92c681fdfc13dc9007890577dd34c6b2a92358f1\", \"traffic_annotation_auditor_unittests\": \"405cdc286f94da1dbf8d0156d78f0e1883b94562\", \"ui_base_unittests\": \"a2a4b5368e8127309378f055f9cef4398c7903c6\", \"ui_touch_selection_unittests\": \"e3eba8668c1fea08a07fba3d16705d789bba4dfc\", \"unit_tests\": \"bf5189e1419f39a75559751c45a295e7beed3273\", \"url_unittests\": \"65d343d36acb84af3781244d957e51d686dc20ea\", \"views_perftests\": \"952b4515dcfc0fb2b8431294d11c1a6ddd97a395\", \"views_unittests\": \"37851a263719998c7dedfdba866b380de7fa1be6\", \"viz_unittests\": \"4c7b644cb41e448514ce8ea0aadba95253277fde\", \"vr_common_unittests\": \"036f79288b9216802740d9343c8b9e6a5d3161e3\", \"vr_pixeltests\": \"bcb4d4cb8b9b64f217604bb0a54dcca68bec4547\", \"webdriver_wpt_tests\": \"5c490391a259fb1f9de9be2fae5478f6e5ba1544\", \"weblayer_browsertests\": \"90a66faf62f2f9df0d1e1b63ca2fc8f9e58c9c30\", \"weblayer_unittests\": \"2c89dd3c3d54020cb0af6beabfdfa8e381302e4a\", \"wm_unittests\": \"f1d17872930bf9fe27958cd0bffe7bef51f56a32\", \"wtf_unittests\": \"51c228580721eb90c194de1d60502b7501067a0b\", \"x11_unittests\": \"33c00a1f9c26e17f43087a2d95bb7b3f001e2f45\", \"xr_browser_tests\": \"9b8c362d3dc2f4ed34798a40feaf1fead75d8975\", \"zlib_unittests\": \"3045d92020a65974b8b7f354b608983b7f6807bf\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_863d9d6073a39cfd51a17e8c0be606c54177e8c90f2c9a7c0e7333e92d562081_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-68-2v8w\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612900432919760",
"status": "COMPLETED",
"status_changed_ts": "1612903774402149",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180430",
"builder:Linux Builder (dbg)",
"buildset:commit/git/bf9e263a5af9f8b8bbbc118d70a9de3db966b917",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bf9e263a5af9f8b8bbbc118d70a9de3db966b917",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021175127719224720",
"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/8855745065719453728/+/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:51a12c880c6b5310",
"user_agent:luci-scheduler"
],
"updated_ts": "1612903774407063",
"url": "https://ci.chromium.org/b/8855745065719453728",
"utcnow_ts": "1612903775235922"
}
}
[20:49:35.249] Invocation finished in 56m16.149400343s with status SUCCEEDED