[20:50:04.234] New invocation is queued and will start shortly
[20:50:05.493] Starting the invocation (attempt 1)
[20:50:05.519] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/acf964b95f5421cc372719139b427be37ad79e7e"
[20:50:05.519] Popped gitiles commit info from properties and tags
[20:50:05.519] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:50:05.519] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:50:05.519] Buildbucket request:
{
"requestId": "8883192377371955888",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8883192377371955888",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4fa3b2a1843c42f333d7332b373ae99428883974"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4fa3b2a1843c42f333d7332b373ae99428883974",
"title": "4fa3b2a1843c42f333d7332b373ae99428883974",
"url": "https://llvm.googlesource.com/llvm-project/+/4fa3b2a1843c42f333d7332b373ae99428883974"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5bdad0555eae01e5eef6a1360c1637a5d9bcde79"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5bdad0555eae01e5eef6a1360c1637a5d9bcde79",
"title": "5bdad0555eae01e5eef6a1360c1637a5d9bcde79",
"url": "https://llvm.googlesource.com/llvm-project/+/5bdad0555eae01e5eef6a1360c1637a5d9bcde79"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "acf964b95f5421cc372719139b427be37ad79e7e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@acf964b95f5421cc372719139b427be37ad79e7e",
"title": "acf964b95f5421cc372719139b427be37ad79e7e",
"url": "https://llvm.googlesource.com/llvm-project/+/acf964b95f5421cc372719139b427be37ad79e7e"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "acf964b95f5421cc372719139b427be37ad79e7e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8883192377371955888"
},
{
"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"
}
}
[20:50:05.867] Scheduled build:
{
"id": "8717762315300772561",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-12T20:50:05.571119852Z",
"updateTime": "2025-04-12T20:50:05.571119852Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "acf964b95f5421cc372719139b427be37ad79e7e",
"ref": "refs/heads/main"
}
},
"canary": true
}
[20:50:05.867] Task URL: https://cr-buildbucket.appspot.com/build/8717762315300772561
[20:50:05.868] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:2:0) after 5m37s
[20:50:05.926] Received PubSub notification, asking Buildbucket for the build status
[20:50:05.955] Build status: SCHEDULED
[20:50:09.349] Received PubSub notification, asking Buildbucket for the build status
[20:50:09.366] Build status: STARTED
[20:55:42.884] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:2:0)
[20:55:42.909] Build status: STARTED
[20:55:42.909] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:5:0) after 1m30s
[20:57:13.080] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:5:0)
[20:57:13.114] Build status: STARTED
[20:57:13.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:6:0) after 9m26s
[21:06:39.313] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:6:0)
[21:06:39.336] Build status: STARTED
[21:06:39.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:7:0) after 1m20s
[21:07:59.372] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:7:0)
[21:07:59.396] Build status: STARTED
[21:07:59.396] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:8:0) after 1m5s
[21:09:04.430] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:8:0)
[21:09:04.489] Build status: STARTED
[21:09:04.489] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:9:0) after 2m21s
[21:11:25.511] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:9:0)
[21:11:25.535] Build status: STARTED
[21:11:25.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:10:0) after 1m54s
[21:13:19.672] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:10:0)
[21:13:19.694] Build status: STARTED
[21:13:19.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:11:0) after 2m30s
[21:15:49.694] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:11:0)
[21:15:49.719] Build status: STARTED
[21:15:49.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:12:0) after 4m14s
[21:20:03.934] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:12:0)
[21:20:03.959] Build status: STARTED
[21:20:03.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:13:0) after 5m7s
[21:25:11.075] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:13:0)
[21:25:11.093] Build status: STARTED
[21:25:11.093] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:14:0) after 4m26s
[21:29:37.159] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:14:0)
[21:29:37.182] Build status: STARTED
[21:29:37.182] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:15:0) after 7m19s
[21:36:56.205] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:15:0)
[21:36:56.227] Build status: STARTED
[21:36:56.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:16:0) after 8m54s
[21:45:50.574] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:16:0)
[21:45:50.593] Build status: STARTED
[21:45:50.593] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:17:0) after 6m30s
[21:52:20.608] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:17:0)
[21:52:20.627] Build status: STARTED
[21:52:20.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:18:0) after 6m36s
[21:58:56.709] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:18:0)
[21:58:56.739] Build status: STARTED
[21:58:56.739] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:19:0) after 7m25s
[22:06:21.728] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:19:0)
[22:06:21.747] Build status: STARTED
[22:06:21.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:20:0) after 5m6s
[22:11:27.738] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:20:0)
[22:11:27.754] Build status: STARTED
[22:11:27.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8883192377371955888:21:0) after 4m40s
[22:15:27.224] Received PubSub notification, asking Buildbucket for the build status
[22:15:27.296] Build:
{
"id": "8717762315300772561",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-12T20:50:05.571119852Z",
"startTime": "2025-04-12T20:50:09.170599221Z",
"endTime": "2025-04-12T22:15:26.438925598Z",
"updateTime": "2025-04-12T22:15:26.438925598Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "acf964b95f5421cc372719139b427be37ad79e7e",
"ref": "refs/heads/main"
}
},
"canary": true
}
[22:15:27.296] Invocation finished in 1h25m23.084288217s with status SUCCEEDED