[16:41:33.054] New invocation is queued and will start shortly
[16:41:34.201] Starting the invocation (attempt 1)
[16:41:34.233] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7a5c1a4abc750fef335c2ee5191d59ebe9e4bf18"
[16:41:34.233] Popped gitiles commit info from properties and tags
[16:41:34.233] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:41:34.233] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:41:34.233] Buildbucket request:
{
"requestId": "8921621126616289536",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8921621126616289536",
"job": "fuchsia/toolchain.ci-clang-windows-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "25b9ed6e4964344e3710359bec4c831e5a8448b9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@25b9ed6e4964344e3710359bec4c831e5a8448b9",
"title": "25b9ed6e4964344e3710359bec4c831e5a8448b9",
"url": "https://llvm.googlesource.com/llvm-project/+/25b9ed6e4964344e3710359bec4c831e5a8448b9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4ad9f5be8348374ed2bfff32842f395f6e5f41a4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4ad9f5be8348374ed2bfff32842f395f6e5f41a4",
"title": "4ad9f5be8348374ed2bfff32842f395f6e5f41a4",
"url": "https://llvm.googlesource.com/llvm-project/+/4ad9f5be8348374ed2bfff32842f395f6e5f41a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "192c23b0c7e5d3daefc2ad7d86c095509749eacd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@192c23b0c7e5d3daefc2ad7d86c095509749eacd",
"title": "192c23b0c7e5d3daefc2ad7d86c095509749eacd",
"url": "https://llvm.googlesource.com/llvm-project/+/192c23b0c7e5d3daefc2ad7d86c095509749eacd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "485ebbff55f41bd12ad768c2974d3280cb581307"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@485ebbff55f41bd12ad768c2974d3280cb581307",
"title": "485ebbff55f41bd12ad768c2974d3280cb581307",
"url": "https://llvm.googlesource.com/llvm-project/+/485ebbff55f41bd12ad768c2974d3280cb581307"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4f13f353cc8dc472a3f00932bc42179776f0f684"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4f13f353cc8dc472a3f00932bc42179776f0f684",
"title": "4f13f353cc8dc472a3f00932bc42179776f0f684",
"url": "https://llvm.googlesource.com/llvm-project/+/4f13f353cc8dc472a3f00932bc42179776f0f684"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "987258f5c7801ebb4f7ce7c6a035634b275a5759"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@987258f5c7801ebb4f7ce7c6a035634b275a5759",
"title": "987258f5c7801ebb4f7ce7c6a035634b275a5759",
"url": "https://llvm.googlesource.com/llvm-project/+/987258f5c7801ebb4f7ce7c6a035634b275a5759"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "381a00de4fdcccd904dac6a0856fb44f12ba0abb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@381a00de4fdcccd904dac6a0856fb44f12ba0abb",
"title": "381a00de4fdcccd904dac6a0856fb44f12ba0abb",
"url": "https://llvm.googlesource.com/llvm-project/+/381a00de4fdcccd904dac6a0856fb44f12ba0abb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "11fcae69dbea4860e20ab799ecca9b0432d7f19d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@11fcae69dbea4860e20ab799ecca9b0432d7f19d",
"title": "11fcae69dbea4860e20ab799ecca9b0432d7f19d",
"url": "https://llvm.googlesource.com/llvm-project/+/11fcae69dbea4860e20ab799ecca9b0432d7f19d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1f90af183d7a007584fac041eaca9f126a1a942f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1f90af183d7a007584fac041eaca9f126a1a942f",
"title": "1f90af183d7a007584fac041eaca9f126a1a942f",
"url": "https://llvm.googlesource.com/llvm-project/+/1f90af183d7a007584fac041eaca9f126a1a942f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8ba4ff392538dac7b803cfdf5bde217ff538a644"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8ba4ff392538dac7b803cfdf5bde217ff538a644",
"title": "8ba4ff392538dac7b803cfdf5bde217ff538a644",
"url": "https://llvm.googlesource.com/llvm-project/+/8ba4ff392538dac7b803cfdf5bde217ff538a644"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1d8479225a8c1efc8c90511e6c7fe608ff38163c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1d8479225a8c1efc8c90511e6c7fe608ff38163c",
"title": "1d8479225a8c1efc8c90511e6c7fe608ff38163c",
"url": "https://llvm.googlesource.com/llvm-project/+/1d8479225a8c1efc8c90511e6c7fe608ff38163c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d58c128bc42b8a9cc45516ba9fe9e6a3c322d7b3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d58c128bc42b8a9cc45516ba9fe9e6a3c322d7b3",
"title": "d58c128bc42b8a9cc45516ba9fe9e6a3c322d7b3",
"url": "https://llvm.googlesource.com/llvm-project/+/d58c128bc42b8a9cc45516ba9fe9e6a3c322d7b3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7a5c1a4abc750fef335c2ee5191d59ebe9e4bf18"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7a5c1a4abc750fef335c2ee5191d59ebe9e4bf18",
"title": "7a5c1a4abc750fef335c2ee5191d59ebe9e4bf18",
"url": "https://llvm.googlesource.com/llvm-project/+/7a5c1a4abc750fef335c2ee5191d59ebe9e4bf18"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7a5c1a4abc750fef335c2ee5191d59ebe9e4bf18",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8921621126616289536"
},
{
"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:41:35.318] Scheduled build:
{
"id": "8756191064478606225",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-13T16:41:34.468509559Z",
"updateTime": "2024-02-13T16:41:34.468509559Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7a5c1a4abc750fef335c2ee5191d59ebe9e4bf18",
"ref": "refs/heads/main"
}
}
}
[16:41:35.318] Task URL: https://cr-buildbucket.appspot.com/build/8756191064478606225
[16:41:35.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:2:0) after 7m59s
[16:41:36.160] Received PubSub notification, asking Buildbucket for the build status
[16:41:36.193] Build status: SCHEDULED
[16:41:36.633] Received PubSub notification, asking Buildbucket for the build status
[16:41:36.819] Build status: STARTED
[16:49:34.365] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:2:0)
[16:49:34.392] Build status: STARTED
[16:49:34.392] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:5:0) after 3m39s
[16:53:13.393] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:5:0)
[16:53:13.427] Build status: STARTED
[16:53:13.427] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:6:0) after 6m2s
[16:59:15.622] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:6:0)
[16:59:15.646] Build status: STARTED
[16:59:15.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:7:0) after 3m4s
[17:02:19.715] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:7:0)
[17:02:19.780] Build status: STARTED
[17:02:19.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:8:0) after 5m15s
[17:07:34.959] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:8:0)
[17:07:35.095] Build status: STARTED
[17:07:35.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:9:0) after 6m2s
[17:13:37.241] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:9:0)
[17:13:37.285] Build status: STARTED
[17:13:37.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:10:0) after 4m21s
[17:17:58.537] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:10:0)
[17:17:58.633] Build status: STARTED
[17:17:58.633] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:11:0) after 1m56s
[17:19:54.681] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:11:0)
[17:19:54.700] Build status: STARTED
[17:19:54.700] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:12:0) after 2m18s
[17:22:12.793] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:12:0)
[17:22:12.816] Build status: STARTED
[17:22:12.821] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:13:0) after 2m15s
[17:24:27.918] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:13:0)
[17:24:27.957] Build status: STARTED
[17:24:27.957] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:14:0) after 2m24s
[17:26:52.100] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:14:0)
[17:26:52.164] Build status: STARTED
[17:26:52.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:15:0) after 8m5s
[17:34:57.267] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:15:0)
[17:34:57.287] Build status: STARTED
[17:34:57.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:16:0) after 7m59s
[17:42:56.328] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:16:0)
[17:42:56.369] Build status: STARTED
[17:42:56.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:17:0) after 9m18s
[17:52:14.400] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:17:0)
[17:52:14.427] Build status: STARTED
[17:52:14.427] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:18:0) after 1m8s
[17:53:22.594] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:18:0)
[17:53:22.633] Build status: STARTED
[17:53:22.633] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-windows-x64-40be1bb5:8921621126616289536:19:0) after 4m57s
[17:53:29.437] Received PubSub notification, asking Buildbucket for the build status
[17:53:29.462] Build:
{
"id": "8756191064478606225",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-windows-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-13T16:41:34.468509559Z",
"startTime": "2024-02-13T16:41:36.092782Z",
"endTime": "2024-02-13T17:53:28.287767Z",
"updateTime": "2024-02-13T17:53:28.287767Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "7a5c1a4abc750fef335c2ee5191d59ebe9e4bf18",
"ref": "refs/heads/main"
}
}
}
[17:53:29.462] Invocation finished in 1h11m56.41569863s with status SUCCEEDED