[19:30:56.269] New invocation is queued and will start shortly
[19:30:57.346] Starting the invocation (attempt 1)
[19:30:57.389] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d22d2e35aed644d77fec6bf78126a8a54a77c7aa"
[19:30:57.389] Popped gitiles commit info from properties and tags
[19:30:57.389] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:30:57.390] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:30:57.390] Buildbucket request:
{
"requestId": "8860457517391720928",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8860457517391720928",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f03005497dc1a4357d7b0d69d9475d262e5825d5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f03005497dc1a4357d7b0d69d9475d262e5825d5",
"title": "f03005497dc1a4357d7b0d69d9475d262e5825d5",
"url": "https://llvm.googlesource.com/llvm-project/+/f03005497dc1a4357d7b0d69d9475d262e5825d5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d921b54d937b1b714aa6c258c0485c6bf18de3ec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d921b54d937b1b714aa6c258c0485c6bf18de3ec",
"title": "d921b54d937b1b714aa6c258c0485c6bf18de3ec",
"url": "https://llvm.googlesource.com/llvm-project/+/d921b54d937b1b714aa6c258c0485c6bf18de3ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b184f00bd06b02e7063a2519be869fb6dea5b6d1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b184f00bd06b02e7063a2519be869fb6dea5b6d1",
"title": "b184f00bd06b02e7063a2519be869fb6dea5b6d1",
"url": "https://llvm.googlesource.com/llvm-project/+/b184f00bd06b02e7063a2519be869fb6dea5b6d1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4012c1f6372c2aa54d1325ea4e6b7cb96e9fc004"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4012c1f6372c2aa54d1325ea4e6b7cb96e9fc004",
"title": "4012c1f6372c2aa54d1325ea4e6b7cb96e9fc004",
"url": "https://llvm.googlesource.com/llvm-project/+/4012c1f6372c2aa54d1325ea4e6b7cb96e9fc004"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fefda86c28f6c3aa8b32d49ef3ec72f620be961d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fefda86c28f6c3aa8b32d49ef3ec72f620be961d",
"title": "fefda86c28f6c3aa8b32d49ef3ec72f620be961d",
"url": "https://llvm.googlesource.com/llvm-project/+/fefda86c28f6c3aa8b32d49ef3ec72f620be961d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fcd70266609f07ee210e011d676748262b5cd782"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fcd70266609f07ee210e011d676748262b5cd782",
"title": "fcd70266609f07ee210e011d676748262b5cd782",
"url": "https://llvm.googlesource.com/llvm-project/+/fcd70266609f07ee210e011d676748262b5cd782"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1b4eed44df19ac03a25e7d8db73bbde62feda0b9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1b4eed44df19ac03a25e7d8db73bbde62feda0b9",
"title": "1b4eed44df19ac03a25e7d8db73bbde62feda0b9",
"url": "https://llvm.googlesource.com/llvm-project/+/1b4eed44df19ac03a25e7d8db73bbde62feda0b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "56c0173d958b0d35892aff414dd3329e3820d262"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@56c0173d958b0d35892aff414dd3329e3820d262",
"title": "56c0173d958b0d35892aff414dd3329e3820d262",
"url": "https://llvm.googlesource.com/llvm-project/+/56c0173d958b0d35892aff414dd3329e3820d262"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f2192b0b64cae114ea32a5762f7ed51873f62e00"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f2192b0b64cae114ea32a5762f7ed51873f62e00",
"title": "f2192b0b64cae114ea32a5762f7ed51873f62e00",
"url": "https://llvm.googlesource.com/llvm-project/+/f2192b0b64cae114ea32a5762f7ed51873f62e00"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f34d06868772bca627da07897d3d334d456427a8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f34d06868772bca627da07897d3d334d456427a8",
"title": "f34d06868772bca627da07897d3d334d456427a8",
"url": "https://llvm.googlesource.com/llvm-project/+/f34d06868772bca627da07897d3d334d456427a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3f3a57c766f560488b2e2f8f9c27a89173058319"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3f3a57c766f560488b2e2f8f9c27a89173058319",
"title": "3f3a57c766f560488b2e2f8f9c27a89173058319",
"url": "https://llvm.googlesource.com/llvm-project/+/3f3a57c766f560488b2e2f8f9c27a89173058319"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5897f276a57b1341524ddbebb2cd815b29ee178f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5897f276a57b1341524ddbebb2cd815b29ee178f",
"title": "5897f276a57b1341524ddbebb2cd815b29ee178f",
"url": "https://llvm.googlesource.com/llvm-project/+/5897f276a57b1341524ddbebb2cd815b29ee178f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b6c4590f1cea5fc9f08c820ac0bebfe17f5d773e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b6c4590f1cea5fc9f08c820ac0bebfe17f5d773e",
"title": "b6c4590f1cea5fc9f08c820ac0bebfe17f5d773e",
"url": "https://llvm.googlesource.com/llvm-project/+/b6c4590f1cea5fc9f08c820ac0bebfe17f5d773e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "42dc78f9454b57b64094650de01322a3f1004d10"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@42dc78f9454b57b64094650de01322a3f1004d10",
"title": "42dc78f9454b57b64094650de01322a3f1004d10",
"url": "https://llvm.googlesource.com/llvm-project/+/42dc78f9454b57b64094650de01322a3f1004d10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "023ccc328b64a9cba501c1a5f8cf05f0c7b9cce1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@023ccc328b64a9cba501c1a5f8cf05f0c7b9cce1",
"title": "023ccc328b64a9cba501c1a5f8cf05f0c7b9cce1",
"url": "https://llvm.googlesource.com/llvm-project/+/023ccc328b64a9cba501c1a5f8cf05f0c7b9cce1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ac387cee97125eef5dea6ce39c4a58d0b0e03711"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ac387cee97125eef5dea6ce39c4a58d0b0e03711",
"title": "ac387cee97125eef5dea6ce39c4a58d0b0e03711",
"url": "https://llvm.googlesource.com/llvm-project/+/ac387cee97125eef5dea6ce39c4a58d0b0e03711"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d22d2e35aed644d77fec6bf78126a8a54a77c7aa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d22d2e35aed644d77fec6bf78126a8a54a77c7aa",
"title": "d22d2e35aed644d77fec6bf78126a8a54a77c7aa",
"url": "https://llvm.googlesource.com/llvm-project/+/d22d2e35aed644d77fec6bf78126a8a54a77c7aa"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d22d2e35aed644d77fec6bf78126a8a54a77c7aa",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8860457517391720928"
},
{
"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"
}
}
[19:30:57.902] Scheduled build:
{
"id": "8695027455449350593",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-19T19:30:57.498488381Z",
"updateTime": "2025-12-19T19:30:57.498488381Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d22d2e35aed644d77fec6bf78126a8a54a77c7aa",
"ref": "refs/heads/main"
}
}
}
[19:30:57.902] Task URL: https://cr-buildbucket.appspot.com/build/8695027455449350593
[19:30:57.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:2:0) after 8m19s
[19:30:58.778] Received PubSub notification, asking Buildbucket for the build status
[19:30:58.797] Build status: SCHEDULED
[19:31:01.719] Received PubSub notification, asking Buildbucket for the build status
[19:31:01.732] Build status: STARTED
[19:39:16.976] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:2:0)
[19:39:16.998] Build status: STARTED
[19:39:16.998] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:5:0) after 3m44s
[19:43:01.064] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:5:0)
[19:43:01.098] Build status: STARTED
[19:43:01.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:6:0) after 6m57s
[19:49:58.131] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:6:0)
[19:49:58.161] Build status: STARTED
[19:49:58.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:7:0) after 3m40s
[19:53:38.202] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:7:0)
[19:53:38.235] Build status: STARTED
[19:53:38.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:8:0) after 4m4s
[19:57:42.321] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:8:0)
[19:57:42.333] Build status: STARTED
[19:57:42.333] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:9:0) after 9m20s
[20:07:02.299] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:9:0)
[20:07:02.319] Build status: STARTED
[20:07:02.319] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:10:0) after 1m8s
[20:08:10.466] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:10:0)
[20:08:10.498] Build status: STARTED
[20:08:10.498] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:11:0) after 2m36s
[20:10:46.619] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:11:0)
[20:10:46.632] Build status: STARTED
[20:10:46.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:12:0) after 4m11s
[20:14:57.892] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:12:0)
[20:14:57.907] Build status: STARTED
[20:14:57.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:13:0) after 2m33s
[20:17:31.069] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:13:0)
[20:17:31.087] Build status: STARTED
[20:17:31.088] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:14:0) after 6m19s
[20:23:50.177] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:14:0)
[20:23:50.194] Build status: STARTED
[20:23:50.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:15:0) after 1m9s
[20:24:59.276] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:15:0)
[20:24:59.293] Build status: STARTED
[20:24:59.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:16:0) after 8m0s
[20:32:59.366] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:16:0)
[20:32:59.385] Build status: STARTED
[20:32:59.385] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:17:0) after 5m32s
[20:38:31.449] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:17:0)
[20:38:31.470] Build status: STARTED
[20:38:31.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:18:0) after 3m11s
[20:41:42.613] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:18:0)
[20:41:42.631] Build status: STARTED
[20:41:42.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:19:0) after 5m43s
[20:47:25.698] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:19:0)
[20:47:25.713] Build status: STARTED
[20:47:25.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:20:0) after 9m13s
[20:56:38.830] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:20:0)
[20:56:38.848] Build status: STARTED
[20:56:38.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:21:0) after 2m48s
[20:59:26.863] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:21:0)
[20:59:26.920] Build status: STARTED
[20:59:26.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:22:0) after 2m7s
[21:01:33.925] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:22:0)
[21:01:33.942] Build status: STARTED
[21:01:33.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:23:0) after 2m20s
[21:03:54.069] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:23:0)
[21:03:54.135] Build status: STARTED
[21:03:54.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8860457517391720928:24:0) after 7m48s
[21:06:45.183] Received PubSub notification, asking Buildbucket for the build status
[21:06:45.231] Build:
{
"id": "8695027455449350593",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-12-19T19:30:57.498488381Z",
"startTime": "2025-12-19T19:31:01.213167448Z",
"endTime": "2025-12-19T21:06:44.870495923Z",
"updateTime": "2025-12-19T21:06:44.870495923Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d22d2e35aed644d77fec6bf78126a8a54a77c7aa",
"ref": "refs/heads/main"
}
}
}
[21:06:45.231] Invocation finished in 1h35m48.969247021s with status SUCCEEDED