[19:47:51.506] New invocation is queued and will start shortly
[19:47:52.678] Starting the invocation (attempt 1)
[19:47:52.715] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9965f3d337bba09fbf2497a78123957fdaee0ffa"
[19:47:52.715] Popped gitiles commit info from properties and tags
[19:47:52.715] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:47:52.715] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:47:52.717] Buildbucket request:
{
"requestId": "8883649276234715040",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8883649276234715040",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "21d912121c9f41385b165a736be787527f5bd7c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@21d912121c9f41385b165a736be787527f5bd7c2",
"title": "21d912121c9f41385b165a736be787527f5bd7c2",
"url": "https://llvm.googlesource.com/llvm-project/+/21d912121c9f41385b165a736be787527f5bd7c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "369c7739d0853b7931410037843d5a63f50bc0a1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@369c7739d0853b7931410037843d5a63f50bc0a1",
"title": "369c7739d0853b7931410037843d5a63f50bc0a1",
"url": "https://llvm.googlesource.com/llvm-project/+/369c7739d0853b7931410037843d5a63f50bc0a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "529e9127f0d61f177f2c62ade531d876cf89bf59"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@529e9127f0d61f177f2c62ade531d876cf89bf59",
"title": "529e9127f0d61f177f2c62ade531d876cf89bf59",
"url": "https://llvm.googlesource.com/llvm-project/+/529e9127f0d61f177f2c62ade531d876cf89bf59"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "10bef367a5643bc41d0172b02e080645c68f821a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@10bef367a5643bc41d0172b02e080645c68f821a",
"title": "10bef367a5643bc41d0172b02e080645c68f821a",
"url": "https://llvm.googlesource.com/llvm-project/+/10bef367a5643bc41d0172b02e080645c68f821a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8f5a3ec649a3b46093c8a8140bbd91f21236fde6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8f5a3ec649a3b46093c8a8140bbd91f21236fde6",
"title": "8f5a3ec649a3b46093c8a8140bbd91f21236fde6",
"url": "https://llvm.googlesource.com/llvm-project/+/8f5a3ec649a3b46093c8a8140bbd91f21236fde6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "76fee8f4edf10fb39f0323171c060e97ec0005b0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@76fee8f4edf10fb39f0323171c060e97ec0005b0",
"title": "76fee8f4edf10fb39f0323171c060e97ec0005b0",
"url": "https://llvm.googlesource.com/llvm-project/+/76fee8f4edf10fb39f0323171c060e97ec0005b0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "27c099bc84d1432752b3828f1ba95de24db76c5e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@27c099bc84d1432752b3828f1ba95de24db76c5e",
"title": "27c099bc84d1432752b3828f1ba95de24db76c5e",
"url": "https://llvm.googlesource.com/llvm-project/+/27c099bc84d1432752b3828f1ba95de24db76c5e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9965f3d337bba09fbf2497a78123957fdaee0ffa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9965f3d337bba09fbf2497a78123957fdaee0ffa",
"title": "9965f3d337bba09fbf2497a78123957fdaee0ffa",
"url": "https://llvm.googlesource.com/llvm-project/+/9965f3d337bba09fbf2497a78123957fdaee0ffa"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9965f3d337bba09fbf2497a78123957fdaee0ffa",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8883649276234715040"
},
{
"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"
}
}
[19:47:53.095] Scheduled build:
{
"id": "8718219214252927921",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-07T19:47:52.775600201Z",
"updateTime": "2025-04-07T19:47:52.775600201Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9965f3d337bba09fbf2497a78123957fdaee0ffa",
"ref": "refs/heads/main"
}
}
}
[19:47:53.095] Task URL: https://cr-buildbucket.appspot.com/build/8718219214252927921
[19:47:53.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:2:0) after 8m55s
[19:47:54.090] Received PubSub notification, asking Buildbucket for the build status
[19:47:54.115] Build status: SCHEDULED
[19:56:48.103] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:2:0)
[19:56:48.132] Build status: SCHEDULED
[19:56:48.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:4:0) after 9m14s
[20:03:15.745] Received PubSub notification, asking Buildbucket for the build status
[20:03:15.782] Build status: STARTED
[20:06:02.192] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:4:0)
[20:06:02.220] Build status: STARTED
[20:06:02.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:6:0) after 4m7s
[20:10:09.247] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:6:0)
[20:10:09.268] Build status: STARTED
[20:10:09.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:7:0) after 7m6s
[20:17:15.321] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:7:0)
[20:17:15.340] Build status: STARTED
[20:17:15.341] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:8:0) after 6m42s
[20:23:57.397] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:8:0)
[20:23:57.456] Build status: STARTED
[20:23:57.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:9:0) after 4m7s
[20:28:04.470] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:9:0)
[20:28:04.509] Build status: STARTED
[20:28:04.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:10:0) after 8m8s
[20:36:12.544] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:10:0)
[20:36:12.564] Build status: STARTED
[20:36:12.564] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:11:0) after 3m12s
[20:39:24.586] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:11:0)
[20:39:24.613] Build status: STARTED
[20:39:24.613] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:12:0) after 1m27s
[20:40:51.667] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:12:0)
[20:40:51.712] Build status: STARTED
[20:40:51.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:13:0) after 3m22s
[20:44:13.788] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:13:0)
[20:44:13.805] Build status: STARTED
[20:44:13.806] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:14:0) after 2m52s
[20:47:05.832] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:14:0)
[20:47:05.848] Build status: STARTED
[20:47:05.848] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:15:0) after 6m0s
[20:53:05.911] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:15:0)
[20:53:05.935] Build status: STARTED
[20:53:05.936] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:16:0) after 9m6s
[21:02:12.051] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:16:0)
[21:02:12.071] Build status: STARTED
[21:02:12.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:17:0) after 1m31s
[21:03:43.088] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:17:0)
[21:03:43.158] Build status: STARTED
[21:03:43.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:18:0) after 8m22s
[21:12:05.180] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:18:0)
[21:12:05.203] Build status: STARTED
[21:12:05.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:19:0) after 9m5s
[21:21:10.290] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:19:0)
[21:21:10.332] Build status: STARTED
[21:21:10.332] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:20:0) after 4m24s
[21:25:34.360] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:20:0)
[21:25:34.441] Build status: STARTED
[21:25:34.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:21:0) after 4m26s
[21:30:00.507] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:21:0)
[21:30:00.526] Build status: STARTED
[21:30:00.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:22:0) after 6m24s
[21:36:24.549] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:22:0)
[21:36:24.570] Build status: STARTED
[21:36:24.570] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8883649276234715040:23:0) after 6m55s
[21:38:04.917] Received PubSub notification, asking Buildbucket for the build status
[21:38:04.933] Build:
{
"id": "8718219214252927921",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-07T19:47:52.775600201Z",
"startTime": "2025-04-07T20:03:15.443680912Z",
"endTime": "2025-04-07T21:37:02.111813780Z",
"updateTime": "2025-04-07T21:37:02.111813780Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9965f3d337bba09fbf2497a78123957fdaee0ffa",
"ref": "refs/heads/main"
}
}
}
[21:38:04.933] Invocation finished in 1h50m13.431696957s with status SUCCEEDED