[16:18:50.983] New invocation is queued and will start shortly
[16:18:52.474] Starting the invocation (attempt 1)
[16:18:52.506] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/32779cd6989e5b30a9ecd4e3c1db62fa551caefb"
[16:18:52.506] Popped gitiles commit info from properties and tags
[16:18:52.506] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:18:52.506] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:18:52.507] Buildbucket request:
{
"requestId": "8873424968729106528",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8873424968729106528",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa6965f722e0573f62e4d1e533dfa5b3a2ce2c4f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa6965f722e0573f62e4d1e533dfa5b3a2ce2c4f",
"title": "fa6965f722e0573f62e4d1e533dfa5b3a2ce2c4f",
"url": "https://llvm.googlesource.com/llvm-project/+/fa6965f722e0573f62e4d1e533dfa5b3a2ce2c4f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "73245b06b3da19ef70e04cf0f0a0d0df1ba82a57"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@73245b06b3da19ef70e04cf0f0a0d0df1ba82a57",
"title": "73245b06b3da19ef70e04cf0f0a0d0df1ba82a57",
"url": "https://llvm.googlesource.com/llvm-project/+/73245b06b3da19ef70e04cf0f0a0d0df1ba82a57"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e7b02fc0cd5f63a14f4117866f860b7f174baf3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e7b02fc0cd5f63a14f4117866f860b7f174baf3",
"title": "8e7b02fc0cd5f63a14f4117866f860b7f174baf3",
"url": "https://llvm.googlesource.com/llvm-project/+/8e7b02fc0cd5f63a14f4117866f860b7f174baf3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e68a20e0b7623738d6af736d3aa02625cba6126a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e68a20e0b7623738d6af736d3aa02625cba6126a",
"title": "e68a20e0b7623738d6af736d3aa02625cba6126a",
"url": "https://llvm.googlesource.com/llvm-project/+/e68a20e0b7623738d6af736d3aa02625cba6126a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "30ad2e24ab3392b1b1f022422255f010ed6dbd63"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@30ad2e24ab3392b1b1f022422255f010ed6dbd63",
"title": "30ad2e24ab3392b1b1f022422255f010ed6dbd63",
"url": "https://llvm.googlesource.com/llvm-project/+/30ad2e24ab3392b1b1f022422255f010ed6dbd63"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d4562a19911e05cf9d81c6857e94cfb1307d4315"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d4562a19911e05cf9d81c6857e94cfb1307d4315",
"title": "d4562a19911e05cf9d81c6857e94cfb1307d4315",
"url": "https://llvm.googlesource.com/llvm-project/+/d4562a19911e05cf9d81c6857e94cfb1307d4315"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "84576c7b5d4f838d9154640bbaf36b703bc552f5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@84576c7b5d4f838d9154640bbaf36b703bc552f5",
"title": "84576c7b5d4f838d9154640bbaf36b703bc552f5",
"url": "https://llvm.googlesource.com/llvm-project/+/84576c7b5d4f838d9154640bbaf36b703bc552f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5e150bb78185b424a8e6e01aa2c4907dde409777"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5e150bb78185b424a8e6e01aa2c4907dde409777",
"title": "5e150bb78185b424a8e6e01aa2c4907dde409777",
"url": "https://llvm.googlesource.com/llvm-project/+/5e150bb78185b424a8e6e01aa2c4907dde409777"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e874615a62e6a5cb7be0be67b0c4c66c4719f67a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e874615a62e6a5cb7be0be67b0c4c66c4719f67a",
"title": "e874615a62e6a5cb7be0be67b0c4c66c4719f67a",
"url": "https://llvm.googlesource.com/llvm-project/+/e874615a62e6a5cb7be0be67b0c4c66c4719f67a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "99fda1a09cf7ce97fbd0ea74101e4fc3283f3428"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@99fda1a09cf7ce97fbd0ea74101e4fc3283f3428",
"title": "99fda1a09cf7ce97fbd0ea74101e4fc3283f3428",
"url": "https://llvm.googlesource.com/llvm-project/+/99fda1a09cf7ce97fbd0ea74101e4fc3283f3428"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1a974527bb986d73afdb62b57ead54e33b54f8ca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1a974527bb986d73afdb62b57ead54e33b54f8ca",
"title": "1a974527bb986d73afdb62b57ead54e33b54f8ca",
"url": "https://llvm.googlesource.com/llvm-project/+/1a974527bb986d73afdb62b57ead54e33b54f8ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3b66d4a987bff6d9d3e8a0932604cb40850136eb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3b66d4a987bff6d9d3e8a0932604cb40850136eb",
"title": "3b66d4a987bff6d9d3e8a0932604cb40850136eb",
"url": "https://llvm.googlesource.com/llvm-project/+/3b66d4a987bff6d9d3e8a0932604cb40850136eb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "860b1e68ea180672d0e02fa8328f4a7c45e16f0f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@860b1e68ea180672d0e02fa8328f4a7c45e16f0f",
"title": "860b1e68ea180672d0e02fa8328f4a7c45e16f0f",
"url": "https://llvm.googlesource.com/llvm-project/+/860b1e68ea180672d0e02fa8328f4a7c45e16f0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a5db2c28443559f5a19f76f9a91ef3280231a969"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a5db2c28443559f5a19f76f9a91ef3280231a969",
"title": "a5db2c28443559f5a19f76f9a91ef3280231a969",
"url": "https://llvm.googlesource.com/llvm-project/+/a5db2c28443559f5a19f76f9a91ef3280231a969"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9bd2aacc68a1c7632abb9410640400dcc09ef50b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9bd2aacc68a1c7632abb9410640400dcc09ef50b",
"title": "9bd2aacc68a1c7632abb9410640400dcc09ef50b",
"url": "https://llvm.googlesource.com/llvm-project/+/9bd2aacc68a1c7632abb9410640400dcc09ef50b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "83dfdd8f5485f6b50213c88f02878f86b3f53852"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@83dfdd8f5485f6b50213c88f02878f86b3f53852",
"title": "83dfdd8f5485f6b50213c88f02878f86b3f53852",
"url": "https://llvm.googlesource.com/llvm-project/+/83dfdd8f5485f6b50213c88f02878f86b3f53852"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "15980624ac516ae2dbbf1f2cd24d63de0f9fd2be"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@15980624ac516ae2dbbf1f2cd24d63de0f9fd2be",
"title": "15980624ac516ae2dbbf1f2cd24d63de0f9fd2be",
"url": "https://llvm.googlesource.com/llvm-project/+/15980624ac516ae2dbbf1f2cd24d63de0f9fd2be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2abd58cb7e817767e69f3c71512ff5c4b79bc881"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2abd58cb7e817767e69f3c71512ff5c4b79bc881",
"title": "2abd58cb7e817767e69f3c71512ff5c4b79bc881",
"url": "https://llvm.googlesource.com/llvm-project/+/2abd58cb7e817767e69f3c71512ff5c4b79bc881"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0a4c6522a6a48cf053d334445b919e769e64ab9b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0a4c6522a6a48cf053d334445b919e769e64ab9b",
"title": "0a4c6522a6a48cf053d334445b919e769e64ab9b",
"url": "https://llvm.googlesource.com/llvm-project/+/0a4c6522a6a48cf053d334445b919e769e64ab9b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "32779cd6989e5b30a9ecd4e3c1db62fa551caefb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@32779cd6989e5b30a9ecd4e3c1db62fa551caefb",
"title": "32779cd6989e5b30a9ecd4e3c1db62fa551caefb",
"url": "https://llvm.googlesource.com/llvm-project/+/32779cd6989e5b30a9ecd4e3c1db62fa551caefb"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "32779cd6989e5b30a9ecd4e3c1db62fa551caefb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8873424968729106528"
},
{
"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:18:53.167] Scheduled build:
{
"id": "8707994906390562849",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-29T16:18:52.586325900Z",
"updateTime": "2025-07-29T16:18:52.586325900Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "32779cd6989e5b30a9ecd4e3c1db62fa551caefb",
"ref": "refs/heads/main"
}
}
}
[16:18:53.167] Task URL: https://cr-buildbucket.appspot.com/build/8707994906390562849
[16:18:53.167] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:2:0) after 3m28s
[16:18:53.238] Received PubSub notification, asking Buildbucket for the build status
[16:18:53.277] Build status: SCHEDULED
[16:22:21.202] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:2:0)
[16:22:21.336] Build status: SCHEDULED
[16:22:21.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:4:0) after 9m27s
[16:31:48.358] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:4:0)
[16:31:48.400] Build status: SCHEDULED
[16:31:48.400] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:5:0) after 3m19s
[16:35:07.423] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:5:0)
[16:35:07.452] Build status: SCHEDULED
[16:35:07.452] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:6:0) after 8m34s
[16:43:41.472] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:6:0)
[16:43:41.500] Build status: SCHEDULED
[16:43:41.500] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:7:0) after 2m58s
[16:46:39.678] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:7:0)
[16:46:39.702] Build status: SCHEDULED
[16:46:39.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:8:0) after 2m36s
[16:47:21.245] Received PubSub notification, asking Buildbucket for the build status
[16:47:21.273] Build status: STARTED
[16:49:15.736] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:8:0)
[16:49:15.771] Build status: STARTED
[16:49:15.771] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:10:0) after 3m50s
[16:53:05.834] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:10:0)
[16:53:05.855] Build status: STARTED
[16:53:05.855] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:11:0) after 6m26s
[16:59:31.928] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:11:0)
[16:59:32.018] Build status: STARTED
[16:59:32.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:12:0) after 1m49s
[17:01:21.091] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:12:0)
[17:01:21.158] Build status: STARTED
[17:01:21.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:13:0) after 8m13s
[17:09:34.190] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:13:0)
[17:09:34.220] Build status: STARTED
[17:09:34.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:14:0) after 1m34s
[17:11:08.297] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:14:0)
[17:11:08.333] Build status: STARTED
[17:11:08.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:15:0) after 6m59s
[17:18:07.336] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:15:0)
[17:18:07.368] Build status: STARTED
[17:18:07.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:16:0) after 8m58s
[17:27:05.389] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:16:0)
[17:27:05.417] Build status: STARTED
[17:27:05.417] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:17:0) after 6m33s
[17:33:38.546] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:17:0)
[17:33:38.563] Build status: STARTED
[17:33:38.563] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:18:0) after 2m48s
[17:36:26.627] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:18:0)
[17:36:26.670] Build status: STARTED
[17:36:26.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:19:0) after 8m5s
[17:44:31.703] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:19:0)
[17:44:31.726] Build status: STARTED
[17:44:31.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:20:0) after 2m53s
[17:47:24.755] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:20:0)
[17:47:24.775] Build status: STARTED
[17:47:24.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:21:0) after 8m45s
[17:56:09.901] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:21:0)
[17:56:09.987] Build status: STARTED
[17:56:09.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:22:0) after 3m58s
[18:00:08.095] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:22:0)
[18:00:08.133] Build status: STARTED
[18:00:08.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:23:0) after 7m10s
[18:07:18.232] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:23:0)
[18:07:18.259] Build status: STARTED
[18:07:18.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:24:0) after 7m55s
[18:15:13.342] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:24:0)
[18:15:13.469] Build status: STARTED
[18:15:13.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:25:0) after 5m8s
[18:20:21.543] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:25:0)
[18:20:21.570] Build status: STARTED
[18:20:21.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8873424968729106528:26:0) after 9m33s
[18:21:46.969] Received PubSub notification, asking Buildbucket for the build status
[18:21:46.998] Build:
{
"id": "8707994906390562849",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-29T16:18:52.586325900Z",
"startTime": "2025-07-29T16:47:21.037476286Z",
"endTime": "2025-07-29T18:21:46.588354506Z",
"updateTime": "2025-07-29T18:21:46.588354506Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "32779cd6989e5b30a9ecd4e3c1db62fa551caefb",
"ref": "refs/heads/main"
}
}
}
[18:21:46.998] Invocation finished in 2h2m56.025371362s with status SUCCEEDED