[12:31:36.856] New invocation is queued and will start shortly
[12:31:37.923] Starting the invocation (attempt 1)
[12:31:37.951] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4508d6aa72b0f31056ae01aff0e8009a252e4683"
[12:31:37.951] Popped gitiles commit info from properties and tags
[12:31:37.951] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:31:37.951] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:31:37.951] Buildbucket request:
{
"requestId": "8886213437404524528",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8886213437404524528",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dd86ece554a42c6a7663a18b779442e8380e4ef8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dd86ece554a42c6a7663a18b779442e8380e4ef8",
"title": "dd86ece554a42c6a7663a18b779442e8380e4ef8",
"url": "https://llvm.googlesource.com/llvm-project/+/dd86ece554a42c6a7663a18b779442e8380e4ef8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0ede277b62d12954342c4a1bd8a0c201d60a3cd9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0ede277b62d12954342c4a1bd8a0c201d60a3cd9",
"title": "0ede277b62d12954342c4a1bd8a0c201d60a3cd9",
"url": "https://llvm.googlesource.com/llvm-project/+/0ede277b62d12954342c4a1bd8a0c201d60a3cd9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "99fdb5dfd8ffc3d872f868aec8ef7fd380c0413a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@99fdb5dfd8ffc3d872f868aec8ef7fd380c0413a",
"title": "99fdb5dfd8ffc3d872f868aec8ef7fd380c0413a",
"url": "https://llvm.googlesource.com/llvm-project/+/99fdb5dfd8ffc3d872f868aec8ef7fd380c0413a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0c7e895de3a9df6ff702fbebd1cdd580cb65e3d1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0c7e895de3a9df6ff702fbebd1cdd580cb65e3d1",
"title": "0c7e895de3a9df6ff702fbebd1cdd580cb65e3d1",
"url": "https://llvm.googlesource.com/llvm-project/+/0c7e895de3a9df6ff702fbebd1cdd580cb65e3d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dd21aacd76e36d4db157a5d7a7b5370d456426e6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dd21aacd76e36d4db157a5d7a7b5370d456426e6",
"title": "dd21aacd76e36d4db157a5d7a7b5370d456426e6",
"url": "https://llvm.googlesource.com/llvm-project/+/dd21aacd76e36d4db157a5d7a7b5370d456426e6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6a9df5b4dd2ac1b00cdc3880c210cc0d2e917f04"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6a9df5b4dd2ac1b00cdc3880c210cc0d2e917f04",
"title": "6a9df5b4dd2ac1b00cdc3880c210cc0d2e917f04",
"url": "https://llvm.googlesource.com/llvm-project/+/6a9df5b4dd2ac1b00cdc3880c210cc0d2e917f04"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "502385c2412aa04867dc7386296a2f9bc4745d36"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@502385c2412aa04867dc7386296a2f9bc4745d36",
"title": "502385c2412aa04867dc7386296a2f9bc4745d36",
"url": "https://llvm.googlesource.com/llvm-project/+/502385c2412aa04867dc7386296a2f9bc4745d36"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fdc8e5ab62318ff39832cbca2056044a9d45bfe0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fdc8e5ab62318ff39832cbca2056044a9d45bfe0",
"title": "fdc8e5ab62318ff39832cbca2056044a9d45bfe0",
"url": "https://llvm.googlesource.com/llvm-project/+/fdc8e5ab62318ff39832cbca2056044a9d45bfe0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "52225d2702592b220f87aa82fb434bf776d4f745"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@52225d2702592b220f87aa82fb434bf776d4f745",
"title": "52225d2702592b220f87aa82fb434bf776d4f745",
"url": "https://llvm.googlesource.com/llvm-project/+/52225d2702592b220f87aa82fb434bf776d4f745"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "94a62b3085e35e1a7781c46bccee236255e1ca28"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@94a62b3085e35e1a7781c46bccee236255e1ca28",
"title": "94a62b3085e35e1a7781c46bccee236255e1ca28",
"url": "https://llvm.googlesource.com/llvm-project/+/94a62b3085e35e1a7781c46bccee236255e1ca28"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "88f010a2ebe828a1a3a1faa25b36716e9b45549a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@88f010a2ebe828a1a3a1faa25b36716e9b45549a",
"title": "88f010a2ebe828a1a3a1faa25b36716e9b45549a",
"url": "https://llvm.googlesource.com/llvm-project/+/88f010a2ebe828a1a3a1faa25b36716e9b45549a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4508d6aa72b0f31056ae01aff0e8009a252e4683"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4508d6aa72b0f31056ae01aff0e8009a252e4683",
"title": "4508d6aa72b0f31056ae01aff0e8009a252e4683",
"url": "https://llvm.googlesource.com/llvm-project/+/4508d6aa72b0f31056ae01aff0e8009a252e4683"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4508d6aa72b0f31056ae01aff0e8009a252e4683",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8886213437404524528"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:31:38.342] Scheduled build:
{
"id": "8720783375534995345",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-10T12:31:38.017001169Z",
"updateTime": "2025-03-10T12:31:38.017001169Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4508d6aa72b0f31056ae01aff0e8009a252e4683",
"ref": "refs/heads/main"
}
}
}
[12:31:38.342] Task URL: https://cr-buildbucket.appspot.com/build/8720783375534995345
[12:31:38.342] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:2:0) after 9m14s
[12:31:43.475] Received PubSub notification, asking Buildbucket for the build status
[12:31:43.507] Build status: SCHEDULED
[12:31:50.942] Received PubSub notification, asking Buildbucket for the build status
[12:31:50.972] Build status: STARTED
[12:40:52.413] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:2:0)
[12:40:52.445] Build status: STARTED
[12:40:52.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:5:0) after 6m14s
[12:47:06.422] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:5:0)
[12:47:06.485] Build status: STARTED
[12:47:06.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:6:0) after 5m53s
[12:52:59.511] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:6:0)
[12:52:59.546] Build status: STARTED
[12:52:59.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:7:0) after 1m11s
[12:54:10.610] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:7:0)
[12:54:10.627] Build status: STARTED
[12:54:10.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:8:0) after 8m45s
[13:02:55.643] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:8:0)
[13:02:55.665] Build status: STARTED
[13:02:55.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:9:0) after 8m23s
[13:11:18.692] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:9:0)
[13:11:18.708] Build status: STARTED
[13:11:18.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:10:0) after 7m32s
[13:18:51.201] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:10:0)
[13:18:51.218] Build status: STARTED
[13:18:51.218] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:11:0) after 7m25s
[13:26:16.251] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:11:0)
[13:26:16.297] Build status: STARTED
[13:26:16.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:12:0) after 4m22s
[13:30:38.413] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:12:0)
[13:30:38.436] Build status: STARTED
[13:30:38.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:13:0) after 1m44s
[13:32:22.438] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:13:0)
[13:32:22.487] Build status: STARTED
[13:32:22.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:14:0) after 8m21s
[13:40:43.540] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:14:0)
[13:40:43.590] Build status: STARTED
[13:40:43.590] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:15:0) after 7m12s
[13:47:55.625] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:15:0)
[13:47:55.644] Build status: STARTED
[13:47:55.644] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:16:0) after 6m10s
[13:54:05.677] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:16:0)
[13:54:05.694] Build status: STARTED
[13:54:05.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886213437404524528:17:0) after 1m13s
[13:54:33.480] Received PubSub notification, asking Buildbucket for the build status
[13:54:33.495] Build:
{
"id": "8720783375534995345",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-10T12:31:38.017001169Z",
"startTime": "2025-03-10T12:31:48.871121255Z",
"endTime": "2025-03-10T13:54:33.123287074Z",
"updateTime": "2025-03-10T13:54:33.123287074Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4508d6aa72b0f31056ae01aff0e8009a252e4683",
"ref": "refs/heads/main"
}
}
}
[13:54:33.495] Invocation finished in 1h22m56.644346451s with status SUCCEEDED