[12:15:00.500] New invocation is queued and will start shortly
[12:15:01.604] Starting the invocation (attempt 1)
[12:15:01.632] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a2b31109458a10197e038959c1ccbcf9a84284a8"
[12:15:01.633] Popped gitiles commit info from properties and tags
[12:15:01.633] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:15:01.633] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:15:01.633] Buildbucket request:
{
"requestId": "8874708667438987936",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8874708667438987936",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ec149d5ef8930986bc3dc404cdb8f7e925333f6e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ec149d5ef8930986bc3dc404cdb8f7e925333f6e",
"title": "ec149d5ef8930986bc3dc404cdb8f7e925333f6e",
"url": "https://llvm.googlesource.com/llvm-project/+/ec149d5ef8930986bc3dc404cdb8f7e925333f6e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3240b4889bb4b700e655d21e908ae07cfda5a55"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3240b4889bb4b700e655d21e908ae07cfda5a55",
"title": "b3240b4889bb4b700e655d21e908ae07cfda5a55",
"url": "https://llvm.googlesource.com/llvm-project/+/b3240b4889bb4b700e655d21e908ae07cfda5a55"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8a7a64873b13e6fd931b748fbf50b3da26fe7fca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8a7a64873b13e6fd931b748fbf50b3da26fe7fca",
"title": "8a7a64873b13e6fd931b748fbf50b3da26fe7fca",
"url": "https://llvm.googlesource.com/llvm-project/+/8a7a64873b13e6fd931b748fbf50b3da26fe7fca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f70e074f21ab00a3377a3a6dec32ab3684e33da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f70e074f21ab00a3377a3a6dec32ab3684e33da",
"title": "2f70e074f21ab00a3377a3a6dec32ab3684e33da",
"url": "https://llvm.googlesource.com/llvm-project/+/2f70e074f21ab00a3377a3a6dec32ab3684e33da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8cbcaee7fe3629554fa21e7a82efaf1be300af42"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8cbcaee7fe3629554fa21e7a82efaf1be300af42",
"title": "8cbcaee7fe3629554fa21e7a82efaf1be300af42",
"url": "https://llvm.googlesource.com/llvm-project/+/8cbcaee7fe3629554fa21e7a82efaf1be300af42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "57d81c23f4c8d3ad88210aab29f0809974e7d1ce"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@57d81c23f4c8d3ad88210aab29f0809974e7d1ce",
"title": "57d81c23f4c8d3ad88210aab29f0809974e7d1ce",
"url": "https://llvm.googlesource.com/llvm-project/+/57d81c23f4c8d3ad88210aab29f0809974e7d1ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2a9afdb7937710a4af5ebe5ab3a4fdd235fbf08e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2a9afdb7937710a4af5ebe5ab3a4fdd235fbf08e",
"title": "2a9afdb7937710a4af5ebe5ab3a4fdd235fbf08e",
"url": "https://llvm.googlesource.com/llvm-project/+/2a9afdb7937710a4af5ebe5ab3a4fdd235fbf08e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a2b31109458a10197e038959c1ccbcf9a84284a8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a2b31109458a10197e038959c1ccbcf9a84284a8",
"title": "a2b31109458a10197e038959c1ccbcf9a84284a8",
"url": "https://llvm.googlesource.com/llvm-project/+/a2b31109458a10197e038959c1ccbcf9a84284a8"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a2b31109458a10197e038959c1ccbcf9a84284a8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8874708667438987936"
},
{
"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"
}
}
[12:15:02.035] Scheduled build:
{
"id": "8709278605520420865",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-15T12:15:01.696448566Z",
"updateTime": "2025-07-15T12:15:01.696448566Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a2b31109458a10197e038959c1ccbcf9a84284a8",
"ref": "refs/heads/main"
}
}
}
[12:15:02.035] Task URL: https://cr-buildbucket.appspot.com/build/8709278605520420865
[12:15:02.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:2:0) after 5m33s
[12:15:02.695] Received PubSub notification, asking Buildbucket for the build status
[12:15:02.729] Build status: SCHEDULED
[12:20:35.057] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:2:0)
[12:20:35.086] Build status: SCHEDULED
[12:20:35.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:4:0) after 7m59s
[12:21:42.868] Received PubSub notification, asking Buildbucket for the build status
[12:21:42.891] Build status: STARTED
[12:28:34.208] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:4:0)
[12:28:34.235] Build status: STARTED
[12:28:34.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:6:0) after 9m42s
[12:38:16.301] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:6:0)
[12:38:16.335] Build status: STARTED
[12:38:16.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:7:0) after 8m45s
[12:47:01.352] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:7:0)
[12:47:01.387] Build status: STARTED
[12:47:01.387] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:8:0) after 5m16s
[12:52:17.447] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:8:0)
[12:52:17.468] Build status: STARTED
[12:52:17.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:9:0) after 9m23s
[13:01:40.491] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:9:0)
[13:01:40.521] Build status: STARTED
[13:01:40.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:10:0) after 5m48s
[13:07:28.538] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:10:0)
[13:07:28.557] Build status: STARTED
[13:07:28.557] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:11:0) after 4m32s
[13:12:00.580] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:11:0)
[13:12:00.602] Build status: STARTED
[13:12:00.602] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:12:0) after 5m26s
[13:17:26.774] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:12:0)
[13:17:26.837] Build status: STARTED
[13:17:26.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:13:0) after 9m59s
[13:27:26.325] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:13:0)
[13:27:26.342] Build status: STARTED
[13:27:26.342] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:14:0) after 1m23s
[13:28:49.586] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:14:0)
[13:28:49.609] Build status: STARTED
[13:28:49.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:15:0) after 8m47s
[13:37:36.634] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:15:0)
[13:37:36.653] Build status: STARTED
[13:37:36.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:16:0) after 6m56s
[13:44:32.694] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:16:0)
[13:44:32.719] Build status: STARTED
[13:44:32.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8874708667438987936:17:0) after 8m42s
[13:51:13.500] Received PubSub notification, asking Buildbucket for the build status
[13:51:13.517] Build:
{
"id": "8709278605520420865",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-15T12:15:01.696448566Z",
"startTime": "2025-07-15T12:21:42.665559003Z",
"endTime": "2025-07-15T13:51:13.064083959Z",
"updateTime": "2025-07-15T13:51:13.064083959Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a2b31109458a10197e038959c1ccbcf9a84284a8",
"ref": "refs/heads/main"
}
}
}
[13:51:13.517] Invocation finished in 1h36m13.034900213s with status SUCCEEDED