[09:07:37.664] New invocation is queued and will start shortly
[09:07:38.987] Starting the invocation (attempt 1)
[09:07:39.013] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5d38a3406b11c70e6f0d1a880b78ed404aba2c36"
[09:07:39.013] Popped gitiles commit info from properties and tags
[09:07:39.013] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:07:39.013] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:07:39.014] Buildbucket request:
{
"requestId": "8894832982944936496",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8894832982944936496",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a9a4a83b6132f076fd14ac31268deaa4bf1381d5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a9a4a83b6132f076fd14ac31268deaa4bf1381d5",
"title": "a9a4a83b6132f076fd14ac31268deaa4bf1381d5",
"url": "https://llvm.googlesource.com/llvm-project/+/a9a4a83b6132f076fd14ac31268deaa4bf1381d5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "636beb6a2833ee0290935f679252c1b662721b31"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@636beb6a2833ee0290935f679252c1b662721b31",
"title": "636beb6a2833ee0290935f679252c1b662721b31",
"url": "https://llvm.googlesource.com/llvm-project/+/636beb6a2833ee0290935f679252c1b662721b31"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fd3907ccb583df99e9c19d2fe84e4e7c52d75de9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fd3907ccb583df99e9c19d2fe84e4e7c52d75de9",
"title": "fd3907ccb583df99e9c19d2fe84e4e7c52d75de9",
"url": "https://llvm.googlesource.com/llvm-project/+/fd3907ccb583df99e9c19d2fe84e4e7c52d75de9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "41cde465acfddb44d400b0a53bb57960762312a2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@41cde465acfddb44d400b0a53bb57960762312a2",
"title": "41cde465acfddb44d400b0a53bb57960762312a2",
"url": "https://llvm.googlesource.com/llvm-project/+/41cde465acfddb44d400b0a53bb57960762312a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a9eb8f0e3dbaf16b6bd83eecb960b6ea8ecaa8c3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a9eb8f0e3dbaf16b6bd83eecb960b6ea8ecaa8c3",
"title": "a9eb8f0e3dbaf16b6bd83eecb960b6ea8ecaa8c3",
"url": "https://llvm.googlesource.com/llvm-project/+/a9eb8f0e3dbaf16b6bd83eecb960b6ea8ecaa8c3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3a8ada67ff45aec5696d72212d516593c3d32893"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3a8ada67ff45aec5696d72212d516593c3d32893",
"title": "3a8ada67ff45aec5696d72212d516593c3d32893",
"url": "https://llvm.googlesource.com/llvm-project/+/3a8ada67ff45aec5696d72212d516593c3d32893"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5d38a3406b11c70e6f0d1a880b78ed404aba2c36"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5d38a3406b11c70e6f0d1a880b78ed404aba2c36",
"title": "5d38a3406b11c70e6f0d1a880b78ed404aba2c36",
"url": "https://llvm.googlesource.com/llvm-project/+/5d38a3406b11c70e6f0d1a880b78ed404aba2c36"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5d38a3406b11c70e6f0d1a880b78ed404aba2c36",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8894832982944936496"
},
{
"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"
}
}
[09:07:39.600] Scheduled build:
{
"id": "8729402920753304545",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-05T09:07:39.123272503Z",
"updateTime": "2024-12-05T09:07:39.123272503Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5d38a3406b11c70e6f0d1a880b78ed404aba2c36",
"ref": "refs/heads/main"
}
}
}
[09:07:39.600] Task URL: https://cr-buildbucket.appspot.com/build/8729402920753304545
[09:07:39.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:2:0) after 2m36s
[09:07:40.451] Received PubSub notification, asking Buildbucket for the build status
[09:07:40.480] Build status: SCHEDULED
[09:07:45.575] Received PubSub notification, asking Buildbucket for the build status
[09:07:45.608] Build status: STARTED
[09:10:15.716] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:2:0)
[09:10:15.752] Build status: STARTED
[09:10:15.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:5:0) after 3m5s
[09:13:20.806] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:5:0)
[09:13:20.828] Build status: STARTED
[09:13:20.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:6:0) after 3m27s
[09:16:47.943] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:6:0)
[09:16:48.013] Build status: STARTED
[09:16:48.013] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:7:0) after 9m34s
[09:26:22.309] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:7:0)
[09:26:22.341] Build status: STARTED
[09:26:22.341] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:8:0) after 5m21s
[09:31:43.459] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:8:0)
[09:31:43.485] Build status: STARTED
[09:31:43.485] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:9:0) after 7m17s
[09:39:00.573] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:9:0)
[09:39:00.594] Build status: STARTED
[09:39:00.594] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:10:0) after 1m40s
[09:40:40.708] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:10:0)
[09:40:40.729] Build status: STARTED
[09:40:40.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:11:0) after 1m24s
[09:42:04.746] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:11:0)
[09:42:04.769] Build status: STARTED
[09:42:04.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:12:0) after 1m10s
[09:43:15.288] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:12:0)
[09:43:15.306] Build status: STARTED
[09:43:15.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:13:0) after 4m3s
[09:47:18.571] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:13:0)
[09:47:18.596] Build status: STARTED
[09:47:18.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:14:0) after 3m35s
[09:50:53.652] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:14:0)
[09:50:53.669] Build status: STARTED
[09:50:53.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:15:0) after 4m25s
[09:55:18.902] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:15:0)
[09:55:18.960] Build status: STARTED
[09:55:18.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:16:0) after 9m35s
[10:04:54.218] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:16:0)
[10:04:54.237] Build status: STARTED
[10:04:54.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:17:0) after 6m6s
[10:11:00.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:17:0)
[10:11:00.287] Build status: STARTED
[10:11:00.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:18:0) after 6m59s
[10:17:59.456] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:18:0)
[10:17:59.478] Build status: STARTED
[10:17:59.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:19:0) after 2m8s
[10:20:07.560] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:19:0)
[10:20:07.588] Build status: STARTED
[10:20:07.588] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:20:0) after 4m44s
[10:24:51.607] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:20:0)
[10:24:51.628] Build status: STARTED
[10:24:51.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:21:0) after 6m16s
[10:31:07.707] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:21:0)
[10:31:07.737] Build status: STARTED
[10:31:07.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894832982944936496:22:0) after 7m55s
[10:35:29.775] Received PubSub notification, asking Buildbucket for the build status
[10:35:29.799] Build:
{
"id": "8729402920753304545",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-05T09:07:39.123272503Z",
"startTime": "2024-12-05T09:07:44.792874244Z",
"endTime": "2024-12-05T10:35:11.163399689Z",
"updateTime": "2024-12-05T10:35:11.163399689Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5d38a3406b11c70e6f0d1a880b78ed404aba2c36",
"ref": "refs/heads/main"
}
}
}
[10:35:29.799] Invocation finished in 1h27m52.148853259s with status SUCCEEDED