[16:35:44.261] New invocation is queued and will start shortly
[16:35:45.363] Starting the invocation (attempt 1)
[16:35:45.393] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c455c4e2d7f78d5992369457066b249699fe2084"
[16:35:45.393] Popped gitiles commit info from properties and tags
[16:35:45.393] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:35:45.394] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:35:45.394] Buildbucket request:
{
"requestId": "8872789727461116816",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8872789727461116816",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0a1eff2ecedcb11acb3e9d4b75ee1e1bebd69a70"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0a1eff2ecedcb11acb3e9d4b75ee1e1bebd69a70",
"title": "0a1eff2ecedcb11acb3e9d4b75ee1e1bebd69a70",
"url": "https://llvm.googlesource.com/llvm-project/+/0a1eff2ecedcb11acb3e9d4b75ee1e1bebd69a70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f6c2a357e71ac2a4ce4137a0cf24b169aff9b42b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f6c2a357e71ac2a4ce4137a0cf24b169aff9b42b",
"title": "f6c2a357e71ac2a4ce4137a0cf24b169aff9b42b",
"url": "https://llvm.googlesource.com/llvm-project/+/f6c2a357e71ac2a4ce4137a0cf24b169aff9b42b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cd40281685f642ad879e33f3fda8d1faa136ebf4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cd40281685f642ad879e33f3fda8d1faa136ebf4",
"title": "cd40281685f642ad879e33f3fda8d1faa136ebf4",
"url": "https://llvm.googlesource.com/llvm-project/+/cd40281685f642ad879e33f3fda8d1faa136ebf4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e06c3a968d8360d786e5f60d9270989fcfaef857"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e06c3a968d8360d786e5f60d9270989fcfaef857",
"title": "e06c3a968d8360d786e5f60d9270989fcfaef857",
"url": "https://llvm.googlesource.com/llvm-project/+/e06c3a968d8360d786e5f60d9270989fcfaef857"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "88283a6e4601381d192ab1e3389b11cd23a83e69"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@88283a6e4601381d192ab1e3389b11cd23a83e69",
"title": "88283a6e4601381d192ab1e3389b11cd23a83e69",
"url": "https://llvm.googlesource.com/llvm-project/+/88283a6e4601381d192ab1e3389b11cd23a83e69"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ae7be39601496aa8f712672844de82285a227646"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ae7be39601496aa8f712672844de82285a227646",
"title": "ae7be39601496aa8f712672844de82285a227646",
"url": "https://llvm.googlesource.com/llvm-project/+/ae7be39601496aa8f712672844de82285a227646"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa39b67de01af189b59f9034ef6228a2951364b0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa39b67de01af189b59f9034ef6228a2951364b0",
"title": "fa39b67de01af189b59f9034ef6228a2951364b0",
"url": "https://llvm.googlesource.com/llvm-project/+/fa39b67de01af189b59f9034ef6228a2951364b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c4f7d8744ac54bc1ede754e8d10655fb86b47f25"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c4f7d8744ac54bc1ede754e8d10655fb86b47f25",
"title": "c4f7d8744ac54bc1ede754e8d10655fb86b47f25",
"url": "https://llvm.googlesource.com/llvm-project/+/c4f7d8744ac54bc1ede754e8d10655fb86b47f25"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0a8ebdb2f0adc60d9fc17d6b3af8933841cca50c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0a8ebdb2f0adc60d9fc17d6b3af8933841cca50c",
"title": "0a8ebdb2f0adc60d9fc17d6b3af8933841cca50c",
"url": "https://llvm.googlesource.com/llvm-project/+/0a8ebdb2f0adc60d9fc17d6b3af8933841cca50c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "74af2cec7bbd307d1dcb7f9f3cdf339d551a1f9f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@74af2cec7bbd307d1dcb7f9f3cdf339d551a1f9f",
"title": "74af2cec7bbd307d1dcb7f9f3cdf339d551a1f9f",
"url": "https://llvm.googlesource.com/llvm-project/+/74af2cec7bbd307d1dcb7f9f3cdf339d551a1f9f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6c9f1ce429809e5a91683ed6cef9a435047bebd1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6c9f1ce429809e5a91683ed6cef9a435047bebd1",
"title": "6c9f1ce429809e5a91683ed6cef9a435047bebd1",
"url": "https://llvm.googlesource.com/llvm-project/+/6c9f1ce429809e5a91683ed6cef9a435047bebd1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d72e58e422be747dfd1e42f8ad370420634190cb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d72e58e422be747dfd1e42f8ad370420634190cb",
"title": "d72e58e422be747dfd1e42f8ad370420634190cb",
"url": "https://llvm.googlesource.com/llvm-project/+/d72e58e422be747dfd1e42f8ad370420634190cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2bbc6147138187946616c1b30743e09825fb61b8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2bbc6147138187946616c1b30743e09825fb61b8",
"title": "2bbc6147138187946616c1b30743e09825fb61b8",
"url": "https://llvm.googlesource.com/llvm-project/+/2bbc6147138187946616c1b30743e09825fb61b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2e40c567fbf5b7366df4f2b1fcb9b748da685d96"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2e40c567fbf5b7366df4f2b1fcb9b748da685d96",
"title": "2e40c567fbf5b7366df4f2b1fcb9b748da685d96",
"url": "https://llvm.googlesource.com/llvm-project/+/2e40c567fbf5b7366df4f2b1fcb9b748da685d96"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dd0bb2c3a8675ff1e2b9de565a301c0a09d3063b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dd0bb2c3a8675ff1e2b9de565a301c0a09d3063b",
"title": "dd0bb2c3a8675ff1e2b9de565a301c0a09d3063b",
"url": "https://llvm.googlesource.com/llvm-project/+/dd0bb2c3a8675ff1e2b9de565a301c0a09d3063b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e8a87da482a13ac9b05acd79d3f412b1a1c06d9a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e8a87da482a13ac9b05acd79d3f412b1a1c06d9a",
"title": "e8a87da482a13ac9b05acd79d3f412b1a1c06d9a",
"url": "https://llvm.googlesource.com/llvm-project/+/e8a87da482a13ac9b05acd79d3f412b1a1c06d9a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "258997c16e4d5438207377d6ce4f9d608860d7ae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@258997c16e4d5438207377d6ce4f9d608860d7ae",
"title": "258997c16e4d5438207377d6ce4f9d608860d7ae",
"url": "https://llvm.googlesource.com/llvm-project/+/258997c16e4d5438207377d6ce4f9d608860d7ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c455c4e2d7f78d5992369457066b249699fe2084"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c455c4e2d7f78d5992369457066b249699fe2084",
"title": "c455c4e2d7f78d5992369457066b249699fe2084",
"url": "https://llvm.googlesource.com/llvm-project/+/c455c4e2d7f78d5992369457066b249699fe2084"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c455c4e2d7f78d5992369457066b249699fe2084",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872789727461116816"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:35:45.829] Scheduled build:
{
"id": "8707359665546377073",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-05T16:35:45.464192440Z",
"updateTime": "2025-08-05T16:35:45.464192440Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c455c4e2d7f78d5992369457066b249699fe2084",
"ref": "refs/heads/main"
}
}
}
[16:35:45.829] Task URL: https://cr-buildbucket.appspot.com/build/8707359665546377073
[16:35:45.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:2:0) after 5m47s
[16:35:46.856] Received PubSub notification, asking Buildbucket for the build status
[16:35:46.878] Build status: SCHEDULED
[16:35:51.087] Received PubSub notification, asking Buildbucket for the build status
[16:35:51.117] Build status: STARTED
[16:41:32.959] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:2:0)
[16:41:32.992] Build status: STARTED
[16:41:32.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:5:0) after 1m18s
[16:42:51.073] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:5:0)
[16:42:51.107] Build status: STARTED
[16:42:51.107] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:6:0) after 1m5s
[16:43:56.152] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:6:0)
[16:43:56.211] Build status: STARTED
[16:43:56.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:7:0) after 4m14s
[16:48:10.232] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:7:0)
[16:48:10.251] Build status: STARTED
[16:48:10.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:8:0) after 5m42s
[16:53:52.279] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:8:0)
[16:53:52.299] Build status: STARTED
[16:53:52.299] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:9:0) after 1m51s
[16:55:43.286] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:9:0)
[16:55:43.338] Build status: STARTED
[16:55:43.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:10:0) after 3m49s
[16:59:32.418] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:10:0)
[16:59:32.445] Build status: STARTED
[16:59:32.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:11:0) after 9m30s
[17:09:02.524] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:11:0)
[17:09:02.546] Build status: STARTED
[17:09:02.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:12:0) after 6m59s
[17:16:01.603] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:12:0)
[17:16:01.625] Build status: STARTED
[17:16:01.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:13:0) after 1m29s
[17:17:30.693] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:13:0)
[17:17:30.783] Build status: STARTED
[17:17:30.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:14:0) after 7m56s
[17:25:26.835] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:14:0)
[17:25:26.868] Build status: STARTED
[17:25:26.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:15:0) after 1m11s
[17:26:37.895] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:15:0)
[17:26:37.972] Build status: STARTED
[17:26:37.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:16:0) after 8m8s
[17:34:46.054] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:16:0)
[17:34:46.140] Build status: STARTED
[17:34:46.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:17:0) after 3m39s
[17:38:25.156] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:17:0)
[17:38:25.172] Build status: STARTED
[17:38:25.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:18:0) after 5m23s
[17:43:48.191] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:18:0)
[17:43:48.213] Build status: STARTED
[17:43:48.213] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:19:0) after 4m5s
[17:47:53.230] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:19:0)
[17:47:53.248] Build status: STARTED
[17:47:53.248] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:20:0) after 2m54s
[17:50:47.271] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:20:0)
[17:50:47.337] Build status: STARTED
[17:50:47.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:21:0) after 1m25s
[17:52:12.361] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:21:0)
[17:52:12.380] Build status: STARTED
[17:52:12.380] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:22:0) after 1m11s
[17:53:23.450] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:22:0)
[17:53:23.468] Build status: STARTED
[17:53:23.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:23:0) after 3m35s
[17:56:58.539] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:23:0)
[17:56:58.582] Build status: STARTED
[17:56:58.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:24:0) after 3m23s
[18:00:21.660] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:24:0)
[18:00:21.713] Build status: STARTED
[18:00:21.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:25:0) after 4m57s
[18:05:18.742] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:25:0)
[18:05:18.763] Build status: STARTED
[18:05:18.763] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8872789727461116816:26:0) after 7m32s
[18:10:31.897] Received PubSub notification, asking Buildbucket for the build status
[18:10:31.927] Build:
{
"id": "8707359665546377073",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-05T16:35:45.464192440Z",
"startTime": "2025-08-05T16:35:50.802735300Z",
"endTime": "2025-08-05T18:10:31.296081675Z",
"updateTime": "2025-08-05T18:10:31.296081675Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c455c4e2d7f78d5992369457066b249699fe2084",
"ref": "refs/heads/main"
}
}
}
[18:10:31.927] Invocation finished in 1h34m47.671994328s with status SUCCEEDED