[12:02:03.410] New invocation is queued and will start shortly
[12:02:04.492] Starting the invocation (attempt 1)
[12:02:04.520] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7b8fd8f31bc6d65a59b6e09ebbeb77fdfb95360f"
[12:02:04.520] Popped gitiles commit info from properties and tags
[12:02:04.520] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:02:04.521] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:02:04.521] Buildbucket request:
{
"requestId": "8868730082489845904",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8868730082489845904",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f9c996856e84f64dd3c306916f238b713a4d777d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f9c996856e84f64dd3c306916f238b713a4d777d",
"title": "f9c996856e84f64dd3c306916f238b713a4d777d",
"url": "https://llvm.googlesource.com/llvm-project/+/f9c996856e84f64dd3c306916f238b713a4d777d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d197c89b53febbd4722f9923e511b7215825860"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d197c89b53febbd4722f9923e511b7215825860",
"title": "4d197c89b53febbd4722f9923e511b7215825860",
"url": "https://llvm.googlesource.com/llvm-project/+/4d197c89b53febbd4722f9923e511b7215825860"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "03e16c8e42a03574062df1c5f2c9c5f2122042d5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@03e16c8e42a03574062df1c5f2c9c5f2122042d5",
"title": "03e16c8e42a03574062df1c5f2c9c5f2122042d5",
"url": "https://llvm.googlesource.com/llvm-project/+/03e16c8e42a03574062df1c5f2c9c5f2122042d5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4e1c996674cc340f290b0a528e2038e76494d8d4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4e1c996674cc340f290b0a528e2038e76494d8d4",
"title": "4e1c996674cc340f290b0a528e2038e76494d8d4",
"url": "https://llvm.googlesource.com/llvm-project/+/4e1c996674cc340f290b0a528e2038e76494d8d4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a05e8d506bb8f986f810d9872715919ddb773bc7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a05e8d506bb8f986f810d9872715919ddb773bc7",
"title": "a05e8d506bb8f986f810d9872715919ddb773bc7",
"url": "https://llvm.googlesource.com/llvm-project/+/a05e8d506bb8f986f810d9872715919ddb773bc7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b6231f5197820026adc452707e920847364f2e6f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b6231f5197820026adc452707e920847364f2e6f",
"title": "b6231f5197820026adc452707e920847364f2e6f",
"url": "https://llvm.googlesource.com/llvm-project/+/b6231f5197820026adc452707e920847364f2e6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6b54c92be02079eff4f4edfbe667e60c3a1949df"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6b54c92be02079eff4f4edfbe667e60c3a1949df",
"title": "6b54c92be02079eff4f4edfbe667e60c3a1949df",
"url": "https://llvm.googlesource.com/llvm-project/+/6b54c92be02079eff4f4edfbe667e60c3a1949df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "61166a9345e58ded6e1b7adb0e3a473ae7496cac"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@61166a9345e58ded6e1b7adb0e3a473ae7496cac",
"title": "61166a9345e58ded6e1b7adb0e3a473ae7496cac",
"url": "https://llvm.googlesource.com/llvm-project/+/61166a9345e58ded6e1b7adb0e3a473ae7496cac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a254f6524aa511eb0ead54f825262e75d467b82e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a254f6524aa511eb0ead54f825262e75d467b82e",
"title": "a254f6524aa511eb0ead54f825262e75d467b82e",
"url": "https://llvm.googlesource.com/llvm-project/+/a254f6524aa511eb0ead54f825262e75d467b82e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fba55c89c32fd45cc279a903b5a749c5951f4593"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fba55c89c32fd45cc279a903b5a749c5951f4593",
"title": "fba55c89c32fd45cc279a903b5a749c5951f4593",
"url": "https://llvm.googlesource.com/llvm-project/+/fba55c89c32fd45cc279a903b5a749c5951f4593"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3c862b4ba39aa53a2dfcffb2fe7862e02f7bd746"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3c862b4ba39aa53a2dfcffb2fe7862e02f7bd746",
"title": "3c862b4ba39aa53a2dfcffb2fe7862e02f7bd746",
"url": "https://llvm.googlesource.com/llvm-project/+/3c862b4ba39aa53a2dfcffb2fe7862e02f7bd746"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7b8fd8f31bc6d65a59b6e09ebbeb77fdfb95360f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7b8fd8f31bc6d65a59b6e09ebbeb77fdfb95360f",
"title": "7b8fd8f31bc6d65a59b6e09ebbeb77fdfb95360f",
"url": "https://llvm.googlesource.com/llvm-project/+/7b8fd8f31bc6d65a59b6e09ebbeb77fdfb95360f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7b8fd8f31bc6d65a59b6e09ebbeb77fdfb95360f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8868730082489845904"
},
{
"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"
}
}
[12:02:05.021] Scheduled build:
{
"id": "8703300020598103441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-19T12:02:04.585390930Z",
"updateTime": "2025-09-19T12:02:04.585390930Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7b8fd8f31bc6d65a59b6e09ebbeb77fdfb95360f",
"ref": "refs/heads/main"
}
}
}
[12:02:05.021] Task URL: https://cr-buildbucket.appspot.com/build/8703300020598103441
[12:02:05.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:2:0) after 4m52s
[12:02:06.000] Received PubSub notification, asking Buildbucket for the build status
[12:02:06.016] Build status: SCHEDULED
[12:02:08.702] Received PubSub notification, asking Buildbucket for the build status
[12:02:08.810] Build status: STARTED
[12:06:57.194] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:2:0)
[12:06:57.211] Build status: STARTED
[12:06:57.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:5:0) after 9m18s
[12:16:15.334] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:5:0)
[12:16:15.365] Build status: STARTED
[12:16:15.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:6:0) after 1m27s
[12:17:42.404] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:6:0)
[12:17:42.435] Build status: STARTED
[12:17:42.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:7:0) after 2m11s
[12:19:53.451] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:7:0)
[12:19:53.478] Build status: STARTED
[12:19:53.478] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:8:0) after 2m7s
[12:22:00.872] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:8:0)
[12:22:00.925] Build status: STARTED
[12:22:00.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:9:0) after 7m24s
[12:29:25.030] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:9:0)
[12:29:25.063] Build status: STARTED
[12:29:25.063] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:10:0) after 8m19s
[12:37:44.083] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:10:0)
[12:37:44.105] Build status: STARTED
[12:37:44.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:11:0) after 6m44s
[12:44:28.169] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:11:0)
[12:44:28.201] Build status: STARTED
[12:44:28.201] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:12:0) after 9m31s
[12:53:59.303] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:12:0)
[12:53:59.326] Build status: STARTED
[12:53:59.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:13:0) after 7m45s
[13:01:44.343] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:13:0)
[13:01:44.362] Build status: STARTED
[13:01:44.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:14:0) after 9m20s
[13:11:04.402] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:14:0)
[13:11:04.427] Build status: STARTED
[13:11:04.428] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:15:0) after 6m56s
[13:18:00.449] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:15:0)
[13:18:00.486] Build status: STARTED
[13:18:00.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:16:0) after 3m58s
[13:21:58.517] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:16:0)
[13:21:58.535] Build status: STARTED
[13:21:58.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:17:0) after 6m13s
[13:28:11.554] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:17:0)
[13:28:11.582] Build status: STARTED
[13:28:11.582] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:18:0) after 4m1s
[13:32:12.598] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:18:0)
[13:32:12.617] Build status: STARTED
[13:32:12.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:19:0) after 2m25s
[13:34:37.672] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:19:0)
[13:34:37.737] Build status: STARTED
[13:34:37.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8868730082489845904:20:0) after 8m56s
[13:34:54.721] Received PubSub notification, asking Buildbucket for the build status
[13:34:54.738] Build:
{
"id": "8703300020598103441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-19T12:02:04.585390930Z",
"startTime": "2025-09-19T12:02:08.248678696Z",
"endTime": "2025-09-19T13:34:54.360749929Z",
"updateTime": "2025-09-19T13:34:54.360749929Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7b8fd8f31bc6d65a59b6e09ebbeb77fdfb95360f",
"ref": "refs/heads/main"
}
}
}
[13:34:54.738] Invocation finished in 1h32m51.340984617s with status SUCCEEDED