[13:14:56.497] New invocation is queued and will start shortly
[13:14:57.903] Starting the invocation (attempt 1)
[13:14:57.931] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/040860accbad57d2ed2ba132460ce618d4ba92fb"
[13:14:57.931] Popped gitiles commit info from properties and tags
[13:14:57.931] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:14:57.931] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:14:57.931] Buildbucket request:
{
"requestId": "8887207278123739792",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8887207278123739792",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "741d7fab4e6c00dea5a38ba202ea80e03b71c59d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@741d7fab4e6c00dea5a38ba202ea80e03b71c59d",
"title": "741d7fab4e6c00dea5a38ba202ea80e03b71c59d",
"url": "https://llvm.googlesource.com/llvm-project/+/741d7fab4e6c00dea5a38ba202ea80e03b71c59d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "556e4dbdcdfc88bc52b43324c4b3af0100c75cc4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@556e4dbdcdfc88bc52b43324c4b3af0100c75cc4",
"title": "556e4dbdcdfc88bc52b43324c4b3af0100c75cc4",
"url": "https://llvm.googlesource.com/llvm-project/+/556e4dbdcdfc88bc52b43324c4b3af0100c75cc4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7b263faf165df7dc647acae435cf9c47bdee4d1f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7b263faf165df7dc647acae435cf9c47bdee4d1f",
"title": "7b263faf165df7dc647acae435cf9c47bdee4d1f",
"url": "https://llvm.googlesource.com/llvm-project/+/7b263faf165df7dc647acae435cf9c47bdee4d1f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "56762b7ace0596404e5ae271f278cf7540b374f2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@56762b7ace0596404e5ae271f278cf7540b374f2",
"title": "56762b7ace0596404e5ae271f278cf7540b374f2",
"url": "https://llvm.googlesource.com/llvm-project/+/56762b7ace0596404e5ae271f278cf7540b374f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fd534e524dd3b683077cab2dae4c87b7c2f1b574"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fd534e524dd3b683077cab2dae4c87b7c2f1b574",
"title": "fd534e524dd3b683077cab2dae4c87b7c2f1b574",
"url": "https://llvm.googlesource.com/llvm-project/+/fd534e524dd3b683077cab2dae4c87b7c2f1b574"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "649f4dcc1930ab5aa338c0f1b13ebb16767be400"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@649f4dcc1930ab5aa338c0f1b13ebb16767be400",
"title": "649f4dcc1930ab5aa338c0f1b13ebb16767be400",
"url": "https://llvm.googlesource.com/llvm-project/+/649f4dcc1930ab5aa338c0f1b13ebb16767be400"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0865a3872ceb65af2660baf6951a4cee44b65fb1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0865a3872ceb65af2660baf6951a4cee44b65fb1",
"title": "0865a3872ceb65af2660baf6951a4cee44b65fb1",
"url": "https://llvm.googlesource.com/llvm-project/+/0865a3872ceb65af2660baf6951a4cee44b65fb1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "285b411e4635e8db2526d653488ee54dad2bff34"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@285b411e4635e8db2526d653488ee54dad2bff34",
"title": "285b411e4635e8db2526d653488ee54dad2bff34",
"url": "https://llvm.googlesource.com/llvm-project/+/285b411e4635e8db2526d653488ee54dad2bff34"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9c26e34fced193f446ab825dc86b1a728d39aa56"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9c26e34fced193f446ab825dc86b1a728d39aa56",
"title": "9c26e34fced193f446ab825dc86b1a728d39aa56",
"url": "https://llvm.googlesource.com/llvm-project/+/9c26e34fced193f446ab825dc86b1a728d39aa56"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "65c45bfa7dd3bc6afa34f2822e61962b810e4244"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@65c45bfa7dd3bc6afa34f2822e61962b810e4244",
"title": "65c45bfa7dd3bc6afa34f2822e61962b810e4244",
"url": "https://llvm.googlesource.com/llvm-project/+/65c45bfa7dd3bc6afa34f2822e61962b810e4244"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "816e7cdb131832108eee0763a354d8ba7a28d98d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@816e7cdb131832108eee0763a354d8ba7a28d98d",
"title": "816e7cdb131832108eee0763a354d8ba7a28d98d",
"url": "https://llvm.googlesource.com/llvm-project/+/816e7cdb131832108eee0763a354d8ba7a28d98d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "040860accbad57d2ed2ba132460ce618d4ba92fb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@040860accbad57d2ed2ba132460ce618d4ba92fb",
"title": "040860accbad57d2ed2ba132460ce618d4ba92fb",
"url": "https://llvm.googlesource.com/llvm-project/+/040860accbad57d2ed2ba132460ce618d4ba92fb"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "040860accbad57d2ed2ba132460ce618d4ba92fb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8887207278123739792"
},
{
"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"
}
}
[13:14:58.339] Scheduled build:
{
"id": "8721777215874858961",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-27T13:14:58.010659127Z",
"updateTime": "2025-02-27T13:14:58.010659127Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "040860accbad57d2ed2ba132460ce618d4ba92fb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[13:14:58.339] Task URL: https://cr-buildbucket.appspot.com/build/8721777215874858961
[13:14:58.339] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:2:0) after 8m43s
[13:15:05.637] Received PubSub notification, asking Buildbucket for the build status
[13:15:05.665] Build status: SCHEDULED
[13:15:16.341] Received PubSub notification, asking Buildbucket for the build status
[13:15:16.366] Build status: STARTED
[13:23:41.471] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:2:0)
[13:23:41.502] Build status: STARTED
[13:23:41.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:5:0) after 7m43s
[13:31:24.533] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:5:0)
[13:31:24.569] Build status: STARTED
[13:31:24.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:6:0) after 4m43s
[13:36:07.636] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:6:0)
[13:36:07.659] Build status: STARTED
[13:36:07.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:7:0) after 6m54s
[13:43:01.728] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:7:0)
[13:43:01.751] Build status: STARTED
[13:43:01.751] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:8:0) after 3m12s
[13:46:13.773] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:8:0)
[13:46:13.792] Build status: STARTED
[13:46:13.792] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:9:0) after 6m10s
[13:52:23.810] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:9:0)
[13:52:23.836] Build status: STARTED
[13:52:23.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:10:0) after 1m54s
[13:54:17.917] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:10:0)
[13:54:17.936] Build status: STARTED
[13:54:17.936] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:11:0) after 8m53s
[14:03:10.966] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:11:0)
[14:03:11.502] Build status: STARTED
[14:03:11.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:12:0) after 6m5s
[14:09:16.593] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:12:0)
[14:09:16.612] Build status: STARTED
[14:09:16.612] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:13:0) after 2m22s
[14:11:38.750] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:13:0)
[14:11:38.773] Build status: STARTED
[14:11:38.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:14:0) after 4m1s
[14:15:39.832] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:14:0)
[14:15:39.848] Build status: STARTED
[14:15:39.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:15:0) after 5m7s
[14:20:46.854] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:15:0)
[14:20:46.880] Build status: STARTED
[14:20:46.880] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:16:0) after 1m51s
[14:22:37.952] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:16:0)
[14:22:37.970] Build status: STARTED
[14:22:37.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:17:0) after 9m2s
[14:31:40.014] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:17:0)
[14:31:40.035] Build status: STARTED
[14:31:40.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:18:0) after 8m52s
[14:40:32.336] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:18:0)
[14:40:32.351] Build status: STARTED
[14:40:32.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:19:0) after 2m11s
[14:42:43.384] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:19:0)
[14:42:43.450] Build status: STARTED
[14:42:43.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:20:0) after 7m53s
[14:50:36.496] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:20:0)
[14:50:36.512] Build status: STARTED
[14:50:36.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:21:0) after 6m16s
[14:56:52.545] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:21:0)
[14:56:52.578] Build status: STARTED
[14:56:52.578] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:22:0) after 2m24s
[14:59:16.596] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:22:0)
[14:59:16.613] Build status: STARTED
[14:59:16.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:23:0) after 7m20s
[15:06:36.659] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:23:0)
[15:06:36.679] Build status: STARTED
[15:06:36.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8887207278123739792:24:0) after 8m50s
[15:10:56.286] Received PubSub notification, asking Buildbucket for the build status
[15:10:56.311] Build:
{
"id": "8721777215874858961",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-27T13:14:58.010659127Z",
"startTime": "2025-02-27T13:15:07.967921114Z",
"endTime": "2025-02-27T15:10:55.985146811Z",
"updateTime": "2025-02-27T15:10:55.985146811Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "040860accbad57d2ed2ba132460ce618d4ba92fb",
"ref": "refs/heads/main"
}
},
"canary": true
}
[15:10:56.311] Invocation finished in 1h55m59.828506364s with status SUCCEEDED