[22:22:32.533] New invocation is queued and will start shortly
[22:22:33.745] Starting the invocation (attempt 1)
[22:22:33.775] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e4104c0eeaaeb739298e865e007b9428d5fcb6c2"
[22:22:33.776] Popped gitiles commit info from properties and tags
[22:22:33.776] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:22:33.776] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:22:33.776] Buildbucket request:
{
"requestId": "8905654607216130096",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8905654607216130096",
"job": "fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2d95dee0c06687814eeb5c883e305a7197e26a95"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2d95dee0c06687814eeb5c883e305a7197e26a95",
"title": "2d95dee0c06687814eeb5c883e305a7197e26a95",
"url": "https://llvm.googlesource.com/llvm-project/+/2d95dee0c06687814eeb5c883e305a7197e26a95"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "da140bc1e3be4dfd49e17c2f4cc496ae75ff8693"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@da140bc1e3be4dfd49e17c2f4cc496ae75ff8693",
"title": "da140bc1e3be4dfd49e17c2f4cc496ae75ff8693",
"url": "https://llvm.googlesource.com/llvm-project/+/da140bc1e3be4dfd49e17c2f4cc496ae75ff8693"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ede49fa5f3f32796618a71880038e2564c9d4db9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ede49fa5f3f32796618a71880038e2564c9d4db9",
"title": "ede49fa5f3f32796618a71880038e2564c9d4db9",
"url": "https://llvm.googlesource.com/llvm-project/+/ede49fa5f3f32796618a71880038e2564c9d4db9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "82c2259aeb87f5cb418decfb6a1961287055e5d2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@82c2259aeb87f5cb418decfb6a1961287055e5d2",
"title": "82c2259aeb87f5cb418decfb6a1961287055e5d2",
"url": "https://llvm.googlesource.com/llvm-project/+/82c2259aeb87f5cb418decfb6a1961287055e5d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0ac9a659009d2090de57b04dae06e9c8c5fcb831"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0ac9a659009d2090de57b04dae06e9c8c5fcb831",
"title": "0ac9a659009d2090de57b04dae06e9c8c5fcb831",
"url": "https://llvm.googlesource.com/llvm-project/+/0ac9a659009d2090de57b04dae06e9c8c5fcb831"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3210bce90f8678d52ea67f812bfe81d1c9de7597"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3210bce90f8678d52ea67f812bfe81d1c9de7597",
"title": "3210bce90f8678d52ea67f812bfe81d1c9de7597",
"url": "https://llvm.googlesource.com/llvm-project/+/3210bce90f8678d52ea67f812bfe81d1c9de7597"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3b6f7cb0b31468078368f77118ab267b43d8628"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3b6f7cb0b31468078368f77118ab267b43d8628",
"title": "b3b6f7cb0b31468078368f77118ab267b43d8628",
"url": "https://llvm.googlesource.com/llvm-project/+/b3b6f7cb0b31468078368f77118ab267b43d8628"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cb5dc1faa8b3702e0d03426ee5dfc5e1b903ec47"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cb5dc1faa8b3702e0d03426ee5dfc5e1b903ec47",
"title": "cb5dc1faa8b3702e0d03426ee5dfc5e1b903ec47",
"url": "https://llvm.googlesource.com/llvm-project/+/cb5dc1faa8b3702e0d03426ee5dfc5e1b903ec47"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cece4ba5c2eebac414ad4d1028c3220e79403a7a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cece4ba5c2eebac414ad4d1028c3220e79403a7a",
"title": "cece4ba5c2eebac414ad4d1028c3220e79403a7a",
"url": "https://llvm.googlesource.com/llvm-project/+/cece4ba5c2eebac414ad4d1028c3220e79403a7a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cf416e0a1bd1b3ff6edc662116295f6fffe24be0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cf416e0a1bd1b3ff6edc662116295f6fffe24be0",
"title": "cf416e0a1bd1b3ff6edc662116295f6fffe24be0",
"url": "https://llvm.googlesource.com/llvm-project/+/cf416e0a1bd1b3ff6edc662116295f6fffe24be0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aeb1989bb585e216a13fddeaf28887bdf8623075"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aeb1989bb585e216a13fddeaf28887bdf8623075",
"title": "aeb1989bb585e216a13fddeaf28887bdf8623075",
"url": "https://llvm.googlesource.com/llvm-project/+/aeb1989bb585e216a13fddeaf28887bdf8623075"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c178fea62d3999acd42f3ddfcc8bd436b574cfed"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c178fea62d3999acd42f3ddfcc8bd436b574cfed",
"title": "c178fea62d3999acd42f3ddfcc8bd436b574cfed",
"url": "https://llvm.googlesource.com/llvm-project/+/c178fea62d3999acd42f3ddfcc8bd436b574cfed"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "34157f694ce45cd3bf14c8494e7581bfd2a9b4d2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@34157f694ce45cd3bf14c8494e7581bfd2a9b4d2",
"title": "34157f694ce45cd3bf14c8494e7581bfd2a9b4d2",
"url": "https://llvm.googlesource.com/llvm-project/+/34157f694ce45cd3bf14c8494e7581bfd2a9b4d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e4104c0eeaaeb739298e865e007b9428d5fcb6c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e4104c0eeaaeb739298e865e007b9428d5fcb6c2",
"title": "e4104c0eeaaeb739298e865e007b9428d5fcb6c2",
"url": "https://llvm.googlesource.com/llvm-project/+/e4104c0eeaaeb739298e865e007b9428d5fcb6c2"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e4104c0eeaaeb739298e865e007b9428d5fcb6c2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905654607216130096"
},
{
"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"
}
}
[22:22:34.247] Scheduled build:
{
"id": "8740224545158824065",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-07T22:22:33.866145776Z",
"updateTime": "2024-08-07T22:22:33.866145776Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e4104c0eeaaeb739298e865e007b9428d5fcb6c2",
"ref": "refs/heads/main"
}
}
}
[22:22:34.247] Task URL: https://cr-buildbucket.appspot.com/build/8740224545158824065
[22:22:34.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:2:0) after 5m56s
[22:22:35.262] Received PubSub notification, asking Buildbucket for the build status
[22:22:35.288] Build status: SCHEDULED
[22:22:53.598] Received PubSub notification, asking Buildbucket for the build status
[22:22:53.638] Build status: STARTED
[22:28:30.298] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:2:0)
[22:28:30.318] Build status: STARTED
[22:28:30.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:5:0) after 8m16s
[22:36:46.339] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:5:0)
[22:36:46.356] Build status: STARTED
[22:36:46.356] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:6:0) after 6m23s
[22:43:09.382] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:6:0)
[22:43:09.409] Build status: STARTED
[22:43:09.409] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:7:0) after 1m48s
[22:44:57.477] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:7:0)
[22:44:57.494] Build status: STARTED
[22:44:57.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:8:0) after 1m16s
[22:46:13.519] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:8:0)
[22:46:13.546] Build status: STARTED
[22:46:13.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:9:0) after 5m28s
[22:51:41.574] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:9:0)
[22:51:41.592] Build status: STARTED
[22:51:41.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:10:0) after 8m9s
[22:59:50.610] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:10:0)
[22:59:50.636] Build status: STARTED
[22:59:50.636] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:11:0) after 4m33s
[23:04:23.715] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:11:0)
[23:04:23.738] Build status: STARTED
[23:04:23.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:12:0) after 5m51s
[23:10:14.757] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:12:0)
[23:10:14.790] Build status: STARTED
[23:10:14.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:13:0) after 3m38s
[23:13:52.807] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:13:0)
[23:13:52.829] Build status: STARTED
[23:13:52.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:14:0) after 7m14s
[23:21:06.856] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:14:0)
[23:21:06.877] Build status: STARTED
[23:21:06.877] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:15:0) after 1m5s
[23:22:11.897] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:15:0)
[23:22:11.938] Build status: STARTED
[23:22:11.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:16:0) after 2m48s
[23:25:00.041] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:16:0)
[23:25:00.063] Build status: STARTED
[23:25:00.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:17:0) after 4m42s
[23:29:42.177] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:17:0)
[23:29:42.198] Build status: STARTED
[23:29:42.198] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:18:0) after 7m36s
[23:37:18.223] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:18:0)
[23:37:18.241] Build status: STARTED
[23:37:18.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:19:0) after 1m40s
[23:38:58.416] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:19:0)
[23:38:58.469] Build status: STARTED
[23:38:58.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:20:0) after 8m32s
[23:47:30.490] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:20:0)
[23:47:30.512] Build status: STARTED
[23:47:30.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:21:0) after 2m55s
[23:50:25.529] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:21:0)
[23:50:25.581] Build status: STARTED
[23:50:25.581] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-arm64-40be1bb5:8905654607216130096:22:0) after 7m4s
[23:50:41.819] Received PubSub notification, asking Buildbucket for the build status
[23:50:41.840] Build:
{
"id": "8740224545158824065",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-arm64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-07T22:22:33.866145776Z",
"startTime": "2024-08-07T22:22:53.412023396Z",
"endTime": "2024-08-07T23:50:41.435017417Z",
"updateTime": "2024-08-07T23:50:41.435017417Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e4104c0eeaaeb739298e865e007b9428d5fcb6c2",
"ref": "refs/heads/main"
}
}
}
[23:50:41.840] Invocation finished in 1h28m9.320857685s with status SUCCEEDED