[16:22:22.746] New invocation is queued and will start shortly
[16:22:24.194] Starting the invocation (attempt 1)
[16:22:24.222] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/760eca1d1079d46e430722c8d8999b327b083240"
[16:22:24.222] Popped gitiles commit info from properties and tags
[16:22:24.222] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:22:24.222] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:22:24.223] Buildbucket request:
{
"requestId": "8936842623162085088",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8936842623162085088",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ad778a8a0ffd0ab54673c04c196ce8192ea15e6f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ad778a8a0ffd0ab54673c04c196ce8192ea15e6f",
"title": "ad778a8a0ffd0ab54673c04c196ce8192ea15e6f",
"url": "https://llvm.googlesource.com/llvm-project/+/ad778a8a0ffd0ab54673c04c196ce8192ea15e6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f0731d5b61ba798e6d5a63a92d9228010e5a3b50"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f0731d5b61ba798e6d5a63a92d9228010e5a3b50",
"title": "f0731d5b61ba798e6d5a63a92d9228010e5a3b50",
"url": "https://llvm.googlesource.com/llvm-project/+/f0731d5b61ba798e6d5a63a92d9228010e5a3b50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d32f9ad0eb7e602ba5000baaacf926f3756769d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d32f9ad0eb7e602ba5000baaacf926f3756769d",
"title": "4d32f9ad0eb7e602ba5000baaacf926f3756769d",
"url": "https://llvm.googlesource.com/llvm-project/+/4d32f9ad0eb7e602ba5000baaacf926f3756769d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e0a087571a31057bb98939e3ada73227bed83c7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e0a087571a31057bb98939e3ada73227bed83c7",
"title": "8e0a087571a31057bb98939e3ada73227bed83c7",
"url": "https://llvm.googlesource.com/llvm-project/+/8e0a087571a31057bb98939e3ada73227bed83c7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c81fe7f6ce33c974e3bcb7a96c1bf6fbc3ddf2b1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c81fe7f6ce33c974e3bcb7a96c1bf6fbc3ddf2b1",
"title": "c81fe7f6ce33c974e3bcb7a96c1bf6fbc3ddf2b1",
"url": "https://llvm.googlesource.com/llvm-project/+/c81fe7f6ce33c974e3bcb7a96c1bf6fbc3ddf2b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f2f5d6fb8d53bc4bd93a3d4e110134ed017b636f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f2f5d6fb8d53bc4bd93a3d4e110134ed017b636f",
"title": "f2f5d6fb8d53bc4bd93a3d4e110134ed017b636f",
"url": "https://llvm.googlesource.com/llvm-project/+/f2f5d6fb8d53bc4bd93a3d4e110134ed017b636f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ef2b1700f4648816e6a6ce27cfee1c501421ee50"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ef2b1700f4648816e6a6ce27cfee1c501421ee50",
"title": "ef2b1700f4648816e6a6ce27cfee1c501421ee50",
"url": "https://llvm.googlesource.com/llvm-project/+/ef2b1700f4648816e6a6ce27cfee1c501421ee50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "77e965ef454ab1fcb2564e3ade17880a71542f58"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@77e965ef454ab1fcb2564e3ade17880a71542f58",
"title": "77e965ef454ab1fcb2564e3ade17880a71542f58",
"url": "https://llvm.googlesource.com/llvm-project/+/77e965ef454ab1fcb2564e3ade17880a71542f58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "09b6e457d91ce84088e6e21783913e5f1e5bd227"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@09b6e457d91ce84088e6e21783913e5f1e5bd227",
"title": "09b6e457d91ce84088e6e21783913e5f1e5bd227",
"url": "https://llvm.googlesource.com/llvm-project/+/09b6e457d91ce84088e6e21783913e5f1e5bd227"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c981c533055e14302e7bff5d6898c9308065f665"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c981c533055e14302e7bff5d6898c9308065f665",
"title": "c981c533055e14302e7bff5d6898c9308065f665",
"url": "https://llvm.googlesource.com/llvm-project/+/c981c533055e14302e7bff5d6898c9308065f665"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2fce8f74b3c04bbf7e941cfed7604edae2b573b6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2fce8f74b3c04bbf7e941cfed7604edae2b573b6",
"title": "2fce8f74b3c04bbf7e941cfed7604edae2b573b6",
"url": "https://llvm.googlesource.com/llvm-project/+/2fce8f74b3c04bbf7e941cfed7604edae2b573b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "456fdf851c19f79a895c59341d491ce819138522"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@456fdf851c19f79a895c59341d491ce819138522",
"title": "456fdf851c19f79a895c59341d491ce819138522",
"url": "https://llvm.googlesource.com/llvm-project/+/456fdf851c19f79a895c59341d491ce819138522"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "760eca1d1079d46e430722c8d8999b327b083240"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@760eca1d1079d46e430722c8d8999b327b083240",
"title": "760eca1d1079d46e430722c8d8999b327b083240",
"url": "https://llvm.googlesource.com/llvm-project/+/760eca1d1079d46e430722c8d8999b327b083240"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "760eca1d1079d46e430722c8d8999b327b083240",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8936842623162085088"
},
{
"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"
}
}
[16:22:24.726] Scheduled build:
{
"id": "8771412560897724033",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-29T16:22:24.276798881Z",
"updateTime": "2023-08-29T16:22:24.276798881Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "760eca1d1079d46e430722c8d8999b327b083240",
"ref": "refs/heads/main"
}
}
}
[16:22:24.726] Task URL: https://cr-buildbucket.appspot.com/build/8771412560897724033
[16:22:24.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:2:0) after 9m44s
[16:22:25.702] Received PubSub notification, asking Buildbucket for the build status
[16:22:25.732] Build status: SCHEDULED
[16:24:18.210] Received PubSub notification, asking Buildbucket for the build status
[16:24:18.241] Build status: STARTED
[16:32:08.839] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:2:0)
[16:32:11.289] Build status: STARTED
[16:32:11.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:5:0) after 6m43s
[16:38:54.308] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:5:0)
[16:38:54.336] Build status: STARTED
[16:38:54.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:6:0) after 8m5s
[16:46:59.352] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:6:0)
[16:46:59.480] Build status: STARTED
[16:46:59.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:7:0) after 8m58s
[16:55:57.868] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:7:0)
[16:55:57.889] Build status: STARTED
[16:55:57.889] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:8:0) after 6m7s
[17:02:05.751] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:8:0)
[17:02:05.777] Build status: STARTED
[17:02:05.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:9:0) after 1m49s
[17:03:54.792] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:9:0)
[17:03:54.812] Build status: STARTED
[17:03:54.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:10:0) after 1m12s
[17:05:06.983] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:10:0)
[17:05:07.004] Build status: STARTED
[17:05:07.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:11:0) after 9m23s
[17:14:30.137] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:11:0)
[17:14:30.161] Build status: STARTED
[17:14:30.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:12:0) after 6m9s
[17:20:39.189] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:12:0)
[17:20:39.221] Build status: STARTED
[17:20:39.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:13:0) after 4m12s
[17:24:51.306] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:13:0)
[17:24:51.325] Build status: STARTED
[17:24:51.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8936842623162085088:14:0) after 8m44s
[17:30:00.505] Received PubSub notification, asking Buildbucket for the build status
[17:30:00.534] Build:
{
"id": "8771412560897724033",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-29T16:22:24.276798881Z",
"startTime": "2023-08-29T16:24:17.352307Z",
"endTime": "2023-08-29T17:29:59.706454779Z",
"updateTime": "2023-08-29T17:29:59.706454779Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "760eca1d1079d46e430722c8d8999b327b083240",
"ref": "refs/heads/main"
}
}
}
[17:30:00.534] Invocation finished in 1h7m37.801119391s with status SUCCEEDED