[10:41:24.181] New invocation is queued and will start shortly
[10:41:24.181] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[10:41:25.464] Starting the invocation (attempt 1)
[10:41:25.494] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f93aa5157a3317b24cff660ac972814ee9ed4dbc"
[10:41:25.494] Reconstructed gitiles commit from tags
[10:41:25.494] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:41:25.494] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:41:25.495] Buildbucket request:
{
"requestId": "8921734382134390032",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "8965b479e828bc148ff5c5320ef7d3e28f45d30bdf8bf6107483bf142c0bcf6f/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "be6dd32c4cfd13da74dc3de5d899f4728f8f03ed",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8921734382134390032",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "12b0cd1f39bc7754ede48a238d4587f5502d36df107bd6f0f4fd264715120dcd/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "be6dd32c4cfd13da74dc3de5d899f4728f8f03ed",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "7f40c5cc4e15a0a67b031f13370afc342a5dc14b"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7f40c5cc4e15a0a67b031f13370afc342a5dc14b",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "c3c214e6-fbc0-4e9e-943e-90ec9f77bebe",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "62b75a6f6702794b778ca9b7772be254358badd4eef89d2affbac128b45bffba/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "be6dd32c4cfd13da74dc3de5d899f4728f8f03ed",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "074f7c2235a7d39f59f5c4d85b8fb87d3459b90d"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/074f7c2235a7d39f59f5c4d85b8fb87d3459b90d",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "72cac9b7-b72c-4a87-948d-8c8488fd9568",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "8965b479e828bc148ff5c5320ef7d3e28f45d30bdf8bf6107483bf142c0bcf6f/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "be6dd32c4cfd13da74dc3de5d899f4728f8f03ed",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f93aa5157a3317b24cff660ac972814ee9ed4dbc"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f93aa5157a3317b24cff660ac972814ee9ed4dbc",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "612d9aa6-4daa-480d-bd09-c7e79c133faa",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f93aa5157a3317b24cff660ac972814ee9ed4dbc"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f93aa5157a3317b24cff660ac972814ee9ed4dbc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8921734382134390032"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:41:25.936] Scheduled build:
{
"id": "8756304320039981649",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-12T10:41:25.548792597Z",
"updateTime": "2024-02-12T10:41:25.548792597Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f93aa5157a3317b24cff660ac972814ee9ed4dbc",
"ref": "refs/heads/main"
}
}
}
[10:41:25.936] Task URL: https://cr-buildbucket.appspot.com/build/8756304320039981649
[10:41:25.936] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:2:0) after 4m55s
[10:41:26.898] Received PubSub notification, asking Buildbucket for the build status
[10:41:26.984] Build status: SCHEDULED
[10:41:56.382] Received PubSub notification, asking Buildbucket for the build status
[10:41:56.463] Build status: STARTED
[10:46:20.956] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:2:0)
[10:46:20.972] Build status: STARTED
[10:46:20.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:5:0) after 6m44s
[10:53:05.281] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:5:0)
[10:53:05.392] Build status: STARTED
[10:53:05.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:6:0) after 8m55s
[11:02:00.418] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:6:0)
[11:02:00.456] Build status: STARTED
[11:02:00.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:7:0) after 8m56s
[11:10:56.630] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:7:0)
[11:10:56.656] Build status: STARTED
[11:10:56.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:8:0) after 2m28s
[11:13:24.719] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:8:0)
[11:13:24.742] Build status: STARTED
[11:13:24.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:9:0) after 1m9s
[11:14:33.759] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:9:0)
[11:14:33.790] Build status: STARTED
[11:14:33.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:10:0) after 5m13s
[11:19:46.935] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:10:0)
[11:19:46.979] Build status: STARTED
[11:19:46.979] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:11:0) after 3m26s
[11:23:13.107] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:11:0)
[11:23:13.160] Build status: STARTED
[11:23:13.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:12:0) after 3m30s
[11:26:43.368] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:12:0)
[11:26:43.411] Build status: STARTED
[11:26:43.411] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:13:0) after 7m47s
[11:34:30.427] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:13:0)
[11:34:30.444] Build status: STARTED
[11:34:30.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:14:0) after 5m57s
[11:40:27.506] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:14:0)
[11:40:27.530] Build status: STARTED
[11:40:27.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:15:0) after 3m19s
[11:43:46.532] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:15:0)
[11:43:46.556] Build status: STARTED
[11:43:46.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:16:0) after 6m3s
[11:49:49.645] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:16:0)
[11:49:49.675] Build status: STARTED
[11:49:49.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:17:0) after 8m24s
[11:58:13.866] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:17:0)
[11:58:13.886] Build status: STARTED
[11:58:13.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:18:0) after 1m43s
[11:59:56.904] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:18:0)
[11:59:56.924] Build status: STARTED
[11:59:56.924] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:19:0) after 2m7s
[12:02:04.099] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:19:0)
[12:02:04.259] Build status: STARTED
[12:02:04.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:20:0) after 4m53s
[12:06:57.459] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:20:0)
[12:06:57.475] Build status: STARTED
[12:06:57.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:21:0) after 8m11s
[12:15:08.537] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:21:0)
[12:15:08.564] Build status: STARTED
[12:15:08.564] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:22:0) after 7m30s
[12:22:38.613] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:22:0)
[12:22:38.632] Build status: STARTED
[12:22:38.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:23:0) after 8m5s
[12:30:43.752] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:23:0)
[12:30:43.777] Build status: STARTED
[12:30:43.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:24:0) after 9m56s
[12:40:39.794] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:24:0)
[12:40:39.818] Build status: STARTED
[12:40:39.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:25:0) after 3m54s
[12:44:33.938] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:25:0)
[12:44:33.966] Build status: STARTED
[12:44:33.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:26:0) after 3m22s
[12:47:56.262] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:26:0)
[12:47:56.305] Build status: STARTED
[12:47:56.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8921734382134390032:27:0) after 2m9s
[12:48:46.118] Received PubSub notification, asking Buildbucket for the build status
[12:48:46.135] Build:
{
"id": "8756304320039981649",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-12T10:41:25.548792597Z",
"startTime": "2024-02-12T10:41:54.288163Z",
"endTime": "2024-02-12T12:48:45.299735Z",
"updateTime": "2024-02-12T12:48:45.299735Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f93aa5157a3317b24cff660ac972814ee9ed4dbc",
"ref": "refs/heads/main"
}
}
}
[12:48:46.135] Invocation finished in 2h7m21.967864977s with status SUCCEEDED