[16:21:15.012] New invocation is queued and will start shortly
[16:21:16.264] Starting the invocation (attempt 1)
[16:21:16.289] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e9c9c33fa4e26b7e18947dfefa960f68945d1899"
[16:21:16.289] Popped gitiles commit info from properties and tags
[16:21:16.289] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:21:16.289] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:21:16.290] Buildbucket request:
{
"requestId": "8880128993218121136",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8880128993218121136",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8696d16242d220373460ab17f9fc10b2dd5d38dc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8696d16242d220373460ab17f9fc10b2dd5d38dc",
"title": "8696d16242d220373460ab17f9fc10b2dd5d38dc",
"url": "https://llvm.googlesource.com/llvm-project/+/8696d16242d220373460ab17f9fc10b2dd5d38dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "78af0f3ab8e6fcd52337b7ba5873deea5d2bfe7d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@78af0f3ab8e6fcd52337b7ba5873deea5d2bfe7d",
"title": "78af0f3ab8e6fcd52337b7ba5873deea5d2bfe7d",
"url": "https://llvm.googlesource.com/llvm-project/+/78af0f3ab8e6fcd52337b7ba5873deea5d2bfe7d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04fde85057cb4da2e560da629df7a52702eac489"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04fde85057cb4da2e560da629df7a52702eac489",
"title": "04fde85057cb4da2e560da629df7a52702eac489",
"url": "https://llvm.googlesource.com/llvm-project/+/04fde85057cb4da2e560da629df7a52702eac489"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6ebb84869e6cf1a643b053e53931c6075b2cc8ae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6ebb84869e6cf1a643b053e53931c6075b2cc8ae",
"title": "6ebb84869e6cf1a643b053e53931c6075b2cc8ae",
"url": "https://llvm.googlesource.com/llvm-project/+/6ebb84869e6cf1a643b053e53931c6075b2cc8ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "087a5d2ec7897cd99d3787820711fec76a8e1792"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@087a5d2ec7897cd99d3787820711fec76a8e1792",
"title": "087a5d2ec7897cd99d3787820711fec76a8e1792",
"url": "https://llvm.googlesource.com/llvm-project/+/087a5d2ec7897cd99d3787820711fec76a8e1792"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "63a4cae56cf896abd12ecf8dbd50f7f5fb9549e1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@63a4cae56cf896abd12ecf8dbd50f7f5fb9549e1",
"title": "63a4cae56cf896abd12ecf8dbd50f7f5fb9549e1",
"url": "https://llvm.googlesource.com/llvm-project/+/63a4cae56cf896abd12ecf8dbd50f7f5fb9549e1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "71d1b4c77c39201b0d533c2eccb2f5cbc1561b22"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@71d1b4c77c39201b0d533c2eccb2f5cbc1561b22",
"title": "71d1b4c77c39201b0d533c2eccb2f5cbc1561b22",
"url": "https://llvm.googlesource.com/llvm-project/+/71d1b4c77c39201b0d533c2eccb2f5cbc1561b22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "be6c1684c058ff40b5cb29e7eb88f06f72dd50df"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@be6c1684c058ff40b5cb29e7eb88f06f72dd50df",
"title": "be6c1684c058ff40b5cb29e7eb88f06f72dd50df",
"url": "https://llvm.googlesource.com/llvm-project/+/be6c1684c058ff40b5cb29e7eb88f06f72dd50df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e30301aaecd24141cbdcd740aa4c16c0d9b05307"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e30301aaecd24141cbdcd740aa4c16c0d9b05307",
"title": "e30301aaecd24141cbdcd740aa4c16c0d9b05307",
"url": "https://llvm.googlesource.com/llvm-project/+/e30301aaecd24141cbdcd740aa4c16c0d9b05307"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "82bad53bda39bd7a7bbdab81e72887dea8479a47"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@82bad53bda39bd7a7bbdab81e72887dea8479a47",
"title": "82bad53bda39bd7a7bbdab81e72887dea8479a47",
"url": "https://llvm.googlesource.com/llvm-project/+/82bad53bda39bd7a7bbdab81e72887dea8479a47"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "589e7abea570a813ef8a2e8b8f130fd40cd07141"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@589e7abea570a813ef8a2e8b8f130fd40cd07141",
"title": "589e7abea570a813ef8a2e8b8f130fd40cd07141",
"url": "https://llvm.googlesource.com/llvm-project/+/589e7abea570a813ef8a2e8b8f130fd40cd07141"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9adcb4fe125e5b2bdf894fb35c7d91e10c10e1ea"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9adcb4fe125e5b2bdf894fb35c7d91e10c10e1ea",
"title": "9adcb4fe125e5b2bdf894fb35c7d91e10c10e1ea",
"url": "https://llvm.googlesource.com/llvm-project/+/9adcb4fe125e5b2bdf894fb35c7d91e10c10e1ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa2263b3097c4e5f361505ce564a246a7f289172"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa2263b3097c4e5f361505ce564a246a7f289172",
"title": "fa2263b3097c4e5f361505ce564a246a7f289172",
"url": "https://llvm.googlesource.com/llvm-project/+/fa2263b3097c4e5f361505ce564a246a7f289172"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f5a24d0c555832ec6e5747cc7bad814ed97cbdc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f5a24d0c555832ec6e5747cc7bad814ed97cbdc",
"title": "2f5a24d0c555832ec6e5747cc7bad814ed97cbdc",
"url": "https://llvm.googlesource.com/llvm-project/+/2f5a24d0c555832ec6e5747cc7bad814ed97cbdc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c72c0b298c13ebc4d374e84b8ea20f8ca4f5ace2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c72c0b298c13ebc4d374e84b8ea20f8ca4f5ace2",
"title": "c72c0b298c13ebc4d374e84b8ea20f8ca4f5ace2",
"url": "https://llvm.googlesource.com/llvm-project/+/c72c0b298c13ebc4d374e84b8ea20f8ca4f5ace2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7fe1b43122230b556481b56210bc72466c1076d5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7fe1b43122230b556481b56210bc72466c1076d5",
"title": "7fe1b43122230b556481b56210bc72466c1076d5",
"url": "https://llvm.googlesource.com/llvm-project/+/7fe1b43122230b556481b56210bc72466c1076d5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e9c9c33fa4e26b7e18947dfefa960f68945d1899"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e9c9c33fa4e26b7e18947dfefa960f68945d1899",
"title": "e9c9c33fa4e26b7e18947dfefa960f68945d1899",
"url": "https://llvm.googlesource.com/llvm-project/+/e9c9c33fa4e26b7e18947dfefa960f68945d1899"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e9c9c33fa4e26b7e18947dfefa960f68945d1899",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8880128993218121136"
},
{
"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"
}
}
[16:21:16.844] Scheduled build:
{
"id": "8714698931107445825",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-16T16:21:16.397885531Z",
"updateTime": "2025-05-16T16:21:16.397885531Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e9c9c33fa4e26b7e18947dfefa960f68945d1899",
"ref": "refs/heads/main"
}
}
}
[16:21:16.844] Task URL: https://cr-buildbucket.appspot.com/build/8714698931107445825
[16:21:16.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:2:0) after 8m14s
[16:21:17.898] Received PubSub notification, asking Buildbucket for the build status
[16:21:20.286] Build status: SCHEDULED
[16:21:21.362] Received PubSub notification, asking Buildbucket for the build status
[16:21:21.402] Build status: STARTED
[16:29:30.909] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:2:0)
[16:29:30.935] Build status: STARTED
[16:29:30.935] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:5:0) after 1m23s
[16:30:53.960] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:5:0)
[16:30:53.988] Build status: STARTED
[16:30:53.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:6:0) after 2m39s
[16:33:33.055] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:6:0)
[16:33:33.289] Build status: STARTED
[16:33:33.289] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:7:0) after 4m8s
[16:37:41.405] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:7:0)
[16:37:41.438] Build status: STARTED
[16:37:41.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:8:0) after 2m14s
[16:39:55.456] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:8:0)
[16:39:55.492] Build status: STARTED
[16:39:55.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:9:0) after 6m50s
[16:46:45.597] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:9:0)
[16:46:45.645] Build status: STARTED
[16:46:45.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:10:0) after 9m34s
[16:56:19.705] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:10:0)
[16:56:19.724] Build status: STARTED
[16:56:19.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:11:0) after 1m44s
[16:58:03.795] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:11:0)
[16:58:03.815] Build status: STARTED
[16:58:03.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:12:0) after 5m48s
[17:03:51.796] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:12:0)
[17:03:51.814] Build status: STARTED
[17:03:51.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:13:0) after 9m30s
[17:13:21.884] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:13:0)
[17:13:21.906] Build status: STARTED
[17:13:21.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:14:0) after 6m58s
[17:20:19.927] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:14:0)
[17:20:19.949] Build status: STARTED
[17:20:19.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:15:0) after 5m21s
[17:25:41.012] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:15:0)
[17:25:41.042] Build status: STARTED
[17:25:41.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:16:0) after 9m18s
[17:34:59.113] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:16:0)
[17:34:59.136] Build status: STARTED
[17:34:59.136] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:17:0) after 7m0s
[17:41:59.296] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:17:0)
[17:41:59.317] Build status: STARTED
[17:41:59.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:18:0) after 2m49s
[17:44:48.335] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:18:0)
[17:44:48.379] Build status: STARTED
[17:44:48.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8880128993218121136:19:0) after 4m46s
[17:45:19.998] Received PubSub notification, asking Buildbucket for the build status
[17:45:20.019] Build:
{
"id": "8714698931107445825",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-16T16:21:16.397885531Z",
"startTime": "2025-05-16T16:21:21.118488986Z",
"endTime": "2025-05-16T17:45:19.669077283Z",
"updateTime": "2025-05-16T17:45:19.669077283Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e9c9c33fa4e26b7e18947dfefa960f68945d1899",
"ref": "refs/heads/main"
}
}
}
[17:45:20.019] Invocation finished in 1h24m5.01757743s with status SUCCEEDED