[19:46:02.678] New invocation is queued and will start shortly
[19:46:03.783] Starting the invocation (attempt 1)
[19:46:03.818] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/bc89380179c4febb8d38948fdc71b9376ee1d6af"
[19:46:03.818] Popped gitiles commit info from properties and tags
[19:46:03.818] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:46:03.818] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:46:03.819] Buildbucket request:
{
"requestId": "8875767454277336320",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875767454277336320",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bfd457588af9a7fa0aca14f14275d169c55e6277"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bfd457588af9a7fa0aca14f14275d169c55e6277",
"title": "bfd457588af9a7fa0aca14f14275d169c55e6277",
"url": "https://llvm.googlesource.com/llvm-project/+/bfd457588af9a7fa0aca14f14275d169c55e6277"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a3dea0addd0e2022b4a5abbd6673fbec6962cdad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a3dea0addd0e2022b4a5abbd6673fbec6962cdad",
"title": "a3dea0addd0e2022b4a5abbd6673fbec6962cdad",
"url": "https://llvm.googlesource.com/llvm-project/+/a3dea0addd0e2022b4a5abbd6673fbec6962cdad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "48ef55ce3e85a637c840189fe553d239f9f1f8f0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@48ef55ce3e85a637c840189fe553d239f9f1f8f0",
"title": "48ef55ce3e85a637c840189fe553d239f9f1f8f0",
"url": "https://llvm.googlesource.com/llvm-project/+/48ef55ce3e85a637c840189fe553d239f9f1f8f0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0afbf1721346faca3dbcd659acf2c558c26146fb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0afbf1721346faca3dbcd659acf2c558c26146fb",
"title": "0afbf1721346faca3dbcd659acf2c558c26146fb",
"url": "https://llvm.googlesource.com/llvm-project/+/0afbf1721346faca3dbcd659acf2c558c26146fb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ea88634764f832285eba11e86a54b1c5e07a72c8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ea88634764f832285eba11e86a54b1c5e07a72c8",
"title": "ea88634764f832285eba11e86a54b1c5e07a72c8",
"url": "https://llvm.googlesource.com/llvm-project/+/ea88634764f832285eba11e86a54b1c5e07a72c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "be762b7b7d60f47ab75e81942c8899331d89f141"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@be762b7b7d60f47ab75e81942c8899331d89f141",
"title": "be762b7b7d60f47ab75e81942c8899331d89f141",
"url": "https://llvm.googlesource.com/llvm-project/+/be762b7b7d60f47ab75e81942c8899331d89f141"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "08ed9e17bf873198608b5e213e086f7bac07e40b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@08ed9e17bf873198608b5e213e086f7bac07e40b",
"title": "08ed9e17bf873198608b5e213e086f7bac07e40b",
"url": "https://llvm.googlesource.com/llvm-project/+/08ed9e17bf873198608b5e213e086f7bac07e40b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "67d6679c91e14e17981e4ea0340f91c79e9524da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@67d6679c91e14e17981e4ea0340f91c79e9524da",
"title": "67d6679c91e14e17981e4ea0340f91c79e9524da",
"url": "https://llvm.googlesource.com/llvm-project/+/67d6679c91e14e17981e4ea0340f91c79e9524da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bc89380179c4febb8d38948fdc71b9376ee1d6af"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bc89380179c4febb8d38948fdc71b9376ee1d6af",
"title": "bc89380179c4febb8d38948fdc71b9376ee1d6af",
"url": "https://llvm.googlesource.com/llvm-project/+/bc89380179c4febb8d38948fdc71b9376ee1d6af"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bc89380179c4febb8d38948fdc71b9376ee1d6af",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875767454277336320"
},
{
"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"
}
}
[19:46:04.195] Scheduled build:
{
"id": "8710337392361193537",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-03T19:46:03.880197852Z",
"updateTime": "2025-07-03T19:46:03.880197852Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bc89380179c4febb8d38948fdc71b9376ee1d6af",
"ref": "refs/heads/main"
}
}
}
[19:46:04.195] Task URL: https://cr-buildbucket.appspot.com/build/8710337392361193537
[19:46:04.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:2:0) after 1m11s
[19:46:05.197] Received PubSub notification, asking Buildbucket for the build status
[19:46:05.220] Build status: SCHEDULED
[19:46:07.859] Received PubSub notification, asking Buildbucket for the build status
[19:46:07.880] Build status: STARTED
[19:47:15.399] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:2:0)
[19:47:15.424] Build status: STARTED
[19:47:15.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:5:0) after 1m15s
[19:48:30.597] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:5:0)
[19:48:30.658] Build status: STARTED
[19:48:30.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:6:0) after 3m9s
[19:51:39.677] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:6:0)
[19:51:39.827] Build status: STARTED
[19:51:39.827] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:7:0) after 7m0s
[19:58:40.133] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:7:0)
[19:58:40.159] Build status: STARTED
[19:58:40.159] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:8:0) after 2m3s
[20:00:43.283] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:8:0)
[20:00:43.308] Build status: STARTED
[20:00:43.308] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:9:0) after 6m51s
[20:07:34.357] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:9:0)
[20:07:34.391] Build status: STARTED
[20:07:34.391] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:10:0) after 4m23s
[20:11:57.490] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:10:0)
[20:11:57.515] Build status: STARTED
[20:11:57.515] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:11:0) after 2m57s
[20:14:54.529] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:11:0)
[20:14:54.552] Build status: STARTED
[20:14:54.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:12:0) after 5m5s
[20:19:59.575] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:12:0)
[20:19:59.601] Build status: STARTED
[20:19:59.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:13:0) after 9m3s
[20:29:02.704] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:13:0)
[20:29:02.737] Build status: STARTED
[20:29:02.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:14:0) after 8m35s
[20:37:37.756] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:14:0)
[20:37:37.779] Build status: STARTED
[20:37:37.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:15:0) after 8m56s
[20:46:33.975] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:15:0)
[20:46:34.001] Build status: STARTED
[20:46:34.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:16:0) after 3m26s
[20:50:00.025] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:16:0)
[20:50:00.056] Build status: STARTED
[20:50:00.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:17:0) after 2m4s
[20:52:04.078] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:17:0)
[20:52:04.104] Build status: STARTED
[20:52:04.104] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:18:0) after 2m58s
[20:55:02.119] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:18:0)
[20:55:02.149] Build status: STARTED
[20:55:02.149] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:19:0) after 3m14s
[20:58:16.355] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:19:0)
[20:58:16.427] Build status: STARTED
[20:58:16.427] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:20:0) after 1m5s
[20:59:21.575] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:20:0)
[20:59:21.595] Build status: STARTED
[20:59:21.595] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:21:0) after 4m4s
[21:03:25.622] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:21:0)
[21:03:25.711] Build status: STARTED
[21:03:25.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8875767454277336320:22:0) after 7m18s
[21:08:37.069] Received PubSub notification, asking Buildbucket for the build status
[21:08:37.098] Build:
{
"id": "8710337392361193537",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-03T19:46:03.880197852Z",
"startTime": "2025-07-03T19:46:07.352818391Z",
"endTime": "2025-07-03T21:08:36.549019811Z",
"updateTime": "2025-07-03T21:08:36.549019811Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bc89380179c4febb8d38948fdc71b9376ee1d6af",
"ref": "refs/heads/main"
}
}
}
[21:08:37.098] Invocation finished in 1h22m34.428959673s with status SUCCEEDED