[16:17:25.092] New invocation is queued and will start shortly
[16:17:26.251] Starting the invocation (attempt 1)
[16:17:26.280] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1ad57b58d6ba53be99bd6f2fa928a126c9deb91c"
[16:17:26.280] Popped gitiles commit info from properties and tags
[16:17:26.280] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:17:26.280] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:17:26.280] Buildbucket request:
{
"requestId": "8880944606998440080",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8880944606998440080",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "93f61ceadb4b29e455d76a887d136a0816a67f23"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@93f61ceadb4b29e455d76a887d136a0816a67f23",
"title": "93f61ceadb4b29e455d76a887d136a0816a67f23",
"url": "https://llvm.googlesource.com/llvm-project/+/93f61ceadb4b29e455d76a887d136a0816a67f23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a0260a95ece74733ada00b19d8b1930dde462a66"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a0260a95ece74733ada00b19d8b1930dde462a66",
"title": "a0260a95ece74733ada00b19d8b1930dde462a66",
"url": "https://llvm.googlesource.com/llvm-project/+/a0260a95ece74733ada00b19d8b1930dde462a66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "09d01be85672dda37ea577fad9c46e6034792b65"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@09d01be85672dda37ea577fad9c46e6034792b65",
"title": "09d01be85672dda37ea577fad9c46e6034792b65",
"url": "https://llvm.googlesource.com/llvm-project/+/09d01be85672dda37ea577fad9c46e6034792b65"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9732427f377ec076601d4d6ede697f39a4409ee4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9732427f377ec076601d4d6ede697f39a4409ee4",
"title": "9732427f377ec076601d4d6ede697f39a4409ee4",
"url": "https://llvm.googlesource.com/llvm-project/+/9732427f377ec076601d4d6ede697f39a4409ee4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "55f59940b1d8fec29c363589907bdf966bc64bdc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@55f59940b1d8fec29c363589907bdf966bc64bdc",
"title": "55f59940b1d8fec29c363589907bdf966bc64bdc",
"url": "https://llvm.googlesource.com/llvm-project/+/55f59940b1d8fec29c363589907bdf966bc64bdc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "99f2bc2f5dc241140be2d0919b43d443fc79b83f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@99f2bc2f5dc241140be2d0919b43d443fc79b83f",
"title": "99f2bc2f5dc241140be2d0919b43d443fc79b83f",
"url": "https://llvm.googlesource.com/llvm-project/+/99f2bc2f5dc241140be2d0919b43d443fc79b83f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e16e068ff8eddd8d53dcfc3595e3ebccfece0a7b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e16e068ff8eddd8d53dcfc3595e3ebccfece0a7b",
"title": "e16e068ff8eddd8d53dcfc3595e3ebccfece0a7b",
"url": "https://llvm.googlesource.com/llvm-project/+/e16e068ff8eddd8d53dcfc3595e3ebccfece0a7b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "29e09aff633bee49ddb744558877b52be868a325"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@29e09aff633bee49ddb744558877b52be868a325",
"title": "29e09aff633bee49ddb744558877b52be868a325",
"url": "https://llvm.googlesource.com/llvm-project/+/29e09aff633bee49ddb744558877b52be868a325"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7d98b66e3d18c0f60e76e20f9ea444c66833b9ba"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7d98b66e3d18c0f60e76e20f9ea444c66833b9ba",
"title": "7d98b66e3d18c0f60e76e20f9ea444c66833b9ba",
"url": "https://llvm.googlesource.com/llvm-project/+/7d98b66e3d18c0f60e76e20f9ea444c66833b9ba"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "38595fb257fee32aaa3b45ff73c3ceaac86e9143"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@38595fb257fee32aaa3b45ff73c3ceaac86e9143",
"title": "38595fb257fee32aaa3b45ff73c3ceaac86e9143",
"url": "https://llvm.googlesource.com/llvm-project/+/38595fb257fee32aaa3b45ff73c3ceaac86e9143"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "461ba2db5d15793d18a5c18ce417c30e335602cc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@461ba2db5d15793d18a5c18ce417c30e335602cc",
"title": "461ba2db5d15793d18a5c18ce417c30e335602cc",
"url": "https://llvm.googlesource.com/llvm-project/+/461ba2db5d15793d18a5c18ce417c30e335602cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "960221623f54b87c0ce786d551111573810c8ac8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@960221623f54b87c0ce786d551111573810c8ac8",
"title": "960221623f54b87c0ce786d551111573810c8ac8",
"url": "https://llvm.googlesource.com/llvm-project/+/960221623f54b87c0ce786d551111573810c8ac8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b9d6cbd4dc1def3f15b7d5ebb8cb4714bdad22bf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b9d6cbd4dc1def3f15b7d5ebb8cb4714bdad22bf",
"title": "b9d6cbd4dc1def3f15b7d5ebb8cb4714bdad22bf",
"url": "https://llvm.googlesource.com/llvm-project/+/b9d6cbd4dc1def3f15b7d5ebb8cb4714bdad22bf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1ac489c8e38ecaeccba7d8826273395eaba2db6c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1ac489c8e38ecaeccba7d8826273395eaba2db6c",
"title": "1ac489c8e38ecaeccba7d8826273395eaba2db6c",
"url": "https://llvm.googlesource.com/llvm-project/+/1ac489c8e38ecaeccba7d8826273395eaba2db6c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5f7213e0b704fa45a72ff788bf1934fdb5cf90ce"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5f7213e0b704fa45a72ff788bf1934fdb5cf90ce",
"title": "5f7213e0b704fa45a72ff788bf1934fdb5cf90ce",
"url": "https://llvm.googlesource.com/llvm-project/+/5f7213e0b704fa45a72ff788bf1934fdb5cf90ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "32752913b12103431dc392242c3c808afb70bd15"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@32752913b12103431dc392242c3c808afb70bd15",
"title": "32752913b12103431dc392242c3c808afb70bd15",
"url": "https://llvm.googlesource.com/llvm-project/+/32752913b12103431dc392242c3c808afb70bd15"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1ad57b58d6ba53be99bd6f2fa928a126c9deb91c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1ad57b58d6ba53be99bd6f2fa928a126c9deb91c",
"title": "1ad57b58d6ba53be99bd6f2fa928a126c9deb91c",
"url": "https://llvm.googlesource.com/llvm-project/+/1ad57b58d6ba53be99bd6f2fa928a126c9deb91c"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1ad57b58d6ba53be99bd6f2fa928a126c9deb91c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8880944606998440080"
},
{
"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:17:26.748] Scheduled build:
{
"id": "8715514545030514273",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-07T16:17:26.347649454Z",
"updateTime": "2025-05-07T16:17:26.347649454Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1ad57b58d6ba53be99bd6f2fa928a126c9deb91c",
"ref": "refs/heads/main"
}
}
}
[16:17:26.748] Task URL: https://cr-buildbucket.appspot.com/build/8715514545030514273
[16:17:26.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:2:0) after 1m47s
[16:17:27.742] Received PubSub notification, asking Buildbucket for the build status
[16:17:27.765] Build status: SCHEDULED
[16:17:32.805] Received PubSub notification, asking Buildbucket for the build status
[16:17:32.850] Build status: STARTED
[16:19:13.759] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:2:0)
[16:19:13.784] Build status: STARTED
[16:19:13.784] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:5:0) after 6m25s
[16:25:38.831] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:5:0)
[16:25:38.856] Build status: STARTED
[16:25:38.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:6:0) after 9m29s
[16:35:08.004] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:6:0)
[16:35:08.056] Build status: STARTED
[16:35:08.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:7:0) after 4m35s
[16:39:43.085] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:7:0)
[16:39:43.106] Build status: STARTED
[16:39:43.106] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:8:0) after 7m22s
[16:47:05.185] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:8:0)
[16:47:05.205] Build status: STARTED
[16:47:05.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:9:0) after 6m9s
[16:53:14.405] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:9:0)
[16:53:14.427] Build status: STARTED
[16:53:14.427] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:10:0) after 5m5s
[16:58:19.456] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:10:0)
[16:58:19.475] Build status: STARTED
[16:58:19.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:11:0) after 4m31s
[17:02:50.570] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:11:0)
[17:02:50.600] Build status: STARTED
[17:02:50.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:12:0) after 8m36s
[17:11:26.669] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:12:0)
[17:11:26.703] Build status: STARTED
[17:11:26.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:13:0) after 7m26s
[17:18:52.841] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:13:0)
[17:18:52.858] Build status: STARTED
[17:18:52.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:14:0) after 2m40s
[17:21:32.886] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:14:0)
[17:21:32.915] Build status: STARTED
[17:21:32.915] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:15:0) after 5m52s
[17:27:24.984] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:15:0)
[17:27:24.999] Build status: STARTED
[17:27:24.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:16:0) after 2m44s
[17:30:09.072] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:16:0)
[17:30:09.093] Build status: STARTED
[17:30:09.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:17:0) after 5m4s
[17:35:13.116] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:17:0)
[17:35:13.196] Build status: STARTED
[17:35:13.196] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:18:0) after 6m9s
[17:41:22.231] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:18:0)
[17:41:22.255] Build status: STARTED
[17:41:22.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:19:0) after 7m35s
[17:48:57.281] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:19:0)
[17:48:57.303] Build status: STARTED
[17:48:57.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:20:0) after 3m39s
[17:52:36.328] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:20:0)
[17:52:36.345] Build status: STARTED
[17:52:36.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:21:0) after 3m43s
[17:56:19.435] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:21:0)
[17:56:19.458] Build status: STARTED
[17:56:19.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880944606998440080:22:0) after 6m32s
[17:57:01.116] Received PubSub notification, asking Buildbucket for the build status
[17:57:01.137] Build:
{
"id": "8715514545030514273",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-07T16:17:26.347649454Z",
"startTime": "2025-05-07T16:17:32.610645865Z",
"endTime": "2025-05-07T17:57:00.620406940Z",
"updateTime": "2025-05-07T17:57:00.620406940Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1ad57b58d6ba53be99bd6f2fa928a126c9deb91c",
"ref": "refs/heads/main"
}
}
}
[17:57:01.137] Invocation finished in 1h39m36.050972527s with status SUCCEEDED