[14:54:08.539] New invocation is queued and will start shortly
[14:54:09.740] Starting the invocation (attempt 1)
[14:54:09.768] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8cc616bc71dfe0648de3843a006ac8827c5fe59d"
[14:54:09.768] Popped gitiles commit info from properties and tags
[14:54:09.768] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:54:09.768] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:54:09.769] Buildbucket request:
{
"requestId": "8896804315393829024",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896804315393829024",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "deb057adb7334734482452daf20ccdd8cece1aa8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@deb057adb7334734482452daf20ccdd8cece1aa8",
"title": "deb057adb7334734482452daf20ccdd8cece1aa8",
"url": "https://llvm.googlesource.com/llvm-project/+/deb057adb7334734482452daf20ccdd8cece1aa8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ec4dab173cf8055b640aa5dbbd27ec8be11974f3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ec4dab173cf8055b640aa5dbbd27ec8be11974f3",
"title": "ec4dab173cf8055b640aa5dbbd27ec8be11974f3",
"url": "https://llvm.googlesource.com/llvm-project/+/ec4dab173cf8055b640aa5dbbd27ec8be11974f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b385c6358c8782742dd6a79ad23953d3b6765446"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b385c6358c8782742dd6a79ad23953d3b6765446",
"title": "b385c6358c8782742dd6a79ad23953d3b6765446",
"url": "https://llvm.googlesource.com/llvm-project/+/b385c6358c8782742dd6a79ad23953d3b6765446"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a33ae1b7df82d7d714156ad050c0b99545fad497"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a33ae1b7df82d7d714156ad050c0b99545fad497",
"title": "a33ae1b7df82d7d714156ad050c0b99545fad497",
"url": "https://llvm.googlesource.com/llvm-project/+/a33ae1b7df82d7d714156ad050c0b99545fad497"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b63b0101ca47b8ba1589283cd34cc80cdb68b902"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b63b0101ca47b8ba1589283cd34cc80cdb68b902",
"title": "b63b0101ca47b8ba1589283cd34cc80cdb68b902",
"url": "https://llvm.googlesource.com/llvm-project/+/b63b0101ca47b8ba1589283cd34cc80cdb68b902"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b6bd7477a91ed47ecc1baae0a961224511679b59"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b6bd7477a91ed47ecc1baae0a961224511679b59",
"title": "b6bd7477a91ed47ecc1baae0a961224511679b59",
"url": "https://llvm.googlesource.com/llvm-project/+/b6bd7477a91ed47ecc1baae0a961224511679b59"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "256050520380b271ff0ac1f01fa56d6665e9af03"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@256050520380b271ff0ac1f01fa56d6665e9af03",
"title": "256050520380b271ff0ac1f01fa56d6665e9af03",
"url": "https://llvm.googlesource.com/llvm-project/+/256050520380b271ff0ac1f01fa56d6665e9af03"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1884ffc41c20b1e08b30eef4e8ebbcc54543a139"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1884ffc41c20b1e08b30eef4e8ebbcc54543a139",
"title": "1884ffc41c20b1e08b30eef4e8ebbcc54543a139",
"url": "https://llvm.googlesource.com/llvm-project/+/1884ffc41c20b1e08b30eef4e8ebbcc54543a139"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8cc616bc71dfe0648de3843a006ac8827c5fe59d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8cc616bc71dfe0648de3843a006ac8827c5fe59d",
"title": "8cc616bc71dfe0648de3843a006ac8827c5fe59d",
"url": "https://llvm.googlesource.com/llvm-project/+/8cc616bc71dfe0648de3843a006ac8827c5fe59d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8cc616bc71dfe0648de3843a006ac8827c5fe59d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896804315393829024"
},
{
"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"
}
}
[14:54:10.365] Scheduled build:
{
"id": "8731374253333629841",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-13T14:54:09.872826123Z",
"updateTime": "2024-11-13T14:54:09.872826123Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8cc616bc71dfe0648de3843a006ac8827c5fe59d",
"ref": "refs/heads/main"
}
}
}
[14:54:10.365] Task URL: https://cr-buildbucket.appspot.com/build/8731374253333629841
[14:54:10.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:2:0) after 4m20s
[14:54:10.557] Received PubSub notification, asking Buildbucket for the build status
[14:54:10.578] Build status: SCHEDULED
[14:58:30.381] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:2:0)
[14:58:30.404] Build status: SCHEDULED
[14:58:30.404] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:4:0) after 2m32s
[15:01:02.421] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:4:0)
[15:01:02.465] Build status: SCHEDULED
[15:01:02.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:5:0) after 9m48s
[15:10:51.013] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:5:0)
[15:10:51.030] Build status: SCHEDULED
[15:10:51.030] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:6:0) after 4m2s
[15:14:53.371] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:6:0)
[15:14:53.399] Build status: SCHEDULED
[15:14:53.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:7:0) after 2m41s
[15:17:34.416] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:7:0)
[15:17:34.439] Build status: SCHEDULED
[15:17:34.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:8:0) after 5m34s
[15:22:37.946] Received PubSub notification, asking Buildbucket for the build status
[15:22:37.971] Build status: STARTED
[15:23:08.508] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:8:0)
[15:23:08.549] Build status: STARTED
[15:23:08.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:10:0) after 9m36s
[15:32:44.565] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:10:0)
[15:32:44.588] Build status: STARTED
[15:32:44.588] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:11:0) after 9m35s
[15:42:19.611] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:11:0)
[15:42:19.628] Build status: STARTED
[15:42:19.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:12:0) after 5m51s
[15:48:10.696] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:12:0)
[15:48:10.712] Build status: STARTED
[15:48:10.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:13:0) after 7m53s
[15:56:03.728] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:13:0)
[15:56:03.749] Build status: STARTED
[15:56:03.749] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:14:0) after 6m28s
[16:02:31.766] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:14:0)
[16:02:31.785] Build status: STARTED
[16:02:31.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:15:0) after 9m58s
[16:12:29.819] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:15:0)
[16:12:29.847] Build status: STARTED
[16:12:29.847] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:16:0) after 6m20s
[16:18:49.904] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:16:0)
[16:18:49.925] Build status: STARTED
[16:18:49.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:17:0) after 4m33s
[16:23:22.946] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:17:0)
[16:23:22.967] Build status: STARTED
[16:23:22.967] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:18:0) after 9m27s
[16:32:49.987] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:18:0)
[16:32:50.008] Build status: STARTED
[16:32:50.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:19:0) after 2m42s
[16:35:32.077] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:19:0)
[16:35:32.114] Build status: STARTED
[16:35:32.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:20:0) after 1m49s
[16:37:21.102] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:20:0)
[16:37:21.147] Build status: STARTED
[16:37:21.147] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896804315393829024:21:0) after 6m33s
[16:39:52.762] Received PubSub notification, asking Buildbucket for the build status
[16:39:52.784] Build:
{
"id": "8731374253333629841",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-13T14:54:09.872826123Z",
"startTime": "2024-11-13T15:22:37.765364007Z",
"endTime": "2024-11-13T16:39:52.063088966Z",
"updateTime": "2024-11-13T16:39:52.063088966Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8cc616bc71dfe0648de3843a006ac8827c5fe59d",
"ref": "refs/heads/main"
}
}
}
[16:39:52.784] Invocation finished in 1h45m44.259581355s with status SUCCEEDED