[20:30:13.439] New invocation is queued and will start shortly
[20:30:15.520] Starting the invocation (attempt 1)
[20:30:15.600] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5ab86ef7c1bf66e7ae3b6fed97084715484c34e3"
[20:30:15.600] Popped gitiles commit info from properties and tags
[20:30:15.600] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:30:15.600] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:30:15.602] Buildbucket request:
{
"requestId": "8919613606497874128",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8919613606497874128",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04bbbba271ebe4c2421f34a4fbf34c328df9f111"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04bbbba271ebe4c2421f34a4fbf34c328df9f111",
"title": "04bbbba271ebe4c2421f34a4fbf34c328df9f111",
"url": "https://llvm.googlesource.com/llvm-project/+/04bbbba271ebe4c2421f34a4fbf34c328df9f111"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6494f9bb8ac1e6f7526b72ee07f71527b8e66066"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6494f9bb8ac1e6f7526b72ee07f71527b8e66066",
"title": "6494f9bb8ac1e6f7526b72ee07f71527b8e66066",
"url": "https://llvm.googlesource.com/llvm-project/+/6494f9bb8ac1e6f7526b72ee07f71527b8e66066"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a6c84079f69f13d745aaaa4595cf8804b119a6c4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a6c84079f69f13d745aaaa4595cf8804b119a6c4",
"title": "a6c84079f69f13d745aaaa4595cf8804b119a6c4",
"url": "https://llvm.googlesource.com/llvm-project/+/a6c84079f69f13d745aaaa4595cf8804b119a6c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c5aacb0dbcb19b154441852763785f0356e5218b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c5aacb0dbcb19b154441852763785f0356e5218b",
"title": "c5aacb0dbcb19b154441852763785f0356e5218b",
"url": "https://llvm.googlesource.com/llvm-project/+/c5aacb0dbcb19b154441852763785f0356e5218b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "862e742292f4a46c4d3879e9cc0d9902ef87f107"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@862e742292f4a46c4d3879e9cc0d9902ef87f107",
"title": "862e742292f4a46c4d3879e9cc0d9902ef87f107",
"url": "https://llvm.googlesource.com/llvm-project/+/862e742292f4a46c4d3879e9cc0d9902ef87f107"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0f5849eeeebc410e420ee11b7e59b4dd28c65318"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0f5849eeeebc410e420ee11b7e59b4dd28c65318",
"title": "0f5849eeeebc410e420ee11b7e59b4dd28c65318",
"url": "https://llvm.googlesource.com/llvm-project/+/0f5849eeeebc410e420ee11b7e59b4dd28c65318"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "946ea4e3ca4c908bfa7c196b982795f5c390b923"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@946ea4e3ca4c908bfa7c196b982795f5c390b923",
"title": "946ea4e3ca4c908bfa7c196b982795f5c390b923",
"url": "https://llvm.googlesource.com/llvm-project/+/946ea4e3ca4c908bfa7c196b982795f5c390b923"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f95a76391c527ba23574cb1d8d8803c9a1d0b7c4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f95a76391c527ba23574cb1d8d8803c9a1d0b7c4",
"title": "f95a76391c527ba23574cb1d8d8803c9a1d0b7c4",
"url": "https://llvm.googlesource.com/llvm-project/+/f95a76391c527ba23574cb1d8d8803c9a1d0b7c4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "15b7b3182cc28f4f0b950bd73d931caa27b833ec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@15b7b3182cc28f4f0b950bd73d931caa27b833ec",
"title": "15b7b3182cc28f4f0b950bd73d931caa27b833ec",
"url": "https://llvm.googlesource.com/llvm-project/+/15b7b3182cc28f4f0b950bd73d931caa27b833ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3ecd38c8e1d34b1e4639a1de9f0cb56c7957cbd2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3ecd38c8e1d34b1e4639a1de9f0cb56c7957cbd2",
"title": "3ecd38c8e1d34b1e4639a1de9f0cb56c7957cbd2",
"url": "https://llvm.googlesource.com/llvm-project/+/3ecd38c8e1d34b1e4639a1de9f0cb56c7957cbd2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b64482e23eefaef7738fde35d0b7c4174aaa6597"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b64482e23eefaef7738fde35d0b7c4174aaa6597",
"title": "b64482e23eefaef7738fde35d0b7c4174aaa6597",
"url": "https://llvm.googlesource.com/llvm-project/+/b64482e23eefaef7738fde35d0b7c4174aaa6597"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eb8f379567e8d014194faefe02ce92813e237afc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eb8f379567e8d014194faefe02ce92813e237afc",
"title": "eb8f379567e8d014194faefe02ce92813e237afc",
"url": "https://llvm.googlesource.com/llvm-project/+/eb8f379567e8d014194faefe02ce92813e237afc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2b184c8f64b577a4cef2c2abde2dceaeece4874d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2b184c8f64b577a4cef2c2abde2dceaeece4874d",
"title": "2b184c8f64b577a4cef2c2abde2dceaeece4874d",
"url": "https://llvm.googlesource.com/llvm-project/+/2b184c8f64b577a4cef2c2abde2dceaeece4874d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5ab86ef7c1bf66e7ae3b6fed97084715484c34e3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5ab86ef7c1bf66e7ae3b6fed97084715484c34e3",
"title": "5ab86ef7c1bf66e7ae3b6fed97084715484c34e3",
"url": "https://llvm.googlesource.com/llvm-project/+/5ab86ef7c1bf66e7ae3b6fed97084715484c34e3"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5ab86ef7c1bf66e7ae3b6fed97084715484c34e3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8919613606497874128"
},
{
"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"
}
}
[20:30:16.085] Scheduled build:
{
"id": "8754183543483403713",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-06T20:30:15.681500363Z",
"updateTime": "2024-03-06T20:30:15.681500363Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5ab86ef7c1bf66e7ae3b6fed97084715484c34e3",
"ref": "refs/heads/main"
}
}
}
[20:30:16.085] Task URL: https://cr-buildbucket.appspot.com/build/8754183543483403713
[20:30:16.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:2:0) after 4m4s
[20:30:16.984] Received PubSub notification, asking Buildbucket for the build status
[20:30:17.020] Build status: SCHEDULED
[20:34:20.189] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:2:0)
[20:34:20.215] Build status: SCHEDULED
[20:34:20.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:4:0) after 8m31s
[20:41:33.445] Received PubSub notification, asking Buildbucket for the build status
[20:41:33.525] Build status: STARTED
[20:42:51.296] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:4:0)
[20:42:51.318] Build status: STARTED
[20:42:51.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:6:0) after 7m31s
[20:50:22.314] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:6:0)
[20:50:22.334] Build status: STARTED
[20:50:22.334] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:7:0) after 7m57s
[20:58:19.396] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:7:0)
[20:58:19.670] Build status: STARTED
[20:58:19.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:8:0) after 4m45s
[21:03:04.706] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:8:0)
[21:03:04.726] Build status: STARTED
[21:03:04.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:9:0) after 5m37s
[21:08:41.812] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:9:0)
[21:08:41.838] Build status: STARTED
[21:08:41.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:10:0) after 1m12s
[21:09:53.893] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:10:0)
[21:09:53.985] Build status: STARTED
[21:09:53.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:11:0) after 9m7s
[21:19:00.965] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:11:0)
[21:19:01.023] Build status: STARTED
[21:19:01.023] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:12:0) after 3m46s
[21:22:47.044] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:12:0)
[21:22:47.080] Build status: STARTED
[21:22:47.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:13:0) after 1m5s
[21:23:52.138] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:13:0)
[21:23:52.214] Build status: STARTED
[21:23:52.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:14:0) after 2m20s
[21:26:12.235] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:14:0)
[21:26:12.255] Build status: STARTED
[21:26:12.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:15:0) after 5m52s
[21:32:04.277] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:15:0)
[21:32:04.305] Build status: STARTED
[21:32:04.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:16:0) after 3m37s
[21:35:41.337] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:16:0)
[21:35:41.359] Build status: STARTED
[21:35:41.359] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:17:0) after 8m8s
[21:43:49.570] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:17:0)
[21:43:49.600] Build status: STARTED
[21:43:49.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:18:0) after 1m45s
[21:45:34.698] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:18:0)
[21:45:34.716] Build status: STARTED
[21:45:34.716] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:19:0) after 3m16s
[21:48:50.737] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:19:0)
[21:48:50.757] Build status: STARTED
[21:48:50.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:20:0) after 3m16s
[21:52:06.785] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:20:0)
[21:52:06.813] Build status: STARTED
[21:52:06.813] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919613606497874128:21:0) after 7m5s
[21:54:45.831] Received PubSub notification, asking Buildbucket for the build status
[21:54:45.865] Build:
{
"id": "8754183543483403713",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-06T20:30:15.681500363Z",
"startTime": "2024-03-06T20:41:32.936182Z",
"endTime": "2024-03-06T21:54:44.828181Z",
"updateTime": "2024-03-06T21:54:44.828181Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5ab86ef7c1bf66e7ae3b6fed97084715484c34e3",
"ref": "refs/heads/main"
}
}
}
[21:54:45.865] Invocation finished in 1h24m32.441972642s with status SUCCEEDED