[08:52:20.075] New invocation is queued and will start shortly
[08:52:21.174] Starting the invocation (attempt 1)
[08:52:21.209] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d488b2225d484027eb2c21a06d27decf008e878b"
[08:52:21.209] Popped gitiles commit info from properties and tags
[08:52:21.209] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:52:21.209] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:52:21.209] Buildbucket request:
{
"requestId": "8916305426134635008",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8916305426134635008",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1b8830c56abd01c9ab70bbbb71a00c2506cf2116"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1b8830c56abd01c9ab70bbbb71a00c2506cf2116",
"title": "1b8830c56abd01c9ab70bbbb71a00c2506cf2116",
"url": "https://llvm.googlesource.com/llvm-project/+/1b8830c56abd01c9ab70bbbb71a00c2506cf2116"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff9bc3a0fa4e3790c437e62450903bf399df37f9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff9bc3a0fa4e3790c437e62450903bf399df37f9",
"title": "ff9bc3a0fa4e3790c437e62450903bf399df37f9",
"url": "https://llvm.googlesource.com/llvm-project/+/ff9bc3a0fa4e3790c437e62450903bf399df37f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1e7763557bbace002b6bb811167942ebebf50f99"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1e7763557bbace002b6bb811167942ebebf50f99",
"title": "1e7763557bbace002b6bb811167942ebebf50f99",
"url": "https://llvm.googlesource.com/llvm-project/+/1e7763557bbace002b6bb811167942ebebf50f99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a5ed14bc8e122fa5ac0aa81f8d8390931bd6b4e4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a5ed14bc8e122fa5ac0aa81f8d8390931bd6b4e4",
"title": "a5ed14bc8e122fa5ac0aa81f8d8390931bd6b4e4",
"url": "https://llvm.googlesource.com/llvm-project/+/a5ed14bc8e122fa5ac0aa81f8d8390931bd6b4e4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ad4e1aba3fd12f81de71ce3985ae66ff80773d90"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ad4e1aba3fd12f81de71ce3985ae66ff80773d90",
"title": "ad4e1aba3fd12f81de71ce3985ae66ff80773d90",
"url": "https://llvm.googlesource.com/llvm-project/+/ad4e1aba3fd12f81de71ce3985ae66ff80773d90"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d488b2225d484027eb2c21a06d27decf008e878b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d488b2225d484027eb2c21a06d27decf008e878b",
"title": "d488b2225d484027eb2c21a06d27decf008e878b",
"url": "https://llvm.googlesource.com/llvm-project/+/d488b2225d484027eb2c21a06d27decf008e878b"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d488b2225d484027eb2c21a06d27decf008e878b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916305426134635008"
},
{
"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"
}
}
[08:52:21.737] Scheduled build:
{
"id": "8750875364214515905",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-12T08:52:21.284881966Z",
"updateTime": "2024-04-12T08:52:21.284881966Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d488b2225d484027eb2c21a06d27decf008e878b",
"ref": "refs/heads/main"
}
},
"canary": true
}
[08:52:21.737] Task URL: https://cr-buildbucket.appspot.com/build/8750875364214515905
[08:52:21.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:2:0) after 1m49s
[08:52:54.048] Received PubSub notification, asking Buildbucket for the build status
[08:52:54.073] Build status: STARTED
[08:52:57.545] Received PubSub notification, asking Buildbucket for the build status
[08:52:57.578] Build status: STARTED
[08:54:10.967] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:2:0)
[08:54:11.060] Build status: STARTED
[08:54:11.060] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:5:0) after 5m22s
[08:59:33.251] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:5:0)
[08:59:33.282] Build status: STARTED
[08:59:33.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:6:0) after 6m37s
[09:06:10.614] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:6:0)
[09:06:10.635] Build status: STARTED
[09:06:10.635] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:7:0) after 6m20s
[09:12:30.667] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:7:0)
[09:12:30.706] Build status: STARTED
[09:12:30.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:8:0) after 1m33s
[09:14:03.768] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:8:0)
[09:14:03.791] Build status: STARTED
[09:14:03.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:9:0) after 9m36s
[09:23:39.816] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:9:0)
[09:23:39.833] Build status: STARTED
[09:23:39.833] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:10:0) after 5m11s
[09:28:50.961] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:10:0)
[09:28:50.985] Build status: STARTED
[09:28:50.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:11:0) after 7m45s
[09:36:36.172] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:11:0)
[09:36:36.195] Build status: STARTED
[09:36:36.195] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:12:0) after 4m4s
[09:40:40.210] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:12:0)
[09:40:40.232] Build status: STARTED
[09:40:40.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:13:0) after 7m31s
[09:48:11.254] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:13:0)
[09:48:11.271] Build status: STARTED
[09:48:11.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:14:0) after 7m21s
[09:55:32.752] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:14:0)
[09:55:32.776] Build status: STARTED
[09:55:32.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:15:0) after 9m56s
[10:05:28.930] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:15:0)
[10:05:29.072] Build status: STARTED
[10:05:29.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8916305426134635008:16:0) after 9m53s
[10:11:45.952] Received PubSub notification, asking Buildbucket for the build status
[10:11:46.040] Build:
{
"id": "8750875364214515905",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-12T08:52:21.284881966Z",
"startTime": "2024-04-12T08:52:26.232547490Z",
"endTime": "2024-04-12T10:11:45.660244836Z",
"updateTime": "2024-04-12T10:11:45.660244836Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d488b2225d484027eb2c21a06d27decf008e878b",
"ref": "refs/heads/main"
}
},
"canary": true
}
[10:11:46.040] Invocation finished in 1h19m25.970800419s with status SUCCEEDED