[20:58:13.092] New invocation is queued and will start shortly
[20:58:14.186] Starting the invocation (attempt 1)
[20:58:14.225] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:58:14.225] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:58:14.225] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021080447668674048",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"18a6b6a554b9c753b600d041ed57ef2d158ab64f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021080447668674048",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/18a6b6a554b9c753b600d041ed57ef2d158ab64f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18a6b6a554b9c753b600d041ed57ef2d158ab64f",
"gitiles_ref:refs/heads/master"
]
}
[20:58:15.045] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612990694316107",
"id": "8855650385675029872",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"18a6b6a554b9c753b600d041ed57ef2d158ab64f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612990694884594",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180467",
"builder:Linux Builder (dbg)",
"buildset:commit/git/18a6b6a554b9c753b600d041ed57ef2d158ab64f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18a6b6a554b9c753b600d041ed57ef2d158ab64f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021080447668674048",
"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/8855650385675029872/+/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": "1612990694884846",
"url": "https://ci.chromium.org/b/8855650385675029872",
"utcnow_ts": "1612990695037610"
}
}
[20:58:15.045] Task URL: https://ci.chromium.org/b/8855650385675029872
[20:58:15.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:2:0) after 1m0s
[20:58:16.878] Received PubSub notification, asking Buildbucket for the build status
[20:58:16.962] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:15.108] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:2:0)
[20:59:15.108] Timer tick, asking Buildbucket for the build status
[20:59:15.249] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:15.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:4:0) after 1m0s
[21:00:15.273] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:4:0)
[21:00:15.273] Timer tick, asking Buildbucket for the build status
[21:00:15.389] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:15.389] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:5:0) after 1m0s
[21:01:15.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:5:0)
[21:01:15.527] Timer tick, asking Buildbucket for the build status
[21:01:15.600] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:15.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:6:0) after 1m0s
[21:02:15.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:6:0)
[21:02:15.610] Timer tick, asking Buildbucket for the build status
[21:02:15.865] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:15.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:7:0) after 1m0s
[21:03:15.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:7:0)
[21:03:15.951] Timer tick, asking Buildbucket for the build status
[21:03:16.073] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:16.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:8:0) after 1m0s
[21:04:16.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:8:0)
[21:04:16.162] Timer tick, asking Buildbucket for the build status
[21:04:16.301] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:16.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:9:0) after 1m0s
[21:05:16.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:9:0)
[21:05:16.395] Timer tick, asking Buildbucket for the build status
[21:05:16.469] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:16.469] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:10:0) after 1m0s
[21:06:16.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:10:0)
[21:06:16.507] Timer tick, asking Buildbucket for the build status
[21:06:16.659] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:16.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:11:0) after 1m0s
[21:07:16.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:11:0)
[21:07:16.744] Timer tick, asking Buildbucket for the build status
[21:07:16.966] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:16.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:12:0) after 1m0s
[21:08:17.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:12:0)
[21:08:17.117] Timer tick, asking Buildbucket for the build status
[21:08:17.350] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:17.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:13:0) after 1m0s
[21:09:17.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:13:0)
[21:09:17.506] Timer tick, asking Buildbucket for the build status
[21:09:17.603] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:17.603] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:14:0) after 1m0s
[21:10:17.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:14:0)
[21:10:17.714] Timer tick, asking Buildbucket for the build status
[21:10:17.906] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:17.906] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:15:0) after 1m0s
[21:11:18.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:15:0)
[21:11:18.075] Timer tick, asking Buildbucket for the build status
[21:11:18.348] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:18.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:16:0) after 1m0s
[21:12:18.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:16:0)
[21:12:18.390] Timer tick, asking Buildbucket for the build status
[21:12:18.546] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:18.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:17:0) after 1m0s
[21:13:18.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:17:0)
[21:13:18.568] Timer tick, asking Buildbucket for the build status
[21:13:18.670] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:18.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:18:0) after 1m0s
[21:14:18.750] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:18:0)
[21:14:18.750] Timer tick, asking Buildbucket for the build status
[21:14:18.846] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:18.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:19:0) after 1m0s
[21:15:18.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:19:0)
[21:15:18.891] Timer tick, asking Buildbucket for the build status
[21:15:18.985] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:18.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:20:0) after 1m0s
[21:16:19.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:20:0)
[21:16:19.011] Timer tick, asking Buildbucket for the build status
[21:16:19.171] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:19.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:21:0) after 1m0s
[21:17:19.207] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:21:0)
[21:17:19.208] Timer tick, asking Buildbucket for the build status
[21:17:19.291] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:19.291] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:22:0) after 1m0s
[21:18:19.259] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:22:0)
[21:18:19.259] Timer tick, asking Buildbucket for the build status
[21:18:19.428] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:19.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:23:0) after 1m0s
[21:19:19.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:23:0)
[21:19:19.474] Timer tick, asking Buildbucket for the build status
[21:19:19.544] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:19.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:24:0) after 1m0s
[21:20:19.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:24:0)
[21:20:19.661] Timer tick, asking Buildbucket for the build status
[21:20:19.749] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:19.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:25:0) after 1m0s
[21:21:19.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:25:0)
[21:21:19.847] Timer tick, asking Buildbucket for the build status
[21:21:19.966] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:19.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:26:0) after 1m0s
[21:22:20.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:26:0)
[21:22:20.032] Timer tick, asking Buildbucket for the build status
[21:22:20.236] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:20.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:27:0) after 1m0s
[21:23:20.271] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:27:0)
[21:23:20.271] Timer tick, asking Buildbucket for the build status
[21:23:20.650] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:20.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:28:0) after 1m0s
[21:24:20.735] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:28:0)
[21:24:20.735] Timer tick, asking Buildbucket for the build status
[21:24:20.809] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:20.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:29:0) after 1m0s
[21:25:20.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:29:0)
[21:25:20.854] Timer tick, asking Buildbucket for the build status
[21:25:20.994] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:20.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:30:0) after 1m0s
[21:26:21.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:30:0)
[21:26:21.025] Timer tick, asking Buildbucket for the build status
[21:26:21.299] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:21.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:31:0) after 1m0s
[21:27:21.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:31:0)
[21:27:21.353] Timer tick, asking Buildbucket for the build status
[21:27:21.742] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:21.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:32:0) after 1m0s
[21:28:21.780] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:32:0)
[21:28:21.780] Timer tick, asking Buildbucket for the build status
[21:28:21.885] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:21.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:33:0) after 1m0s
[21:29:21.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:33:0)
[21:29:21.967] Timer tick, asking Buildbucket for the build status
[21:29:22.153] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:22.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:34:0) after 1m0s
[21:30:22.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:34:0)
[21:30:22.241] Timer tick, asking Buildbucket for the build status
[21:30:22.429] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:22.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:35:0) after 1m0s
[21:31:22.480] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:35:0)
[21:31:22.480] Timer tick, asking Buildbucket for the build status
[21:31:22.733] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:22.733] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:36:0) after 1m0s
[21:32:22.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:36:0)
[21:32:22.742] Timer tick, asking Buildbucket for the build status
[21:32:22.851] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:22.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:37:0) after 1m0s
[21:33:22.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:37:0)
[21:33:22.909] Timer tick, asking Buildbucket for the build status
[21:33:23.009] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:23.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:38:0) after 1m0s
[21:34:23.022] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:38:0)
[21:34:23.022] Timer tick, asking Buildbucket for the build status
[21:34:23.110] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:23.110] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:39:0) after 1m0s
[21:35:23.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:39:0)
[21:35:23.099] Timer tick, asking Buildbucket for the build status
[21:35:23.222] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:23.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:40:0) after 1m0s
[21:36:23.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:40:0)
[21:36:23.244] Timer tick, asking Buildbucket for the build status
[21:36:23.426] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:23.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:41:0) after 1m0s
[21:37:23.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:41:0)
[21:37:23.453] Timer tick, asking Buildbucket for the build status
[21:37:23.597] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:23.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:42:0) after 1m0s
[21:38:23.613] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:42:0)
[21:38:23.613] Timer tick, asking Buildbucket for the build status
[21:38:23.917] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:23.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:43:0) after 1m0s
[21:39:23.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:43:0)
[21:39:23.901] Timer tick, asking Buildbucket for the build status
[21:39:24.052] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:24.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:44:0) after 1m0s
[21:40:24.182] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:44:0)
[21:40:24.182] Timer tick, asking Buildbucket for the build status
[21:40:24.271] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:24.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:45:0) after 1m0s
[21:41:24.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:45:0)
[21:41:24.373] Timer tick, asking Buildbucket for the build status
[21:41:25.320] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:25.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:46:0) after 1m0s
[21:42:25.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:46:0)
[21:42:25.400] Timer tick, asking Buildbucket for the build status
[21:42:25.624] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:25.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:47:0) after 1m0s
[21:43:25.717] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:47:0)
[21:43:25.717] Timer tick, asking Buildbucket for the build status
[21:43:25.937] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:25.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:48:0) after 1m0s
[21:44:25.982] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:48:0)
[21:44:25.982] Timer tick, asking Buildbucket for the build status
[21:44:26.059] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:26.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:49:0) after 1m0s
[21:45:26.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:49:0)
[21:45:26.161] Timer tick, asking Buildbucket for the build status
[21:45:26.236] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:26.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:50:0) after 1m0s
[21:46:26.353] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:50:0)
[21:46:26.353] Timer tick, asking Buildbucket for the build status
[21:46:26.438] Build 8855650385675029872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:26.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021080447668674048:51:0) after 1m0s
[21:47:25.660] Received PubSub notification, asking Buildbucket for the build status
[21:47:25.980] Build 8855650385675029872: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:47:25.980] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612993644653298",
"created_by": "project:chromium",
"created_ts": "1612990694316107",
"id": "8855650385675029872",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"18a6b6a554b9c753b600d041ed57ef2d158ab64f\"}}",
"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\": \"18a6b6a554b9c753b600d041ed57ef2d158ab64f\", \"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\": 180467, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e0a588752c827daef74960bbc80d7f5c4f73c4dd\", \"got_nacl_revision\": \"4de55da44c4b511989359381e8b7a88a01fe0634\", \"got_revision\": \"18a6b6a554b9c753b600d041ed57ef2d158ab64f\", \"got_revision_cp\": \"refs/heads/master@{#852790}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"673a7fe5c3ff6686c98951cafb24a93ca5bd1303\", \"got_v8_revision\": \"4a2d4d761da903dbfbbfcddb6fa50dc1b27c7667\", \"got_v8_revision_cp\": \"refs/heads/9.0.159@{#1}\", \"got_webrtc_revision\": \"7bad75b3906ae78b67b2a8cec095d877deb58215\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33214}\", \"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\": \"18a6b6a554b9c753b600d041ed57ef2d158ab64f\", \"swarm_hashes_refs/heads/master(at){#852790}_without_patch\": {\"absl_hardening_tests\": \"a80780b48b3d0cd83668962442aabb53f53974bd\", \"accessibility_unittests\": \"837b4bb4ef5544865c97c02cc3dd2a047969cec1\", \"angle_unittests\": \"d1cc0efde9f6beef1ce560144732de91fe11dcd5\", \"app_shell_unittests\": \"977f80f34c7ffaa8b4fa6845cb6a4cfd2a991463\", \"aura_unittests\": \"99eaf594e2170df2801815f859aad6fdf66a2243\", \"base_unittests\": \"06b57f23f4bd318586a202c8b891d322a3d1b099\", \"base_util_unittests\": \"49d94c0fbfccd1a0e27c3b2e25466703e825722e\", \"blink_common_unittests\": \"218f60ea69e9c1ee5b0afd662691bb7c6c427cd3\", \"blink_fuzzer_unittests\": \"98d2c10bb46112aa0dd83172c8b7bfe7315ed2ad\", \"blink_heap_unittests\": \"403f5fc8b7e08a6616d26f99bf56f59bf6e32e39\", \"blink_platform_unittests\": \"423a37d1d1c74873df82a1d14bbbe50d18dc8791\", \"blink_python_tests\": \"2d5c6945d09b73848c40e74420219a62acada59f\", \"blink_unittests\": \"085936cbe6fb8daca63477f8c9138181a06e2d8b\", \"blink_web_tests\": \"2446b962044dae1804bbc5677be2c45aff60f696\", \"boringssl_crypto_tests\": \"7011543503c5b06b10f3661736248a2283174a2b\", \"boringssl_ssl_tests\": \"a747d32267ed606b45d56657c54117b26f2f989f\", \"browser_tests\": \"1f96ac3e63afb616f68843f8ff0b5440ae56e6fd\", \"capture_unittests\": \"1767d2aedce6c5474c871380c193708763eca056\", \"cast_unittests\": \"effcabf797bc4da2952f4ba150b30e2893d9f4fd\", \"cc_unittests\": \"92312a2da7b034c4d17598c8db866e2e584c4feb\", \"chrome_app_unittests\": \"fc59e8b99d738cff27ff537384c50c497d2fd3af\", \"chromedriver_unittests\": \"e128573d3e82278a9cb1400f21845198b16f1fc6\", \"components_browsertests\": \"9ff311cfd7de333b3dfb70a00057a1b87bd9bdfd\", \"components_unittests\": \"4dbf394760370e000001a08f20f0f21fee8ef9c1\", \"compositor_unittests\": \"9b9fdb417b21da9131520e1480cd8b2e42717c25\", \"content_browsertests\": \"2324063623faf0cdbd39d50e344717ed2de83791\", \"content_shell_crash_test\": \"9efc635b9e8f90ed7d1a0ad170d68338371fbebe\", \"content_unittests\": \"3accd42886f181615916832c710ca66524bae8d1\", \"crashpad_tests\": \"52933b4000805dbb7f0ddcb06f0e00c791477b06\", \"cronet_tests\": \"0ae00e7d6bf2fe4021b44e97784407d7fadcaebd\", \"cronet_unittests\": \"d5b9bf40757cf5de762c5f6560bf282d36e0f424\", \"crypto_unittests\": \"748c3693e97988206fce6fb2c8d37e16e3b9dfd8\", \"dbus_unittests\": \"d5a9e67c747fc0209151771911c28b0cc8195910\", \"device_unittests\": \"e1ea94fafe079d89ae353c53f1854016e39533e0\", \"display_unittests\": \"ed544335d34422f9c3259357ba25595d304b2891\", \"events_unittests\": \"1aecadb28aa9267bf97e0fb406406387e44dd91e\", \"extensions_browsertests\": \"5f6c045088689f59c7a5b2a79292a4a706c4de7e\", \"extensions_unittests\": \"766be13cd91a53eec5b15b171e70b8a86361caba\", \"filesystem_service_unittests\": \"bcd6d1890342423771bb5071287d37fa7ff42608\", \"flatbuffers_unittests\": \"eac01a3774a90cf68bd2cb5c5e10e20502448f17\", \"gcm_unit_tests\": \"fa1c630ae83b2e63c956e975e868a36a3c7eb707\", \"gfx_unittests\": \"a7abcc2b4e354aee5b3f2e953b4e8c61bbd73f62\", \"gin_unittests\": \"f3ddcab188c1559ef5a8a6cb62b17c864a17584a\", \"google_apis_unittests\": \"d71b3cbb253bed8c5627c8a83861b7ef043b67ae\", \"gpu_unittests\": \"345c2d47e3a89f8c76a42320fa64cf09e5fd58c6\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"0013f3ca1fba72cf02bff2af7e23bbd8e530844e\", \"headless_browsertests\": \"c112d7d55a249a94536f1895762c9e9d3abad4ad\", \"headless_unittests\": \"570f0e9b00268069ac81179905a339c6ec32d654\", \"interactive_ui_tests\": \"5b669a2f856e69780ea85532834c84420636a1e2\", \"ipc_tests\": \"3871e34cdee60ed08b378b83f11553347dddfcdf\", \"jingle_unittests\": \"f5545902da87483655b41469ef134cfc1d797fd7\", \"latency_unittests\": \"13fbb2d3deb29e7d64e0b87d98dbfe04d222e9aa\", \"libjingle_xmpp_unittests\": \"cbb0510260e9ef4472943db98b1f72ee92bdbd6b\", \"liburlpattern_unittests\": \"3b49763654dbd0cd9ad49ce591228dc6d7fa827b\", \"media_blink_unittests\": \"42fd9f332792f2157c6d714298021406a24046f0\", \"media_unittests\": \"71cc726477523a96c4dd5bb838d34d3eba511ae8\", \"message_center_unittests\": \"a81685297c118b6704c611349ed411bc9a271249\", \"metrics_python_tests\": \"822f7b59ffcb7e5abeb92121fda82907f1d62696\", \"midi_unittests\": \"e5dced99a8b19315cbd7bf3edcdea882718ea4ae\", \"mojo_core_unittests\": \"d8306a09e25295d68fa303b15a54c5735b09ff56\", \"mojo_unittests\": \"064497eaa124b5790848b071fffd63f2ded13401\", \"nacl_helper_nonsfi_unittests\": \"47a6669b9c7832107902528a60d8aa302ee42f02\", \"nacl_loader_unittests\": \"06147e2561f2957f85930a5e21ea04b0ee0a676f\", \"native_theme_unittests\": \"ccee53b289db655fbece924d479d5b2cfb0adc21\", \"net_unittests\": \"89f1db0a639ec2162b2e0a58f7168bd3f6a0456b\", \"openscreen_unittests\": \"f9720e1a782f3ad851b1fcf5d1679a141db7ec4e\", \"pdf_unittests\": \"d55671e16f660d9ff58e79328c270fdd5c0b74ad\", \"perfetto_unittests\": \"e9a3c2c0b76dedb35abf4fcfc998013b60a1bc9a\", \"ppapi_unittests\": \"a31cf25cb9c6e51bc846b0a30f5dc2da601685a9\", \"printing_unittests\": \"559ff092dc3944bb0fd844133a28db142ed48806\", \"remoting_unittests\": \"c211ad361d205c59f44896ff8b73216bfdcac3e6\", \"sandbox_linux_unittests\": \"e56bf4c15ad25f77d49a2fe72b5eb9ce56d4b732\", \"service_manager_unittests\": \"03206b8dafd83d6ec107d53d585ef14839d50399\", \"services_unittests\": \"5233bfcc8288afc1da374ede8b3b8f233700258c\", \"shell_dialogs_unittests\": \"386272ba184704b11811a78bea27d13aab80798d\", \"skia_unittests\": \"f7d585e9684827d1d2b4e370c0eb990aa078247c\", \"snapshot_unittests\": \"766149743dbd8e3534b5d36bea16fe84f8225e75\", \"sql_unittests\": \"f218ccaa854f923dff2f9a57f9ca4b9c3bdff23a\", \"storage_unittests\": \"dd47e0896648541b95ddb03cab2f91cddfc382aa\", \"sync_integration_tests\": \"81952596a13a078c2e784ce5c4ba96695b277f46\", \"telemetry_gpu_unittests\": \"854b3b1d1a7d5f4237b848ce1b846c64f9bc0ec9\", \"telemetry_perf_unittests\": \"0e0fe2c8335f00e08e2148820251825bf9dda872\", \"telemetry_unittests\": \"dd2f147b5bc61653cb5198af7cf1b26042f57f46\", \"traffic_annotation_auditor_unittests\": \"d72465ce41166f96f0c69a0dbf808a3ae96c6dd8\", \"ui_base_unittests\": \"db5382f3a145a9677a0b269f9a35b098255bd696\", \"ui_touch_selection_unittests\": \"60972fbe07b43a9c7d8e0f02a75a603c78f16d2e\", \"unit_tests\": \"d79c542d08193a85c6b3f629bf789446ca6253c1\", \"url_unittests\": \"f55e1360ba0c7064415ce0f0a5b19dbec4b79756\", \"views_perftests\": \"075cc77110e411088d4f8ea556860bab514471e0\", \"views_unittests\": \"710519e55fa9b0180e814b34bad3ff9e880c4274\", \"viz_unittests\": \"9e32f7b53d0f7f71324835cab30d38250a3addac\", \"vr_common_unittests\": \"3a15934825699cc77151d92c0bb5a150f47310d9\", \"vr_pixeltests\": \"109a0cb29f899a6d770c8c8adf6e3213a7af12ac\", \"webdriver_wpt_tests\": \"dcd9f9065a3249e6b6e45ade4b395761cd8580c4\", \"weblayer_browsertests\": \"cdfff1ed9bd4b5076c993e25b4ae578a98375151\", \"weblayer_unittests\": \"d830e37df6dec6f2a5393150ff3083f1307bb11b\", \"wm_unittests\": \"0ca9d0010ebca12360a463f37624b279a535a43f\", \"wtf_unittests\": \"11abbf1e093c3b506f54e3fd3fc7b503a194806c\", \"x11_unittests\": \"978e61d62198fa99243dc40512c127537736424c\", \"xr_browser_tests\": \"d6655b6bde0f7a331533a5c9c607a7288c9695e1\", \"zlib_unittests\": \"94407c12347ffc68beab9cd40ac406816d19a8fc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_171aeb6ea7c277f8a23548bef504d6412b8f4fe5eb401735c265dcbe781a3afe_v2\", \"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_304607b978b8f4bcd63bac0f543c3a69f6b4c7cf202dcd2d3c5b8d4a70be201e_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": "1612990696094377",
"status": "COMPLETED",
"status_changed_ts": "1612993645237533",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180467",
"builder:Linux Builder (dbg)",
"buildset:commit/git/18a6b6a554b9c753b600d041ed57ef2d158ab64f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/18a6b6a554b9c753b600d041ed57ef2d158ab64f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021080447668674048",
"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/8855650385675029872/+/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:51a68e4f06f8b210",
"user_agent:luci-scheduler"
],
"updated_ts": "1612993645250455",
"url": "https://ci.chromium.org/b/8855650385675029872",
"utcnow_ts": "1612993645943746"
}
}
[21:47:25.980] Invocation finished in 49m12.949195561s with status SUCCEEDED