[13:03:44.822] New invocation is queued and will start shortly
[13:03:46.287] Starting the invocation (attempt 1)
[13:03:46.318] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9ea2da5758ee96ae7b8b3f914939ea1224af2cde"
[13:03:46.318] Popped gitiles commit info from properties and tags
[13:03:46.318] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:03:46.318] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:03:46.318] Buildbucket request:
{
"requestId": "8886573803659065152",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8886573803659065152",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "156cdcf2ffc9a5f851e1b340891172462938b5ea"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@156cdcf2ffc9a5f851e1b340891172462938b5ea",
"title": "156cdcf2ffc9a5f851e1b340891172462938b5ea",
"url": "https://llvm.googlesource.com/llvm-project/+/156cdcf2ffc9a5f851e1b340891172462938b5ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9501275a351063a55b6a0e017d3630a26c0d9da9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9501275a351063a55b6a0e017d3630a26c0d9da9",
"title": "9501275a351063a55b6a0e017d3630a26c0d9da9",
"url": "https://llvm.googlesource.com/llvm-project/+/9501275a351063a55b6a0e017d3630a26c0d9da9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5ee1c0b7148571ed9d60e447b66fb0f35de14576"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5ee1c0b7148571ed9d60e447b66fb0f35de14576",
"title": "5ee1c0b7148571ed9d60e447b66fb0f35de14576",
"url": "https://llvm.googlesource.com/llvm-project/+/5ee1c0b7148571ed9d60e447b66fb0f35de14576"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e2911aa2c254c071c2ab898a69c69ba8c94586f8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e2911aa2c254c071c2ab898a69c69ba8c94586f8",
"title": "e2911aa2c254c071c2ab898a69c69ba8c94586f8",
"url": "https://llvm.googlesource.com/llvm-project/+/e2911aa2c254c071c2ab898a69c69ba8c94586f8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "29ff168363fa9a41f04b19a9afe5930330f35b4c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@29ff168363fa9a41f04b19a9afe5930330f35b4c",
"title": "29ff168363fa9a41f04b19a9afe5930330f35b4c",
"url": "https://llvm.googlesource.com/llvm-project/+/29ff168363fa9a41f04b19a9afe5930330f35b4c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8c61ef17c3aefd13eaf75f401aa8f3c7dd5d4a12"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8c61ef17c3aefd13eaf75f401aa8f3c7dd5d4a12",
"title": "8c61ef17c3aefd13eaf75f401aa8f3c7dd5d4a12",
"url": "https://llvm.googlesource.com/llvm-project/+/8c61ef17c3aefd13eaf75f401aa8f3c7dd5d4a12"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5d1029b4a87f36a394c169b89b26a74d17f7ff01"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5d1029b4a87f36a394c169b89b26a74d17f7ff01",
"title": "5d1029b4a87f36a394c169b89b26a74d17f7ff01",
"url": "https://llvm.googlesource.com/llvm-project/+/5d1029b4a87f36a394c169b89b26a74d17f7ff01"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "512ef4c7e36d1a61ad6e6c0a5a340de127b67961"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@512ef4c7e36d1a61ad6e6c0a5a340de127b67961",
"title": "512ef4c7e36d1a61ad6e6c0a5a340de127b67961",
"url": "https://llvm.googlesource.com/llvm-project/+/512ef4c7e36d1a61ad6e6c0a5a340de127b67961"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "59e0704a52cfa7f829c7eb25db0f7b1e13e44418"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@59e0704a52cfa7f829c7eb25db0f7b1e13e44418",
"title": "59e0704a52cfa7f829c7eb25db0f7b1e13e44418",
"url": "https://llvm.googlesource.com/llvm-project/+/59e0704a52cfa7f829c7eb25db0f7b1e13e44418"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7358973df1b53785cace2e3431d141078dc53e7c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7358973df1b53785cace2e3431d141078dc53e7c",
"title": "7358973df1b53785cace2e3431d141078dc53e7c",
"url": "https://llvm.googlesource.com/llvm-project/+/7358973df1b53785cace2e3431d141078dc53e7c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9ea2da5758ee96ae7b8b3f914939ea1224af2cde"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9ea2da5758ee96ae7b8b3f914939ea1224af2cde",
"title": "9ea2da5758ee96ae7b8b3f914939ea1224af2cde",
"url": "https://llvm.googlesource.com/llvm-project/+/9ea2da5758ee96ae7b8b3f914939ea1224af2cde"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9ea2da5758ee96ae7b8b3f914939ea1224af2cde",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8886573803659065152"
},
{
"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"
}
}
[13:03:46.968] Scheduled build:
{
"id": "8721143741369528609",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-06T13:03:46.376614871Z",
"updateTime": "2025-03-06T13:03:46.376614871Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9ea2da5758ee96ae7b8b3f914939ea1224af2cde",
"ref": "refs/heads/main"
}
}
}
[13:03:46.968] Task URL: https://cr-buildbucket.appspot.com/build/8721143741369528609
[13:03:46.968] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:2:0) after 9m21s
[13:03:47.947] Received PubSub notification, asking Buildbucket for the build status
[13:03:47.972] Build status: SCHEDULED
[13:03:51.113] Received PubSub notification, asking Buildbucket for the build status
[13:03:51.153] Build status: STARTED
[13:13:08.009] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:2:0)
[13:13:08.050] Build status: STARTED
[13:13:08.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:5:0) after 2m10s
[13:15:18.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:5:0)
[13:15:18.340] Build status: STARTED
[13:15:18.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:6:0) after 7m55s
[13:23:13.364] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:6:0)
[13:23:13.394] Build status: STARTED
[13:23:13.394] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:7:0) after 4m8s
[13:27:21.444] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:7:0)
[13:27:21.469] Build status: STARTED
[13:27:21.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:8:0) after 8m49s
[13:36:10.547] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:8:0)
[13:36:10.605] Build status: STARTED
[13:36:10.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:9:0) after 4m58s
[13:41:08.683] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:9:0)
[13:41:08.703] Build status: STARTED
[13:41:08.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:10:0) after 3m17s
[13:44:25.721] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:10:0)
[13:44:25.783] Build status: STARTED
[13:44:25.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:11:0) after 3m22s
[13:47:47.776] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:11:0)
[13:47:47.804] Build status: STARTED
[13:47:47.804] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:12:0) after 6m21s
[13:54:08.921] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:12:0)
[13:54:08.942] Build status: STARTED
[13:54:08.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:13:0) after 6m22s
[14:00:30.949] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:13:0)
[14:00:31.008] Build status: STARTED
[14:00:31.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:14:0) after 5m24s
[14:05:55.070] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:14:0)
[14:05:55.121] Build status: STARTED
[14:05:55.121] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:15:0) after 9m12s
[14:15:07.200] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:15:0)
[14:15:07.216] Build status: STARTED
[14:15:07.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:16:0) after 3m3s
[14:18:10.275] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:16:0)
[14:18:10.292] Build status: STARTED
[14:18:10.292] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:17:0) after 4m8s
[14:22:18.478] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:17:0)
[14:22:18.536] Build status: STARTED
[14:22:18.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:18:0) after 5m15s
[14:27:33.949] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:18:0)
[14:27:33.969] Build status: STARTED
[14:27:33.969] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8886573803659065152:19:0) after 3m12s
[14:29:02.554] Received PubSub notification, asking Buildbucket for the build status
[14:29:02.577] Build:
{
"id": "8721143741369528609",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-03-06T13:03:46.376614871Z",
"startTime": "2025-03-06T13:03:50.924842035Z",
"endTime": "2025-03-06T14:29:02.191662460Z",
"updateTime": "2025-03-06T14:29:02.191662460Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9ea2da5758ee96ae7b8b3f914939ea1224af2cde",
"ref": "refs/heads/main"
}
}
}
[14:29:02.577] Invocation finished in 1h25m17.768095408s with status SUCCEEDED