[16:38:14.446] New invocation is queued and will start shortly
[16:38:17.568] Starting the invocation (attempt 1)
[16:38:17.595] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c95af0844d64f15b99fab37c25efb01a8d783847"
[16:38:17.595] Popped gitiles commit info from properties and tags
[16:38:17.595] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:38:17.596] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:38:17.596] Buildbucket request:
{
"requestId": "8894170454049094784",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8894170454049094784",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6f8a363a483489687597e29b8bda0975e821f188"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6f8a363a483489687597e29b8bda0975e821f188",
"title": "6f8a363a483489687597e29b8bda0975e821f188",
"url": "https://llvm.googlesource.com/llvm-project/+/6f8a363a483489687597e29b8bda0975e821f188"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "010d0115fc8e3834fc6f747f0841f3b1e467c4da"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@010d0115fc8e3834fc6f747f0841f3b1e467c4da",
"title": "010d0115fc8e3834fc6f747f0841f3b1e467c4da",
"url": "https://llvm.googlesource.com/llvm-project/+/010d0115fc8e3834fc6f747f0841f3b1e467c4da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f229ea2ffe9bb8380a4285bd379736aaadaf55ac"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f229ea2ffe9bb8380a4285bd379736aaadaf55ac",
"title": "f229ea2ffe9bb8380a4285bd379736aaadaf55ac",
"url": "https://llvm.googlesource.com/llvm-project/+/f229ea2ffe9bb8380a4285bd379736aaadaf55ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a8e66d7f17bc648865cebf6b1e58c7a9071c6a84"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a8e66d7f17bc648865cebf6b1e58c7a9071c6a84",
"title": "a8e66d7f17bc648865cebf6b1e58c7a9071c6a84",
"url": "https://llvm.googlesource.com/llvm-project/+/a8e66d7f17bc648865cebf6b1e58c7a9071c6a84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f8238f849c4836b333082f387d91408234ea73b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f8238f849c4836b333082f387d91408234ea73b",
"title": "2f8238f849c4836b333082f387d91408234ea73b",
"url": "https://llvm.googlesource.com/llvm-project/+/2f8238f849c4836b333082f387d91408234ea73b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fda80a4fcad8bab67fc1f522d68012e572866066"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fda80a4fcad8bab67fc1f522d68012e572866066",
"title": "fda80a4fcad8bab67fc1f522d68012e572866066",
"url": "https://llvm.googlesource.com/llvm-project/+/fda80a4fcad8bab67fc1f522d68012e572866066"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6c8f41d3367476d35ac730abf9f980291737193b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6c8f41d3367476d35ac730abf9f980291737193b",
"title": "6c8f41d3367476d35ac730abf9f980291737193b",
"url": "https://llvm.googlesource.com/llvm-project/+/6c8f41d3367476d35ac730abf9f980291737193b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e5371eded9c22ec4854634c9c58df793562f782d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e5371eded9c22ec4854634c9c58df793562f782d",
"title": "e5371eded9c22ec4854634c9c58df793562f782d",
"url": "https://llvm.googlesource.com/llvm-project/+/e5371eded9c22ec4854634c9c58df793562f782d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4aacafd49b74dc168e0d99018b4c8289ce9c923e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4aacafd49b74dc168e0d99018b4c8289ce9c923e",
"title": "4aacafd49b74dc168e0d99018b4c8289ce9c923e",
"url": "https://llvm.googlesource.com/llvm-project/+/4aacafd49b74dc168e0d99018b4c8289ce9c923e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9c319d5bb40785c969d2af76535ca62448dfafa7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9c319d5bb40785c969d2af76535ca62448dfafa7",
"title": "9c319d5bb40785c969d2af76535ca62448dfafa7",
"url": "https://llvm.googlesource.com/llvm-project/+/9c319d5bb40785c969d2af76535ca62448dfafa7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "60d9e6fba884048e1047a208b61f0dfd8baabaaa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@60d9e6fba884048e1047a208b61f0dfd8baabaaa",
"title": "60d9e6fba884048e1047a208b61f0dfd8baabaaa",
"url": "https://llvm.googlesource.com/llvm-project/+/60d9e6fba884048e1047a208b61f0dfd8baabaaa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bdd365825d0766b6991c8f5443f8a9f76e75011a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bdd365825d0766b6991c8f5443f8a9f76e75011a",
"title": "bdd365825d0766b6991c8f5443f8a9f76e75011a",
"url": "https://llvm.googlesource.com/llvm-project/+/bdd365825d0766b6991c8f5443f8a9f76e75011a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c95af0844d64f15b99fab37c25efb01a8d783847"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c95af0844d64f15b99fab37c25efb01a8d783847",
"title": "c95af0844d64f15b99fab37c25efb01a8d783847",
"url": "https://llvm.googlesource.com/llvm-project/+/c95af0844d64f15b99fab37c25efb01a8d783847"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c95af0844d64f15b99fab37c25efb01a8d783847",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8894170454049094784"
},
{
"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:38:17.986] Scheduled build:
{
"id": "8728740390022477441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-12T16:38:17.665800096Z",
"updateTime": "2024-12-12T16:38:17.665800096Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c95af0844d64f15b99fab37c25efb01a8d783847",
"ref": "refs/heads/main"
}
}
}
[16:38:17.986] Task URL: https://cr-buildbucket.appspot.com/build/8728740390022477441
[16:38:17.986] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:2:0) after 5m29s
[16:38:18.963] Received PubSub notification, asking Buildbucket for the build status
[16:38:18.979] Build status: SCHEDULED
[16:38:22.466] Received PubSub notification, asking Buildbucket for the build status
[16:38:22.484] Build status: STARTED
[16:43:47.009] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:2:0)
[16:43:47.042] Build status: STARTED
[16:43:47.042] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:5:0) after 8m14s
[16:52:01.122] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:5:0)
[16:52:01.141] Build status: STARTED
[16:52:01.141] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:6:0) after 4m1s
[16:56:02.171] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:6:0)
[16:56:02.188] Build status: STARTED
[16:56:02.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:7:0) after 5m10s
[17:01:12.275] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:7:0)
[17:01:12.293] Build status: STARTED
[17:01:12.293] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:8:0) after 9m0s
[17:10:12.410] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:8:0)
[17:10:12.439] Build status: STARTED
[17:10:12.439] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:9:0) after 8m10s
[17:18:22.538] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:9:0)
[17:18:22.625] Build status: STARTED
[17:18:22.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:10:0) after 6m0s
[17:24:22.623] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:10:0)
[17:24:22.651] Build status: STARTED
[17:24:22.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:11:0) after 8m13s
[17:32:35.667] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:11:0)
[17:32:35.687] Build status: STARTED
[17:32:35.687] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:12:0) after 9m1s
[17:41:36.863] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:12:0)
[17:41:36.883] Build status: STARTED
[17:41:36.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:13:0) after 7m53s
[17:49:29.899] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:13:0)
[17:49:29.919] Build status: STARTED
[17:49:29.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:14:0) after 8m0s
[17:57:30.078] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:14:0)
[17:57:30.101] Build status: STARTED
[17:57:30.101] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:15:0) after 4m33s
[18:02:03.119] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:15:0)
[18:02:03.138] Build status: STARTED
[18:02:03.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8894170454049094784:16:0) after 2m0s
[18:03:55.600] Received PubSub notification, asking Buildbucket for the build status
[18:03:55.613] Build:
{
"id": "8728740390022477441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-12T16:38:17.665800096Z",
"startTime": "2024-12-12T16:38:22.270614963Z",
"endTime": "2024-12-12T18:03:55.102398585Z",
"updateTime": "2024-12-12T18:03:55.102398585Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c95af0844d64f15b99fab37c25efb01a8d783847",
"ref": "refs/heads/main"
}
}
}
[18:03:55.613] Invocation finished in 1h25m41.171587759s with status SUCCEEDED