[19:12:01.512] New invocation is queued and will start shortly
[19:12:02.878] Starting the invocation (attempt 1)
[19:12:02.903] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ab9cd53b86e84cc2db47d312232de4789c15adc4"
[19:12:02.903] Popped gitiles commit info from properties and tags
[19:12:02.903] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:12:02.903] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:12:02.904] Buildbucket request:
{
"requestId": "8887456603256857664",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887456603256857664",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "36fdeb2aded08a776fcffefa73cb7667e7fc6c2d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@36fdeb2aded08a776fcffefa73cb7667e7fc6c2d",
"title": "36fdeb2aded08a776fcffefa73cb7667e7fc6c2d",
"url": "https://llvm.googlesource.com/llvm-project/+/36fdeb2aded08a776fcffefa73cb7667e7fc6c2d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a6abbe03094a7afc85d4d35c24e6cedd1cfc4ef2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a6abbe03094a7afc85d4d35c24e6cedd1cfc4ef2",
"title": "a6abbe03094a7afc85d4d35c24e6cedd1cfc4ef2",
"url": "https://llvm.googlesource.com/llvm-project/+/a6abbe03094a7afc85d4d35c24e6cedd1cfc4ef2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7f6f186736c81ab3ca1881ed9d5569ffc1050df8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7f6f186736c81ab3ca1881ed9d5569ffc1050df8",
"title": "7f6f186736c81ab3ca1881ed9d5569ffc1050df8",
"url": "https://llvm.googlesource.com/llvm-project/+/7f6f186736c81ab3ca1881ed9d5569ffc1050df8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a0be17dc91d054290910b5787f41900fb6ef0d6e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a0be17dc91d054290910b5787f41900fb6ef0d6e",
"title": "a0be17dc91d054290910b5787f41900fb6ef0d6e",
"url": "https://llvm.googlesource.com/llvm-project/+/a0be17dc91d054290910b5787f41900fb6ef0d6e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "664cbd1b5db190724ceea498d1f520eb66d78d69"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@664cbd1b5db190724ceea498d1f520eb66d78d69",
"title": "664cbd1b5db190724ceea498d1f520eb66d78d69",
"url": "https://llvm.googlesource.com/llvm-project/+/664cbd1b5db190724ceea498d1f520eb66d78d69"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "571b787b83cb1bfc7d4c8214b296ec965e7bb7e2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@571b787b83cb1bfc7d4c8214b296ec965e7bb7e2",
"title": "571b787b83cb1bfc7d4c8214b296ec965e7bb7e2",
"url": "https://llvm.googlesource.com/llvm-project/+/571b787b83cb1bfc7d4c8214b296ec965e7bb7e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8dbc393e447299d1a4d35b96c6e66542a5928cff"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8dbc393e447299d1a4d35b96c6e66542a5928cff",
"title": "8dbc393e447299d1a4d35b96c6e66542a5928cff",
"url": "https://llvm.googlesource.com/llvm-project/+/8dbc393e447299d1a4d35b96c6e66542a5928cff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e298fc2da97120a30ee2f120ac184ab209fc1eb4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e298fc2da97120a30ee2f120ac184ab209fc1eb4",
"title": "e298fc2da97120a30ee2f120ac184ab209fc1eb4",
"url": "https://llvm.googlesource.com/llvm-project/+/e298fc2da97120a30ee2f120ac184ab209fc1eb4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d9d1f241f27bab3c7b8914196316a6e6202cc61e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d9d1f241f27bab3c7b8914196316a6e6202cc61e",
"title": "d9d1f241f27bab3c7b8914196316a6e6202cc61e",
"url": "https://llvm.googlesource.com/llvm-project/+/d9d1f241f27bab3c7b8914196316a6e6202cc61e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9638d08af96c4cb8cf16785eed92179b2658bdfe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9638d08af96c4cb8cf16785eed92179b2658bdfe",
"title": "9638d08af96c4cb8cf16785eed92179b2658bdfe",
"url": "https://llvm.googlesource.com/llvm-project/+/9638d08af96c4cb8cf16785eed92179b2658bdfe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "51ce6c437fec1fe0170d077424e1cbc141d05c2b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@51ce6c437fec1fe0170d077424e1cbc141d05c2b",
"title": "51ce6c437fec1fe0170d077424e1cbc141d05c2b",
"url": "https://llvm.googlesource.com/llvm-project/+/51ce6c437fec1fe0170d077424e1cbc141d05c2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d9b0571b5c408b3c699143a8870d04414351d28d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d9b0571b5c408b3c699143a8870d04414351d28d",
"title": "d9b0571b5c408b3c699143a8870d04414351d28d",
"url": "https://llvm.googlesource.com/llvm-project/+/d9b0571b5c408b3c699143a8870d04414351d28d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "41cd6d2b1d6323bebfb20349d9f45b9c0ea75ada"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@41cd6d2b1d6323bebfb20349d9f45b9c0ea75ada",
"title": "41cd6d2b1d6323bebfb20349d9f45b9c0ea75ada",
"url": "https://llvm.googlesource.com/llvm-project/+/41cd6d2b1d6323bebfb20349d9f45b9c0ea75ada"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "823a597d2ad0a76e8d5278a789f37a07b393cd2a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@823a597d2ad0a76e8d5278a789f37a07b393cd2a",
"title": "823a597d2ad0a76e8d5278a789f37a07b393cd2a",
"url": "https://llvm.googlesource.com/llvm-project/+/823a597d2ad0a76e8d5278a789f37a07b393cd2a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d536169010e4a1c70523edbdec5c6dfcbd49fda"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d536169010e4a1c70523edbdec5c6dfcbd49fda",
"title": "4d536169010e4a1c70523edbdec5c6dfcbd49fda",
"url": "https://llvm.googlesource.com/llvm-project/+/4d536169010e4a1c70523edbdec5c6dfcbd49fda"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "69cc16fb55089f624aba106a714aaf3f1a5504f5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@69cc16fb55089f624aba106a714aaf3f1a5504f5",
"title": "69cc16fb55089f624aba106a714aaf3f1a5504f5",
"url": "https://llvm.googlesource.com/llvm-project/+/69cc16fb55089f624aba106a714aaf3f1a5504f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab9cd53b86e84cc2db47d312232de4789c15adc4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab9cd53b86e84cc2db47d312232de4789c15adc4",
"title": "ab9cd53b86e84cc2db47d312232de4789c15adc4",
"url": "https://llvm.googlesource.com/llvm-project/+/ab9cd53b86e84cc2db47d312232de4789c15adc4"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ab9cd53b86e84cc2db47d312232de4789c15adc4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887456603256857664"
},
{
"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"
}
}
[19:12:03.320] Scheduled build:
{
"id": "8722026541064003633",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-24T19:12:02.981789444Z",
"updateTime": "2025-02-24T19:12:02.981789444Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ab9cd53b86e84cc2db47d312232de4789c15adc4",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:12:03.320] Task URL: https://cr-buildbucket.appspot.com/build/8722026541064003633
[19:12:03.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:2:0) after 1m18s
[19:12:04.321] Received PubSub notification, asking Buildbucket for the build status
[19:12:04.345] Build status: SCHEDULED
[19:12:07.952] Received PubSub notification, asking Buildbucket for the build status
[19:12:07.974] Build status: STARTED
[19:13:21.480] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:2:0)
[19:13:21.504] Build status: STARTED
[19:13:21.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:5:0) after 1m8s
[19:14:29.524] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:5:0)
[19:14:29.553] Build status: STARTED
[19:14:29.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:6:0) after 9m40s
[19:24:09.578] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:6:0)
[19:24:09.641] Build status: STARTED
[19:24:09.641] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:7:0) after 6m27s
[19:30:36.687] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:7:0)
[19:30:36.724] Build status: STARTED
[19:30:36.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:8:0) after 2m59s
[19:33:35.751] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:8:0)
[19:33:35.777] Build status: STARTED
[19:33:35.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:9:0) after 8m36s
[19:42:11.868] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:9:0)
[19:42:11.891] Build status: STARTED
[19:42:11.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:10:0) after 2m49s
[19:45:00.945] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:10:0)
[19:45:00.967] Build status: STARTED
[19:45:00.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:11:0) after 4m14s
[19:49:14.981] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:11:0)
[19:49:15.001] Build status: STARTED
[19:49:15.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:12:0) after 7m4s
[19:56:19.091] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:12:0)
[19:56:19.122] Build status: STARTED
[19:56:19.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:13:0) after 9m9s
[20:05:28.097] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:13:0)
[20:05:28.121] Build status: STARTED
[20:05:28.121] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:14:0) after 1m25s
[20:06:53.150] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:14:0)
[20:06:53.181] Build status: STARTED
[20:06:53.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:15:0) after 2m4s
[20:08:57.248] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:15:0)
[20:08:57.264] Build status: STARTED
[20:08:57.264] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:16:0) after 4m35s
[20:13:32.499] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:16:0)
[20:13:32.555] Build status: STARTED
[20:13:32.555] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:17:0) after 5m33s
[20:19:05.621] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:17:0)
[20:19:05.643] Build status: STARTED
[20:19:05.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:18:0) after 2m41s
[20:21:46.734] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:18:0)
[20:21:46.747] Build status: STARTED
[20:21:46.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:19:0) after 7m15s
[20:29:01.782] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:19:0)
[20:29:01.820] Build status: STARTED
[20:29:01.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:20:0) after 9m9s
[20:38:10.836] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:20:0)
[20:38:10.858] Build status: STARTED
[20:38:10.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:21:0) after 7m55s
[20:46:05.871] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:21:0)
[20:46:05.898] Build status: STARTED
[20:46:05.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:22:0) after 2m39s
[20:48:44.880] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:22:0)
[20:48:44.897] Build status: STARTED
[20:48:44.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887456603256857664:23:0) after 9m53s
[20:57:17.845] Received PubSub notification, asking Buildbucket for the build status
[20:57:18.037] Build:
{
"id": "8722026541064003633",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-24T19:12:02.981789444Z",
"startTime": "2025-02-24T19:12:07.726009190Z",
"endTime": "2025-02-24T20:57:17.463270274Z",
"updateTime": "2025-02-24T20:57:17.463270274Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ab9cd53b86e84cc2db47d312232de4789c15adc4",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:57:18.037] Invocation finished in 1h45m16.531636288s with status SUCCEEDED