[21:31:49.801] New invocation is queued and will start shortly
[21:31:50.911] Starting the invocation (attempt 1)
[21:31:50.945] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/659192b1843c4af180700783caca4cdc7afa3eab"
[21:31:50.945] Popped gitiles commit info from properties and tags
[21:31:50.945] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:31:50.945] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:31:50.946] Buildbucket request:
{
"requestId": "8899134816173612624",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8899134816173612624",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7f2e937469a8cec3fe977bf41ad2dfb9b4ce648a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7f2e937469a8cec3fe977bf41ad2dfb9b4ce648a",
"title": "7f2e937469a8cec3fe977bf41ad2dfb9b4ce648a",
"url": "https://llvm.googlesource.com/llvm-project/+/7f2e937469a8cec3fe977bf41ad2dfb9b4ce648a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f148d5791bae39fdbe6c97559c82b6c6ab64a100"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f148d5791bae39fdbe6c97559c82b6c6ab64a100",
"title": "f148d5791bae39fdbe6c97559c82b6c6ab64a100",
"url": "https://llvm.googlesource.com/llvm-project/+/f148d5791bae39fdbe6c97559c82b6c6ab64a100"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "98e838a890191b9250ad33741a1c121a9591caa3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@98e838a890191b9250ad33741a1c121a9591caa3",
"title": "98e838a890191b9250ad33741a1c121a9591caa3",
"url": "https://llvm.googlesource.com/llvm-project/+/98e838a890191b9250ad33741a1c121a9591caa3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2bff9d9ffe3a4813961c1cf3af2e9ac5a20190bd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2bff9d9ffe3a4813961c1cf3af2e9ac5a20190bd",
"title": "2bff9d9ffe3a4813961c1cf3af2e9ac5a20190bd",
"url": "https://llvm.googlesource.com/llvm-project/+/2bff9d9ffe3a4813961c1cf3af2e9ac5a20190bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e669bbbb7265a7d4d59bac2d3889194efa167ea8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e669bbbb7265a7d4d59bac2d3889194efa167ea8",
"title": "e669bbbb7265a7d4d59bac2d3889194efa167ea8",
"url": "https://llvm.googlesource.com/llvm-project/+/e669bbbb7265a7d4d59bac2d3889194efa167ea8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b55c52c047a167f42abbde9a33356cfb96b82c7f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b55c52c047a167f42abbde9a33356cfb96b82c7f",
"title": "b55c52c047a167f42abbde9a33356cfb96b82c7f",
"url": "https://llvm.googlesource.com/llvm-project/+/b55c52c047a167f42abbde9a33356cfb96b82c7f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d5746d73cedcf7a593dc4b4f2ce2465e2d45750b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d5746d73cedcf7a593dc4b4f2ce2465e2d45750b",
"title": "d5746d73cedcf7a593dc4b4f2ce2465e2d45750b",
"url": "https://llvm.googlesource.com/llvm-project/+/d5746d73cedcf7a593dc4b4f2ce2465e2d45750b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7437f3ef7e2c56f0f54154bba1260150bbf7a59e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7437f3ef7e2c56f0f54154bba1260150bbf7a59e",
"title": "7437f3ef7e2c56f0f54154bba1260150bbf7a59e",
"url": "https://llvm.googlesource.com/llvm-project/+/7437f3ef7e2c56f0f54154bba1260150bbf7a59e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4c4b93dcb9d8f2400891ffbe79ff55dc9e70b71b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4c4b93dcb9d8f2400891ffbe79ff55dc9e70b71b",
"title": "4c4b93dcb9d8f2400891ffbe79ff55dc9e70b71b",
"url": "https://llvm.googlesource.com/llvm-project/+/4c4b93dcb9d8f2400891ffbe79ff55dc9e70b71b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "65cf7afb6d9d8c6137b90d909ee4fcf251439f48"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@65cf7afb6d9d8c6137b90d909ee4fcf251439f48",
"title": "65cf7afb6d9d8c6137b90d909ee4fcf251439f48",
"url": "https://llvm.googlesource.com/llvm-project/+/65cf7afb6d9d8c6137b90d909ee4fcf251439f48"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e56e9dd8adca2e86f22783bf5e745ee1ba7ead5f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e56e9dd8adca2e86f22783bf5e745ee1ba7ead5f",
"title": "e56e9dd8adca2e86f22783bf5e745ee1ba7ead5f",
"url": "https://llvm.googlesource.com/llvm-project/+/e56e9dd8adca2e86f22783bf5e745ee1ba7ead5f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "825f9cb1b31aa91d23eba803003897490de74a20"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@825f9cb1b31aa91d23eba803003897490de74a20",
"title": "825f9cb1b31aa91d23eba803003897490de74a20",
"url": "https://llvm.googlesource.com/llvm-project/+/825f9cb1b31aa91d23eba803003897490de74a20"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "76196998e25b98d81abc437708622261810782ca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@76196998e25b98d81abc437708622261810782ca",
"title": "76196998e25b98d81abc437708622261810782ca",
"url": "https://llvm.googlesource.com/llvm-project/+/76196998e25b98d81abc437708622261810782ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "709abacdc350d63c61888607edb28ce272daa0a0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@709abacdc350d63c61888607edb28ce272daa0a0",
"title": "709abacdc350d63c61888607edb28ce272daa0a0",
"url": "https://llvm.googlesource.com/llvm-project/+/709abacdc350d63c61888607edb28ce272daa0a0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "47d9ca87b0385975e8b14f5df06886ddd6057b17"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@47d9ca87b0385975e8b14f5df06886ddd6057b17",
"title": "47d9ca87b0385975e8b14f5df06886ddd6057b17",
"url": "https://llvm.googlesource.com/llvm-project/+/47d9ca87b0385975e8b14f5df06886ddd6057b17"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b88d94caba518bc63c25fe476c4de3d9b0bbd2c0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b88d94caba518bc63c25fe476c4de3d9b0bbd2c0",
"title": "b88d94caba518bc63c25fe476c4de3d9b0bbd2c0",
"url": "https://llvm.googlesource.com/llvm-project/+/b88d94caba518bc63c25fe476c4de3d9b0bbd2c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6e02e19cd382f1524eaedd374ac33872cb565f67"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6e02e19cd382f1524eaedd374ac33872cb565f67",
"title": "6e02e19cd382f1524eaedd374ac33872cb565f67",
"url": "https://llvm.googlesource.com/llvm-project/+/6e02e19cd382f1524eaedd374ac33872cb565f67"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "659192b1843c4af180700783caca4cdc7afa3eab"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@659192b1843c4af180700783caca4cdc7afa3eab",
"title": "659192b1843c4af180700783caca4cdc7afa3eab",
"url": "https://llvm.googlesource.com/llvm-project/+/659192b1843c4af180700783caca4cdc7afa3eab"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "659192b1843c4af180700783caca4cdc7afa3eab",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8899134816173612624"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[21:31:51.953] Scheduled build:
{
"id": "8733704754215852481",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-18T21:31:51.037245463Z",
"updateTime": "2024-10-18T21:31:51.037245463Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "659192b1843c4af180700783caca4cdc7afa3eab",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:31:51.953] Task URL: https://cr-buildbucket.appspot.com/build/8733704754215852481
[21:31:51.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:2:0) after 6m24s
[21:31:52.699] Received PubSub notification, asking Buildbucket for the build status
[21:31:52.776] Build status: SCHEDULED
[21:31:56.674] Received PubSub notification, asking Buildbucket for the build status
[21:31:56.698] Build status: STARTED
[21:38:15.972] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:2:0)
[21:38:16.038] Build status: STARTED
[21:38:16.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:5:0) after 9m29s
[21:47:45.152] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:5:0)
[21:47:45.181] Build status: STARTED
[21:47:45.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:6:0) after 1m2s
[21:48:47.204] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:6:0)
[21:48:47.221] Build status: STARTED
[21:48:47.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:7:0) after 6m31s
[21:55:18.237] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:7:0)
[21:55:18.258] Build status: STARTED
[21:55:18.258] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:8:0) after 6m48s
[22:02:06.274] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:8:0)
[22:02:06.293] Build status: STARTED
[22:02:06.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:9:0) after 2m42s
[22:04:48.312] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:9:0)
[22:04:48.328] Build status: STARTED
[22:04:48.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:10:0) after 1m57s
[22:06:45.356] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:10:0)
[22:06:45.407] Build status: STARTED
[22:06:45.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:11:0) after 1m59s
[22:08:44.461] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:11:0)
[22:08:44.493] Build status: STARTED
[22:08:44.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:12:0) after 2m54s
[22:11:39.469] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:12:0)
[22:11:39.551] Build status: STARTED
[22:11:39.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:13:0) after 9m36s
[22:21:15.572] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:13:0)
[22:21:15.589] Build status: STARTED
[22:21:15.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:14:0) after 1m4s
[22:22:19.674] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:14:0)
[22:22:19.701] Build status: STARTED
[22:22:19.701] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:15:0) after 2m30s
[22:24:49.723] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:15:0)
[22:24:49.741] Build status: STARTED
[22:24:49.741] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:16:0) after 7m50s
[22:32:39.767] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:16:0)
[22:32:39.784] Build status: STARTED
[22:32:39.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:17:0) after 2m10s
[22:34:49.803] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:17:0)
[22:34:49.824] Build status: STARTED
[22:34:49.824] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:18:0) after 2m43s
[22:37:32.822] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:18:0)
[22:37:32.866] Build status: STARTED
[22:37:32.866] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:19:0) after 7m53s
[22:45:25.885] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:19:0)
[22:45:25.902] Build status: STARTED
[22:45:25.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:20:0) after 4m52s
[22:50:18.046] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:20:0)
[22:50:18.064] Build status: STARTED
[22:50:18.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:21:0) after 8m55s
[22:59:13.332] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:21:0)
[22:59:13.363] Build status: STARTED
[22:59:13.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8899134816173612624:22:0) after 6m44s
[23:03:53.946] Received PubSub notification, asking Buildbucket for the build status
[23:03:53.962] Build:
{
"id": "8733704754215852481",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-18T21:31:51.037245463Z",
"startTime": "2024-10-18T21:31:56.483830332Z",
"endTime": "2024-10-18T23:03:53.622096120Z",
"updateTime": "2024-10-18T23:03:53.622096120Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "659192b1843c4af180700783caca4cdc7afa3eab",
"ref": "refs/heads/main"
}
},
"canary": true
}
[23:03:53.962] Invocation finished in 1h32m4.175686756s with status FAILED