[15:56:28.565] New invocation is queued and will start shortly
[15:56:28.565] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[15:56:29.651] Starting the invocation (attempt 1)
[15:56:29.679] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f1200ca7ac88c6ff9aa4fe3b560cf326dc3d4e25"
[15:56:29.679] Reconstructed gitiles commit from tags
[15:56:29.679] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:56:29.679] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:56:29.679] Buildbucket request:
{
"requestId": "8927784556191179664",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "362b420cccb911b1333ced33af3c8d22fefccf391062ab154a3508be3725d6ef/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "3120ece573b5df9399f75e741e86d99aa556e2d9",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8927784556191179664",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "1bb490396b5d0e507d768b7fa023f39897c2ac7822b3db329624cce69a4f8ed4/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "3917c00d7487fa5b0e3b02d1251aaffacc194564",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f17e76697289e6a54e89298a49f12b6799dd3e1a"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f17e76697289e6a54e89298a49f12b6799dd3e1a",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "bc0c5f82-cbcd-4f5c-8be3-320154dad967",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "cdca9de388e73fbfc7975508868c3990855b784460dcccdb4cfd860a3c6d0ace/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "3120ece573b5df9399f75e741e86d99aa556e2d9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f2f077898f09f80d09e0506fef25bc605e20ba34"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f2f077898f09f80d09e0506fef25bc605e20ba34",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "25567226-6d32-452c-8822-c94e4f111bc9",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "04cfc1446ef4bb3957d43b0d9c096bcc4734378ec9c77faf98497f2257e0ebc0/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "3120ece573b5df9399f75e741e86d99aa556e2d9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "5384fb3d407c8bf4f34117baf60ddcb273a4b6d2"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5384fb3d407c8bf4f34117baf60ddcb273a4b6d2",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "1617a248-0148-4c6f-9957-e5380c48f13e",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "9f755a7306cce3c7bed54fb9eb71bb84665f726afffc060dd4dc804ade2a769b/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "3120ece573b5df9399f75e741e86d99aa556e2d9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "155a013225203359af132b31bb150f39608876c7"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/155a013225203359af132b31bb150f39608876c7",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "0894b614-2285-4655-adca-543a25f86466",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "362b420cccb911b1333ced33af3c8d22fefccf391062ab154a3508be3725d6ef/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "3120ece573b5df9399f75e741e86d99aa556e2d9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f1200ca7ac88c6ff9aa4fe3b560cf326dc3d4e25"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f1200ca7ac88c6ff9aa4fe3b560cf326dc3d4e25",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "6bcc5fc7-d4c5-45b3-bf4e-1c8c58fcda89",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f1200ca7ac88c6ff9aa4fe3b560cf326dc3d4e25"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f1200ca7ac88c6ff9aa4fe3b560cf326dc3d4e25",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8927784556191179664"
},
{
"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"
}
}
[15:56:30.692] Scheduled build:
{
"id": "8762354494166199201",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-07T15:56:29.874221682Z",
"updateTime": "2023-12-07T15:56:29.874221682Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f1200ca7ac88c6ff9aa4fe3b560cf326dc3d4e25",
"ref": "refs/heads/main"
}
}
}
[15:56:30.692] Task URL: https://cr-buildbucket.appspot.com/build/8762354494166199201
[15:56:30.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:2:0) after 5m39s
[15:56:31.334] Received PubSub notification, asking Buildbucket for the build status
[15:56:31.351] Build status: SCHEDULED
[15:59:41.539] Received PubSub notification, asking Buildbucket for the build status
[15:59:41.708] Build status: STARTED
[16:02:09.816] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:2:0)
[16:02:09.848] Build status: STARTED
[16:02:09.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:5:0) after 2m34s
[16:04:43.900] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:5:0)
[16:04:43.929] Build status: STARTED
[16:04:43.929] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:6:0) after 1m15s
[16:05:58.987] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:6:0)
[16:05:59.014] Build status: STARTED
[16:05:59.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:7:0) after 5m12s
[16:11:11.096] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:7:0)
[16:11:11.136] Build status: STARTED
[16:11:11.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:8:0) after 4m51s
[16:16:02.141] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:8:0)
[16:16:02.171] Build status: STARTED
[16:16:02.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:9:0) after 2m23s
[16:18:25.186] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:9:0)
[16:18:25.209] Build status: STARTED
[16:18:25.209] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:10:0) after 2m25s
[16:20:50.233] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:10:0)
[16:20:50.254] Build status: STARTED
[16:20:50.254] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:11:0) after 7m42s
[16:28:32.380] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:11:0)
[16:28:32.404] Build status: STARTED
[16:28:32.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:12:0) after 3m13s
[16:31:45.420] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:12:0)
[16:31:45.440] Build status: STARTED
[16:31:45.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:13:0) after 6m15s
[16:38:00.787] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:13:0)
[16:38:00.812] Build status: STARTED
[16:38:00.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:14:0) after 9m28s
[16:47:28.897] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:14:0)
[16:47:28.919] Build status: STARTED
[16:47:28.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:15:0) after 2m9s
[16:49:37.993] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:15:0)
[16:49:38.014] Build status: STARTED
[16:49:38.014] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:16:0) after 6m44s
[16:56:22.034] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:16:0)
[16:56:22.057] Build status: STARTED
[16:56:22.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:17:0) after 9m28s
[17:05:50.128] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:17:0)
[17:05:50.144] Build status: STARTED
[17:05:50.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:18:0) after 1m16s
[17:07:06.201] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:18:0)
[17:07:06.227] Build status: STARTED
[17:07:06.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:19:0) after 1m21s
[17:08:27.274] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:19:0)
[17:08:27.301] Build status: STARTED
[17:08:27.301] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:20:0) after 3m43s
[17:12:10.348] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:20:0)
[17:12:10.437] Build status: STARTED
[17:12:10.437] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:21:0) after 1m42s
[17:13:52.507] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:21:0)
[17:13:52.533] Build status: STARTED
[17:13:52.533] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:22:0) after 6m3s
[17:19:55.628] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:22:0)
[17:19:55.645] Build status: STARTED
[17:19:55.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:23:0) after 4m9s
[17:24:04.624] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:23:0)
[17:24:04.661] Build status: STARTED
[17:24:04.661] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:24:0) after 6m20s
[17:30:24.777] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:24:0)
[17:30:24.814] Build status: STARTED
[17:30:24.814] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:25:0) after 9m41s
[17:40:05.832] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:25:0)
[17:40:05.850] Build status: STARTED
[17:40:05.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:26:0) after 2m36s
[17:42:41.857] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:26:0)
[17:42:41.879] Build status: STARTED
[17:42:41.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:27:0) after 1m19s
[17:44:00.902] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:27:0)
[17:44:00.978] Build status: STARTED
[17:44:00.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:28:0) after 2m16s
[17:46:16.995] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:28:0)
[17:46:17.066] Build status: STARTED
[17:46:17.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:29:0) after 8m0s
[17:54:17.104] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:29:0)
[17:54:17.130] Build status: STARTED
[17:54:17.130] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:30:0) after 7m33s
[18:01:50.156] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:30:0)
[18:01:50.193] Build status: STARTED
[18:01:50.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:31:0) after 7m23s
[18:09:13.220] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:31:0)
[18:09:13.288] Build status: STARTED
[18:09:13.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927784556191179664:32:0) after 5m56s
[18:13:22.689] Received PubSub notification, asking Buildbucket for the build status
[18:13:22.727] Build:
{
"id": "8762354494166199201",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-07T15:56:29.874221682Z",
"startTime": "2023-12-07T15:59:40.841132Z",
"endTime": "2023-12-07T18:13:21.850417Z",
"updateTime": "2023-12-07T18:13:21.850417Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f1200ca7ac88c6ff9aa4fe3b560cf326dc3d4e25",
"ref": "refs/heads/main"
}
}
}
[18:13:22.728] Invocation finished in 2h16m54.16743642s with status FAILED