[22:02:14.163] New invocation is queued and will start shortly
[22:02:15.303] Starting the invocation (attempt 1)
[22:02:15.329] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4b4ea6d84bddb5e7b3f144d18630390755e8f7b6"
[22:02:15.329] Popped gitiles commit info from properties and tags
[22:02:15.329] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:02:15.329] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:02:15.329] Buildbucket request:
{
"requestId": "8901669618250894240",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901669618250894240",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2e414799d0ad511cd7999895014a2cae2ea5e3e3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2e414799d0ad511cd7999895014a2cae2ea5e3e3",
"title": "2e414799d0ad511cd7999895014a2cae2ea5e3e3",
"url": "https://llvm.googlesource.com/llvm-project/+/2e414799d0ad511cd7999895014a2cae2ea5e3e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "751389218edcd29c51a9f1ba159c7870b632fcaa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@751389218edcd29c51a9f1ba159c7870b632fcaa",
"title": "751389218edcd29c51a9f1ba159c7870b632fcaa",
"url": "https://llvm.googlesource.com/llvm-project/+/751389218edcd29c51a9f1ba159c7870b632fcaa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e8335aef063e08a7cd8a543d7ab14b20f554c07b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e8335aef063e08a7cd8a543d7ab14b20f554c07b",
"title": "e8335aef063e08a7cd8a543d7ab14b20f554c07b",
"url": "https://llvm.googlesource.com/llvm-project/+/e8335aef063e08a7cd8a543d7ab14b20f554c07b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8be575e49816ee6ff0b0b924e0b84b2a9fff98aa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8be575e49816ee6ff0b0b924e0b84b2a9fff98aa",
"title": "8be575e49816ee6ff0b0b924e0b84b2a9fff98aa",
"url": "https://llvm.googlesource.com/llvm-project/+/8be575e49816ee6ff0b0b924e0b84b2a9fff98aa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6959ec91d7f8b579a7698cfe244d434b177af493"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6959ec91d7f8b579a7698cfe244d434b177af493",
"title": "6959ec91d7f8b579a7698cfe244d434b177af493",
"url": "https://llvm.googlesource.com/llvm-project/+/6959ec91d7f8b579a7698cfe244d434b177af493"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "76bc1eddb2cf8b6cc073649ade21b59bbed438a2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@76bc1eddb2cf8b6cc073649ade21b59bbed438a2",
"title": "76bc1eddb2cf8b6cc073649ade21b59bbed438a2",
"url": "https://llvm.googlesource.com/llvm-project/+/76bc1eddb2cf8b6cc073649ade21b59bbed438a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2011cbcd84102236dd6d58e2079ac676a3403f25"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2011cbcd84102236dd6d58e2079ac676a3403f25",
"title": "2011cbcd84102236dd6d58e2079ac676a3403f25",
"url": "https://llvm.googlesource.com/llvm-project/+/2011cbcd84102236dd6d58e2079ac676a3403f25"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2672947633865c19c332c8e39f0d11e841e2480f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2672947633865c19c332c8e39f0d11e841e2480f",
"title": "2672947633865c19c332c8e39f0d11e841e2480f",
"url": "https://llvm.googlesource.com/llvm-project/+/2672947633865c19c332c8e39f0d11e841e2480f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "07045b567962c86a9e16abc4f3a848ef35a06f5c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@07045b567962c86a9e16abc4f3a848ef35a06f5c",
"title": "07045b567962c86a9e16abc4f3a848ef35a06f5c",
"url": "https://llvm.googlesource.com/llvm-project/+/07045b567962c86a9e16abc4f3a848ef35a06f5c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d621025d4fc2f2438affdca7a016dd93b56f4e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d621025d4fc2f2438affdca7a016dd93b56f4e0",
"title": "4d621025d4fc2f2438affdca7a016dd93b56f4e0",
"url": "https://llvm.googlesource.com/llvm-project/+/4d621025d4fc2f2438affdca7a016dd93b56f4e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4b4ea6d84bddb5e7b3f144d18630390755e8f7b6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4b4ea6d84bddb5e7b3f144d18630390755e8f7b6",
"title": "4b4ea6d84bddb5e7b3f144d18630390755e8f7b6",
"url": "https://llvm.googlesource.com/llvm-project/+/4b4ea6d84bddb5e7b3f144d18630390755e8f7b6"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4b4ea6d84bddb5e7b3f144d18630390755e8f7b6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901669618250894240"
},
{
"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"
}
}
[22:02:15.818] Scheduled build:
{
"id": "8736239556285956673",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-20T22:02:15.405851107Z",
"updateTime": "2024-09-20T22:02:15.405851107Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4b4ea6d84bddb5e7b3f144d18630390755e8f7b6",
"ref": "refs/heads/main"
}
}
}
[22:02:15.818] Task URL: https://cr-buildbucket.appspot.com/build/8736239556285956673
[22:02:15.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:2:0) after 9m0s
[22:02:16.787] Received PubSub notification, asking Buildbucket for the build status
[22:02:17.076] Build status: SCHEDULED
[22:02:20.083] Received PubSub notification, asking Buildbucket for the build status
[22:02:20.113] Build status: STARTED
[22:11:15.839] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:2:0)
[22:11:15.862] Build status: STARTED
[22:11:15.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:5:0) after 1m47s
[22:13:02.897] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:5:0)
[22:13:02.970] Build status: STARTED
[22:13:02.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:6:0) after 9m42s
[22:22:45.003] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:6:0)
[22:22:45.030] Build status: STARTED
[22:22:45.030] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:7:0) after 1m4s
[22:23:49.017] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:7:0)
[22:23:49.034] Build status: STARTED
[22:23:49.034] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:8:0) after 8m14s
[22:32:03.007] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:8:0)
[22:32:03.088] Build status: STARTED
[22:32:03.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:9:0) after 7m15s
[22:39:18.104] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:9:0)
[22:39:18.125] Build status: STARTED
[22:39:18.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:10:0) after 9m15s
[22:48:33.228] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:10:0)
[22:48:33.247] Build status: STARTED
[22:48:33.247] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:11:0) after 3m52s
[22:52:25.279] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:11:0)
[22:52:25.297] Build status: STARTED
[22:52:25.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:12:0) after 8m45s
[23:01:10.422] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:12:0)
[23:01:10.451] Build status: STARTED
[23:01:10.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:13:0) after 3m6s
[23:04:16.472] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:13:0)
[23:04:16.490] Build status: STARTED
[23:04:16.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:14:0) after 4m12s
[23:08:28.508] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:14:0)
[23:08:28.526] Build status: STARTED
[23:08:28.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:15:0) after 1m5s
[23:09:33.561] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:15:0)
[23:09:33.582] Build status: STARTED
[23:09:33.583] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:16:0) after 7m25s
[23:16:58.599] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:16:0)
[23:16:58.620] Build status: STARTED
[23:16:58.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901669618250894240:17:0) after 2m20s
[23:17:04.851] Received PubSub notification, asking Buildbucket for the build status
[23:17:04.871] Build:
{
"id": "8736239556285956673",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-20T22:02:15.405851107Z",
"startTime": "2024-09-20T22:02:19.858428303Z",
"endTime": "2024-09-20T23:17:04.532636726Z",
"updateTime": "2024-09-20T23:17:04.532636726Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4b4ea6d84bddb5e7b3f144d18630390755e8f7b6",
"ref": "refs/heads/main"
}
}
}
[23:17:04.871] Invocation finished in 1h14m50.722411179s with status SUCCEEDED