[10:23:21.252] New invocation is queued and will start shortly
[10:23:22.396] Starting the invocation (attempt 1)
[10:23:22.435] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:23:22.435] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:23:22.435] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017858899020347856",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e4d487dee9afbfdf0229e79742a3b8e570c199c3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9017858899020347856",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"gitiles_ref:refs/heads/master"
]
}
[10:23:23.163] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616063002566981",
"id": "8852428836979175504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616063002961982",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181482",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017858899020347856",
"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/8852428836979175504/+/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": "1616063002962092",
"url": "https://ci.chromium.org/b/8852428836979175504",
"utcnow_ts": "1616063003149200"
}
}
[10:23:23.163] Task URL: https://ci.chromium.org/b/8852428836979175504
[10:23:23.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:2:0) after 1m0s
[10:24:01.860] Received PubSub notification, asking Buildbucket for the build status
[10:24:01.935] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:23.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:2:0)
[10:24:23.228] Timer tick, asking Buildbucket for the build status
[10:24:23.304] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:23.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:4:0) after 1m0s
[10:25:23.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:4:0)
[10:25:23.311] Timer tick, asking Buildbucket for the build status
[10:25:23.381] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:23.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:5:0) after 1m0s
[10:26:23.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:5:0)
[10:26:23.405] Timer tick, asking Buildbucket for the build status
[10:26:23.648] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:23.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:6:0) after 1m0s
[10:27:23.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:6:0)
[10:27:23.706] Timer tick, asking Buildbucket for the build status
[10:27:23.869] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:23.869] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:7:0) after 1m0s
[10:28:23.849] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:7:0)
[10:28:23.849] Timer tick, asking Buildbucket for the build status
[10:28:23.944] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:23.944] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:8:0) after 1m0s
[10:29:23.966] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:8:0)
[10:29:23.966] Timer tick, asking Buildbucket for the build status
[10:29:24.422] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:24.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:9:0) after 1m0s
[10:30:24.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:9:0)
[10:30:24.453] Timer tick, asking Buildbucket for the build status
[10:30:24.513] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:24.513] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:10:0) after 1m0s
[10:31:24.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:10:0)
[10:31:24.575] Timer tick, asking Buildbucket for the build status
[10:31:24.646] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:24.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:11:0) after 1m0s
[10:32:24.719] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:11:0)
[10:32:24.719] Timer tick, asking Buildbucket for the build status
[10:32:24.782] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:24.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:12:0) after 1m0s
[10:33:24.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:12:0)
[10:33:24.857] Timer tick, asking Buildbucket for the build status
[10:33:24.947] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:24.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:13:0) after 1m0s
[10:34:24.997] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:13:0)
[10:34:24.997] Timer tick, asking Buildbucket for the build status
[10:34:25.087] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:25.087] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:14:0) after 1m0s
[10:35:25.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:14:0)
[10:35:25.106] Timer tick, asking Buildbucket for the build status
[10:35:25.191] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:25.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:15:0) after 1m0s
[10:36:25.261] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:15:0)
[10:36:25.261] Timer tick, asking Buildbucket for the build status
[10:36:25.594] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:25.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:16:0) after 1m0s
[10:37:25.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:16:0)
[10:37:25.607] Timer tick, asking Buildbucket for the build status
[10:37:25.675] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:25.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:17:0) after 1m0s
[10:38:25.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:17:0)
[10:38:25.708] Timer tick, asking Buildbucket for the build status
[10:38:25.974] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:25.974] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:18:0) after 1m0s
[10:39:25.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:18:0)
[10:39:25.975] Timer tick, asking Buildbucket for the build status
[10:39:26.349] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:26.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:19:0) after 1m0s
[10:40:26.355] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:19:0)
[10:40:26.355] Timer tick, asking Buildbucket for the build status
[10:40:26.516] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:26.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:20:0) after 1m0s
[10:41:26.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:20:0)
[10:41:26.534] Timer tick, asking Buildbucket for the build status
[10:41:26.676] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:26.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:21:0) after 1m0s
[10:42:26.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:21:0)
[10:42:26.693] Timer tick, asking Buildbucket for the build status
[10:42:26.767] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:26.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:22:0) after 1m0s
[10:43:26.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:22:0)
[10:43:26.825] Timer tick, asking Buildbucket for the build status
[10:43:26.902] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:26.902] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:23:0) after 1m0s
[10:44:26.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:23:0)
[10:44:26.921] Timer tick, asking Buildbucket for the build status
[10:44:27.043] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:27.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:24:0) after 1m0s
[10:45:27.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:24:0)
[10:45:27.087] Timer tick, asking Buildbucket for the build status
[10:45:27.280] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:27.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:25:0) after 1m0s
[10:46:27.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:25:0)
[10:46:27.299] Timer tick, asking Buildbucket for the build status
[10:46:27.535] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:27.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:26:0) after 1m0s
[10:47:27.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:26:0)
[10:47:27.663] Timer tick, asking Buildbucket for the build status
[10:47:27.791] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:27.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:27:0) after 1m0s
[10:48:27.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:27:0)
[10:48:27.835] Timer tick, asking Buildbucket for the build status
[10:48:27.917] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:27.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:28:0) after 1m0s
[10:49:27.909] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:28:0)
[10:49:27.909] Timer tick, asking Buildbucket for the build status
[10:49:27.988] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:27.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:29:0) after 1m0s
[10:50:28.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:29:0)
[10:50:28.008] Timer tick, asking Buildbucket for the build status
[10:50:28.076] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:28.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:30:0) after 1m0s
[10:51:28.099] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:30:0)
[10:51:28.099] Timer tick, asking Buildbucket for the build status
[10:51:28.212] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:28.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:31:0) after 1m0s
[10:52:28.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:31:0)
[10:52:28.238] Timer tick, asking Buildbucket for the build status
[10:52:28.392] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:28.392] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:32:0) after 1m0s
[10:53:28.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:32:0)
[10:53:28.421] Timer tick, asking Buildbucket for the build status
[10:53:28.516] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:28.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:33:0) after 1m0s
[10:54:28.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:33:0)
[10:54:28.494] Timer tick, asking Buildbucket for the build status
[10:54:28.557] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:28.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:34:0) after 1m0s
[10:55:28.696] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:34:0)
[10:55:28.696] Timer tick, asking Buildbucket for the build status
[10:55:28.977] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:28.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:35:0) after 1m0s
[10:56:29.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:35:0)
[10:56:29.074] Timer tick, asking Buildbucket for the build status
[10:56:29.295] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:29.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:36:0) after 1m0s
[10:57:29.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:36:0)
[10:57:29.397] Timer tick, asking Buildbucket for the build status
[10:57:29.757] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:29.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:37:0) after 1m0s
[10:58:29.940] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:37:0)
[10:58:29.940] Timer tick, asking Buildbucket for the build status
[10:58:30.092] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:30.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:38:0) after 1m0s
[10:59:30.080] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:38:0)
[10:59:30.080] Timer tick, asking Buildbucket for the build status
[10:59:30.427] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:30.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:39:0) after 1m0s
[11:00:30.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:39:0)
[11:00:30.520] Timer tick, asking Buildbucket for the build status
[11:00:30.595] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:30.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:40:0) after 1m0s
[11:01:30.692] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:40:0)
[11:01:30.692] Timer tick, asking Buildbucket for the build status
[11:01:30.780] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:30.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:41:0) after 1m0s
[11:02:30.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:41:0)
[11:02:30.836] Timer tick, asking Buildbucket for the build status
[11:02:31.201] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:31.201] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:42:0) after 1m0s
[11:03:31.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:42:0)
[11:03:31.194] Timer tick, asking Buildbucket for the build status
[11:03:31.569] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:31.569] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:43:0) after 1m0s
[11:04:31.589] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:43:0)
[11:04:31.589] Timer tick, asking Buildbucket for the build status
[11:04:31.666] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:31.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:44:0) after 1m0s
[11:05:31.733] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:44:0)
[11:05:31.733] Timer tick, asking Buildbucket for the build status
[11:05:31.812] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:31.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:45:0) after 1m0s
[11:06:31.858] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:45:0)
[11:06:31.858] Timer tick, asking Buildbucket for the build status
[11:06:31.946] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:31.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:46:0) after 1m0s
[11:07:32.016] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:46:0)
[11:07:32.016] Timer tick, asking Buildbucket for the build status
[11:07:32.112] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:32.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:47:0) after 1m0s
[11:08:32.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:47:0)
[11:08:32.148] Timer tick, asking Buildbucket for the build status
[11:08:32.264] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:32.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:48:0) after 1m0s
[11:09:32.379] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:48:0)
[11:09:32.379] Timer tick, asking Buildbucket for the build status
[11:09:32.456] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:32.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:49:0) after 1m0s
[11:10:32.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:49:0)
[11:10:32.506] Timer tick, asking Buildbucket for the build status
[11:10:32.911] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:32.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:50:0) after 1m0s
[11:11:32.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:50:0)
[11:11:32.963] Timer tick, asking Buildbucket for the build status
[11:11:33.048] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:33.048] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:51:0) after 1m0s
[11:12:33.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:51:0)
[11:12:33.783] Timer tick, asking Buildbucket for the build status
[11:12:33.986] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:33.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:52:0) after 1m0s
[11:13:34.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:52:0)
[11:13:34.028] Timer tick, asking Buildbucket for the build status
[11:13:34.104] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:34.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:53:0) after 1m0s
[11:14:34.093] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:53:0)
[11:14:34.093] Timer tick, asking Buildbucket for the build status
[11:14:34.211] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:34.211] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:54:0) after 1m0s
[11:15:34.246] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:54:0)
[11:15:34.246] Timer tick, asking Buildbucket for the build status
[11:15:34.402] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:34.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:55:0) after 1m0s
[11:16:34.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:55:0)
[11:16:34.375] Timer tick, asking Buildbucket for the build status
[11:16:34.719] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:34.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:56:0) after 1m0s
[11:17:34.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:56:0)
[11:17:34.738] Timer tick, asking Buildbucket for the build status
[11:17:34.816] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:34.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:57:0) after 1m0s
[11:18:34.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:57:0)
[11:18:34.884] Timer tick, asking Buildbucket for the build status
[11:18:36.073] Build 8852428836979175504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:36.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017858899020347856:58:0) after 1m0s
[11:19:00.513] Received PubSub notification, asking Buildbucket for the build status
[11:19:00.678] Build 8852428836979175504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:19:00.678] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616066339530188",
"created_by": "project:chromium",
"created_ts": "1616063002566981",
"id": "8852428836979175504",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\"}}",
"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\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\", \"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-117-8x3x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181482, \"got_angle_revision\": \"39296f396f5bf9abb8c8d80b147be7029c633964\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\", \"got_revision_cp\": \"refs/heads/master@{#864176}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"4f0f4e2a3c5ad9dc7312774da5197e0179c30863\", \"got_v8_revision_cp\": \"refs/heads/9.1.146@{#1}\", \"got_webrtc_revision\": \"92a768ad66f54ca57002f6f2e87c7a732e3fec39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33488}\", \"is_cached\": true, \"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\": \"e4d487dee9afbfdf0229e79742a3b8e570c199c3\", \"swarm_hashes_refs/heads/master(at){#864176}_without_patch\": {\"absl_hardening_tests\": \"765fd73bad35ae4eea8411a420048bf2403ea2f8\", \"accessibility_unittests\": \"30ec5526bc85f8aa6d34743a6aebc04cc78df45b\", \"angle_unittests\": \"8181fb5eb4947b02e7acba7bcd78285cb0909782\", \"app_shell_unittests\": \"96b5f19894a53aac74d3ac796c7bf4497f6418a2\", \"aura_unittests\": \"705b180ec993ecabc10be0c46af877e7978bf509\", \"base_unittests\": \"27569fa756f6c9c9c7d4954cee873bb5b141b592\", \"base_util_unittests\": \"a277b472a62df7a10893bd50beb0e909f56657ab\", \"blink_common_unittests\": \"b7897234ae9bca7141dd67321654ae6283647c68\", \"blink_fuzzer_unittests\": \"0b34aed4f7d48e75fe3c95c9a1d21c1de6111624\", \"blink_heap_unittests\": \"dfcb86660ec09ec432957de7dd2f5567b0b8057d\", \"blink_platform_unittests\": \"3f2f47e18dd8746bfbde4668fd2388df9798c160\", \"blink_python_tests\": \"6f7de1864321cae1796da6dab8b577fe138b7f44\", \"blink_unittests\": \"1cb0d0ffafd4a2e8bf5238dda0716d6ddb231dcb\", \"blink_web_tests\": \"2e678a4e94f5b722bf0cd8acc24c31532bc6390e\", \"boringssl_crypto_tests\": \"c3ca2e151d6d1372e690a13c2aaa63df27fb51d5\", \"boringssl_ssl_tests\": \"56ee84605b180f7775b7b1aabc020be4007e656c\", \"browser_tests\": \"09ce3fcb683ae36505f4c6934ea42c1def166676\", \"capture_unittests\": \"1d161a9b40b2c1b7a39a42e8e01ff6cdeeac848e\", \"cast_unittests\": \"c476408237beb8944aa752de43b86947ed693ea7\", \"cc_unittests\": \"5d5864feccf41b50d78106577447ed34be873964\", \"chrome_app_unittests\": \"17673d7e8b90c6a90a5700d0d38271b36b01f800\", \"chromedriver_unittests\": \"36e635c05e90f8857cba6b26346af4bbd6270a11\", \"color_unittests\": \"fb4a7084bc933f41897d8b1ac123d3f70ee75eb4\", \"components_browsertests\": \"7692391ef41085941315e8199a789e7c6d7b320f\", \"components_unittests\": \"fa3c2d84b3d701ebd62450429534d1cd41c46c99\", \"compositor_unittests\": \"3a62802951151e3af2013e6adcc2b8fe019d11f4\", \"content_browsertests\": \"a051695769b97e7791d0c63927e8e6f548cecfcc\", \"content_shell_crash_test\": \"5a6ee6ee9fbb0281cc4a3ea03b5c90a3486238ca\", \"content_unittests\": \"b29867087128887520ad0989896090882d1f2e56\", \"crashpad_tests\": \"c4056907c7db463c35f650cc87e6afa9ac8665b7\", \"cronet_tests\": \"f137ebdee18bc4b9948505db9e09e847847e7881\", \"cronet_unittests\": \"d5eac6364a30ca47dd9a47e526444b66553c83b2\", \"crypto_unittests\": \"7e49939ef5707782aea1d90d041f0343911a80dc\", \"dbus_unittests\": \"f09cc1fe78736025211268bf8ef06a05a9bb73bf\", \"device_unittests\": \"0700dd2e77483ab7536529dc5ea072bb01b24335\", \"display_unittests\": \"52177c25e4c3a022062be6f70b406820b1166170\", \"events_unittests\": \"7a88290b982414bdf940c0d7bf4bc63aeba4f233\", \"extensions_browsertests\": \"71bc7b5884dc4b45a363356716450b2a4c7daa31\", \"extensions_unittests\": \"c5342efb0c9a471dd134c1294bb5f2b8b190e78f\", \"filesystem_service_unittests\": \"cb393ef71c080be313ab83c3fda550e90e6f4bd7\", \"flatbuffers_unittests\": \"053e6ac98b117f7c5980e972268db1930536e1f7\", \"gcm_unit_tests\": \"8bf3f762a241b321fb4f66521c0dd8000cb600f1\", \"gfx_unittests\": \"dc93ca9dce6a43c535bdbc1e658da603b8724083\", \"gin_unittests\": \"fffd5271da00df4d237bf7966028ab31441ad59a\", \"google_apis_unittests\": \"d4dde1a4c01b30498a229ac14a94dcfe2b7f63e7\", \"gpu_unittests\": \"d88ba845472840776fb2fac93ecf1bb80c20dd4a\", \"grit_python_unittests\": \"7ad08adeec1e5c63b898e2e191a9ad3e35ab39f9\", \"gwp_asan_unittests\": \"1cef57ef93bfc968da8b582f0e165df9d1e1fefe\", \"headless_browsertests\": \"4d76a4b32387e6ee24c51ccefef9aef301d04650\", \"headless_unittests\": \"829af6968d5470ddc798858c6c94b62491d30bc2\", \"interactive_ui_tests\": \"58682006b29c14e98f4c75148c87ba328cb73c1b\", \"ipc_tests\": \"b7280868f42cffec680bd25a36daedd5de534c06\", \"jingle_unittests\": \"ba891b6d499fecbf7d198d8ac04f25db42687377\", \"latency_unittests\": \"86431bbd009cd74ea8342adc050ee449dddb917e\", \"libjingle_xmpp_unittests\": \"f00d16988e156ffc2ef5e046c17ebe472bf117ce\", \"liburlpattern_unittests\": \"61ebd5e7cedaff08f2f575b3d1495fff6de23365\", \"media_blink_unittests\": \"d83d75d38c5f34fe94161a132291ae1b81c95fcb\", \"media_unittests\": \"7bbb3d2688849cf4ff29e0ba3b1dd2a9c2dc2ed3\", \"message_center_unittests\": \"9d0028dcbfe86510a6d668849ccc02948ba684cb\", \"metrics_python_tests\": \"81ea0eb267b4f5003f1d9050026d3ca691c71bf7\", \"midi_unittests\": \"0cc2eda1b46d5d4f7167acee06fa7461d110c57a\", \"mojo_core_unittests\": \"c10504b4282c04fbcf829fa0c1c6a42757e0ed4f\", \"mojo_unittests\": \"8a95bee45a6831268807e73224887c14584e6d38\", \"nacl_helper_nonsfi_unittests\": \"6c12ea8638e8b33a83eab2055e02cf882f4f3bff\", \"nacl_loader_unittests\": \"ade02bb715a543c80577f3f0e2d5f815c56ceec9\", \"native_theme_unittests\": \"b21c5a461f97bb777c76a6594909b4c9e129b0db\", \"net_unittests\": \"10a1c341d6d6d989665b974eeee29f8276b9013d\", \"openscreen_unittests\": \"dfe7317ad2a6a2df5576e3bd412694f8c49c82e4\", \"pdf_unittests\": \"26d97b3c7b857c015832805182f553a123ee0707\", \"perfetto_unittests\": \"c9df6427a0de33f5e5aa5584d02a0bf06bf23064\", \"ppapi_unittests\": \"5b441c3875fa271dd320762a9b4f45df9ea40f26\", \"printing_unittests\": \"867007dd2b85ed54ca12ae9b0df1770ac2086bec\", \"remoting_unittests\": \"e66811f88f6dae719e45aa1788c18182a0ff4689\", \"sandbox_linux_unittests\": \"061e8b5b6aa4580e06d580caa4fd12eba5e4a30d\", \"service_manager_unittests\": \"b775db837cfd78cec2743c1546b309c7615dcc1b\", \"services_unittests\": \"4985325fc03704b558c22bb27f113bbee4612e22\", \"shell_dialogs_unittests\": \"213bffebdfed8cad291469a70d83e67255aa676a\", \"skia_unittests\": \"fda46a610eb9a88320ca0e92d493a9f2bdd16783\", \"snapshot_unittests\": \"69d5c8626b99c5277cc70c258387fde1fa6b2b15\", \"sql_unittests\": \"0780101b60ceb0e80cd48ce3afa45a4b53498fc4\", \"storage_unittests\": \"e04045d259b631b8b94a13fd9ba9f56c04be5e20\", \"sync_integration_tests\": \"1128fbd53292b71ec97ca39865c675f9315f2f69\", \"telemetry_gpu_unittests\": \"34379e9e8b66cbfde637a6de746bed6d4d581d16\", \"telemetry_perf_unittests\": \"4d909429d6f292387c3210b1832131c58aefc0c4\", \"telemetry_unittests\": \"13aed5e25bf81e5b316db4d00114bd402b102e03\", \"traffic_annotation_auditor_unittests\": \"934e18c7e66795dd2e6d2168d93c5d56d025e972\", \"ui_base_unittests\": \"8aa9b747802cd183520a9e630a303fc08cdf58c5\", \"ui_touch_selection_unittests\": \"2545609f261141cbe94d88d26d876b55d7b15960\", \"unit_tests\": \"f9b7c213d5dc407b0901ba19e6312a63d2546c0c\", \"url_unittests\": \"5ccdf7a07e0a6435d59e59237686c594edc00dc6\", \"views_perftests\": \"200890901da2819e420075de84afeafd82feab98\", \"views_unittests\": \"365186d2cc6f0365aa1aecb615ec963227847163\", \"viz_unittests\": \"cb590782ce54b57bf60c722aca902d3b42f4cf12\", \"vr_common_unittests\": \"df7272dc7acdcc1e73816ec5d25698d3d3383335\", \"vr_pixeltests\": \"62fd1749b3b07f8f8b4e41dcb75a07f0c7297587\", \"webdriver_wpt_tests\": \"d3ebb0ebc637820169bd66f0287396e280a8ee77\", \"weblayer_browsertests\": \"f4ddbad69ae005cfb257bf4a8ec3d6f019f68725\", \"weblayer_unittests\": \"17edc2daf5cc79386e042b7f94e18b738bdebbe0\", \"wm_unittests\": \"9e7f448e7dce30d2f95cd899521fce7c41b5fc14\", \"wtf_unittests\": \"40b53c00b97f735273298cd7b32746dd782c95a8\", \"x11_unittests\": \"80374f18d0f0e8a177e05a83108ab91b0f8617d0\", \"xr_browser_tests\": \"aa62fe346e3e03365ef39b4896ba4b5981020f05\", \"zlib_unittests\": \"05869b746966b90b55b96187c7a6a73831e720da\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2bbcd421f4eb1113f3a23522b280d70ced47ef846cc2e40eada60721dff8d17e_v2\", \"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_9a735a3fee4d607751977496b4455c795aec36ba7fa141f862fdf473488122eb_v2\", \"builder_db6a6033e460ced730b3940170fe4cf923f58c29fb56731f98470df5edf70e65_v2\", \"builder_de67dcb387b95c18ea83e54ea320474d260d319089536d63e3279fdbb975ff72_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-117-8x3x\"], \"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\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616063041196190",
"status": "COMPLETED",
"status_changed_ts": "1616066340015334",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181482",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e4d487dee9afbfdf0229e79742a3b8e570c199c3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017858899020347856",
"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/8852428836979175504/+/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:525dae048c821d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1616066340049721",
"url": "https://ci.chromium.org/b/8852428836979175504",
"utcnow_ts": "1616066340669724"
}
}
[11:19:00.678] Invocation finished in 55m39.442775477s with status SUCCEEDED