[20:11:09.652] New invocation is queued and will start shortly
[20:11:09.652] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[20:11:10.880] Starting the invocation (attempt 1)
[20:11:10.905] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2414e5cb9efa289b841bb814d20c7eb6f355fa4d"
[20:11:10.905] Reconstructed gitiles commit from tags
[20:11:10.905] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:11:10.905] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:11:10.905] Buildbucket request:
{
"requestId": "8930758232700880608",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "3e85088fa364b95c67e31998895c164c313220063612c07a3a20af323aec5d9e/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ccca4ca8475db6fc118e7f59d7772971e334c69c",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8930758232700880608",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "992d405d193045ee9e2a2875b6ef0c6ee173d4c62c77440fc3935d79b29a13fc/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ccca4ca8475db6fc118e7f59d7772971e334c69c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "1bb48c440b9299d251ec47d220f1c3a8db523041"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1bb48c440b9299d251ec47d220f1c3a8db523041",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "770ffdb1-812d-4749-a58f-f3ed9e7174da",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e99d121a942f95ce1fe74f3f1aa2e70ca545864f0aa96b8eccb42730e9a7b03c/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ccca4ca8475db6fc118e7f59d7772971e334c69c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "422ffc525a064c2397a57bbfa90c5446bd0f0aee"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/422ffc525a064c2397a57bbfa90c5446bd0f0aee",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "c03205a7-342e-44db-8ac5-8123f37cf278",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "3e85088fa364b95c67e31998895c164c313220063612c07a3a20af323aec5d9e/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ccca4ca8475db6fc118e7f59d7772971e334c69c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2414e5cb9efa289b841bb814d20c7eb6f355fa4d"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2414e5cb9efa289b841bb814d20c7eb6f355fa4d",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "2151ba8a-41c4-48b7-9c4a-7ba160323975",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2414e5cb9efa289b841bb814d20c7eb6f355fa4d"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2414e5cb9efa289b841bb814d20c7eb6f355fa4d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8930758232700880608"
},
{
"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"
}
}
[20:11:11.611] Scheduled build:
{
"id": "8765328170568714801",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-04T20:11:11.064911878Z",
"updateTime": "2023-11-04T20:11:11.064911878Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2414e5cb9efa289b841bb814d20c7eb6f355fa4d",
"ref": "refs/heads/main"
}
}
}
[20:11:11.611] Task URL: https://cr-buildbucket.appspot.com/build/8765328170568714801
[20:11:11.611] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:2:0) after 8m13s
[20:11:12.495] Received PubSub notification, asking Buildbucket for the build status
[20:11:12.527] Build status: SCHEDULED
[20:11:13.064] Received PubSub notification, asking Buildbucket for the build status
[20:11:13.094] Build status: STARTED
[20:19:24.603] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:2:0)
[20:19:24.637] Build status: STARTED
[20:19:24.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:5:0) after 2m56s
[20:22:20.696] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:5:0)
[20:22:20.719] Build status: STARTED
[20:22:20.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:6:0) after 4m32s
[20:26:52.770] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:6:0)
[20:26:52.793] Build status: STARTED
[20:26:52.793] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:7:0) after 3m15s
[20:30:07.845] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:7:0)
[20:30:07.876] Build status: STARTED
[20:30:07.876] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:8:0) after 6m33s
[20:36:40.957] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:8:0)
[20:36:40.977] Build status: STARTED
[20:36:40.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:9:0) after 6m15s
[20:42:56.098] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:9:0)
[20:42:56.117] Build status: STARTED
[20:42:56.117] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:10:0) after 3m53s
[20:46:49.139] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:10:0)
[20:46:49.164] Build status: STARTED
[20:46:49.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:11:0) after 3m32s
[20:50:21.184] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:11:0)
[20:50:21.214] Build status: STARTED
[20:50:21.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:12:0) after 3m18s
[20:53:39.412] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:12:0)
[20:53:39.432] Build status: STARTED
[20:53:39.432] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:13:0) after 6m56s
[21:00:35.454] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:13:0)
[21:00:35.503] Build status: STARTED
[21:00:35.503] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:14:0) after 4m31s
[21:05:06.714] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:14:0)
[21:05:06.736] Build status: STARTED
[21:05:06.736] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:15:0) after 7m38s
[21:12:44.823] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:15:0)
[21:12:44.852] Build status: STARTED
[21:12:44.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:16:0) after 7m43s
[21:20:27.868] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:16:0)
[21:20:27.944] Build status: STARTED
[21:20:27.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:17:0) after 2m27s
[21:22:55.121] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:17:0)
[21:22:55.137] Build status: STARTED
[21:22:55.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:18:0) after 5m3s
[21:27:58.160] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:18:0)
[21:27:58.218] Build status: STARTED
[21:27:58.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:19:0) after 1m36s
[21:29:34.231] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:19:0)
[21:29:34.249] Build status: STARTED
[21:29:34.249] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:20:0) after 4m57s
[21:34:31.524] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:20:0)
[21:34:31.604] Build status: STARTED
[21:34:31.604] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:21:0) after 9m39s
[21:44:10.713] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:21:0)
[21:44:10.734] Build status: STARTED
[21:44:10.734] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:22:0) after 9m15s
[21:53:25.771] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:22:0)
[21:53:25.803] Build status: STARTED
[21:53:25.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:23:0) after 3m53s
[21:57:18.964] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:23:0)
[21:57:18.993] Build status: STARTED
[21:57:18.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8930758232700880608:24:0) after 8m59s
[22:05:28.217] Received PubSub notification, asking Buildbucket for the build status
[22:05:28.239] Build:
{
"id": "8765328170568714801",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-11-04T20:11:11.064911878Z",
"startTime": "2023-11-04T20:11:12.189040Z",
"endTime": "2023-11-04T22:05:27.318933Z",
"updateTime": "2023-11-04T22:05:27.318933Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2414e5cb9efa289b841bb814d20c7eb6f355fa4d",
"ref": "refs/heads/main"
}
}
}
[22:05:28.239] Invocation finished in 1h54m18.591822146s with status FAILED