[10:40:33.162] New invocation is queued and will start shortly
[10:40:34.360] Starting the invocation (attempt 1)
[10:40:34.387] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d2c5892c226342bd11341e5bd75c8b5152bde9a9"
[10:40:34.387] Popped gitiles commit info from properties and tags
[10:40:34.387] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:40:34.387] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:40:34.388] Buildbucket request:
{
"requestId": "8857682380387622896",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8857682380387622896",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5104e7783e56d06d70c41d92c30275ad917c7533"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5104e7783e56d06d70c41d92c30275ad917c7533",
"title": "5104e7783e56d06d70c41d92c30275ad917c7533",
"url": "https://llvm.googlesource.com/llvm-project/+/5104e7783e56d06d70c41d92c30275ad917c7533"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff5e583dbe2c6dd678e2ec78a14e2209d16c246d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff5e583dbe2c6dd678e2ec78a14e2209d16c246d",
"title": "ff5e583dbe2c6dd678e2ec78a14e2209d16c246d",
"url": "https://llvm.googlesource.com/llvm-project/+/ff5e583dbe2c6dd678e2ec78a14e2209d16c246d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d88138d3483cdfb8d674fae2e8bb0fa6dd1ac75a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d88138d3483cdfb8d674fae2e8bb0fa6dd1ac75a",
"title": "d88138d3483cdfb8d674fae2e8bb0fa6dd1ac75a",
"url": "https://llvm.googlesource.com/llvm-project/+/d88138d3483cdfb8d674fae2e8bb0fa6dd1ac75a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "db98b99f1eae0d3cc8f19b76db24f0039b5935de"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@db98b99f1eae0d3cc8f19b76db24f0039b5935de",
"title": "db98b99f1eae0d3cc8f19b76db24f0039b5935de",
"url": "https://llvm.googlesource.com/llvm-project/+/db98b99f1eae0d3cc8f19b76db24f0039b5935de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5b454fb11b0f5c64e4b53297bb5ef12171638d79"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5b454fb11b0f5c64e4b53297bb5ef12171638d79",
"title": "5b454fb11b0f5c64e4b53297bb5ef12171638d79",
"url": "https://llvm.googlesource.com/llvm-project/+/5b454fb11b0f5c64e4b53297bb5ef12171638d79"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "78481a2444b1d4bf9369b722af3a645e72ba5535"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@78481a2444b1d4bf9369b722af3a645e72ba5535",
"title": "78481a2444b1d4bf9369b722af3a645e72ba5535",
"url": "https://llvm.googlesource.com/llvm-project/+/78481a2444b1d4bf9369b722af3a645e72ba5535"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4a880833b7a441a3e9222f7bd0128f1dc74b1a96"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4a880833b7a441a3e9222f7bd0128f1dc74b1a96",
"title": "4a880833b7a441a3e9222f7bd0128f1dc74b1a96",
"url": "https://llvm.googlesource.com/llvm-project/+/4a880833b7a441a3e9222f7bd0128f1dc74b1a96"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "593103465326850f23bc9a6078ae7fb01065d46e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@593103465326850f23bc9a6078ae7fb01065d46e",
"title": "593103465326850f23bc9a6078ae7fb01065d46e",
"url": "https://llvm.googlesource.com/llvm-project/+/593103465326850f23bc9a6078ae7fb01065d46e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0e304e6d9f306ead81fc5177b8a497af0d416a73"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0e304e6d9f306ead81fc5177b8a497af0d416a73",
"title": "0e304e6d9f306ead81fc5177b8a497af0d416a73",
"url": "https://llvm.googlesource.com/llvm-project/+/0e304e6d9f306ead81fc5177b8a497af0d416a73"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3d90b7a2d7333ead420b18baece183249404329a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3d90b7a2d7333ead420b18baece183249404329a",
"title": "3d90b7a2d7333ead420b18baece183249404329a",
"url": "https://llvm.googlesource.com/llvm-project/+/3d90b7a2d7333ead420b18baece183249404329a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e697dba370a0da6bc491c8438aec562ad1f8e057"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e697dba370a0da6bc491c8438aec562ad1f8e057",
"title": "e697dba370a0da6bc491c8438aec562ad1f8e057",
"url": "https://llvm.googlesource.com/llvm-project/+/e697dba370a0da6bc491c8438aec562ad1f8e057"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9f19d1895d37fca90c9f1ff763fa5ffd7133a07e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9f19d1895d37fca90c9f1ff763fa5ffd7133a07e",
"title": "9f19d1895d37fca90c9f1ff763fa5ffd7133a07e",
"url": "https://llvm.googlesource.com/llvm-project/+/9f19d1895d37fca90c9f1ff763fa5ffd7133a07e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d2c5892c226342bd11341e5bd75c8b5152bde9a9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d2c5892c226342bd11341e5bd75c8b5152bde9a9",
"title": "d2c5892c226342bd11341e5bd75c8b5152bde9a9",
"url": "https://llvm.googlesource.com/llvm-project/+/d2c5892c226342bd11341e5bd75c8b5152bde9a9"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d2c5892c226342bd11341e5bd75c8b5152bde9a9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857682380387622896"
},
{
"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"
}
}
[10:40:34.980] Scheduled build:
{
"id": "8692252318391963585",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-19T10:40:34.434078022Z",
"updateTime": "2026-01-19T10:40:34.434078022Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d2c5892c226342bd11341e5bd75c8b5152bde9a9",
"ref": "refs/heads/main"
}
}
}
[10:40:34.980] Task URL: https://cr-buildbucket.appspot.com/build/8692252318391963585
[10:40:34.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:2:0) after 4m47s
[10:40:41.634] Received PubSub notification, asking Buildbucket for the build status
[10:40:41.667] Build status: STARTED
[10:40:44.683] Received PubSub notification, asking Buildbucket for the build status
[10:40:44.817] Build status: STARTED
[10:45:22.002] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:2:0)
[10:45:22.020] Build status: STARTED
[10:45:22.020] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:5:0) after 3m45s
[10:49:07.643] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:5:0)
[10:49:07.664] Build status: STARTED
[10:49:07.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:6:0) after 5m22s
[10:54:29.732] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:6:0)
[10:54:29.749] Build status: STARTED
[10:54:29.749] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:7:0) after 3m6s
[10:57:35.810] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:7:0)
[10:57:35.867] Build status: STARTED
[10:57:35.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:8:0) after 1m54s
[10:59:30.105] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:8:0)
[10:59:30.120] Build status: STARTED
[10:59:30.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:9:0) after 2m35s
[11:02:05.356] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:9:0)
[11:02:05.370] Build status: STARTED
[11:02:05.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:10:0) after 4m28s
[11:06:33.483] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:10:0)
[11:06:33.506] Build status: STARTED
[11:06:33.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:11:0) after 4m57s
[11:11:30.526] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:11:0)
[11:11:30.550] Build status: STARTED
[11:11:30.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:12:0) after 2m51s
[11:14:21.815] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:12:0)
[11:14:21.833] Build status: STARTED
[11:14:21.834] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:13:0) after 1m11s
[11:15:32.997] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:13:0)
[11:15:33.010] Build status: STARTED
[11:15:33.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:14:0) after 3m31s
[11:19:04.027] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:14:0)
[11:19:04.046] Build status: STARTED
[11:19:04.046] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:15:0) after 9m31s
[11:28:35.065] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:15:0)
[11:28:35.090] Build status: STARTED
[11:28:35.090] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:16:0) after 1m22s
[11:29:57.107] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:16:0)
[11:29:57.123] Build status: STARTED
[11:29:57.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:17:0) after 7m20s
[11:37:17.617] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:17:0)
[11:37:17.697] Build status: STARTED
[11:37:17.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:18:0) after 4m1s
[11:41:18.941] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:18:0)
[11:41:18.960] Build status: STARTED
[11:41:18.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:19:0) after 8m27s
[11:49:45.978] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:19:0)
[11:49:46.000] Build status: STARTED
[11:49:46.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:20:0) after 8m23s
[11:58:09.021] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:20:0)
[11:58:09.038] Build status: STARTED
[11:58:09.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:21:0) after 5m17s
[12:03:26.103] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:21:0)
[12:03:26.122] Build status: STARTED
[12:03:26.122] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8857682380387622896:22:0) after 8m19s
[12:11:43.844] Received PubSub notification, asking Buildbucket for the build status
[12:11:43.859] Build:
{
"id": "8692252318391963585",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-19T10:40:34.434078022Z",
"startTime": "2026-01-19T10:40:39.664361852Z",
"endTime": "2026-01-19T12:11:43.227360650Z",
"updateTime": "2026-01-19T12:11:43.227360650Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d2c5892c226342bd11341e5bd75c8b5152bde9a9",
"ref": "refs/heads/main"
}
}
}
[12:11:43.859] Invocation finished in 1h31m10.710535929s with status SUCCEEDED