[14:34:10.561] New invocation is queued and will start shortly
[14:34:11.890] Starting the invocation (attempt 1)
[14:34:11.920] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1d594fdb8d0d210893ae346bb6869343dd7a1949"
[14:34:11.920] Popped gitiles commit info from properties and tags
[14:34:11.920] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:34:11.921] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:34:11.922] Buildbucket request:
{
"requestId": "8872797375458560112",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8872797375458560112",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cda4820270dc9d4e84107152130a54c5ecc4976d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cda4820270dc9d4e84107152130a54c5ecc4976d",
"title": "cda4820270dc9d4e84107152130a54c5ecc4976d",
"url": "https://llvm.googlesource.com/llvm-project/+/cda4820270dc9d4e84107152130a54c5ecc4976d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e005ba3668846a013284b893b8bc246c63fce3ae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e005ba3668846a013284b893b8bc246c63fce3ae",
"title": "e005ba3668846a013284b893b8bc246c63fce3ae",
"url": "https://llvm.googlesource.com/llvm-project/+/e005ba3668846a013284b893b8bc246c63fce3ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fd07d90f9f95190cb3abb901ae3d98eb67b84573"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fd07d90f9f95190cb3abb901ae3d98eb67b84573",
"title": "fd07d90f9f95190cb3abb901ae3d98eb67b84573",
"url": "https://llvm.googlesource.com/llvm-project/+/fd07d90f9f95190cb3abb901ae3d98eb67b84573"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ee47427386eb405d347bb2d24c925c3130bdde53"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ee47427386eb405d347bb2d24c925c3130bdde53",
"title": "ee47427386eb405d347bb2d24c925c3130bdde53",
"url": "https://llvm.googlesource.com/llvm-project/+/ee47427386eb405d347bb2d24c925c3130bdde53"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "34c2ea326c7a8167d54575b794b9cf1ab6e7d2fd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@34c2ea326c7a8167d54575b794b9cf1ab6e7d2fd",
"title": "34c2ea326c7a8167d54575b794b9cf1ab6e7d2fd",
"url": "https://llvm.googlesource.com/llvm-project/+/34c2ea326c7a8167d54575b794b9cf1ab6e7d2fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cc2a385e65483688d3e4a0091e0767960f9eb8c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cc2a385e65483688d3e4a0091e0767960f9eb8c2",
"title": "cc2a385e65483688d3e4a0091e0767960f9eb8c2",
"url": "https://llvm.googlesource.com/llvm-project/+/cc2a385e65483688d3e4a0091e0767960f9eb8c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2444c4a69861c643c6628b736affe5861cc79080"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2444c4a69861c643c6628b736affe5861cc79080",
"title": "2444c4a69861c643c6628b736affe5861cc79080",
"url": "https://llvm.googlesource.com/llvm-project/+/2444c4a69861c643c6628b736affe5861cc79080"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "47ef3d069bcfb8ec31c06cdd619557c84d1084ad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@47ef3d069bcfb8ec31c06cdd619557c84d1084ad",
"title": "47ef3d069bcfb8ec31c06cdd619557c84d1084ad",
"url": "https://llvm.googlesource.com/llvm-project/+/47ef3d069bcfb8ec31c06cdd619557c84d1084ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b723887224c57ecfd7d8530ad066ee233abf559b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b723887224c57ecfd7d8530ad066ee233abf559b",
"title": "b723887224c57ecfd7d8530ad066ee233abf559b",
"url": "https://llvm.googlesource.com/llvm-project/+/b723887224c57ecfd7d8530ad066ee233abf559b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3f59a22711ff6423ad158e2eec44d2c1f0eaee31"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3f59a22711ff6423ad158e2eec44d2c1f0eaee31",
"title": "3f59a22711ff6423ad158e2eec44d2c1f0eaee31",
"url": "https://llvm.googlesource.com/llvm-project/+/3f59a22711ff6423ad158e2eec44d2c1f0eaee31"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6099d0c1f93f17bcb5f79d33777defccfc46320b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6099d0c1f93f17bcb5f79d33777defccfc46320b",
"title": "6099d0c1f93f17bcb5f79d33777defccfc46320b",
"url": "https://llvm.googlesource.com/llvm-project/+/6099d0c1f93f17bcb5f79d33777defccfc46320b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "16766b3aef281a24acad08292ffe69554b44805b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@16766b3aef281a24acad08292ffe69554b44805b",
"title": "16766b3aef281a24acad08292ffe69554b44805b",
"url": "https://llvm.googlesource.com/llvm-project/+/16766b3aef281a24acad08292ffe69554b44805b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "be8ef3dfbdd485df16bc9c7eed66f5c3c109d238"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@be8ef3dfbdd485df16bc9c7eed66f5c3c109d238",
"title": "be8ef3dfbdd485df16bc9c7eed66f5c3c109d238",
"url": "https://llvm.googlesource.com/llvm-project/+/be8ef3dfbdd485df16bc9c7eed66f5c3c109d238"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "908ef456062bcb5c5e4745f10e161782bd07f342"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@908ef456062bcb5c5e4745f10e161782bd07f342",
"title": "908ef456062bcb5c5e4745f10e161782bd07f342",
"url": "https://llvm.googlesource.com/llvm-project/+/908ef456062bcb5c5e4745f10e161782bd07f342"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3847620ba9a22a13de30bd77d059aae6f484dd94"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3847620ba9a22a13de30bd77d059aae6f484dd94",
"title": "3847620ba9a22a13de30bd77d059aae6f484dd94",
"url": "https://llvm.googlesource.com/llvm-project/+/3847620ba9a22a13de30bd77d059aae6f484dd94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "06458fff874fb272d1d99c26293b9210ae1aad5f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@06458fff874fb272d1d99c26293b9210ae1aad5f",
"title": "06458fff874fb272d1d99c26293b9210ae1aad5f",
"url": "https://llvm.googlesource.com/llvm-project/+/06458fff874fb272d1d99c26293b9210ae1aad5f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff8b4f8151391f94eac268775382d4b10a17d913"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff8b4f8151391f94eac268775382d4b10a17d913",
"title": "ff8b4f8151391f94eac268775382d4b10a17d913",
"url": "https://llvm.googlesource.com/llvm-project/+/ff8b4f8151391f94eac268775382d4b10a17d913"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1d594fdb8d0d210893ae346bb6869343dd7a1949"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1d594fdb8d0d210893ae346bb6869343dd7a1949",
"title": "1d594fdb8d0d210893ae346bb6869343dd7a1949",
"url": "https://llvm.googlesource.com/llvm-project/+/1d594fdb8d0d210893ae346bb6869343dd7a1949"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1d594fdb8d0d210893ae346bb6869343dd7a1949",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872797375458560112"
},
{
"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"
}
}
[14:34:12.469] Scheduled build:
{
"id": "8707367313240832033",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-05T14:34:12.054215718Z",
"updateTime": "2025-08-05T14:34:12.054215718Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1d594fdb8d0d210893ae346bb6869343dd7a1949",
"ref": "refs/heads/main"
}
},
"canary": true
}
[14:34:12.469] Task URL: https://cr-buildbucket.appspot.com/build/8707367313240832033
[14:34:12.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:2:0) after 5m37s
[14:34:13.442] Received PubSub notification, asking Buildbucket for the build status
[14:34:13.466] Build status: SCHEDULED
[14:34:16.046] Received PubSub notification, asking Buildbucket for the build status
[14:34:16.074] Build status: STARTED
[14:39:49.543] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:2:0)
[14:39:49.690] Build status: STARTED
[14:39:49.691] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:5:0) after 7m37s
[14:47:26.723] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:5:0)
[14:47:26.746] Build status: STARTED
[14:47:26.746] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:6:0) after 1m13s
[14:48:39.771] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:6:0)
[14:48:39.798] Build status: STARTED
[14:48:39.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:7:0) after 1m15s
[14:49:54.826] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:7:0)
[14:49:54.861] Build status: STARTED
[14:49:54.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:8:0) after 7m24s
[14:57:18.940] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:8:0)
[14:57:18.981] Build status: STARTED
[14:57:18.981] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:9:0) after 2m52s
[15:00:11.018] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:9:0)
[15:00:11.097] Build status: STARTED
[15:00:11.097] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:10:0) after 7m30s
[15:07:41.124] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:10:0)
[15:07:41.164] Build status: STARTED
[15:07:41.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:11:0) after 8m43s
[15:16:24.199] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:11:0)
[15:16:24.217] Build status: STARTED
[15:16:24.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:12:0) after 5m0s
[15:21:24.311] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:12:0)
[15:21:24.364] Build status: STARTED
[15:21:24.364] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:13:0) after 9m54s
[15:31:18.434] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:13:0)
[15:31:18.451] Build status: STARTED
[15:31:18.451] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:14:0) after 5m43s
[15:37:01.476] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:14:0)
[15:37:01.495] Build status: STARTED
[15:37:01.495] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:15:0) after 9m0s
[15:46:01.585] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:15:0)
[15:46:01.623] Build status: STARTED
[15:46:01.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:16:0) after 5m46s
[15:51:47.702] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:16:0)
[15:51:47.728] Build status: STARTED
[15:51:47.728] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:17:0) after 1m2s
[15:52:49.720] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:17:0)
[15:52:49.745] Build status: STARTED
[15:52:49.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:18:0) after 7m41s
[16:00:30.767] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:18:0)
[16:00:30.786] Build status: STARTED
[16:00:30.786] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8872797375458560112:19:0) after 3m47s
[16:01:39.088] Received PubSub notification, asking Buildbucket for the build status
[16:01:39.106] Build:
{
"id": "8707367313240832033",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-05T14:34:12.054215718Z",
"startTime": "2025-08-05T14:34:15.770400283Z",
"endTime": "2025-08-05T16:01:37.879771097Z",
"updateTime": "2025-08-05T16:01:37.879771097Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1d594fdb8d0d210893ae346bb6869343dd7a1949",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:01:39.106] Invocation finished in 1h27m28.550204485s with status SUCCEEDED