[22:57:11.489] New invocation is queued and will start shortly
[22:57:12.587] Starting the invocation (attempt 1)
[22:57:12.632] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:57:12.632] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:57:12.632] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020257589784299840",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"46f0e936056d2a4d4794afe4b286c5e30ea6a2d8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9020257589784299840",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/46f0e936056d2a4d4794afe4b286c5e30ea6a2d8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46f0e936056d2a4d4794afe4b286c5e30ea6a2d8",
"gitiles_ref:refs/heads/master"
]
}
[22:57:13.922] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613775432735138",
"id": "8854827527802314752",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"46f0e936056d2a4d4794afe4b286c5e30ea6a2d8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613775433217690",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180762",
"builder:Linux Builder (dbg)",
"buildset:commit/git/46f0e936056d2a4d4794afe4b286c5e30ea6a2d8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46f0e936056d2a4d4794afe4b286c5e30ea6a2d8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020257589784299840",
"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/8854827527802314752/+/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": "1613775433217837",
"url": "https://ci.chromium.org/b/8854827527802314752",
"utcnow_ts": "1613775433908078"
}
}
[22:57:13.922] Task URL: https://ci.chromium.org/b/8854827527802314752
[22:57:13.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:2:0) after 1m0s
[22:57:15.761] Received PubSub notification, asking Buildbucket for the build status
[22:57:15.856] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:13.929] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:2:0)
[22:58:13.929] Timer tick, asking Buildbucket for the build status
[22:58:13.995] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:13.995] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:4:0) after 1m0s
[22:59:14.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:4:0)
[22:59:14.037] Timer tick, asking Buildbucket for the build status
[22:59:14.228] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:14.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:5:0) after 1m0s
[23:00:14.267] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:5:0)
[23:00:14.267] Timer tick, asking Buildbucket for the build status
[23:00:14.626] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:14.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:6:0) after 1m0s
[23:01:14.666] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:6:0)
[23:01:14.666] Timer tick, asking Buildbucket for the build status
[23:01:14.838] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:14.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:7:0) after 1m0s
[23:02:14.901] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:7:0)
[23:02:14.901] Timer tick, asking Buildbucket for the build status
[23:02:15.357] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:15.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:8:0) after 1m0s
[23:03:15.361] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:8:0)
[23:03:15.361] Timer tick, asking Buildbucket for the build status
[23:03:15.707] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:15.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:9:0) after 1m0s
[23:04:15.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:9:0)
[23:04:15.724] Timer tick, asking Buildbucket for the build status
[23:04:16.052] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:16.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:10:0) after 1m0s
[23:05:16.092] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:10:0)
[23:05:16.092] Timer tick, asking Buildbucket for the build status
[23:05:16.293] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:16.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:11:0) after 1m0s
[23:06:16.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:11:0)
[23:06:16.349] Timer tick, asking Buildbucket for the build status
[23:06:16.600] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:16.600] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:12:0) after 1m0s
[23:07:16.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:12:0)
[23:07:16.658] Timer tick, asking Buildbucket for the build status
[23:07:17.151] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:17.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:13:0) after 1m0s
[23:08:17.284] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:13:0)
[23:08:17.284] Timer tick, asking Buildbucket for the build status
[23:08:21.046] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:21.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:14:0) after 1m0s
[23:09:21.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:14:0)
[23:09:21.065] Timer tick, asking Buildbucket for the build status
[23:09:21.144] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:21.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:15:0) after 1m0s
[23:10:21.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:15:0)
[23:10:21.164] Timer tick, asking Buildbucket for the build status
[23:10:21.459] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:21.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:16:0) after 1m0s
[23:11:21.489] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:16:0)
[23:11:21.489] Timer tick, asking Buildbucket for the build status
[23:11:21.923] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:21.924] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:17:0) after 1m0s
[23:12:21.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:17:0)
[23:12:21.968] Timer tick, asking Buildbucket for the build status
[23:12:22.135] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:22.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:18:0) after 1m0s
[23:13:22.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:18:0)
[23:13:22.213] Timer tick, asking Buildbucket for the build status
[23:13:22.560] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:22.560] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:19:0) after 1m0s
[23:14:22.691] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:19:0)
[23:14:22.691] Timer tick, asking Buildbucket for the build status
[23:14:22.788] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:22.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:20:0) after 1m0s
[23:15:22.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:20:0)
[23:15:22.835] Timer tick, asking Buildbucket for the build status
[23:15:23.022] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:23.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:21:0) after 1m0s
[23:16:23.107] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:21:0)
[23:16:23.107] Timer tick, asking Buildbucket for the build status
[23:16:23.242] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:23.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:22:0) after 1m0s
[23:17:23.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:22:0)
[23:17:23.345] Timer tick, asking Buildbucket for the build status
[23:17:23.443] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:23.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:23:0) after 1m0s
[23:18:23.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:23:0)
[23:18:23.544] Timer tick, asking Buildbucket for the build status
[23:18:23.706] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:23.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:24:0) after 1m0s
[23:19:23.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:24:0)
[23:19:23.778] Timer tick, asking Buildbucket for the build status
[23:19:23.865] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:23.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:25:0) after 1m0s
[23:20:23.913] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:25:0)
[23:20:23.913] Timer tick, asking Buildbucket for the build status
[23:20:24.204] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:24.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:26:0) after 1m0s
[23:21:24.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:26:0)
[23:21:24.176] Timer tick, asking Buildbucket for the build status
[23:21:24.521] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:24.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:27:0) after 1m0s
[23:22:24.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:27:0)
[23:22:24.573] Timer tick, asking Buildbucket for the build status
[23:22:24.690] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:24.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:28:0) after 1m0s
[23:23:24.730] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:28:0)
[23:23:24.730] Timer tick, asking Buildbucket for the build status
[23:23:25.320] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:25.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:29:0) after 1m0s
[23:24:25.341] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:29:0)
[23:24:25.341] Timer tick, asking Buildbucket for the build status
[23:24:25.423] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:25.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:30:0) after 1m0s
[23:25:25.447] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:30:0)
[23:25:25.447] Timer tick, asking Buildbucket for the build status
[23:25:25.548] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:25.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:31:0) after 1m0s
[23:26:25.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:31:0)
[23:26:25.642] Timer tick, asking Buildbucket for the build status
[23:26:25.858] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:25.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:32:0) after 1m0s
[23:27:25.875] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:32:0)
[23:27:25.875] Timer tick, asking Buildbucket for the build status
[23:27:26.213] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:26.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:33:0) after 1m0s
[23:28:26.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:33:0)
[23:28:26.244] Timer tick, asking Buildbucket for the build status
[23:28:30.923] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:30.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:34:0) after 1m0s
[23:29:31.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:34:0)
[23:29:31.075] Timer tick, asking Buildbucket for the build status
[23:29:31.165] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:31.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:35:0) after 1m0s
[23:30:31.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:35:0)
[23:30:31.245] Timer tick, asking Buildbucket for the build status
[23:30:31.565] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:31.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:36:0) after 1m0s
[23:31:31.577] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:36:0)
[23:31:31.577] Timer tick, asking Buildbucket for the build status
[23:31:31.652] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:31.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:37:0) after 1m0s
[23:32:31.705] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:37:0)
[23:32:31.705] Timer tick, asking Buildbucket for the build status
[23:32:32.160] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:32.160] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:38:0) after 1m0s
[23:33:32.181] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:38:0)
[23:33:32.181] Timer tick, asking Buildbucket for the build status
[23:33:32.267] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:32.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:39:0) after 1m0s
[23:34:32.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:39:0)
[23:34:32.497] Timer tick, asking Buildbucket for the build status
[23:34:32.574] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:32.574] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:40:0) after 1m0s
[23:35:32.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:40:0)
[23:35:32.704] Timer tick, asking Buildbucket for the build status
[23:35:32.946] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:32.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:41:0) after 1m0s
[23:36:33.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:41:0)
[23:36:33.015] Timer tick, asking Buildbucket for the build status
[23:36:33.136] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:33.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:42:0) after 1m0s
[23:37:33.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:42:0)
[23:37:33.194] Timer tick, asking Buildbucket for the build status
[23:37:33.636] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:33.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:43:0) after 1m0s
[23:38:33.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:43:0)
[23:38:33.643] Timer tick, asking Buildbucket for the build status
[23:38:33.861] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:33.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:44:0) after 1m0s
[23:39:33.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:44:0)
[23:39:33.921] Timer tick, asking Buildbucket for the build status
[23:39:34.069] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:34.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:45:0) after 1m0s
[23:40:34.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:45:0)
[23:40:34.117] Timer tick, asking Buildbucket for the build status
[23:40:34.212] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:34.212] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:46:0) after 1m0s
[23:41:34.256] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:46:0)
[23:41:34.256] Timer tick, asking Buildbucket for the build status
[23:41:34.364] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:34.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:47:0) after 1m0s
[23:42:34.378] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:47:0)
[23:42:34.378] Timer tick, asking Buildbucket for the build status
[23:42:34.556] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:34.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:48:0) after 1m0s
[23:43:34.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:48:0)
[23:43:34.558] Timer tick, asking Buildbucket for the build status
[23:43:34.634] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:34.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:49:0) after 1m0s
[23:44:34.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:49:0)
[23:44:34.661] Timer tick, asking Buildbucket for the build status
[23:44:35.020] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:35.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:50:0) after 1m0s
[23:45:35.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:50:0)
[23:45:35.104] Timer tick, asking Buildbucket for the build status
[23:45:35.209] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:35.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:51:0) after 1m0s
[23:46:35.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:51:0)
[23:46:35.287] Timer tick, asking Buildbucket for the build status
[23:46:37.912] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:37.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:52:0) after 1m0s
[23:47:38.011] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:52:0)
[23:47:38.011] Timer tick, asking Buildbucket for the build status
[23:47:38.090] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:38.090] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:53:0) after 1m0s
[23:48:38.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:53:0)
[23:48:38.159] Timer tick, asking Buildbucket for the build status
[23:48:38.319] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:38.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:54:0) after 1m0s
[23:49:38.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:54:0)
[23:49:38.414] Timer tick, asking Buildbucket for the build status
[23:49:38.837] Build 8854827527802314752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:38.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020257589784299840:55:0) after 1m0s
[23:50:27.748] Received PubSub notification, asking Buildbucket for the build status
[23:50:28.019] Build 8854827527802314752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:50:28.019] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613778621935168",
"created_by": "project:chromium",
"created_ts": "1613775432735138",
"id": "8854827527802314752",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"46f0e936056d2a4d4794afe4b286c5e30ea6a2d8\"}}",
"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\": \"46f0e936056d2a4d4794afe4b286c5e30ea6a2d8\", \"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-197-8brl\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180762, \"got_angle_revision\": \"b50c0b01c7d577bddd135b99288f885052db4fab\", \"got_dawn_revision\": \"76d0e38bd706dbba287a25ba3fcde11e1f6fd516\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"46f0e936056d2a4d4794afe4b286c5e30ea6a2d8\", \"got_revision_cp\": \"refs/heads/master@{#855971}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"35368945f0cb89f80e17129997ce2a17e51c2aa3\", \"got_v8_revision\": \"e7f275688dbc4e03f9b6346ab70cd2835fe7d6d0\", \"got_v8_revision_cp\": \"refs/heads/9.0.218@{#1}\", \"got_webrtc_revision\": \"753c76a705199ea752933f3688a8e4c8233dca53\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33298}\", \"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\": \"46f0e936056d2a4d4794afe4b286c5e30ea6a2d8\", \"swarm_hashes_refs/heads/master(at){#855971}_without_patch\": {\"absl_hardening_tests\": \"218c844d434ada9cff57a6026ec1e9dbd34f714a\", \"accessibility_unittests\": \"6dcf534134ac66e431faaec321f530369ecf75c9\", \"angle_unittests\": \"b09804104dbe0248a6f2626ed76890e99c285734\", \"app_shell_unittests\": \"c08bf5bbca943d55a859a5c24683fa72b54b4b54\", \"aura_unittests\": \"149a9f3ab781c8de14a141c54b4055041b66151c\", \"base_unittests\": \"4b92c6cb1d193ee8f40134f5d4d793728c25194c\", \"base_util_unittests\": \"be16af598a0bb1e1cb1d91ba87aedc805c3a2d81\", \"blink_common_unittests\": \"e314abf80b81d069c5520e1e80ac4630564ac911\", \"blink_fuzzer_unittests\": \"64fef123b0f5f617ff3dfaf5b3cf2a5b04fa00ab\", \"blink_heap_unittests\": \"3658d836f51a1fb9bc37734b46945f611b893de0\", \"blink_platform_unittests\": \"27c4c5c937485a1f21dbe6f223a793a229165d4a\", \"blink_python_tests\": \"6c361d595b411cf6fe04a2f507b20aec33f37d66\", \"blink_unittests\": \"48e074de1bf3f89d36ea70d9a09fb5605adffa59\", \"blink_web_tests\": \"d0fa64947e3270f30dc44617e2919be3acdc02c9\", \"boringssl_crypto_tests\": \"2413b1f3f573f8b57795b8894708cdc2937acbec\", \"boringssl_ssl_tests\": \"25cec846e6596704535bb52ba92555f55572a2c9\", \"browser_tests\": \"f4dc2b2d103e5fea3ee688523b9f85e1daac0599\", \"capture_unittests\": \"7ea256401c77e7bc379c007b3015579ef4ad0b3a\", \"cast_unittests\": \"026e2e07707976b32355c25804e4934e2a101ab6\", \"cc_unittests\": \"8d2a6d3223032b33698b15900239a8b9067cd9f4\", \"chrome_app_unittests\": \"4947e55609a05e9dec71913b2636688fa6fe41db\", \"chromedriver_unittests\": \"7b554e622d841eb054d7089e81397637bc2b7eb8\", \"components_browsertests\": \"5e408108ec4c1b8f38d606e058b39afdbbd707ab\", \"components_unittests\": \"1005a0a938d822908381372c360d8508ce639954\", \"compositor_unittests\": \"9d672c03f11871db1aa0136024d769bd5c3bc99a\", \"content_browsertests\": \"f1ece3158682a8ec076075a4789bf6680761ab5c\", \"content_shell_crash_test\": \"b5e00a41170408400b512029cfe3a47f67cb1d90\", \"content_unittests\": \"f55f5d21c2b3e99512cf154b0ef159bab5c70b2a\", \"crashpad_tests\": \"641b7f71650758399ae958e0d37c2965bf66b8fc\", \"cronet_tests\": \"e25bb5b0d8eee7e6beaafd69abbd9d29550d5572\", \"cronet_unittests\": \"5e499cae477f7b2343ccbf5833643c4daa4280ce\", \"crypto_unittests\": \"f513121b4715b6b7ad85060d5c74a6ac7554ccf9\", \"dbus_unittests\": \"f33bb0fe3a833f039b6246efdf099314ef16e4fa\", \"device_unittests\": \"2f7e5fc75ccf84f54f50b0b17caf389e935427f9\", \"display_unittests\": \"0595691f6547c3d31cc9b3c6ec26502dab80f5ea\", \"events_unittests\": \"506d75ea6c0f908248a800f2e47b0b15b794260b\", \"extensions_browsertests\": \"50080a17af3a5152c6e99da924c6144f2b59ffd7\", \"extensions_unittests\": \"e5fbe4e7e8c0915722b311213419485263d491bc\", \"filesystem_service_unittests\": \"5f493971acf614d04e4559ee1e5795af748713e2\", \"flatbuffers_unittests\": \"698230cd2ee29799b3293b30c69cdc80b3ff243d\", \"gcm_unit_tests\": \"2a1fc65dd4d82768a2a37c6ebc798cdb4f10359d\", \"gfx_unittests\": \"9aa395eaaf03630daaa7a31379a76cbb56a9a372\", \"gin_unittests\": \"ce529e101ac5e9e7094ddc636b71e3f88f99d20a\", \"google_apis_unittests\": \"55eb04790eb3c31b0c9cbf51e33e2ff1001009c4\", \"gpu_unittests\": \"42eec755a6dd9b984eb193ec7765a2139a0c1042\", \"grit_python_unittests\": \"e9472d6ec31317123f3dfff9be51bd5eb8f9349b\", \"gwp_asan_unittests\": \"64c13fba928c7694ae3bb9c3a78ae64cf2553941\", \"headless_browsertests\": \"83b0e97460708344839dc0ad2759e891dc4c5c1c\", \"headless_unittests\": \"211374ee606379060aaa2f2568c08fd751955519\", \"interactive_ui_tests\": \"c529a3a41b4aeced431afb0691f5e452414d4b89\", \"ipc_tests\": \"15576448e7111ab010b6b95b45abdab29a2cdb8b\", \"jingle_unittests\": \"f7d2c06923dc580f1e27a3687d50d2c5421be766\", \"latency_unittests\": \"658612450ec3d8609540bab1dee1d50667cf5ec2\", \"libjingle_xmpp_unittests\": \"c20a2ba5a7bc2896022181ac56614233fd1c7bfd\", \"liburlpattern_unittests\": \"5b24ecd252d283322651e65c1781b30969a58d07\", \"media_blink_unittests\": \"1d762e986351a253c77fe30fe686c9375b0c2e3f\", \"media_unittests\": \"b00a6a88991a51665c26e1548237301544032e23\", \"message_center_unittests\": \"5f31469f296081762d590642cddddf9baeec5235\", \"metrics_python_tests\": \"96353807ac898699347f94dd0259309b87f0a110\", \"midi_unittests\": \"4738d2f068dc255a26cf19b32f9a8b7d57fa72e0\", \"mojo_core_unittests\": \"ee3dd22f5b776cb4a02c7b9bfce6558782ce01d7\", \"mojo_unittests\": \"5d1040a4fbf7ba3c8939ce32dea1d1fb37d6b096\", \"nacl_helper_nonsfi_unittests\": \"d2cac5c5c0abb5acad087c67a3946f3e29e5f161\", \"nacl_loader_unittests\": \"8c7e766f3fdc2792a063e8f3bfb89a642ccb792c\", \"native_theme_unittests\": \"1f5a7db72ee903b8a5d084a59b28fb904374a102\", \"net_unittests\": \"6ae0f6602916103a38321efa11b8a877957fe0c5\", \"openscreen_unittests\": \"41a849cff31483c9816ccfe748d82ef4cdcaef68\", \"pdf_unittests\": \"2f99e9075c570249a2f01f0a2b3783a4c957a451\", \"perfetto_unittests\": \"0a533ddb7fab3fd2d0bc2224810d0e7e6a00869b\", \"ppapi_unittests\": \"385b78681c83b5e83913a3b28c7921b6ac1f3ed2\", \"printing_unittests\": \"2e48485ca0e4390ba95e09c193580dbdc2148cfd\", \"remoting_unittests\": \"a2032548e5cc8290b1ded33221a8e7921b2aa527\", \"sandbox_linux_unittests\": \"e445228374e75706c46e1224f0b742c061828cbe\", \"service_manager_unittests\": \"f87cbdc0f8687982eef559b3090d711e8168fde3\", \"services_unittests\": \"fdfeac05552324cfb83900c42d28bcdb5bce5394\", \"shell_dialogs_unittests\": \"faa5f14abac7e7950fc60ec06e24d4a395324cd6\", \"skia_unittests\": \"cb941ec280ca3a7adc7860987bae6614bd8d776c\", \"snapshot_unittests\": \"2913a1b46f8cb7526693fcd1d898f7197fecc9cc\", \"sql_unittests\": \"7cc3bcf1f708bab38af23cd738ca6c1d314cb1f0\", \"storage_unittests\": \"dfd0d8dc8288f772e88bfb4ca1b71afeff07120f\", \"sync_integration_tests\": \"f523ae6e42420d4aab0e86f9128af6e568946b60\", \"telemetry_gpu_unittests\": \"b7786512c642dcffeed50c5aad93823a6402582a\", \"telemetry_perf_unittests\": \"0489abe329811c887eb710a3c932ae835af18bca\", \"telemetry_unittests\": \"ba9eff2251cd1f2fbc7115260bef731eb4b0862b\", \"traffic_annotation_auditor_unittests\": \"9062b8991935f8dbf5f35c6209a125f017bd0657\", \"ui_base_unittests\": \"6b8884a5d513f2cab263b7e541314375173cc3dc\", \"ui_touch_selection_unittests\": \"6df4c2420bc5f5df459933c440bfb1cbe759ccb4\", \"unit_tests\": \"c4b48ed7d8c867be44843eb1b599a125d10c1b25\", \"url_unittests\": \"2687d5ec68af0d6642b22d86177ab436dc3c597f\", \"views_perftests\": \"ab3c4564d8cb8e6b846ad6f36ae18ba7281dba9d\", \"views_unittests\": \"7b9536efceddac523d0a23079be88e0ab2e33348\", \"viz_unittests\": \"f767b390a874a88b3c2a0fcbced0dabe9e483e90\", \"vr_common_unittests\": \"adbad1e9c74af1c922de522e5522a718dd62e981\", \"vr_pixeltests\": \"b9bcb49f38576880944de5eab25accd2298c95d9\", \"webdriver_wpt_tests\": \"d195af3c12b824a820512f88d4e7ca73846bcaf0\", \"weblayer_browsertests\": \"85f2132c9ee5edcd116e37a98531a795766ca7bd\", \"weblayer_unittests\": \"bca3ea820c99ca5592b0b8cecf318e184b5d0195\", \"wm_unittests\": \"c2e211e309f4c7605a94bf11b68ea25635a80fe5\", \"wtf_unittests\": \"248f7617afef6441d3d4e0d070c01b537bcabfce\", \"x11_unittests\": \"fe141a5327b998e680ad3fa674768c7930b566c3\", \"xr_browser_tests\": \"66488af37fc819db5363dc90aa9438f845dc6e88\", \"zlib_unittests\": \"5607695d794dea9e5bd446041e417fa2b96e43cf\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_25c22b29ff9525bbfd333bb12e92a9faf5d35886dc9a7dacce03d872c45df5d1_v2\", \"builder_4026221a727cf2e856e94035b8eeb49c4c65d62e8974e693170551540c198531_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_97036e5ee279fe6b8fb101acad8b19632bb6faa5e992f50a2e031a6b74482977_v2\", \"builder_a9a41095618141e4757e131cf792803c0a27ecf4e01eb5d0d372c002309e764f_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-197-8brl\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613775434823084",
"status": "COMPLETED",
"status_changed_ts": "1613778622598306",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180762",
"builder:Linux Builder (dbg)",
"buildset:commit/git/46f0e936056d2a4d4794afe4b286c5e30ea6a2d8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/46f0e936056d2a4d4794afe4b286c5e30ea6a2d8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020257589784299840",
"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/8854827527802314752/+/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:51d5547968485d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613778622691710",
"url": "https://ci.chromium.org/b/8854827527802314752",
"utcnow_ts": "1613778627996346"
}
}
[23:50:28.019] Invocation finished in 53m16.556991031s with status SUCCEEDED