[09:08:34.533] New invocation is queued and will start shortly
[09:08:35.718] Starting the invocation (attempt 1)
[09:08:35.757] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/22576e2ccec60af6d27d8fd95ad3ca721b914815"
[09:08:35.757] Popped gitiles commit info from properties and tags
[09:08:35.757] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:08:35.757] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:08:35.757] Buildbucket request:
{
"requestId": "8880156214755520160",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8880156214755520160",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1c2c02c8cbb6949c06fe26a72200ccfb37ac8c96"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1c2c02c8cbb6949c06fe26a72200ccfb37ac8c96",
"title": "1c2c02c8cbb6949c06fe26a72200ccfb37ac8c96",
"url": "https://llvm.googlesource.com/llvm-project/+/1c2c02c8cbb6949c06fe26a72200ccfb37ac8c96"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bf92b127d2637948f53d11a187e865aa10e2e74c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bf92b127d2637948f53d11a187e865aa10e2e74c",
"title": "bf92b127d2637948f53d11a187e865aa10e2e74c",
"url": "https://llvm.googlesource.com/llvm-project/+/bf92b127d2637948f53d11a187e865aa10e2e74c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eb4fde9a4e7e43947be9116563f5307f745bc541"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eb4fde9a4e7e43947be9116563f5307f745bc541",
"title": "eb4fde9a4e7e43947be9116563f5307f745bc541",
"url": "https://llvm.googlesource.com/llvm-project/+/eb4fde9a4e7e43947be9116563f5307f745bc541"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "39fa5b31c5e603ef96f5130913c86c821b2f0620"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@39fa5b31c5e603ef96f5130913c86c821b2f0620",
"title": "39fa5b31c5e603ef96f5130913c86c821b2f0620",
"url": "https://llvm.googlesource.com/llvm-project/+/39fa5b31c5e603ef96f5130913c86c821b2f0620"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bb5566aac2f236d49c74ce3c53b5c832f4d9a22b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bb5566aac2f236d49c74ce3c53b5c832f4d9a22b",
"title": "bb5566aac2f236d49c74ce3c53b5c832f4d9a22b",
"url": "https://llvm.googlesource.com/llvm-project/+/bb5566aac2f236d49c74ce3c53b5c832f4d9a22b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "82a9cb358b4977e06179419b472a5b7657e55963"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@82a9cb358b4977e06179419b472a5b7657e55963",
"title": "82a9cb358b4977e06179419b472a5b7657e55963",
"url": "https://llvm.googlesource.com/llvm-project/+/82a9cb358b4977e06179419b472a5b7657e55963"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c2045f24eab06960e0418d7d82856407b19156ad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c2045f24eab06960e0418d7d82856407b19156ad",
"title": "c2045f24eab06960e0418d7d82856407b19156ad",
"url": "https://llvm.googlesource.com/llvm-project/+/c2045f24eab06960e0418d7d82856407b19156ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fd85ffb4c43be80c179145a382d78a7c9ca3c1b7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fd85ffb4c43be80c179145a382d78a7c9ca3c1b7",
"title": "fd85ffb4c43be80c179145a382d78a7c9ca3c1b7",
"url": "https://llvm.googlesource.com/llvm-project/+/fd85ffb4c43be80c179145a382d78a7c9ca3c1b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "858649ad0e2bd4c24d4e577094707a53acfe6ade"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@858649ad0e2bd4c24d4e577094707a53acfe6ade",
"title": "858649ad0e2bd4c24d4e577094707a53acfe6ade",
"url": "https://llvm.googlesource.com/llvm-project/+/858649ad0e2bd4c24d4e577094707a53acfe6ade"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3aaf44f95de24339d73c0093576a4a3cc42404ad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3aaf44f95de24339d73c0093576a4a3cc42404ad",
"title": "3aaf44f95de24339d73c0093576a4a3cc42404ad",
"url": "https://llvm.googlesource.com/llvm-project/+/3aaf44f95de24339d73c0093576a4a3cc42404ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5e7bc5e080fb393c3ddb954fa9fd3714284f72c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5e7bc5e080fb393c3ddb954fa9fd3714284f72c2",
"title": "5e7bc5e080fb393c3ddb954fa9fd3714284f72c2",
"url": "https://llvm.googlesource.com/llvm-project/+/5e7bc5e080fb393c3ddb954fa9fd3714284f72c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aacebaeab5448b4ef614aa8aca52ca210e451f79"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aacebaeab5448b4ef614aa8aca52ca210e451f79",
"title": "aacebaeab5448b4ef614aa8aca52ca210e451f79",
"url": "https://llvm.googlesource.com/llvm-project/+/aacebaeab5448b4ef614aa8aca52ca210e451f79"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "22576e2ccec60af6d27d8fd95ad3ca721b914815"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@22576e2ccec60af6d27d8fd95ad3ca721b914815",
"title": "22576e2ccec60af6d27d8fd95ad3ca721b914815",
"url": "https://llvm.googlesource.com/llvm-project/+/22576e2ccec60af6d27d8fd95ad3ca721b914815"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "22576e2ccec60af6d27d8fd95ad3ca721b914815",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8880156214755520160"
},
{
"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"
}
}
[09:08:36.203] Scheduled build:
{
"id": "8714726152747668545",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-16T09:08:35.818461465Z",
"updateTime": "2025-05-16T09:08:35.818461465Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "22576e2ccec60af6d27d8fd95ad3ca721b914815",
"ref": "refs/heads/main"
}
}
}
[09:08:36.203] Task URL: https://cr-buildbucket.appspot.com/build/8714726152747668545
[09:08:36.203] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:2:0) after 5m59s
[09:08:37.216] Received PubSub notification, asking Buildbucket for the build status
[09:08:37.240] Build status: SCHEDULED
[09:14:35.220] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:2:0)
[09:14:35.252] Build status: SCHEDULED
[09:14:35.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:4:0) after 7m46s
[09:22:21.773] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:4:0)
[09:22:21.837] Build status: SCHEDULED
[09:22:21.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:5:0) after 5m6s
[09:22:47.834] Received PubSub notification, asking Buildbucket for the build status
[09:22:47.863] Build status: STARTED
[09:27:27.879] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:5:0)
[09:27:27.895] Build status: STARTED
[09:27:27.895] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:7:0) after 9m10s
[09:36:38.192] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:7:0)
[09:36:38.270] Build status: STARTED
[09:36:38.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:8:0) after 8m50s
[09:45:29.278] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:8:0)
[09:45:29.302] Build status: STARTED
[09:45:29.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:9:0) after 2m16s
[09:47:45.498] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:9:0)
[09:47:45.516] Build status: STARTED
[09:47:45.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:10:0) after 2m25s
[09:50:10.533] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:10:0)
[09:50:10.594] Build status: STARTED
[09:50:10.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:11:0) after 1m33s
[09:51:43.620] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:11:0)
[09:51:43.639] Build status: STARTED
[09:51:43.639] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:12:0) after 4m33s
[09:56:16.717] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:12:0)
[09:56:16.742] Build status: STARTED
[09:56:16.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:13:0) after 5m5s
[10:01:21.887] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:13:0)
[10:01:21.905] Build status: STARTED
[10:01:21.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:14:0) after 1m45s
[10:03:07.251] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:14:0)
[10:03:07.326] Build status: STARTED
[10:03:07.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:15:0) after 1m10s
[10:04:17.341] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:15:0)
[10:04:17.366] Build status: STARTED
[10:04:17.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:16:0) after 1m35s
[10:05:52.500] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:16:0)
[10:05:52.524] Build status: STARTED
[10:05:52.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:17:0) after 1m16s
[10:07:08.641] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:17:0)
[10:07:08.669] Build status: STARTED
[10:07:08.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:18:0) after 1m24s
[10:08:32.695] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:18:0)
[10:08:32.723] Build status: STARTED
[10:08:32.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:19:0) after 6m36s
[10:15:09.298] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:19:0)
[10:15:09.317] Build status: STARTED
[10:15:09.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:20:0) after 4m47s
[10:19:56.414] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:20:0)
[10:19:56.438] Build status: STARTED
[10:19:56.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:21:0) after 5m46s
[10:25:42.462] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:21:0)
[10:25:42.479] Build status: STARTED
[10:25:42.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:22:0) after 1m49s
[10:27:31.502] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:22:0)
[10:27:31.522] Build status: STARTED
[10:27:31.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:23:0) after 2m25s
[10:29:57.114] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:23:0)
[10:29:57.133] Build status: STARTED
[10:29:57.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:24:0) after 3m7s
[10:33:04.295] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:24:0)
[10:33:04.312] Build status: STARTED
[10:33:04.312] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:25:0) after 3m43s
[10:36:47.552] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:25:0)
[10:36:47.588] Build status: STARTED
[10:36:47.588] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:26:0) after 8m35s
[10:45:22.605] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:26:0)
[10:45:22.626] Build status: STARTED
[10:45:22.626] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:27:0) after 6m32s
[10:51:54.640] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:27:0)
[10:51:54.658] Build status: STARTED
[10:51:54.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:28:0) after 6m29s
[10:58:23.755] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:28:0)
[10:58:23.856] Build status: STARTED
[10:58:23.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8880156214755520160:29:0) after 7m8s
[10:59:03.989] Received PubSub notification, asking Buildbucket for the build status
[10:59:04.050] Build:
{
"id": "8714726152747668545",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-16T09:08:35.818461465Z",
"startTime": "2025-05-16T09:22:47.530011615Z",
"endTime": "2025-05-16T10:59:03.472673100Z",
"updateTime": "2025-05-16T10:59:03.472673100Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "22576e2ccec60af6d27d8fd95ad3ca721b914815",
"ref": "refs/heads/main"
}
}
}
[10:59:04.050] Invocation finished in 1h50m29.530897694s with status SUCCEEDED