[08:39:02.891] New invocation is queued and will start shortly
[08:39:04.082] Starting the invocation (attempt 1)
[08:39:04.108] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/53c7fe50d869386459226aeac5ec72ee918737c9"
[08:39:04.108] Popped gitiles commit info from properties and tags
[08:39:04.108] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:39:04.108] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:39:04.108] Buildbucket request:
{
"requestId": "8891210902350271888",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8891210902350271888",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4eaff6c58ae2f130ac8d63cf2c87bbb483114876"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4eaff6c58ae2f130ac8d63cf2c87bbb483114876",
"title": "4eaff6c58ae2f130ac8d63cf2c87bbb483114876",
"url": "https://llvm.googlesource.com/llvm-project/+/4eaff6c58ae2f130ac8d63cf2c87bbb483114876"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "87d7aebdd43102160d93d8e5859228d860ea072d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@87d7aebdd43102160d93d8e5859228d860ea072d",
"title": "87d7aebdd43102160d93d8e5859228d860ea072d",
"url": "https://llvm.googlesource.com/llvm-project/+/87d7aebdd43102160d93d8e5859228d860ea072d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "726cfc67b69633119279a6369263491421861b1d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@726cfc67b69633119279a6369263491421861b1d",
"title": "726cfc67b69633119279a6369263491421861b1d",
"url": "https://llvm.googlesource.com/llvm-project/+/726cfc67b69633119279a6369263491421861b1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c9bc0fffa74d374bec57a1c1a320ec99b49f4e29"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c9bc0fffa74d374bec57a1c1a320ec99b49f4e29",
"title": "c9bc0fffa74d374bec57a1c1a320ec99b49f4e29",
"url": "https://llvm.googlesource.com/llvm-project/+/c9bc0fffa74d374bec57a1c1a320ec99b49f4e29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "99fc649c5f9a0592f4aaed7945a0ffa79a191c33"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@99fc649c5f9a0592f4aaed7945a0ffa79a191c33",
"title": "99fc649c5f9a0592f4aaed7945a0ffa79a191c33",
"url": "https://llvm.googlesource.com/llvm-project/+/99fc649c5f9a0592f4aaed7945a0ffa79a191c33"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cfe5a0847a42d7e67942d70f938d2d664a95990c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cfe5a0847a42d7e67942d70f938d2d664a95990c",
"title": "cfe5a0847a42d7e67942d70f938d2d664a95990c",
"url": "https://llvm.googlesource.com/llvm-project/+/cfe5a0847a42d7e67942d70f938d2d664a95990c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1a935d7a17519e9b75d12c3caf9a54a3405a0af3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1a935d7a17519e9b75d12c3caf9a54a3405a0af3",
"title": "1a935d7a17519e9b75d12c3caf9a54a3405a0af3",
"url": "https://llvm.googlesource.com/llvm-project/+/1a935d7a17519e9b75d12c3caf9a54a3405a0af3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "95f7c2f88dc5b2fd851c3181b03300538151133e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@95f7c2f88dc5b2fd851c3181b03300538151133e",
"title": "95f7c2f88dc5b2fd851c3181b03300538151133e",
"url": "https://llvm.googlesource.com/llvm-project/+/95f7c2f88dc5b2fd851c3181b03300538151133e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "53c7fe50d869386459226aeac5ec72ee918737c9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@53c7fe50d869386459226aeac5ec72ee918737c9",
"title": "53c7fe50d869386459226aeac5ec72ee918737c9",
"url": "https://llvm.googlesource.com/llvm-project/+/53c7fe50d869386459226aeac5ec72ee918737c9"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53c7fe50d869386459226aeac5ec72ee918737c9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8891210902350271888"
},
{
"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"
}
}
[08:39:04.505] Scheduled build:
{
"id": "8725780840357591777",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-14T08:39:04.169492316Z",
"updateTime": "2025-01-14T08:39:04.169492316Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53c7fe50d869386459226aeac5ec72ee918737c9",
"ref": "refs/heads/main"
}
}
}
[08:39:04.505] Task URL: https://cr-buildbucket.appspot.com/build/8725780840357591777
[08:39:04.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:2:0) after 2m45s
[08:39:06.389] Received PubSub notification, asking Buildbucket for the build status
[08:39:06.418] Build status: SCHEDULED
[08:39:16.120] Received PubSub notification, asking Buildbucket for the build status
[08:39:16.223] Build status: STARTED
[08:41:49.734] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:2:0)
[08:41:49.756] Build status: STARTED
[08:41:49.756] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:5:0) after 6m53s
[08:48:42.771] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:5:0)
[08:48:42.819] Build status: STARTED
[08:48:42.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:6:0) after 8m7s
[08:56:50.015] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:6:0)
[08:56:50.048] Build status: STARTED
[08:56:50.048] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:7:0) after 2m50s
[08:59:40.073] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:7:0)
[08:59:40.112] Build status: STARTED
[08:59:40.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:8:0) after 3m40s
[09:03:20.135] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:8:0)
[09:03:20.213] Build status: STARTED
[09:03:20.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:9:0) after 2m54s
[09:06:14.289] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:9:0)
[09:06:14.306] Build status: STARTED
[09:06:14.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:10:0) after 3m55s
[09:10:09.404] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:10:0)
[09:10:09.429] Build status: STARTED
[09:10:09.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:11:0) after 4m56s
[09:15:05.453] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:11:0)
[09:15:05.475] Build status: STARTED
[09:15:05.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:12:0) after 5m29s
[09:20:34.510] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:12:0)
[09:20:34.663] Build status: STARTED
[09:20:34.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:13:0) after 3m12s
[09:23:46.744] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:13:0)
[09:23:46.764] Build status: STARTED
[09:23:46.764] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:14:0) after 6m39s
[09:30:25.924] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:14:0)
[09:30:25.948] Build status: STARTED
[09:30:25.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:15:0) after 6m36s
[09:37:02.074] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:15:0)
[09:37:02.109] Build status: STARTED
[09:37:02.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:16:0) after 6m57s
[09:43:59.128] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:16:0)
[09:43:59.152] Build status: STARTED
[09:43:59.152] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:17:0) after 9m55s
[09:53:54.175] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:17:0)
[09:53:54.189] Build status: STARTED
[09:53:54.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:18:0) after 1m2s
[09:54:56.341] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:18:0)
[09:54:56.356] Build status: STARTED
[09:54:56.356] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:19:0) after 5m21s
[10:00:17.371] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:19:0)
[10:00:17.402] Build status: STARTED
[10:00:17.402] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:20:0) after 5m37s
[10:05:54.518] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:20:0)
[10:05:54.541] Build status: STARTED
[10:05:54.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8891210902350271888:21:0) after 6m10s
[10:08:24.342] Received PubSub notification, asking Buildbucket for the build status
[10:08:24.359] Build:
{
"id": "8725780840357591777",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-14T08:39:04.169492316Z",
"startTime": "2025-01-14T08:39:12.860221745Z",
"endTime": "2025-01-14T10:08:23.960232961Z",
"updateTime": "2025-01-14T10:08:23.960232961Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53c7fe50d869386459226aeac5ec72ee918737c9",
"ref": "refs/heads/main"
}
}
}
[10:08:24.359] Invocation finished in 1h29m21.47423505s with status SUCCEEDED