[09:40:47.456] New invocation is queued and will start shortly
[09:40:48.577] Starting the invocation (attempt 1)
[09:40:48.610] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7b65971e1f64e0736da31decae495e25db3ac773"
[09:40:48.610] Popped gitiles commit info from properties and tags
[09:40:48.610] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:40:48.610] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:40:48.611] Buildbucket request:
{
"requestId": "8899179550879526464",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8899179550879526464",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0d1a91e8f91e364b83f77e597dfb835d70fe9cf9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0d1a91e8f91e364b83f77e597dfb835d70fe9cf9",
"title": "0d1a91e8f91e364b83f77e597dfb835d70fe9cf9",
"url": "https://llvm.googlesource.com/llvm-project/+/0d1a91e8f91e364b83f77e597dfb835d70fe9cf9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d1ee850743c29bd2064b9a308e84f048827f143e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d1ee850743c29bd2064b9a308e84f048827f143e",
"title": "d1ee850743c29bd2064b9a308e84f048827f143e",
"url": "https://llvm.googlesource.com/llvm-project/+/d1ee850743c29bd2064b9a308e84f048827f143e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f15d7e43e17f72839861bfe3a5c466c325bc04d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f15d7e43e17f72839861bfe3a5c466c325bc04d",
"title": "2f15d7e43e17f72839861bfe3a5c466c325bc04d",
"url": "https://llvm.googlesource.com/llvm-project/+/2f15d7e43e17f72839861bfe3a5c466c325bc04d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bafc66e50f623a34eb23a14dd66bdbee944cd197"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bafc66e50f623a34eb23a14dd66bdbee944cd197",
"title": "bafc66e50f623a34eb23a14dd66bdbee944cd197",
"url": "https://llvm.googlesource.com/llvm-project/+/bafc66e50f623a34eb23a14dd66bdbee944cd197"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7eaf92b3e4db5e3be9e9ee137866090d66dd08fb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7eaf92b3e4db5e3be9e9ee137866090d66dd08fb",
"title": "7eaf92b3e4db5e3be9e9ee137866090d66dd08fb",
"url": "https://llvm.googlesource.com/llvm-project/+/7eaf92b3e4db5e3be9e9ee137866090d66dd08fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f792f6e7157751441b06c7212edfea1a0651a27"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f792f6e7157751441b06c7212edfea1a0651a27",
"title": "2f792f6e7157751441b06c7212edfea1a0651a27",
"url": "https://llvm.googlesource.com/llvm-project/+/2f792f6e7157751441b06c7212edfea1a0651a27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c72992bf897b22465b2c80343b1b4a5afd1508ef"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c72992bf897b22465b2c80343b1b4a5afd1508ef",
"title": "c72992bf897b22465b2c80343b1b4a5afd1508ef",
"url": "https://llvm.googlesource.com/llvm-project/+/c72992bf897b22465b2c80343b1b4a5afd1508ef"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7a43be1690e27ddf8813e49d93eb419d214fcd7a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7a43be1690e27ddf8813e49d93eb419d214fcd7a",
"title": "7a43be1690e27ddf8813e49d93eb419d214fcd7a",
"url": "https://llvm.googlesource.com/llvm-project/+/7a43be1690e27ddf8813e49d93eb419d214fcd7a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3a1df05ca91fa6a0f893123ad08a46a443b0b486"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3a1df05ca91fa6a0f893123ad08a46a443b0b486",
"title": "3a1df05ca91fa6a0f893123ad08a46a443b0b486",
"url": "https://llvm.googlesource.com/llvm-project/+/3a1df05ca91fa6a0f893123ad08a46a443b0b486"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3ec1b1a4dd52641c4b84cac55ef3a228960a0bdc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3ec1b1a4dd52641c4b84cac55ef3a228960a0bdc",
"title": "3ec1b1a4dd52641c4b84cac55ef3a228960a0bdc",
"url": "https://llvm.googlesource.com/llvm-project/+/3ec1b1a4dd52641c4b84cac55ef3a228960a0bdc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5f7502bf1f193482e23385cdd4cfecf09f19ccbc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5f7502bf1f193482e23385cdd4cfecf09f19ccbc",
"title": "5f7502bf1f193482e23385cdd4cfecf09f19ccbc",
"url": "https://llvm.googlesource.com/llvm-project/+/5f7502bf1f193482e23385cdd4cfecf09f19ccbc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7b65971e1f64e0736da31decae495e25db3ac773"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7b65971e1f64e0736da31decae495e25db3ac773",
"title": "7b65971e1f64e0736da31decae495e25db3ac773",
"url": "https://llvm.googlesource.com/llvm-project/+/7b65971e1f64e0736da31decae495e25db3ac773"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7b65971e1f64e0736da31decae495e25db3ac773",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8899179550879526464"
},
{
"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:40:49.087] Scheduled build:
{
"id": "8733749488911284721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-18T09:40:48.707872299Z",
"updateTime": "2024-10-18T09:40:48.707872299Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7b65971e1f64e0736da31decae495e25db3ac773",
"ref": "refs/heads/main"
}
}
}
[09:40:49.087] Task URL: https://cr-buildbucket.appspot.com/build/8733749488911284721
[09:40:49.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:2:0) after 3m14s
[09:40:49.959] Received PubSub notification, asking Buildbucket for the build status
[09:40:49.985] Build status: SCHEDULED
[09:40:55.385] Received PubSub notification, asking Buildbucket for the build status
[09:40:55.406] Build status: STARTED
[09:44:03.221] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:2:0)
[09:44:03.263] Build status: STARTED
[09:44:03.263] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:5:0) after 3m54s
[09:47:57.281] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:5:0)
[09:47:57.445] Build status: STARTED
[09:47:57.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:6:0) after 9m53s
[09:57:50.717] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:6:0)
[09:57:50.740] Build status: STARTED
[09:57:50.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:7:0) after 4m53s
[10:02:43.756] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:7:0)
[10:02:43.832] Build status: STARTED
[10:02:43.832] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:8:0) after 4m53s
[10:07:37.056] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:8:0)
[10:07:37.074] Build status: STARTED
[10:07:37.075] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:9:0) after 2m26s
[10:10:03.145] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:9:0)
[10:10:03.241] Build status: STARTED
[10:10:03.241] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:10:0) after 5m1s
[10:15:04.609] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:10:0)
[10:15:04.627] Build status: STARTED
[10:15:04.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:11:0) after 5m15s
[10:20:19.705] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:11:0)
[10:20:19.724] Build status: STARTED
[10:20:19.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:12:0) after 9m54s
[10:30:13.749] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:12:0)
[10:30:13.765] Build status: STARTED
[10:30:13.765] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:13:0) after 7m19s
[10:37:32.818] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:13:0)
[10:37:32.838] Build status: STARTED
[10:37:32.838] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:14:0) after 1m27s
[10:38:59.895] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:14:0)
[10:38:59.912] Build status: STARTED
[10:38:59.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:15:0) after 9m38s
[10:48:37.928] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:15:0)
[10:48:37.973] Build status: STARTED
[10:48:37.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:16:0) after 2m6s
[10:50:44.181] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:16:0)
[10:50:44.197] Build status: STARTED
[10:50:44.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899179550879526464:17:0) after 7m2s
[10:56:05.408] Received PubSub notification, asking Buildbucket for the build status
[10:56:05.432] Build:
{
"id": "8733749488911284721",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-18T09:40:48.707872299Z",
"startTime": "2024-10-18T09:40:55.152974022Z",
"endTime": "2024-10-18T10:56:04.788869310Z",
"updateTime": "2024-10-18T10:56:04.788869310Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7b65971e1f64e0736da31decae495e25db3ac773",
"ref": "refs/heads/main"
}
}
}
[10:56:05.432] Invocation finished in 1h15m17.986518613s with status SUCCEEDED