[22:12:22.832] New invocation is queued and will start shortly
[22:12:23.961] Starting the invocation (attempt 1)
[22:12:23.992] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4a9df48cf81d99a78c79bbcc95db16e14005b74c"
[22:12:23.992] Popped gitiles commit info from properties and tags
[22:12:23.992] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:12:23.992] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:12:23.993] Buildbucket request:
{
"requestId": "8868419893339001968",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868419893339001968",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2b5e29efd97c1e704e7678e53afe81bbb4745ea5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2b5e29efd97c1e704e7678e53afe81bbb4745ea5",
"title": "2b5e29efd97c1e704e7678e53afe81bbb4745ea5",
"url": "https://llvm.googlesource.com/llvm-project/+/2b5e29efd97c1e704e7678e53afe81bbb4745ea5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a00450944d2a91aba302954556c1c23ae049dfc7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a00450944d2a91aba302954556c1c23ae049dfc7",
"title": "a00450944d2a91aba302954556c1c23ae049dfc7",
"url": "https://llvm.googlesource.com/llvm-project/+/a00450944d2a91aba302954556c1c23ae049dfc7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d5c0f2d7afb747fc1bf52db4d0476329be0dcf0f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d5c0f2d7afb747fc1bf52db4d0476329be0dcf0f",
"title": "d5c0f2d7afb747fc1bf52db4d0476329be0dcf0f",
"url": "https://llvm.googlesource.com/llvm-project/+/d5c0f2d7afb747fc1bf52db4d0476329be0dcf0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6f64b01810a2e46c1b05b20589272532ba633e56"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6f64b01810a2e46c1b05b20589272532ba633e56",
"title": "6f64b01810a2e46c1b05b20589272532ba633e56",
"url": "https://llvm.googlesource.com/llvm-project/+/6f64b01810a2e46c1b05b20589272532ba633e56"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "207d399d17f651feaf1bd7af49395c80ee5b6014"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@207d399d17f651feaf1bd7af49395c80ee5b6014",
"title": "207d399d17f651feaf1bd7af49395c80ee5b6014",
"url": "https://llvm.googlesource.com/llvm-project/+/207d399d17f651feaf1bd7af49395c80ee5b6014"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4f2a00d7972d502b19758ddf846ed43c745a3bbc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4f2a00d7972d502b19758ddf846ed43c745a3bbc",
"title": "4f2a00d7972d502b19758ddf846ed43c745a3bbc",
"url": "https://llvm.googlesource.com/llvm-project/+/4f2a00d7972d502b19758ddf846ed43c745a3bbc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "360b059a21c690bf199cb2c8a7bb1fade2481656"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@360b059a21c690bf199cb2c8a7bb1fade2481656",
"title": "360b059a21c690bf199cb2c8a7bb1fade2481656",
"url": "https://llvm.googlesource.com/llvm-project/+/360b059a21c690bf199cb2c8a7bb1fade2481656"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "61a535a2cdf4a28495a03d906cfb4250acbc7da7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@61a535a2cdf4a28495a03d906cfb4250acbc7da7",
"title": "61a535a2cdf4a28495a03d906cfb4250acbc7da7",
"url": "https://llvm.googlesource.com/llvm-project/+/61a535a2cdf4a28495a03d906cfb4250acbc7da7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "42b195e1bf5cf6807d95a51ac0abb6f79e60796a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@42b195e1bf5cf6807d95a51ac0abb6f79e60796a",
"title": "42b195e1bf5cf6807d95a51ac0abb6f79e60796a",
"url": "https://llvm.googlesource.com/llvm-project/+/42b195e1bf5cf6807d95a51ac0abb6f79e60796a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4a9df48cf81d99a78c79bbcc95db16e14005b74c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4a9df48cf81d99a78c79bbcc95db16e14005b74c",
"title": "4a9df48cf81d99a78c79bbcc95db16e14005b74c",
"url": "https://llvm.googlesource.com/llvm-project/+/4a9df48cf81d99a78c79bbcc95db16e14005b74c"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4a9df48cf81d99a78c79bbcc95db16e14005b74c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868419893339001968"
},
{
"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"
}
}
[22:12:24.361] Scheduled build:
{
"id": "8702989831401159009",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-22T22:12:24.055139847Z",
"updateTime": "2025-09-22T22:12:24.055139847Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4a9df48cf81d99a78c79bbcc95db16e14005b74c",
"ref": "refs/heads/main"
}
}
}
[22:12:24.361] Task URL: https://cr-buildbucket.appspot.com/build/8702989831401159009
[22:12:24.361] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:2:0) after 6m23s
[22:12:24.999] Received PubSub notification, asking Buildbucket for the build status
[22:12:25.101] Build status: SCHEDULED
[22:12:28.402] Received PubSub notification, asking Buildbucket for the build status
[22:12:28.429] Build status: STARTED
[22:18:47.396] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:2:0)
[22:18:47.423] Build status: STARTED
[22:18:47.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:5:0) after 5m24s
[22:24:11.530] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:5:0)
[22:24:11.550] Build status: STARTED
[22:24:11.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:6:0) after 8m8s
[22:32:19.610] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:6:0)
[22:32:19.654] Build status: STARTED
[22:32:19.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:7:0) after 7m57s
[22:40:16.670] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:7:0)
[22:40:16.696] Build status: STARTED
[22:40:16.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:8:0) after 8m34s
[22:48:50.710] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:8:0)
[22:48:50.790] Build status: STARTED
[22:48:50.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:9:0) after 1m37s
[22:50:27.849] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:9:0)
[22:50:28.531] Build status: STARTED
[22:50:28.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:10:0) after 3m24s
[22:53:52.524] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:10:0)
[22:53:52.538] Build status: STARTED
[22:53:52.538] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:11:0) after 2m43s
[22:56:35.555] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:11:0)
[22:56:35.619] Build status: STARTED
[22:56:35.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:12:0) after 3m3s
[22:59:38.682] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:12:0)
[22:59:38.698] Build status: STARTED
[22:59:38.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:13:0) after 9m36s
[23:09:14.714] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:13:0)
[23:09:14.742] Build status: STARTED
[23:09:14.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:14:0) after 4m29s
[23:13:43.758] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:14:0)
[23:13:43.775] Build status: STARTED
[23:13:43.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:15:0) after 4m20s
[23:18:03.855] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:15:0)
[23:18:03.875] Build status: STARTED
[23:18:03.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:16:0) after 3m21s
[23:21:24.891] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:16:0)
[23:21:24.911] Build status: STARTED
[23:21:24.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:17:0) after 7m9s
[23:28:34.042] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:17:0)
[23:28:34.057] Build status: STARTED
[23:28:34.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:18:0) after 1m49s
[23:30:23.108] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:18:0)
[23:30:23.137] Build status: STARTED
[23:30:23.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:19:0) after 6m17s
[23:36:40.153] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:19:0)
[23:36:40.183] Build status: STARTED
[23:36:40.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:20:0) after 2m55s
[23:39:35.195] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:20:0)
[23:39:35.223] Build status: STARTED
[23:39:35.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868419893339001968:21:0) after 9m59s
[23:43:39.930] Received PubSub notification, asking Buildbucket for the build status
[23:43:39.960] Build:
{
"id": "8702989831401159009",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-22T22:12:24.055139847Z",
"startTime": "2025-09-22T22:12:27.747604717Z",
"endTime": "2025-09-22T23:43:39.562546814Z",
"updateTime": "2025-09-22T23:43:39.562546814Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4a9df48cf81d99a78c79bbcc95db16e14005b74c",
"ref": "refs/heads/main"
}
}
}
[23:43:39.960] Invocation finished in 1h31m17.136520001s with status SUCCEEDED