[08:34:54.610] New invocation is queued and will start shortly
[08:34:55.718] Starting the invocation (attempt 1)
[08:34:55.752] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d0dcfd4c68171c3b9b863626c08efa7f38cd0c54"
[08:34:55.752] Popped gitiles commit info from properties and tags
[08:34:55.752] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:34:55.752] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:34:55.753] Buildbucket request:
{
"requestId": "8881426690325363488",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8881426690325363488",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aea2f6f69cd256d85a0d3986c0e72181bb5247ab"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aea2f6f69cd256d85a0d3986c0e72181bb5247ab",
"title": "aea2f6f69cd256d85a0d3986c0e72181bb5247ab",
"url": "https://llvm.googlesource.com/llvm-project/+/aea2f6f69cd256d85a0d3986c0e72181bb5247ab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b4ab53c3b04787f430c2e3484998951c48b05968"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b4ab53c3b04787f430c2e3484998951c48b05968",
"title": "b4ab53c3b04787f430c2e3484998951c48b05968",
"url": "https://llvm.googlesource.com/llvm-project/+/b4ab53c3b04787f430c2e3484998951c48b05968"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8b752b9874489229e4afceadd958fdc9ff7a2edb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8b752b9874489229e4afceadd958fdc9ff7a2edb",
"title": "8b752b9874489229e4afceadd958fdc9ff7a2edb",
"url": "https://llvm.googlesource.com/llvm-project/+/8b752b9874489229e4afceadd958fdc9ff7a2edb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3f367a65d31a7178e222a7babae7baa0a93ff292"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3f367a65d31a7178e222a7babae7baa0a93ff292",
"title": "3f367a65d31a7178e222a7babae7baa0a93ff292",
"url": "https://llvm.googlesource.com/llvm-project/+/3f367a65d31a7178e222a7babae7baa0a93ff292"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff28e1a5a92da380c2869aba09971687c26d2f0f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff28e1a5a92da380c2869aba09971687c26d2f0f",
"title": "ff28e1a5a92da380c2869aba09971687c26d2f0f",
"url": "https://llvm.googlesource.com/llvm-project/+/ff28e1a5a92da380c2869aba09971687c26d2f0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4109bac3301eb7b7033eec3c8e8107be8cad9bc9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4109bac3301eb7b7033eec3c8e8107be8cad9bc9",
"title": "4109bac3301eb7b7033eec3c8e8107be8cad9bc9",
"url": "https://llvm.googlesource.com/llvm-project/+/4109bac3301eb7b7033eec3c8e8107be8cad9bc9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "140c2b6d081b781b19f50bf1c4fbf4b17bfacdc1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@140c2b6d081b781b19f50bf1c4fbf4b17bfacdc1",
"title": "140c2b6d081b781b19f50bf1c4fbf4b17bfacdc1",
"url": "https://llvm.googlesource.com/llvm-project/+/140c2b6d081b781b19f50bf1c4fbf4b17bfacdc1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a8ec6e8788832cff77ec855a2331438c937fb5da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a8ec6e8788832cff77ec855a2331438c937fb5da",
"title": "a8ec6e8788832cff77ec855a2331438c937fb5da",
"url": "https://llvm.googlesource.com/llvm-project/+/a8ec6e8788832cff77ec855a2331438c937fb5da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f66f2fe0e5be6dc6eb3ef4d42af8692f9adcdc80"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f66f2fe0e5be6dc6eb3ef4d42af8692f9adcdc80",
"title": "f66f2fe0e5be6dc6eb3ef4d42af8692f9adcdc80",
"url": "https://llvm.googlesource.com/llvm-project/+/f66f2fe0e5be6dc6eb3ef4d42af8692f9adcdc80"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "592243c1cb3ea53b34033132a87b0d14af9d1079"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@592243c1cb3ea53b34033132a87b0d14af9d1079",
"title": "592243c1cb3ea53b34033132a87b0d14af9d1079",
"url": "https://llvm.googlesource.com/llvm-project/+/592243c1cb3ea53b34033132a87b0d14af9d1079"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "db247ddc9d5411ace70b478f7119eb44a43a8e5c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@db247ddc9d5411ace70b478f7119eb44a43a8e5c",
"title": "db247ddc9d5411ace70b478f7119eb44a43a8e5c",
"url": "https://llvm.googlesource.com/llvm-project/+/db247ddc9d5411ace70b478f7119eb44a43a8e5c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9bc20fbbadb18a1c3415d4442066ed35a6bcc175"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9bc20fbbadb18a1c3415d4442066ed35a6bcc175",
"title": "9bc20fbbadb18a1c3415d4442066ed35a6bcc175",
"url": "https://llvm.googlesource.com/llvm-project/+/9bc20fbbadb18a1c3415d4442066ed35a6bcc175"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8a84a19cf9ccbc1d0878f51b0466dc3a3b93dbe3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8a84a19cf9ccbc1d0878f51b0466dc3a3b93dbe3",
"title": "8a84a19cf9ccbc1d0878f51b0466dc3a3b93dbe3",
"url": "https://llvm.googlesource.com/llvm-project/+/8a84a19cf9ccbc1d0878f51b0466dc3a3b93dbe3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "68bfe91b5a34f80dbcc4f0a7fa5d7aa1cdf959c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@68bfe91b5a34f80dbcc4f0a7fa5d7aa1cdf959c2",
"title": "68bfe91b5a34f80dbcc4f0a7fa5d7aa1cdf959c2",
"url": "https://llvm.googlesource.com/llvm-project/+/68bfe91b5a34f80dbcc4f0a7fa5d7aa1cdf959c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "abe93fe7c88c477343c884036982ddc15f820425"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@abe93fe7c88c477343c884036982ddc15f820425",
"title": "abe93fe7c88c477343c884036982ddc15f820425",
"url": "https://llvm.googlesource.com/llvm-project/+/abe93fe7c88c477343c884036982ddc15f820425"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "df344285e260109e016e28a14e663f376d8e903c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@df344285e260109e016e28a14e663f376d8e903c",
"title": "df344285e260109e016e28a14e663f376d8e903c",
"url": "https://llvm.googlesource.com/llvm-project/+/df344285e260109e016e28a14e663f376d8e903c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d0dcfd4c68171c3b9b863626c08efa7f38cd0c54"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d0dcfd4c68171c3b9b863626c08efa7f38cd0c54",
"title": "d0dcfd4c68171c3b9b863626c08efa7f38cd0c54",
"url": "https://llvm.googlesource.com/llvm-project/+/d0dcfd4c68171c3b9b863626c08efa7f38cd0c54"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d0dcfd4c68171c3b9b863626c08efa7f38cd0c54",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8881426690325363488"
},
{
"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"
}
}
[08:34:56.165] Scheduled build:
{
"id": "8715996628402904097",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-02T08:34:55.816506406Z",
"updateTime": "2025-05-02T08:34:55.816506406Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d0dcfd4c68171c3b9b863626c08efa7f38cd0c54",
"ref": "refs/heads/main"
}
}
}
[08:34:56.165] Task URL: https://cr-buildbucket.appspot.com/build/8715996628402904097
[08:34:56.165] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:2:0) after 8m45s
[08:35:22.691] Received PubSub notification, asking Buildbucket for the build status
[08:35:22.724] Build status: SCHEDULED
[08:43:41.185] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:2:0)
[08:43:41.218] Build status: SCHEDULED
[08:43:41.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:4:0) after 7m45s
[08:51:26.334] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:4:0)
[08:51:26.354] Build status: SCHEDULED
[08:51:26.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:5:0) after 4m48s
[08:56:14.428] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:5:0)
[08:56:14.456] Build status: SCHEDULED
[08:56:14.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:6:0) after 6m9s
[08:58:15.967] Received PubSub notification, asking Buildbucket for the build status
[08:58:15.989] Build status: STARTED
[09:02:23.472] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:6:0)
[09:02:23.496] Build status: STARTED
[09:02:23.496] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:8:0) after 5m30s
[09:07:53.521] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:8:0)
[09:07:53.685] Build status: STARTED
[09:07:53.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:9:0) after 8m55s
[09:16:48.732] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:9:0)
[09:16:48.840] Build status: STARTED
[09:16:48.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:10:0) after 9m44s
[09:26:32.916] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:10:0)
[09:26:32.940] Build status: STARTED
[09:26:32.940] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:11:0) after 9m39s
[09:36:12.004] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:11:0)
[09:36:12.021] Build status: STARTED
[09:36:12.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:12:0) after 4m38s
[09:40:50.035] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:12:0)
[09:40:50.054] Build status: STARTED
[09:40:50.054] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:13:0) after 4m34s
[09:45:24.071] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:13:0)
[09:45:24.086] Build status: STARTED
[09:45:24.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:14:0) after 8m36s
[09:54:00.167] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:14:0)
[09:54:00.188] Build status: STARTED
[09:54:00.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:15:0) after 1m58s
[09:55:58.263] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:15:0)
[09:55:58.277] Build status: STARTED
[09:55:58.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:16:0) after 2m22s
[09:58:20.302] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:16:0)
[09:58:20.317] Build status: STARTED
[09:58:20.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:17:0) after 8m42s
[10:07:02.466] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:17:0)
[10:07:02.539] Build status: STARTED
[10:07:02.539] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:18:0) after 2m11s
[10:09:13.691] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:18:0)
[10:09:13.712] Build status: STARTED
[10:09:13.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:19:0) after 4m46s
[10:13:59.758] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:19:0)
[10:13:59.848] Build status: STARTED
[10:13:59.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:20:0) after 9m35s
[10:23:35.207] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:20:0)
[10:23:35.226] Build status: STARTED
[10:23:35.226] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:21:0) after 3m25s
[10:27:00.646] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:21:0)
[10:27:00.670] Build status: STARTED
[10:27:00.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:22:0) after 6m14s
[10:33:14.777] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:22:0)
[10:33:14.799] Build status: STARTED
[10:33:14.799] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8881426690325363488:23:0) after 5m29s
[10:34:49.911] Received PubSub notification, asking Buildbucket for the build status
[10:34:49.930] Build:
{
"id": "8715996628402904097",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-02T08:34:55.816506406Z",
"startTime": "2025-05-02T08:58:15.655841446Z",
"endTime": "2025-05-02T10:34:37.994835853Z",
"updateTime": "2025-05-02T10:34:37.994835853Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d0dcfd4c68171c3b9b863626c08efa7f38cd0c54",
"ref": "refs/heads/main"
}
}
}
[10:34:49.930] Invocation finished in 1h59m55.331295505s with status SUCCEEDED