[20:16:43.502] New invocation is queued and will start shortly
[20:16:44.709] Starting the invocation (attempt 1)
[20:16:44.737] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d2a9df2c8ffd21fd52fbd8199a191d10078f41af"
[20:16:44.737] Popped gitiles commit info from properties and tags
[20:16:44.737] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:16:44.737] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:16:44.737] Buildbucket request:
{
"requestId": "8920339231502595920",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8920339231502595920",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e3b60540c81354b321018a47bf159ca9b52d776"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e3b60540c81354b321018a47bf159ca9b52d776",
"title": "8e3b60540c81354b321018a47bf159ca9b52d776",
"url": "https://llvm.googlesource.com/llvm-project/+/8e3b60540c81354b321018a47bf159ca9b52d776"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "16e74fd48988ac95551d0f64e1b36f78a82a89a2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@16e74fd48988ac95551d0f64e1b36f78a82a89a2",
"title": "16e74fd48988ac95551d0f64e1b36f78a82a89a2",
"url": "https://llvm.googlesource.com/llvm-project/+/16e74fd48988ac95551d0f64e1b36f78a82a89a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "40ba1f60e9f4b186d71272d4bc23b5af6204244d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@40ba1f60e9f4b186d71272d4bc23b5af6204244d",
"title": "40ba1f60e9f4b186d71272d4bc23b5af6204244d",
"url": "https://llvm.googlesource.com/llvm-project/+/40ba1f60e9f4b186d71272d4bc23b5af6204244d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "19181f24e516ce1cb58cd5ba27515eb968ae22d9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@19181f24e516ce1cb58cd5ba27515eb968ae22d9",
"title": "19181f24e516ce1cb58cd5ba27515eb968ae22d9",
"url": "https://llvm.googlesource.com/llvm-project/+/19181f24e516ce1cb58cd5ba27515eb968ae22d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9ca8db352d22444feabd859380252f13826a8aff"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9ca8db352d22444feabd859380252f13826a8aff",
"title": "9ca8db352d22444feabd859380252f13826a8aff",
"url": "https://llvm.googlesource.com/llvm-project/+/9ca8db352d22444feabd859380252f13826a8aff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d23ef9ef3685eb42ebf719bc28cfe2e4651932fc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d23ef9ef3685eb42ebf719bc28cfe2e4651932fc",
"title": "d23ef9ef3685eb42ebf719bc28cfe2e4651932fc",
"url": "https://llvm.googlesource.com/llvm-project/+/d23ef9ef3685eb42ebf719bc28cfe2e4651932fc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3189b13b274a3411f939574aa573a7656bf372b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3189b13b274a3411f939574aa573a7656bf372b",
"title": "b3189b13b274a3411f939574aa573a7656bf372b",
"url": "https://llvm.googlesource.com/llvm-project/+/b3189b13b274a3411f939574aa573a7656bf372b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f42e321b9fb54300c4450e699cd3cc453e994b58"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f42e321b9fb54300c4450e699cd3cc453e994b58",
"title": "f42e321b9fb54300c4450e699cd3cc453e994b58",
"url": "https://llvm.googlesource.com/llvm-project/+/f42e321b9fb54300c4450e699cd3cc453e994b58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fd4204464905be198b158a0f30e5c06cc4ce3686"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fd4204464905be198b158a0f30e5c06cc4ce3686",
"title": "fd4204464905be198b158a0f30e5c06cc4ce3686",
"url": "https://llvm.googlesource.com/llvm-project/+/fd4204464905be198b158a0f30e5c06cc4ce3686"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a76c524adc57220253b34e166f59ed19634e28f5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a76c524adc57220253b34e166f59ed19634e28f5",
"title": "a76c524adc57220253b34e166f59ed19634e28f5",
"url": "https://llvm.googlesource.com/llvm-project/+/a76c524adc57220253b34e166f59ed19634e28f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0d1f95760b07a31293ccc82086306833326b70a4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0d1f95760b07a31293ccc82086306833326b70a4",
"title": "0d1f95760b07a31293ccc82086306833326b70a4",
"url": "https://llvm.googlesource.com/llvm-project/+/0d1f95760b07a31293ccc82086306833326b70a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d2a9df2c8ffd21fd52fbd8199a191d10078f41af"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d2a9df2c8ffd21fd52fbd8199a191d10078f41af",
"title": "d2a9df2c8ffd21fd52fbd8199a191d10078f41af",
"url": "https://llvm.googlesource.com/llvm-project/+/d2a9df2c8ffd21fd52fbd8199a191d10078f41af"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d2a9df2c8ffd21fd52fbd8199a191d10078f41af",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8920339231502595920"
},
{
"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:16:45.242] Scheduled build:
{
"id": "8754909169477330993",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-27T20:16:44.807903266Z",
"updateTime": "2024-02-27T20:16:44.807903266Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d2a9df2c8ffd21fd52fbd8199a191d10078f41af",
"ref": "refs/heads/main"
}
}
}
[20:16:45.242] Task URL: https://cr-buildbucket.appspot.com/build/8754909169477330993
[20:16:45.242] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:2:0) after 7m39s
[20:16:46.157] Received PubSub notification, asking Buildbucket for the build status
[20:16:46.193] Build status: SCHEDULED
[20:16:47.058] Received PubSub notification, asking Buildbucket for the build status
[20:16:47.086] Build status: STARTED
[20:24:24.262] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:2:0)
[20:24:24.305] Build status: STARTED
[20:24:24.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:5:0) after 2m21s
[20:26:45.325] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:5:0)
[20:26:45.357] Build status: STARTED
[20:26:45.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:6:0) after 9m37s
[20:36:22.377] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:6:0)
[20:36:22.398] Build status: STARTED
[20:36:22.398] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:7:0) after 6m39s
[20:43:01.490] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:7:0)
[20:43:01.524] Build status: STARTED
[20:43:01.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:8:0) after 5m15s
[20:48:16.581] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:8:0)
[20:48:16.606] Build status: STARTED
[20:48:16.606] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:9:0) after 1m7s
[20:49:23.645] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:9:0)
[20:49:23.664] Build status: STARTED
[20:49:23.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:10:0) after 9m53s
[20:59:16.682] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:10:0)
[20:59:16.802] Build status: STARTED
[20:59:16.802] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:11:0) after 4m41s
[21:03:57.819] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:11:0)
[21:03:58.176] Build status: STARTED
[21:03:58.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:12:0) after 9m18s
[21:13:16.275] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:12:0)
[21:13:16.322] Build status: STARTED
[21:13:16.322] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:13:0) after 3m45s
[21:17:01.352] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:13:0)
[21:17:01.377] Build status: STARTED
[21:17:01.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:14:0) after 9m28s
[21:26:29.468] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:14:0)
[21:26:29.495] Build status: STARTED
[21:26:29.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:15:0) after 2m35s
[21:29:04.622] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:15:0)
[21:29:04.652] Build status: STARTED
[21:29:04.652] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8920339231502595920:16:0) after 9m5s
[21:29:36.371] Received PubSub notification, asking Buildbucket for the build status
[21:29:36.412] Build:
{
"id": "8754909169477330993",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-27T20:16:44.807903266Z",
"startTime": "2024-02-27T20:16:46.335497Z",
"endTime": "2024-02-27T21:29:35.681018Z",
"updateTime": "2024-02-27T21:29:35.681018Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d2a9df2c8ffd21fd52fbd8199a191d10078f41af",
"ref": "refs/heads/main"
}
}
}
[21:29:36.412] Invocation finished in 1h12m52.9201122s with status SUCCEEDED