[09:46:22.232] New invocation is queued and will start shortly
[09:46:23.341] Starting the invocation (attempt 1)
[09:46:23.363] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/6da8f3bd5df2bb860f8cc32e9cfc739baf102295"
[09:46:23.363] Popped gitiles commit info from properties and tags
[09:46:23.363] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:46:23.363] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:46:23.364] Buildbucket request:
{
"requestId": "8879157270267790912",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8879157270267790912",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "80da58da343620e458e34f01df95b329e7a5763c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@80da58da343620e458e34f01df95b329e7a5763c",
"title": "80da58da343620e458e34f01df95b329e7a5763c",
"url": "https://llvm.googlesource.com/llvm-project/+/80da58da343620e458e34f01df95b329e7a5763c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "104f5d1ff84613542442b71bcb59e19c5ed17b89"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@104f5d1ff84613542442b71bcb59e19c5ed17b89",
"title": "104f5d1ff84613542442b71bcb59e19c5ed17b89",
"url": "https://llvm.googlesource.com/llvm-project/+/104f5d1ff84613542442b71bcb59e19c5ed17b89"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "692d9f26b5c8a027b6c3eeeb426ee2df15ee8147"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@692d9f26b5c8a027b6c3eeeb426ee2df15ee8147",
"title": "692d9f26b5c8a027b6c3eeeb426ee2df15ee8147",
"url": "https://llvm.googlesource.com/llvm-project/+/692d9f26b5c8a027b6c3eeeb426ee2df15ee8147"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "052c70451afb7323ef72f321f3b0b5abb024b302"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@052c70451afb7323ef72f321f3b0b5abb024b302",
"title": "052c70451afb7323ef72f321f3b0b5abb024b302",
"url": "https://llvm.googlesource.com/llvm-project/+/052c70451afb7323ef72f321f3b0b5abb024b302"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8fe33a05b94d716830f7ad119d2afcb06e09cc4d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8fe33a05b94d716830f7ad119d2afcb06e09cc4d",
"title": "8fe33a05b94d716830f7ad119d2afcb06e09cc4d",
"url": "https://llvm.googlesource.com/llvm-project/+/8fe33a05b94d716830f7ad119d2afcb06e09cc4d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "03fc480b9acde73f2cbd2ca216bf879b6b28a473"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@03fc480b9acde73f2cbd2ca216bf879b6b28a473",
"title": "03fc480b9acde73f2cbd2ca216bf879b6b28a473",
"url": "https://llvm.googlesource.com/llvm-project/+/03fc480b9acde73f2cbd2ca216bf879b6b28a473"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "58ee6e6c4bc59a1c960c24c782661cb1578af7c4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@58ee6e6c4bc59a1c960c24c782661cb1578af7c4",
"title": "58ee6e6c4bc59a1c960c24c782661cb1578af7c4",
"url": "https://llvm.googlesource.com/llvm-project/+/58ee6e6c4bc59a1c960c24c782661cb1578af7c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "afd53edefa771e5e2136a4cb159843a74a586660"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@afd53edefa771e5e2136a4cb159843a74a586660",
"title": "afd53edefa771e5e2136a4cb159843a74a586660",
"url": "https://llvm.googlesource.com/llvm-project/+/afd53edefa771e5e2136a4cb159843a74a586660"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7569de527298a52618239ef68b9374a5c35c8b97"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7569de527298a52618239ef68b9374a5c35c8b97",
"title": "7569de527298a52618239ef68b9374a5c35c8b97",
"url": "https://llvm.googlesource.com/llvm-project/+/7569de527298a52618239ef68b9374a5c35c8b97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bf6cd24aaadd8310408d733c944f0d5f9cc14c0a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bf6cd24aaadd8310408d733c944f0d5f9cc14c0a",
"title": "bf6cd24aaadd8310408d733c944f0d5f9cc14c0a",
"url": "https://llvm.googlesource.com/llvm-project/+/bf6cd24aaadd8310408d733c944f0d5f9cc14c0a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fb27867bd5a04975516b099681587ea32f38f3d4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fb27867bd5a04975516b099681587ea32f38f3d4",
"title": "fb27867bd5a04975516b099681587ea32f38f3d4",
"url": "https://llvm.googlesource.com/llvm-project/+/fb27867bd5a04975516b099681587ea32f38f3d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6da8f3bd5df2bb860f8cc32e9cfc739baf102295"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6da8f3bd5df2bb860f8cc32e9cfc739baf102295",
"title": "6da8f3bd5df2bb860f8cc32e9cfc739baf102295",
"url": "https://llvm.googlesource.com/llvm-project/+/6da8f3bd5df2bb860f8cc32e9cfc739baf102295"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6da8f3bd5df2bb860f8cc32e9cfc739baf102295",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8879157270267790912"
},
{
"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"
}
}
[09:46:23.760] Scheduled build:
{
"id": "8713727208357976401",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-27T09:46:23.426695091Z",
"updateTime": "2025-05-27T09:46:23.426695091Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6da8f3bd5df2bb860f8cc32e9cfc739baf102295",
"ref": "refs/heads/main"
}
}
}
[09:46:23.760] Task URL: https://cr-buildbucket.appspot.com/build/8713727208357976401
[09:46:23.760] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:2:0) after 4m43s
[09:46:24.742] Received PubSub notification, asking Buildbucket for the build status
[09:46:24.773] Build status: SCHEDULED
[09:46:28.051] Received PubSub notification, asking Buildbucket for the build status
[09:46:28.388] Build status: STARTED
[09:51:06.847] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:2:0)
[09:51:06.870] Build status: STARTED
[09:51:06.870] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:5:0) after 7m51s
[09:58:57.878] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:5:0)
[09:58:57.923] Build status: STARTED
[09:58:57.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:6:0) after 8m45s
[10:07:42.947] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:6:0)
[10:07:42.973] Build status: STARTED
[10:07:42.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:7:0) after 2m27s
[10:10:10.040] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:7:0)
[10:10:10.077] Build status: STARTED
[10:10:10.077] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:8:0) after 8m0s
[10:18:10.092] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:8:0)
[10:18:10.119] Build status: STARTED
[10:18:10.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:9:0) after 4m5s
[10:22:15.190] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:9:0)
[10:22:15.213] Build status: STARTED
[10:22:15.213] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:10:0) after 3m20s
[10:25:35.247] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:10:0)
[10:25:35.275] Build status: STARTED
[10:25:35.275] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:11:0) after 2m26s
[10:28:01.290] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:11:0)
[10:28:01.352] Build status: STARTED
[10:28:01.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:12:0) after 9m47s
[10:37:49.218] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:12:0)
[10:37:49.237] Build status: STARTED
[10:37:49.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:13:0) after 7m3s
[10:44:52.266] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:13:0)
[10:44:52.288] Build status: STARTED
[10:44:52.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:14:0) after 7m31s
[10:52:23.369] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:14:0)
[10:52:23.388] Build status: STARTED
[10:52:23.388] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:15:0) after 4m43s
[10:57:06.553] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:15:0)
[10:57:06.578] Build status: STARTED
[10:57:06.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:16:0) after 5m10s
[11:02:16.777] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:16:0)
[11:02:16.807] Build status: STARTED
[11:02:16.807] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:17:0) after 3m27s
[11:05:43.823] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:17:0)
[11:05:43.843] Build status: STARTED
[11:05:43.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:18:0) after 4m20s
[11:10:03.931] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:18:0)
[11:10:03.951] Build status: STARTED
[11:10:03.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:19:0) after 2m8s
[11:12:11.972] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:19:0)
[11:12:12.004] Build status: STARTED
[11:12:12.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:20:0) after 4m51s
[11:17:03.400] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:20:0)
[11:17:03.470] Build status: STARTED
[11:17:03.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:21:0) after 8m35s
[11:25:38.670] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:21:0)
[11:25:38.696] Build status: STARTED
[11:25:38.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:22:0) after 6m35s
[11:32:13.717] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:22:0)
[11:32:13.750] Build status: STARTED
[11:32:13.751] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8879157270267790912:23:0) after 7m15s
[11:35:09.704] Received PubSub notification, asking Buildbucket for the build status
[11:35:09.720] Build:
{
"id": "8713727208357976401",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-27T09:46:23.426695091Z",
"startTime": "2025-05-27T09:46:27.868875283Z",
"endTime": "2025-05-27T11:35:09.186931221Z",
"updateTime": "2025-05-27T11:35:09.186931221Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6da8f3bd5df2bb860f8cc32e9cfc739baf102295",
"ref": "refs/heads/main"
}
}
}
[11:35:09.720] Invocation finished in 1h48m47.498807689s with status SUCCEEDED