[07:41:08.695] New invocation is queued and will start shortly
[07:41:09.806] Starting the invocation (attempt 1)
[07:41:09.840] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:41:09.842] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:41:09.842] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019590446704629344",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"80173c6bebed7f2085e5a7c6f5af7f76c63e79a3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019590446704629344",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/80173c6bebed7f2085e5a7c6f5af7f76c63e79a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/80173c6bebed7f2085e5a7c6f5af7f76c63e79a3",
"gitiles_ref:refs/heads/master"
]
}
[07:41:10.481] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614411669915909",
"id": "8854160384765850560",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"80173c6bebed7f2085e5a7c6f5af7f76c63e79a3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614411670374496",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180979",
"builder:Linux Builder (dbg)",
"buildset:commit/git/80173c6bebed7f2085e5a7c6f5af7f76c63e79a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/80173c6bebed7f2085e5a7c6f5af7f76c63e79a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019590446704629344",
"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/8854160384765850560/+/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": "1614411670374603",
"url": "https://ci.chromium.org/b/8854160384765850560",
"utcnow_ts": "1614411670474156"
}
}
[07:41:10.481] Task URL: https://ci.chromium.org/b/8854160384765850560
[07:41:10.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:2:0) after 1m0s
[07:42:10.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:2:0)
[07:42:10.533] Timer tick, asking Buildbucket for the build status
[07:42:10.686] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:42:10.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:3:0) after 1m0s
[07:43:10.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:3:0)
[07:43:10.740] Timer tick, asking Buildbucket for the build status
[07:43:10.822] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:43:10.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:4:0) after 1m0s
[07:44:10.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:4:0)
[07:44:10.833] Timer tick, asking Buildbucket for the build status
[07:44:10.901] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:44:10.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:5:0) after 1m0s
[07:45:10.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:5:0)
[07:45:10.885] Timer tick, asking Buildbucket for the build status
[07:45:10.976] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:45:10.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:6:0) after 1m0s
[07:46:10.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:6:0)
[07:46:10.993] Timer tick, asking Buildbucket for the build status
[07:46:11.059] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:46:11.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:7:0) after 1m0s
[07:47:11.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:7:0)
[07:47:11.074] Timer tick, asking Buildbucket for the build status
[07:47:11.151] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:47:11.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:8:0) after 1m0s
[07:48:11.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:8:0)
[07:48:11.165] Timer tick, asking Buildbucket for the build status
[07:48:11.317] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:48:11.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:9:0) after 1m0s
[07:49:11.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:9:0)
[07:49:11.318] Timer tick, asking Buildbucket for the build status
[07:49:11.437] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:49:11.437] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:10:0) after 1m0s
[07:50:11.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:10:0)
[07:50:11.459] Timer tick, asking Buildbucket for the build status
[07:50:11.533] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:50:11.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:11:0) after 1m0s
[07:51:11.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:11:0)
[07:51:11.583] Timer tick, asking Buildbucket for the build status
[07:51:11.665] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:51:11.665] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:12:0) after 1m0s
[07:52:11.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:12:0)
[07:52:11.671] Timer tick, asking Buildbucket for the build status
[07:52:11.770] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:52:11.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:13:0) after 1m0s
[07:53:11.793] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:13:0)
[07:53:11.793] Timer tick, asking Buildbucket for the build status
[07:53:11.858] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:53:11.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:14:0) after 1m0s
[07:54:11.869] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:14:0)
[07:54:11.869] Timer tick, asking Buildbucket for the build status
[07:54:11.933] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:54:11.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:15:0) after 1m0s
[07:55:11.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:15:0)
[07:55:11.954] Timer tick, asking Buildbucket for the build status
[07:55:12.023] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:55:12.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:16:0) after 1m0s
[07:56:12.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:16:0)
[07:56:12.072] Timer tick, asking Buildbucket for the build status
[07:56:12.132] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:56:12.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:17:0) after 1m0s
[07:57:12.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:17:0)
[07:57:12.163] Timer tick, asking Buildbucket for the build status
[07:57:12.229] Build 8854160384765850560: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:57:12.229] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:18:0) after 1m0s
[07:57:24.331] Received PubSub notification, asking Buildbucket for the build status
[07:57:24.555] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:12.278] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:18:0)
[07:58:12.278] Timer tick, asking Buildbucket for the build status
[07:58:12.348] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:12.348] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:20:0) after 1m0s
[07:59:12.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:20:0)
[07:59:12.374] Timer tick, asking Buildbucket for the build status
[07:59:12.469] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:12.469] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:21:0) after 1m0s
[08:00:12.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:21:0)
[08:00:12.806] Timer tick, asking Buildbucket for the build status
[08:00:12.893] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:12.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:22:0) after 1m0s
[08:01:12.954] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:22:0)
[08:01:12.954] Timer tick, asking Buildbucket for the build status
[08:01:13.109] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:13.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:23:0) after 1m0s
[08:02:13.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:23:0)
[08:02:13.309] Timer tick, asking Buildbucket for the build status
[08:02:13.360] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:13.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:24:0) after 1m0s
[08:03:13.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:24:0)
[08:03:13.643] Timer tick, asking Buildbucket for the build status
[08:03:13.708] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:13.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:25:0) after 1m0s
[08:04:13.828] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:25:0)
[08:04:13.828] Timer tick, asking Buildbucket for the build status
[08:04:13.914] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:13.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:26:0) after 1m0s
[08:05:14.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:26:0)
[08:05:14.162] Timer tick, asking Buildbucket for the build status
[08:05:14.279] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:14.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:27:0) after 1m0s
[08:06:14.343] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:27:0)
[08:06:14.343] Timer tick, asking Buildbucket for the build status
[08:06:14.426] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:14.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:28:0) after 1m0s
[08:07:14.550] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:28:0)
[08:07:14.550] Timer tick, asking Buildbucket for the build status
[08:07:14.613] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:14.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:29:0) after 1m0s
[08:08:14.748] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:29:0)
[08:08:14.748] Timer tick, asking Buildbucket for the build status
[08:08:14.821] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:14.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:30:0) after 1m0s
[08:09:14.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:30:0)
[08:09:14.890] Timer tick, asking Buildbucket for the build status
[08:09:14.945] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:14.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:31:0) after 1m0s
[08:10:15.102] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:31:0)
[08:10:15.102] Timer tick, asking Buildbucket for the build status
[08:10:15.179] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:15.179] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:32:0) after 1m0s
[08:11:15.243] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:32:0)
[08:11:15.243] Timer tick, asking Buildbucket for the build status
[08:11:15.306] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:15.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:33:0) after 1m0s
[08:12:15.383] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:33:0)
[08:12:15.383] Timer tick, asking Buildbucket for the build status
[08:12:15.463] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:15.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:34:0) after 1m0s
[08:13:15.565] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:34:0)
[08:13:15.565] Timer tick, asking Buildbucket for the build status
[08:13:15.625] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:15.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:35:0) after 1m0s
[08:14:15.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:35:0)
[08:14:15.706] Timer tick, asking Buildbucket for the build status
[08:14:15.772] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:15.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:36:0) after 1m0s
[08:15:15.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:36:0)
[08:15:15.857] Timer tick, asking Buildbucket for the build status
[08:15:16.205] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:16.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:37:0) after 1m0s
[08:16:16.220] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:37:0)
[08:16:16.220] Timer tick, asking Buildbucket for the build status
[08:16:16.281] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:16.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:38:0) after 1m0s
[08:17:16.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:38:0)
[08:17:16.318] Timer tick, asking Buildbucket for the build status
[08:17:16.394] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:16.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:39:0) after 1m0s
[08:18:16.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:39:0)
[08:18:16.416] Timer tick, asking Buildbucket for the build status
[08:18:16.502] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:16.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:40:0) after 1m0s
[08:19:16.519] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:40:0)
[08:19:16.519] Timer tick, asking Buildbucket for the build status
[08:19:16.581] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:16.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:41:0) after 1m0s
[08:20:16.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:41:0)
[08:20:16.679] Timer tick, asking Buildbucket for the build status
[08:20:16.763] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:16.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:42:0) after 1m0s
[08:21:16.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:42:0)
[08:21:16.769] Timer tick, asking Buildbucket for the build status
[08:21:16.841] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:16.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:43:0) after 1m0s
[08:22:16.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:43:0)
[08:22:16.856] Timer tick, asking Buildbucket for the build status
[08:22:17.023] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:17.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:44:0) after 1m0s
[08:23:17.038] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:44:0)
[08:23:17.038] Timer tick, asking Buildbucket for the build status
[08:23:17.094] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:17.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:45:0) after 1m0s
[08:24:17.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:45:0)
[08:24:17.065] Timer tick, asking Buildbucket for the build status
[08:24:17.218] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:17.218] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:46:0) after 1m0s
[08:25:17.236] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:46:0)
[08:25:17.236] Timer tick, asking Buildbucket for the build status
[08:25:17.303] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:17.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:47:0) after 1m0s
[08:26:17.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:47:0)
[08:26:17.319] Timer tick, asking Buildbucket for the build status
[08:26:17.503] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:17.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:48:0) after 1m0s
[08:27:17.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:48:0)
[08:27:17.532] Timer tick, asking Buildbucket for the build status
[08:27:17.709] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:17.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:49:0) after 1m0s
[08:28:17.681] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:49:0)
[08:28:17.681] Timer tick, asking Buildbucket for the build status
[08:28:17.757] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:17.757] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:50:0) after 1m0s
[08:29:17.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:50:0)
[08:29:17.814] Timer tick, asking Buildbucket for the build status
[08:29:17.912] Build 8854160384765850560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:17.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019590446704629344:51:0) after 1m0s
[08:29:44.602] Received PubSub notification, asking Buildbucket for the build status
[08:29:44.682] Build 8854160384765850560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:29:44.682] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614414584120568",
"created_by": "project:chromium",
"created_ts": "1614411669915909",
"id": "8854160384765850560",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"80173c6bebed7f2085e5a7c6f5af7f76c63e79a3\"}}",
"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\": \"80173c6bebed7f2085e5a7c6f5af7f76c63e79a3\", \"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-central1-b-8-87-r5pn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180979, \"got_angle_revision\": \"c508e707f9a18cd20d04a02a4274364835113e95\", \"got_dawn_revision\": \"329c1c98fef964ea532a0579ae6f2553ff3382c5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"80173c6bebed7f2085e5a7c6f5af7f76c63e79a3\", \"got_revision_cp\": \"refs/heads/master@{#858409}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"45e415150419491d6d12428ba6ee98876a405ba4\", \"got_v8_revision_cp\": \"refs/heads/9.1.1@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"80173c6bebed7f2085e5a7c6f5af7f76c63e79a3\", \"swarm_hashes_refs/heads/master(at){#858409}_without_patch\": {\"absl_hardening_tests\": \"8a55701d1f751e21a359295715cd17dde23d29d6\", \"accessibility_unittests\": \"e52c7e10464fd7cb768574c603d7bafb33f94938\", \"angle_unittests\": \"ad6381f5557acda2ab38b5cafa93e180f02726d9\", \"app_shell_unittests\": \"2afa60b20b67365d2c28fa0c95ae00c331c2e532\", \"aura_unittests\": \"03f62db315b2e116fb90b7a77c8c17b5e8bb112e\", \"base_unittests\": \"a842ab35a5ed73ab36c3d9190af6827fb9889776\", \"base_util_unittests\": \"e2c993eb676d370a18eb5d4225609c56c0cccb4b\", \"blink_common_unittests\": \"de41c0bc73567b448cbe8bb33165245efc6d79ae\", \"blink_fuzzer_unittests\": \"15f6101e0a290f13e0d3c8925a5e594171197915\", \"blink_heap_unittests\": \"08adcec34ffc35110f657ff14c23bea3ac877e01\", \"blink_platform_unittests\": \"5b757a3c412b8a7d48d23f626ebf1729766fb266\", \"blink_python_tests\": \"fff05e97c39bc0cde4418a881888f3bf1a57679a\", \"blink_unittests\": \"429e6d96053bcfa0be7d4594967e3e8073c63d30\", \"blink_web_tests\": \"58c2428abc3fc91a31bd055faf12140cb21c37e7\", \"boringssl_crypto_tests\": \"d68f49b04485ca2c7d6c705266b78c36e46ff915\", \"boringssl_ssl_tests\": \"5fc6482a225e0085d9e680ad2bc94cb0ad81a4b9\", \"browser_tests\": \"22c67bda4d56012bef600ec2af7a450d18138514\", \"capture_unittests\": \"8528d6c456fd26159140d527aec7131cc15d5706\", \"cast_unittests\": \"50f2f64cb8581104e4bb310fdd704ec101cf51a4\", \"cc_unittests\": \"e9e71d7030f672ddb6b7451ea56399c3c57e0f5d\", \"chrome_app_unittests\": \"4d2ad4b6a37d3bd79244361acc3d5587248e3e32\", \"chromedriver_unittests\": \"211c876b1c0bbc496e3a6c1afc7e439b0519674a\", \"color_unittests\": \"6812ec539cb97baf96459700858605c9f67aebc4\", \"components_browsertests\": \"9abeeb685bd3076e951122bec03bdab55c4db2e4\", \"components_unittests\": \"b7ad4c2ef97dc15c67584fa3bd3163ae417345db\", \"compositor_unittests\": \"5cb2d620d4fcd74d1717673fe03efc3eb8119d2b\", \"content_browsertests\": \"d09808fadc75ce074e7ade96068f791f5a45e57d\", \"content_shell_crash_test\": \"e67af880db85905db78dc417dca858628777baef\", \"content_unittests\": \"479fcb66f82ab60e6234f4e5a62b331262fa04d1\", \"crashpad_tests\": \"d6b5fd4d98967fbff018849b087998a7f0000bef\", \"cronet_tests\": \"49c7bc00bd5daff1fa53519d3898e4435a5d86e4\", \"cronet_unittests\": \"145745adcdc5e4f2b8c4afa1602fb080cb0076d5\", \"crypto_unittests\": \"dc5a608ab7ba0fe5b0a7765fc3fbd0dbeb5e73d5\", \"dbus_unittests\": \"0f2c20f08a7bcd672028673cff08c94bb34c6665\", \"device_unittests\": \"fea8510344a37caf36f061b96b0d8291b9a6eecc\", \"display_unittests\": \"38a6861ebfb34d475757f5501da6489f71df2d73\", \"events_unittests\": \"232cb5681e1b5670b9e4f37d08dc5a9dd7b704aa\", \"extensions_browsertests\": \"f5b98c9b44bc86d1bd45c545d4e0cfe3b1b90d62\", \"extensions_unittests\": \"20c4ada4cf055b2beb5ecd1e85f280808afd6864\", \"filesystem_service_unittests\": \"6dd39c8fae00fbc0f2e54db1ee3b7b2f1f123da2\", \"flatbuffers_unittests\": \"b321573a6e379376cdf327a0c56c65611af14695\", \"gcm_unit_tests\": \"ff95981510ceeb574d47de8ba49ad84aaf66ff48\", \"gfx_unittests\": \"2338c3085450aaa074b06d4b72cd894a7d684458\", \"gin_unittests\": \"69c94ba5590fbcecc5fd3a271c18aa14d676bf1f\", \"google_apis_unittests\": \"1ccfd72eb8b842cfd59d3cebc85eef156a66a39e\", \"gpu_unittests\": \"86eec5ae4c512b5fac7c90da280bd81e2ed5a50e\", \"grit_python_unittests\": \"00738482c42a9310ca0fd96f0709b3d808390403\", \"gwp_asan_unittests\": \"92189fbcbb4e1dbe5151e1abb9bb19edf6cd390d\", \"headless_browsertests\": \"5741c0414d2b1c8e804db9d0516a221d814b014f\", \"headless_unittests\": \"63262ef796be39d800e98568f4b5e0076ccc5ab9\", \"interactive_ui_tests\": \"a9532027e3a9356598e28ea5b09ecbd5f63027cd\", \"ipc_tests\": \"62033e02d4b5b7bdd89c9f29abf37352d026d626\", \"jingle_unittests\": \"dae81a2da0ac9039196675589b8318410bbaf285\", \"latency_unittests\": \"0cfb1ffef2faa38a41901aefc39490a18da66228\", \"libjingle_xmpp_unittests\": \"1f972acdc3f90cf7e49417a1cb2058e1935d46b2\", \"liburlpattern_unittests\": \"9cf7141d03848bd60ecf44d349b1b27a7a7bcf7f\", \"media_blink_unittests\": \"7a75aceeda00ac5221eeeed0bf488f6577b32ebd\", \"media_unittests\": \"896597d439e4d987fa2832dd211d8a5afa205132\", \"message_center_unittests\": \"b2d1ccd6e9569cea1cd3a5d7e8b40f11dc3a95c1\", \"metrics_python_tests\": \"b0f5bb40588ffa1ad1b3b22d878cd3405aa657eb\", \"midi_unittests\": \"c680317071416bb1170fbf91421e2e564a25a91b\", \"mojo_core_unittests\": \"544ac9b3e9346c54e015bab61b91eddee94df347\", \"mojo_unittests\": \"e98fd33fa998c9c53db97a4d5b21e7f6ffc6aa64\", \"nacl_helper_nonsfi_unittests\": \"951d902c865d70585a439825f2254fc68c3638a6\", \"nacl_loader_unittests\": \"0efaae334420b24711f38c97e83b3efd30fb8ce7\", \"native_theme_unittests\": \"4a67586426f5b5fee14be106963364125a3ff976\", \"net_unittests\": \"759a91e3eb982d695d6979347bd0af38aa4d59e1\", \"openscreen_unittests\": \"b87bc270f2ce5534c8e95b8b3b1c4544a034aeea\", \"pdf_unittests\": \"e3964db66725550557e41744a81e037a961089f2\", \"perfetto_unittests\": \"eeb30e937fc90f141f083ae2b14d297e69189236\", \"ppapi_unittests\": \"2865809839ee8e7222b21df307e6a42326507148\", \"printing_unittests\": \"786b9a82ad05392a725a959c1a1bb282ca829005\", \"remoting_unittests\": \"8f3a7230e8b636c8142bc5e28abbdac8ad07b447\", \"sandbox_linux_unittests\": \"d1fba41fc10ff32fe4623015e09d7f6062402290\", \"service_manager_unittests\": \"c2e6319b98f2e78956b2fd853d16d76dc1c8fb65\", \"services_unittests\": \"9b6608bb6533fbf3d5e2ca51d3f2d2ed6ce2e88a\", \"shell_dialogs_unittests\": \"8d6b00b1637d70fc5a8330105b9e0578449d1090\", \"skia_unittests\": \"0e1e57bffa2e5925e41bb670bb25360319c3d11f\", \"snapshot_unittests\": \"334011859cac301b0058694f7005d6d24c956a92\", \"sql_unittests\": \"c70a8c3948d0d8c8e18e3b0ea8a9fb55d2e9c7f3\", \"storage_unittests\": \"e36a2d821475265a9cea3b32aabc5dcfb4d1edca\", \"sync_integration_tests\": \"662c428201b8c572b1795849297b2cad09926b1b\", \"telemetry_gpu_unittests\": \"74e876a27574c1b290070ee17ab9ce805f4894f1\", \"telemetry_perf_unittests\": \"1e46c9eebdbbe26aa4948ffc759c728bd0230d56\", \"telemetry_unittests\": \"f0ae1a2cf5234b34c07e48fb1587d62341534f10\", \"traffic_annotation_auditor_unittests\": \"d1b4a76490db2fa87bb5de6a9da6c811f35793b8\", \"ui_base_unittests\": \"3fdd1037b3c5d4546bffb13ade6e563a70101579\", \"ui_touch_selection_unittests\": \"42f81fa6d1429fdc6235f0d758240523d0ecdc13\", \"unit_tests\": \"90a88083cce1db6a9d20e32ed51f7dc3596e25c9\", \"url_unittests\": \"62324f922c3d799831a642a5f9bd8ec312b0417c\", \"views_perftests\": \"ee6a52a65b4e7ea90b5f86cc661d341c2852c590\", \"views_unittests\": \"f7335a2184116653d5400777240bb403d4c3e346\", \"viz_unittests\": \"93701eb0a8e26695a120a2761c9dc9010f4d799d\", \"vr_common_unittests\": \"cbf035dcaf2e32cc9514204c6ec42a86d1a22816\", \"vr_pixeltests\": \"9e0d0813d6bcd84d64e40aceb18c4d6000654c81\", \"webdriver_wpt_tests\": \"79d3e6fb583a1bc2c77def82c96478e303631751\", \"weblayer_browsertests\": \"cf75b7991fe0d30bf7cb66b670c1fd00e71361f8\", \"weblayer_unittests\": \"5e9a9bfc3304058bb7abb164f146034012d35938\", \"wm_unittests\": \"3f8a140c5aa6ff6fc892cabaa95ac0355b8d52d6\", \"wtf_unittests\": \"fe4d022ce2772b9f7406f770bb8e95d235f8afb4\", \"x11_unittests\": \"6347ec5607d56f3e3acf5a6adc2e0e233f67c371\", \"xr_browser_tests\": \"5eb8d6dacb9cf39b9d2e40a764d1f7b6b4f47298\", \"zlib_unittests\": \"c71a07466e7744819e7402d77000791e638ae28c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_279625ee090c361ea8cf031374b7b020d1191c526e0ef1068ab634999c69ee70_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_8afdcfef4ae6fecf44bdc59bc36ab1bd30dfc75b00b262fd5e6b3421af127659_v2\", \"builder_d7a16d1002a90b006293eb3aaf9b6ed11d06403f3c58091e1c5077b5d2ff0b40_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-central1-b-8-87-r5pn\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614412643818043",
"status": "COMPLETED",
"status_changed_ts": "1614414584367284",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180979",
"builder:Linux Builder (dbg)",
"buildset:commit/git/80173c6bebed7f2085e5a7c6f5af7f76c63e79a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/80173c6bebed7f2085e5a7c6f5af7f76c63e79a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019590446704629344",
"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/8854160384765850560/+/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:51fb40ac4ea1ec10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614414584371816",
"url": "https://ci.chromium.org/b/8854160384765850560",
"utcnow_ts": "1614414584675007"
}
}
[08:29:44.682] Invocation finished in 48m36.000081886s with status SUCCEEDED