[16:15:22.376] New invocation is queued and will start shortly
[16:15:22.376] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[16:15:23.447] Starting the invocation (attempt 1)
[16:15:23.474] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/23dc248ef02366ab33d3c2f99936ed75b1505b24"
[16:15:23.474] Reconstructed gitiles commit from tags
[16:15:23.474] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:15:23.474] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:15:23.475] Buildbucket request:
{
"requestId": "8927692770340753488",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6f6bbd2049fbb5b06f7b1745d61d93387b7fa270a19cfd15984814dc93777eed/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f6d33667e95860bb728defdad1dbe039224316a4",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8927692770340753488",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "57ac76bb3c7e628afd70422c9bc20ddd22a9415cf3809779db200ca4d4dc51bc/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f6d33667e95860bb728defdad1dbe039224316a4",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "d5e2cbd01a17edeb56aad2f161c76ce3f854676f"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d5e2cbd01a17edeb56aad2f161c76ce3f854676f",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "77611f2f-b2b3-4a25-856b-00eb27c33bb3",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "267eb66ef8c89f6a7522b7deb6444733ce792be4c318a6b811b763c636a535b7/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f6d33667e95860bb728defdad1dbe039224316a4",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9b154dad5b465bfc45b962488682ed4f95e049a3"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9b154dad5b465bfc45b962488682ed4f95e049a3",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "643ad47c-fe20-4e4f-ba1e-ebb6e4c4a5f0",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e594ab4eac9784cbced154009391e0dac1977e9edeb6685acd99bf71af54428b/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f6d33667e95860bb728defdad1dbe039224316a4",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "4a2a6397f11da7c15a73d19fb1e6c9dcd1ceb5af"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4a2a6397f11da7c15a73d19fb1e6c9dcd1ceb5af",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "fc329460-4d88-4d36-b27f-7d8a80d6bcb7",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6f6bbd2049fbb5b06f7b1745d61d93387b7fa270a19cfd15984814dc93777eed/577"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f6d33667e95860bb728defdad1dbe039224316a4",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "23dc248ef02366ab33d3c2f99936ed75b1505b24"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/23dc248ef02366ab33d3c2f99936ed75b1505b24",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d03e404f-84e4-48af-9abe-71899b826ac9",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "23dc248ef02366ab33d3c2f99936ed75b1505b24"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "23dc248ef02366ab33d3c2f99936ed75b1505b24",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8927692770340753488"
},
{
"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"
}
}
[16:15:24.170] Scheduled build:
{
"id": "8762262708443486513",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-08T16:15:23.561385066Z",
"updateTime": "2023-12-08T16:15:23.561385066Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "23dc248ef02366ab33d3c2f99936ed75b1505b24",
"ref": "refs/heads/main"
}
}
}
[16:15:24.170] Task URL: https://cr-buildbucket.appspot.com/build/8762262708443486513
[16:15:24.170] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:2:0) after 5m13s
[16:15:25.111] Received PubSub notification, asking Buildbucket for the build status
[16:15:25.142] Build status: SCHEDULED
[16:16:29.765] Received PubSub notification, asking Buildbucket for the build status
[16:16:29.829] Build status: STARTED
[16:20:37.277] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:2:0)
[16:20:37.363] Build status: STARTED
[16:20:37.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:5:0) after 1m20s
[16:21:57.387] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:5:0)
[16:21:57.450] Build status: STARTED
[16:21:57.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:6:0) after 7m15s
[16:29:12.484] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:6:0)
[16:29:12.515] Build status: STARTED
[16:29:12.515] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:7:0) after 5m28s
[16:34:40.532] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:7:0)
[16:34:40.562] Build status: STARTED
[16:34:40.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:8:0) after 4m40s
[16:39:20.587] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:8:0)
[16:39:20.610] Build status: STARTED
[16:39:20.610] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:9:0) after 4m3s
[16:43:23.640] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:9:0)
[16:43:23.663] Build status: STARTED
[16:43:23.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:10:0) after 6m12s
[16:49:35.796] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:10:0)
[16:49:35.828] Build status: STARTED
[16:49:35.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:11:0) after 7m30s
[16:57:05.854] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:11:0)
[16:57:05.875] Build status: STARTED
[16:57:05.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:12:0) after 1m15s
[16:58:20.897] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:12:0)
[16:58:20.926] Build status: STARTED
[16:58:20.926] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:13:0) after 2m6s
[17:00:26.972] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:13:0)
[17:00:27.010] Build status: STARTED
[17:00:27.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:14:0) after 4m24s
[17:04:51.033] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:14:0)
[17:04:51.109] Build status: STARTED
[17:04:51.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:15:0) after 3m51s
[17:08:43.451] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:15:0)
[17:08:43.489] Build status: STARTED
[17:08:43.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:16:0) after 8m3s
[17:16:46.522] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:16:0)
[17:16:46.544] Build status: STARTED
[17:16:46.544] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:17:0) after 1m27s
[17:18:13.570] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:17:0)
[17:18:13.593] Build status: STARTED
[17:18:13.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:18:0) after 4m3s
[17:22:16.829] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:18:0)
[17:22:16.942] Build status: STARTED
[17:22:16.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:19:0) after 4m50s
[17:27:06.930] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:19:0)
[17:27:06.949] Build status: STARTED
[17:27:06.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:20:0) after 6m7s
[17:33:13.974] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:20:0)
[17:33:13.998] Build status: STARTED
[17:33:13.998] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:21:0) after 7m7s
[17:40:21.143] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:21:0)
[17:40:21.182] Build status: STARTED
[17:40:21.182] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:22:0) after 7m7s
[17:47:28.259] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:22:0)
[17:47:28.284] Build status: STARTED
[17:47:28.284] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:23:0) after 3m57s
[17:51:26.378] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:23:0)
[17:51:26.396] Build status: STARTED
[17:51:26.396] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:24:0) after 8m13s
[17:59:39.401] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:24:0)
[17:59:39.423] Build status: STARTED
[17:59:39.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:25:0) after 1m24s
[18:01:03.594] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:25:0)
[18:01:03.654] Build status: STARTED
[18:01:03.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:26:0) after 3m57s
[18:05:00.681] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:26:0)
[18:05:00.701] Build status: STARTED
[18:05:00.701] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:27:0) after 4m5s
[18:09:05.719] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:27:0)
[18:09:05.762] Build status: STARTED
[18:09:05.762] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:28:0) after 4m32s
[18:13:37.769] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:28:0)
[18:13:37.817] Build status: STARTED
[18:13:37.817] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8927692770340753488:29:0) after 9m20s
[18:14:17.414] Received PubSub notification, asking Buildbucket for the build status
[18:14:17.477] Build:
{
"id": "8762262708443486513",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-12-08T16:15:23.561385066Z",
"startTime": "2023-12-08T16:16:28.982718Z",
"endTime": "2023-12-08T18:14:16.353393Z",
"updateTime": "2023-12-08T18:14:16.353393Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "23dc248ef02366ab33d3c2f99936ed75b1505b24",
"ref": "refs/heads/main"
}
}
}
[18:14:17.477] Invocation finished in 1h58m55.109206253s with status FAILED