[19:50:20.493] New invocation is queued and will start shortly
[19:50:21.716] Starting the invocation (attempt 1)
[19:50:21.778] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/77369a7f1a81f7991a3df2dad1bc8e277bc7559d"
[19:50:21.778] Popped gitiles commit info from properties and tags
[19:50:21.779] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:50:21.779] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:50:21.779] Buildbucket request:
{
"requestId": "8912458955335561088",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8912458955335561088",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8c718a3a91df4ab68dc3f1ca3887ea730c9aed84"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8c718a3a91df4ab68dc3f1ca3887ea730c9aed84",
"title": "8c718a3a91df4ab68dc3f1ca3887ea730c9aed84",
"url": "https://llvm.googlesource.com/llvm-project/+/8c718a3a91df4ab68dc3f1ca3887ea730c9aed84"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6bf450c7a60fa62c642e39836566da94bb9bbc91"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6bf450c7a60fa62c642e39836566da94bb9bbc91",
"title": "6bf450c7a60fa62c642e39836566da94bb9bbc91",
"url": "https://llvm.googlesource.com/llvm-project/+/6bf450c7a60fa62c642e39836566da94bb9bbc91"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "098c6dfa8157681699a71fce9e3d94515e66311f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@098c6dfa8157681699a71fce9e3d94515e66311f",
"title": "098c6dfa8157681699a71fce9e3d94515e66311f",
"url": "https://llvm.googlesource.com/llvm-project/+/098c6dfa8157681699a71fce9e3d94515e66311f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "66b5f16b2fc2ec9e34189c4042f0bea57291d2a4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@66b5f16b2fc2ec9e34189c4042f0bea57291d2a4",
"title": "66b5f16b2fc2ec9e34189c4042f0bea57291d2a4",
"url": "https://llvm.googlesource.com/llvm-project/+/66b5f16b2fc2ec9e34189c4042f0bea57291d2a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b9d40a7ae4b3e5b9829eca8a497637c9fab6dd3e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b9d40a7ae4b3e5b9829eca8a497637c9fab6dd3e",
"title": "b9d40a7ae4b3e5b9829eca8a497637c9fab6dd3e",
"url": "https://llvm.googlesource.com/llvm-project/+/b9d40a7ae4b3e5b9829eca8a497637c9fab6dd3e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1126657af5b6b0a6a64c4f4c04cf9d255d5129e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1126657af5b6b0a6a64c4f4c04cf9d255d5129e0",
"title": "1126657af5b6b0a6a64c4f4c04cf9d255d5129e0",
"url": "https://llvm.googlesource.com/llvm-project/+/1126657af5b6b0a6a64c4f4c04cf9d255d5129e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "77369a7f1a81f7991a3df2dad1bc8e277bc7559d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@77369a7f1a81f7991a3df2dad1bc8e277bc7559d",
"title": "77369a7f1a81f7991a3df2dad1bc8e277bc7559d",
"url": "https://llvm.googlesource.com/llvm-project/+/77369a7f1a81f7991a3df2dad1bc8e277bc7559d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "77369a7f1a81f7991a3df2dad1bc8e277bc7559d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8912458955335561088"
},
{
"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"
}
}
[19:50:22.239] Scheduled build:
{
"id": "8747028893249915409",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-24T19:50:21.852512149Z",
"updateTime": "2024-05-24T19:50:21.852512149Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "77369a7f1a81f7991a3df2dad1bc8e277bc7559d",
"ref": "refs/heads/main"
}
}
}
[19:50:22.239] Task URL: https://cr-buildbucket.appspot.com/build/8747028893249915409
[19:50:22.239] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:2:0) after 2m16s
[19:50:23.155] Received PubSub notification, asking Buildbucket for the build status
[19:50:23.221] Build status: SCHEDULED
[19:50:27.264] Received PubSub notification, asking Buildbucket for the build status
[19:50:27.285] Build status: STARTED
[19:52:38.310] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:2:0)
[19:52:38.327] Build status: STARTED
[19:52:38.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:5:0) after 7m43s
[20:00:21.399] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:5:0)
[20:00:21.433] Build status: STARTED
[20:00:21.433] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:6:0) after 6m30s
[20:06:51.460] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:6:0)
[20:06:51.480] Build status: STARTED
[20:06:51.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:7:0) after 2m57s
[20:09:48.490] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:7:0)
[20:09:48.512] Build status: STARTED
[20:09:48.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:8:0) after 5m36s
[20:15:24.537] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:8:0)
[20:15:24.562] Build status: STARTED
[20:15:24.562] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:9:0) after 3m54s
[20:19:18.585] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:9:0)
[20:19:18.605] Build status: STARTED
[20:19:18.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:10:0) after 3m19s
[20:22:37.624] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:10:0)
[20:22:37.645] Build status: STARTED
[20:22:37.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:11:0) after 4m34s
[20:27:11.761] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:11:0)
[20:27:11.785] Build status: STARTED
[20:27:11.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:12:0) after 4m56s
[20:32:07.824] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:12:0)
[20:32:07.851] Build status: STARTED
[20:32:07.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:13:0) after 6m35s
[20:38:42.874] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:13:0)
[20:38:42.911] Build status: STARTED
[20:38:42.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:14:0) after 8m46s
[20:47:28.984] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:14:0)
[20:47:29.014] Build status: STARTED
[20:47:29.014] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:15:0) after 5m41s
[20:53:10.035] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:15:0)
[20:53:10.056] Build status: STARTED
[20:53:10.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:16:0) after 2m40s
[20:55:50.074] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:16:0)
[20:55:50.092] Build status: STARTED
[20:55:50.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:17:0) after 1m4s
[20:56:54.198] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:17:0)
[20:56:54.216] Build status: STARTED
[20:56:54.216] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8912458955335561088:18:0) after 5m40s
[21:01:42.422] Received PubSub notification, asking Buildbucket for the build status
[21:01:42.564] Build:
{
"id": "8747028893249915409",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-24T19:50:21.852512149Z",
"startTime": "2024-05-24T19:50:27.029302517Z",
"endTime": "2024-05-24T21:01:32.483152144Z",
"updateTime": "2024-05-24T21:01:32.483152144Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "77369a7f1a81f7991a3df2dad1bc8e277bc7559d",
"ref": "refs/heads/main"
}
}
}
[21:01:42.564] Invocation finished in 1h11m22.084778356s with status SUCCEEDED