[20:15:24.381] New invocation is queued and will start shortly
[20:15:25.588] Starting the invocation (attempt 1)
[20:15:25.619] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2260ebf7b6df15db96c76039758dd9dbf009c334"
[20:15:25.619] Popped gitiles commit info from properties and tags
[20:15:25.619] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:15:25.619] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:15:25.620] Buildbucket request:
{
"requestId": "8931120353464748736",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8931120353464748736",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4c997e1536e4f5b43c38f6a4325441a7804d0da1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4c997e1536e4f5b43c38f6a4325441a7804d0da1",
"title": "4c997e1536e4f5b43c38f6a4325441a7804d0da1",
"url": "https://llvm.googlesource.com/llvm-project/+/4c997e1536e4f5b43c38f6a4325441a7804d0da1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2d4ada215ebb3062947c399cf20d386aa78619a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2d4ada215ebb3062947c399cf20d386aa78619a6",
"title": "2d4ada215ebb3062947c399cf20d386aa78619a6",
"url": "https://llvm.googlesource.com/llvm-project/+/2d4ada215ebb3062947c399cf20d386aa78619a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "297230acdadd667fda379debd7dda20ace4f7213"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@297230acdadd667fda379debd7dda20ace4f7213",
"title": "297230acdadd667fda379debd7dda20ace4f7213",
"url": "https://llvm.googlesource.com/llvm-project/+/297230acdadd667fda379debd7dda20ace4f7213"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c81a2c058e2b8a0bb8426cfaedc90e00d9290eb0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c81a2c058e2b8a0bb8426cfaedc90e00d9290eb0",
"title": "c81a2c058e2b8a0bb8426cfaedc90e00d9290eb0",
"url": "https://llvm.googlesource.com/llvm-project/+/c81a2c058e2b8a0bb8426cfaedc90e00d9290eb0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ba177c7286f538a9f4d4962fc8ac6440a2244ed9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ba177c7286f538a9f4d4962fc8ac6440a2244ed9",
"title": "ba177c7286f538a9f4d4962fc8ac6440a2244ed9",
"url": "https://llvm.googlesource.com/llvm-project/+/ba177c7286f538a9f4d4962fc8ac6440a2244ed9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f19af90cf88246d42ce1f2310ded70895e0835b8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f19af90cf88246d42ce1f2310ded70895e0835b8",
"title": "f19af90cf88246d42ce1f2310ded70895e0835b8",
"url": "https://llvm.googlesource.com/llvm-project/+/f19af90cf88246d42ce1f2310ded70895e0835b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b1b4bf0618d391d1c9e961d0b4f86e99be0b9e3b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b1b4bf0618d391d1c9e961d0b4f86e99be0b9e3b",
"title": "b1b4bf0618d391d1c9e961d0b4f86e99be0b9e3b",
"url": "https://llvm.googlesource.com/llvm-project/+/b1b4bf0618d391d1c9e961d0b4f86e99be0b9e3b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b799080f19c2c1a23d096289e6e03cdbd8b44895"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b799080f19c2c1a23d096289e6e03cdbd8b44895",
"title": "b799080f19c2c1a23d096289e6e03cdbd8b44895",
"url": "https://llvm.googlesource.com/llvm-project/+/b799080f19c2c1a23d096289e6e03cdbd8b44895"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2260ebf7b6df15db96c76039758dd9dbf009c334"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2260ebf7b6df15db96c76039758dd9dbf009c334",
"title": "2260ebf7b6df15db96c76039758dd9dbf009c334",
"url": "https://llvm.googlesource.com/llvm-project/+/2260ebf7b6df15db96c76039758dd9dbf009c334"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2260ebf7b6df15db96c76039758dd9dbf009c334",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931120353464748736"
},
{
"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:15:26.493] Scheduled build:
{
"id": "8765690291373006145",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-31T20:15:25.753221178Z",
"updateTime": "2023-10-31T20:15:25.753221178Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2260ebf7b6df15db96c76039758dd9dbf009c334",
"ref": "refs/heads/main"
}
}
}
[20:15:26.493] Task URL: https://cr-buildbucket.appspot.com/build/8765690291373006145
[20:15:26.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:2:0) after 9m17s
[20:15:27.352] Received PubSub notification, asking Buildbucket for the build status
[20:15:27.472] Build status: SCHEDULED
[20:15:28.282] Received PubSub notification, asking Buildbucket for the build status
[20:15:28.312] Build status: STARTED
[20:24:43.509] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:2:0)
[20:24:43.543] Build status: STARTED
[20:24:43.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:5:0) after 1m46s
[20:26:29.530] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:5:0)
[20:26:29.549] Build status: STARTED
[20:26:29.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:6:0) after 8m36s
[20:35:05.566] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:6:0)
[20:35:05.595] Build status: STARTED
[20:35:05.595] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:7:0) after 4m13s
[20:39:18.615] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:7:0)
[20:39:18.831] Build status: STARTED
[20:39:18.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:8:0) after 3m20s
[20:42:38.968] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:8:0)
[20:42:39.018] Build status: STARTED
[20:42:39.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:9:0) after 8m25s
[20:51:04.178] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:9:0)
[20:51:04.207] Build status: STARTED
[20:51:04.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:10:0) after 8m40s
[20:59:44.231] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:10:0)
[20:59:44.253] Build status: STARTED
[20:59:44.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:11:0) after 8m30s
[21:08:14.525] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:11:0)
[21:08:14.543] Build status: STARTED
[21:08:14.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931120353464748736:12:0) after 9m5s
[21:16:58.238] Received PubSub notification, asking Buildbucket for the build status
[21:16:58.266] Build:
{
"id": "8765690291373006145",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-31T20:15:25.753221178Z",
"startTime": "2023-10-31T20:15:27.157971Z",
"endTime": "2023-10-31T21:16:57.465595Z",
"updateTime": "2023-10-31T21:16:57.465595Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2260ebf7b6df15db96c76039758dd9dbf009c334",
"ref": "refs/heads/main"
}
}
}
[21:16:58.266] Invocation finished in 1h1m33.890893711s with status SUCCEEDED