[14:58:34.889] New invocation is queued and will start shortly
[14:58:36.185] Starting the invocation (attempt 1)
[14:58:36.207] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/958f9ff83ea9aa071df1c84c6a467b17d6b8dadf"
[14:58:36.207] Popped gitiles commit info from properties and tags
[14:58:36.207] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:58:36.208] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:58:36.208] Buildbucket request:
{
"requestId": "8840996304791112864",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8840996304791112864",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9d3fe6cf06f1c20a337ce546115523bf1db925de"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9d3fe6cf06f1c20a337ce546115523bf1db925de",
"title": "9d3fe6cf06f1c20a337ce546115523bf1db925de",
"url": "https://llvm.googlesource.com/llvm-project/+/9d3fe6cf06f1c20a337ce546115523bf1db925de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e757e814e30741d6eae6044cea22dca78baa4edf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e757e814e30741d6eae6044cea22dca78baa4edf",
"title": "e757e814e30741d6eae6044cea22dca78baa4edf",
"url": "https://llvm.googlesource.com/llvm-project/+/e757e814e30741d6eae6044cea22dca78baa4edf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d9cf5980b7788a8840d69c6e4abb9092a35997bc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d9cf5980b7788a8840d69c6e4abb9092a35997bc",
"title": "d9cf5980b7788a8840d69c6e4abb9092a35997bc",
"url": "https://llvm.googlesource.com/llvm-project/+/d9cf5980b7788a8840d69c6e4abb9092a35997bc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "150aa53d48aa6fdde26e00ea118582eb949f0dca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@150aa53d48aa6fdde26e00ea118582eb949f0dca",
"title": "150aa53d48aa6fdde26e00ea118582eb949f0dca",
"url": "https://llvm.googlesource.com/llvm-project/+/150aa53d48aa6fdde26e00ea118582eb949f0dca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b52427b6864cc553d9506c39b7f1bfde5f1e170"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b52427b6864cc553d9506c39b7f1bfde5f1e170",
"title": "6b52427b6864cc553d9506c39b7f1bfde5f1e170",
"url": "https://llvm.googlesource.com/llvm-project/+/6b52427b6864cc553d9506c39b7f1bfde5f1e170"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fdae383abe622856b2178b1eb2d6f1c454acf176"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fdae383abe622856b2178b1eb2d6f1c454acf176",
"title": "fdae383abe622856b2178b1eb2d6f1c454acf176",
"url": "https://llvm.googlesource.com/llvm-project/+/fdae383abe622856b2178b1eb2d6f1c454acf176"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "84301dd17f4261b4b8c293cd21b6641b3fdc0add"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@84301dd17f4261b4b8c293cd21b6641b3fdc0add",
"title": "84301dd17f4261b4b8c293cd21b6641b3fdc0add",
"url": "https://llvm.googlesource.com/llvm-project/+/84301dd17f4261b4b8c293cd21b6641b3fdc0add"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "75e637791bff7b6c0c11754fb29991b6b140ee2c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@75e637791bff7b6c0c11754fb29991b6b140ee2c",
"title": "75e637791bff7b6c0c11754fb29991b6b140ee2c",
"url": "https://llvm.googlesource.com/llvm-project/+/75e637791bff7b6c0c11754fb29991b6b140ee2c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3a1f2e1da409a473b4b357810c4a37fd178aa3ca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3a1f2e1da409a473b4b357810c4a37fd178aa3ca",
"title": "3a1f2e1da409a473b4b357810c4a37fd178aa3ca",
"url": "https://llvm.googlesource.com/llvm-project/+/3a1f2e1da409a473b4b357810c4a37fd178aa3ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8ad500f6f7d7347ca097d9c442fbf4a0f604dc26"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8ad500f6f7d7347ca097d9c442fbf4a0f604dc26",
"title": "8ad500f6f7d7347ca097d9c442fbf4a0f604dc26",
"url": "https://llvm.googlesource.com/llvm-project/+/8ad500f6f7d7347ca097d9c442fbf4a0f604dc26"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "02c51adb8ff2b2b4c1041ac9f9d260c20ef77cc4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@02c51adb8ff2b2b4c1041ac9f9d260c20ef77cc4",
"title": "02c51adb8ff2b2b4c1041ac9f9d260c20ef77cc4",
"url": "https://llvm.googlesource.com/llvm-project/+/02c51adb8ff2b2b4c1041ac9f9d260c20ef77cc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "155689a48e43878d2252cd39037909e87b018103"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@155689a48e43878d2252cd39037909e87b018103",
"title": "155689a48e43878d2252cd39037909e87b018103",
"url": "https://llvm.googlesource.com/llvm-project/+/155689a48e43878d2252cd39037909e87b018103"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c53e2a89a48b312901eb70141d5a4e99ed1c532d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c53e2a89a48b312901eb70141d5a4e99ed1c532d",
"title": "c53e2a89a48b312901eb70141d5a4e99ed1c532d",
"url": "https://llvm.googlesource.com/llvm-project/+/c53e2a89a48b312901eb70141d5a4e99ed1c532d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1654b66a6d797371564381ad4e109c994f4f764f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1654b66a6d797371564381ad4e109c994f4f764f",
"title": "1654b66a6d797371564381ad4e109c994f4f764f",
"url": "https://llvm.googlesource.com/llvm-project/+/1654b66a6d797371564381ad4e109c994f4f764f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b9e3e6546dcb4b33d023b7a336163d5650cda9d4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b9e3e6546dcb4b33d023b7a336163d5650cda9d4",
"title": "b9e3e6546dcb4b33d023b7a336163d5650cda9d4",
"url": "https://llvm.googlesource.com/llvm-project/+/b9e3e6546dcb4b33d023b7a336163d5650cda9d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fed8a6f2e38bd82835ddb651305782db6b62f326"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fed8a6f2e38bd82835ddb651305782db6b62f326",
"title": "fed8a6f2e38bd82835ddb651305782db6b62f326",
"url": "https://llvm.googlesource.com/llvm-project/+/fed8a6f2e38bd82835ddb651305782db6b62f326"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "34436db53d3e4ad36e86019109fb5ceee9bb4d8c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@34436db53d3e4ad36e86019109fb5ceee9bb4d8c",
"title": "34436db53d3e4ad36e86019109fb5ceee9bb4d8c",
"url": "https://llvm.googlesource.com/llvm-project/+/34436db53d3e4ad36e86019109fb5ceee9bb4d8c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f5771c8ecc5a9edd4469e08255402436dc7dd31"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f5771c8ecc5a9edd4469e08255402436dc7dd31",
"title": "2f5771c8ecc5a9edd4469e08255402436dc7dd31",
"url": "https://llvm.googlesource.com/llvm-project/+/2f5771c8ecc5a9edd4469e08255402436dc7dd31"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "958f9ff83ea9aa071df1c84c6a467b17d6b8dadf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@958f9ff83ea9aa071df1c84c6a467b17d6b8dadf",
"title": "958f9ff83ea9aa071df1c84c6a467b17d6b8dadf",
"url": "https://llvm.googlesource.com/llvm-project/+/958f9ff83ea9aa071df1c84c6a467b17d6b8dadf"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "958f9ff83ea9aa071df1c84c6a467b17d6b8dadf",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8840996304791112864"
},
{
"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"
}
}
[14:58:36.665] Scheduled build:
{
"id": "8675566242632766657",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-22T14:58:36.328595239Z",
"updateTime": "2026-07-22T14:58:36.328595239Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "958f9ff83ea9aa071df1c84c6a467b17d6b8dadf",
"ref": "refs/heads/main"
}
}
}
[14:58:36.665] Task URL: https://cr-buildbucket.appspot.com/build/8675566242632766657
[14:58:36.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:2:0) after 1m22s
[14:58:37.615] Received PubSub notification, asking Buildbucket for the build status
[14:58:37.648] Build status: SCHEDULED
[14:58:41.669] Received PubSub notification, asking Buildbucket for the build status
[14:58:41.741] Build status: STARTED
[14:59:58.715] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:2:0)
[14:59:58.732] Build status: STARTED
[14:59:58.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:5:0) after 1m10s
[15:01:08.780] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:5:0)
[15:01:08.824] Build status: STARTED
[15:01:08.824] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:6:0) after 4m3s
[15:05:12.033] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:6:0)
[15:05:12.064] Build status: STARTED
[15:05:12.064] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:7:0) after 6m44s
[15:11:56.202] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:7:0)
[15:11:56.236] Build status: STARTED
[15:11:56.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:8:0) after 3m12s
[15:15:08.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:8:0)
[15:15:08.288] Build status: STARTED
[15:15:08.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:9:0) after 1m2s
[15:16:10.443] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:9:0)
[15:16:10.777] Build status: STARTED
[15:16:10.778] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:10:0) after 6m38s
[15:22:48.792] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:10:0)
[15:22:48.820] Build status: STARTED
[15:22:48.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:11:0) after 5m43s
[15:28:31.896] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:11:0)
[15:28:31.919] Build status: STARTED
[15:28:31.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:12:0) after 8m32s
[15:37:03.987] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:12:0)
[15:37:04.026] Build status: STARTED
[15:37:04.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:13:0) after 6m10s
[15:43:14.113] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:13:0)
[15:43:14.134] Build status: STARTED
[15:43:14.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:14:0) after 2m37s
[15:45:51.280] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:14:0)
[15:45:51.309] Build status: STARTED
[15:45:51.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:15:0) after 1m30s
[15:47:21.301] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:15:0)
[15:47:21.316] Build status: STARTED
[15:47:21.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:16:0) after 6m39s
[15:54:00.359] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:16:0)
[15:54:00.387] Build status: STARTED
[15:54:00.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:17:0) after 6m51s
[16:00:51.450] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:17:0)
[16:00:51.470] Build status: STARTED
[16:00:51.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:18:0) after 2m27s
[16:03:19.023] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:18:0)
[16:03:19.097] Build status: STARTED
[16:03:19.097] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:19:0) after 8m12s
[16:11:31.089] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:19:0)
[16:11:31.116] Build status: STARTED
[16:11:31.116] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:20:0) after 8m25s
[16:19:56.235] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:20:0)
[16:19:56.300] Build status: STARTED
[16:19:56.300] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:21:0) after 7m6s
[16:27:02.318] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:21:0)
[16:27:02.438] Build status: STARTED
[16:27:02.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:22:0) after 1m18s
[16:28:20.455] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:22:0)
[16:28:20.487] Build status: STARTED
[16:28:20.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:23:0) after 1m51s
[16:30:11.552] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:23:0)
[16:30:11.607] Build status: STARTED
[16:30:11.607] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:24:0) after 3m46s
[16:33:57.820] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:24:0)
[16:33:57.867] Build status: STARTED
[16:33:57.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:25:0) after 2m55s
[16:36:52.923] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:25:0)
[16:36:52.953] Build status: STARTED
[16:36:52.953] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:26:0) after 9m25s
[16:46:18.152] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:26:0)
[16:46:18.177] Build status: STARTED
[16:46:18.177] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:27:0) after 4m31s
[16:50:49.491] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:27:0)
[16:50:49.547] Build status: STARTED
[16:50:49.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8840996304791112864:28:0) after 7m5s
[16:54:13.386] Received PubSub notification, asking Buildbucket for the build status
[16:54:13.409] Build:
{
"id": "8675566242632766657",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-07-22T14:58:36.328595239Z",
"startTime": "2026-07-22T14:58:41.491424761Z",
"endTime": "2026-07-22T16:54:12.715287252Z",
"updateTime": "2026-07-22T16:54:12.715287252Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "958f9ff83ea9aa071df1c84c6a467b17d6b8dadf",
"ref": "refs/heads/main"
}
}
}
[16:54:13.409] Invocation finished in 1h55m38.523066062s with status SUCCEEDED