[12:54:50.657] New invocation is queued and will start shortly
[12:54:51.899] Starting the invocation (attempt 1)
[12:54:51.926] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e63de82d904c2364c84489894eeb81fb9c08a023"
[12:54:51.926] Popped gitiles commit info from properties and tags
[12:54:51.926] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:54:51.926] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:54:51.927] Buildbucket request:
{
"requestId": "8875883921739973376",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875883921739973376",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "585b41c2ecc0bf72b9956b86f1b19e21ff02259d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@585b41c2ecc0bf72b9956b86f1b19e21ff02259d",
"title": "585b41c2ecc0bf72b9956b86f1b19e21ff02259d",
"url": "https://llvm.googlesource.com/llvm-project/+/585b41c2ecc0bf72b9956b86f1b19e21ff02259d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5fe63ae9a3fb7502ce7ed076ea14def97d79e85e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5fe63ae9a3fb7502ce7ed076ea14def97d79e85e",
"title": "5fe63ae9a3fb7502ce7ed076ea14def97d79e85e",
"url": "https://llvm.googlesource.com/llvm-project/+/5fe63ae9a3fb7502ce7ed076ea14def97d79e85e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dea4f3213d84507ca9741faccab789f48c44e00d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dea4f3213d84507ca9741faccab789f48c44e00d",
"title": "dea4f3213d84507ca9741faccab789f48c44e00d",
"url": "https://llvm.googlesource.com/llvm-project/+/dea4f3213d84507ca9741faccab789f48c44e00d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f575b18fdc8359bddc8747dbb8b16e5d10705dda"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f575b18fdc8359bddc8747dbb8b16e5d10705dda",
"title": "f575b18fdc8359bddc8747dbb8b16e5d10705dda",
"url": "https://llvm.googlesource.com/llvm-project/+/f575b18fdc8359bddc8747dbb8b16e5d10705dda"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6ec9b1b366726311a6c991c68c62f05d61e4b87d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6ec9b1b366726311a6c991c68c62f05d61e4b87d",
"title": "6ec9b1b366726311a6c991c68c62f05d61e4b87d",
"url": "https://llvm.googlesource.com/llvm-project/+/6ec9b1b366726311a6c991c68c62f05d61e4b87d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9eac5f72f6296812ecc8dc23ce2b312b4f3e75e8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9eac5f72f6296812ecc8dc23ce2b312b4f3e75e8",
"title": "9eac5f72f6296812ecc8dc23ce2b312b4f3e75e8",
"url": "https://llvm.googlesource.com/llvm-project/+/9eac5f72f6296812ecc8dc23ce2b312b4f3e75e8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c0e9084b1ce1a93fd8c2a650e48b3e11d831b649"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c0e9084b1ce1a93fd8c2a650e48b3e11d831b649",
"title": "c0e9084b1ce1a93fd8c2a650e48b3e11d831b649",
"url": "https://llvm.googlesource.com/llvm-project/+/c0e9084b1ce1a93fd8c2a650e48b3e11d831b649"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0aafeb8ba1b1adcf04d5d82553228ca82845fcb0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0aafeb8ba1b1adcf04d5d82553228ca82845fcb0",
"title": "0aafeb8ba1b1adcf04d5d82553228ca82845fcb0",
"url": "https://llvm.googlesource.com/llvm-project/+/0aafeb8ba1b1adcf04d5d82553228ca82845fcb0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9c0743fbc5ba38ae5f66444d144d314326dc8468"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9c0743fbc5ba38ae5f66444d144d314326dc8468",
"title": "9c0743fbc5ba38ae5f66444d144d314326dc8468",
"url": "https://llvm.googlesource.com/llvm-project/+/9c0743fbc5ba38ae5f66444d144d314326dc8468"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4e213159af9eea0716d2cdfbae2c482176608042"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4e213159af9eea0716d2cdfbae2c482176608042",
"title": "4e213159af9eea0716d2cdfbae2c482176608042",
"url": "https://llvm.googlesource.com/llvm-project/+/4e213159af9eea0716d2cdfbae2c482176608042"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "acb52a8a98f0d14a6720f8f6b40e0194ccf9b426"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@acb52a8a98f0d14a6720f8f6b40e0194ccf9b426",
"title": "acb52a8a98f0d14a6720f8f6b40e0194ccf9b426",
"url": "https://llvm.googlesource.com/llvm-project/+/acb52a8a98f0d14a6720f8f6b40e0194ccf9b426"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e63de82d904c2364c84489894eeb81fb9c08a023"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e63de82d904c2364c84489894eeb81fb9c08a023",
"title": "e63de82d904c2364c84489894eeb81fb9c08a023",
"url": "https://llvm.googlesource.com/llvm-project/+/e63de82d904c2364c84489894eeb81fb9c08a023"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e63de82d904c2364c84489894eeb81fb9c08a023",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875883921739973376"
},
{
"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"
}
}
[12:54:52.520] Scheduled build:
{
"id": "8710453859669073457",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-02T12:54:51.999768656Z",
"updateTime": "2025-07-02T12:54:51.999768656Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e63de82d904c2364c84489894eeb81fb9c08a023",
"ref": "refs/heads/main"
}
}
}
[12:54:52.520] Task URL: https://cr-buildbucket.appspot.com/build/8710453859669073457
[12:54:52.520] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:2:0) after 3m44s
[12:54:53.433] Received PubSub notification, asking Buildbucket for the build status
[12:54:53.482] Build status: SCHEDULED
[12:58:36.545] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:2:0)
[12:58:36.578] Build status: SCHEDULED
[12:58:36.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:4:0) after 3m4s
[13:01:40.605] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:4:0)
[13:01:40.628] Build status: SCHEDULED
[13:01:40.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:5:0) after 7m43s
[13:09:23.671] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:5:0)
[13:09:23.696] Build status: SCHEDULED
[13:09:23.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:6:0) after 6m43s
[13:16:06.687] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:6:0)
[13:16:06.723] Build status: SCHEDULED
[13:16:06.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:7:0) after 2m26s
[13:18:32.790] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:7:0)
[13:18:32.816] Build status: SCHEDULED
[13:18:32.816] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:8:0) after 5m16s
[13:23:48.867] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:8:0)
[13:23:48.902] Build status: SCHEDULED
[13:23:48.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:9:0) after 2m15s
[13:26:04.060] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:9:0)
[13:26:04.080] Build status: SCHEDULED
[13:26:04.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:10:0) after 4m27s
[13:30:31.201] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:10:0)
[13:30:31.230] Build status: SCHEDULED
[13:30:31.230] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:11:0) after 2m14s
[13:32:45.250] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:11:0)
[13:32:45.267] Build status: SCHEDULED
[13:32:45.267] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:12:0) after 5m39s
[13:38:24.326] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:12:0)
[13:38:24.342] Build status: SCHEDULED
[13:38:24.342] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:13:0) after 2m52s
[13:41:16.369] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:13:0)
[13:41:16.390] Build status: SCHEDULED
[13:41:16.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:14:0) after 1m27s
[13:42:31.641] Received PubSub notification, asking Buildbucket for the build status
[13:42:31.666] Build status: STARTED
[13:42:43.407] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:14:0)
[13:42:43.460] Build status: STARTED
[13:42:43.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:16:0) after 9m52s
[13:52:35.488] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:16:0)
[13:52:35.577] Build status: STARTED
[13:52:35.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:17:0) after 1m57s
[13:54:32.651] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:17:0)
[13:54:32.676] Build status: STARTED
[13:54:32.676] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:18:0) after 7m18s
[14:01:50.818] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:18:0)
[14:01:50.860] Build status: STARTED
[14:01:50.860] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:19:0) after 7m56s
[14:09:46.867] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:19:0)
[14:09:46.884] Build status: STARTED
[14:09:46.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:20:0) after 2m12s
[14:11:58.907] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:20:0)
[14:11:58.931] Build status: STARTED
[14:11:58.931] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:21:0) after 5m0s
[14:16:59.003] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:21:0)
[14:16:59.116] Build status: STARTED
[14:16:59.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:22:0) after 6m6s
[14:23:05.152] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:22:0)
[14:23:05.192] Build status: STARTED
[14:23:05.192] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:23:0) after 7m45s
[14:30:50.305] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:23:0)
[14:30:50.331] Build status: STARTED
[14:30:50.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:24:0) after 8m13s
[14:39:03.391] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:24:0)
[14:39:03.408] Build status: STARTED
[14:39:03.408] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:25:0) after 4m16s
[14:43:19.457] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:25:0)
[14:43:19.488] Build status: STARTED
[14:43:19.488] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:26:0) after 9m39s
[14:52:58.590] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:26:0)
[14:52:58.615] Build status: STARTED
[14:52:58.615] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:27:0) after 3m0s
[14:55:58.604] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:27:0)
[14:55:58.620] Build status: STARTED
[14:55:58.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:28:0) after 1m3s
[14:57:01.649] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:28:0)
[14:57:01.666] Build status: STARTED
[14:57:01.666] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:29:0) after 6m8s
[15:03:09.687] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:29:0)
[15:03:09.710] Build status: STARTED
[15:03:09.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:30:0) after 5m19s
[15:08:28.738] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:30:0)
[15:08:28.757] Build status: STARTED
[15:08:28.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:31:0) after 2m26s
[15:10:54.818] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:31:0)
[15:10:54.854] Build status: STARTED
[15:10:54.854] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875883921739973376:32:0) after 3m46s
[15:11:37.217] Received PubSub notification, asking Buildbucket for the build status
[15:11:37.263] Build:
{
"id": "8710453859669073457",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-02T12:54:51.999768656Z",
"startTime": "2025-07-02T13:42:30.911574814Z",
"endTime": "2025-07-02T15:11:36.604358134Z",
"updateTime": "2025-07-02T15:11:36.604358134Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e63de82d904c2364c84489894eeb81fb9c08a023",
"ref": "refs/heads/main"
}
}
}
[15:11:37.263] Invocation finished in 2h16m46.622072754s with status SUCCEEDED