[19:22:14.152] New invocation is queued and will start shortly
[19:22:14.152] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[19:22:15.257] Starting the invocation (attempt 1)
[19:22:15.288] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f89b1b8a68065c4b880417abb0563bce21399b52"
[19:22:15.288] Reconstructed gitiles commit from tags
[19:22:15.288] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:22:15.288] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:22:15.289] Buildbucket request:
{
"requestId": "8913366693248857472",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug-tot-build_only"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "ad26538bc05a931810ae82096ac7f68c33cfc870d4b3550be55e07100a1e9028/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "565e7b4a4d55d1881d0488ff4f420e4d5c4dff2f",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913366693248857472",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "a9a22c363ab538e7027a83038cb35499c63e631a4704425efd3022d81135f9f9/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "5b016e42df99ed355144c3c5a52d757fedcd6c92",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2ff43ce87e66d9324370e35ea6743ef57400c76e"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2ff43ce87e66d9324370e35ea6743ef57400c76e",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7eb2eaf0-344d-4be9-b948-4dc2ac78441e",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d658482b559a454df9b982da34f3cc75f7792162142edc65b44a16b092181cb7/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "2d95c71eb318030a816c80d7aeb69f60b797db50",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "86f655cb4e2f4134d48219a2959a10c90e3396cb"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/86f655cb4e2f4134d48219a2959a10c90e3396cb",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "09a7a86f-b621-409c-a6dc-c590a981c523",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "ad26538bc05a931810ae82096ac7f68c33cfc870d4b3550be55e07100a1e9028/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "565e7b4a4d55d1881d0488ff4f420e4d5c4dff2f",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f89b1b8a68065c4b880417abb0563bce21399b52"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f89b1b8a68065c4b880417abb0563bce21399b52",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "223618e8-fa7e-402f-8bf4-1c7c5c9aaa38",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f89b1b8a68065c4b880417abb0563bce21399b52"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f89b1b8a68065c4b880417abb0563bce21399b52",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913366693248857472"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:22:15.859] Scheduled build:
{
"id": "8747936631320906977",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug-tot-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-14T19:22:15.367185067Z",
"updateTime": "2024-05-14T19:22:15.367185067Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f89b1b8a68065c4b880417abb0563bce21399b52",
"ref": "refs/heads/main"
}
}
}
[19:22:15.859] Task URL: https://cr-buildbucket.appspot.com/build/8747936631320906977
[19:22:15.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:2:0) after 7m19s
[19:22:16.777] Received PubSub notification, asking Buildbucket for the build status
[19:22:16.809] Build status: SCHEDULED
[19:22:20.250] Received PubSub notification, asking Buildbucket for the build status
[19:22:20.277] Build status: STARTED
[19:29:34.907] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:2:0)
[19:29:34.955] Build status: STARTED
[19:29:34.955] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:5:0) after 8m0s
[19:37:35.022] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:5:0)
[19:37:35.045] Build status: STARTED
[19:37:35.045] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:6:0) after 2m8s
[19:39:43.080] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:6:0)
[19:39:43.105] Build status: STARTED
[19:39:43.106] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:7:0) after 4m5s
[19:43:48.246] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:7:0)
[19:43:48.274] Build status: STARTED
[19:43:48.274] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:8:0) after 4m22s
[19:48:10.306] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:8:0)
[19:48:10.386] Build status: STARTED
[19:48:10.386] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:9:0) after 9m0s
[19:57:10.490] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:9:0)
[19:57:10.518] Build status: STARTED
[19:57:10.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:10:0) after 1m35s
[19:58:45.494] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:10:0)
[19:58:45.517] Build status: STARTED
[19:58:45.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:11:0) after 3m26s
[20:02:11.633] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:11:0)
[20:02:11.654] Build status: STARTED
[20:02:11.654] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:12:0) after 1m40s
[20:03:51.677] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:12:0)
[20:03:51.695] Build status: STARTED
[20:03:51.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:13:0) after 9m29s
[20:13:20.741] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:13:0)
[20:13:20.770] Build status: STARTED
[20:13:20.770] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:14:0) after 3m7s
[20:16:27.800] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:14:0)
[20:16:27.822] Build status: STARTED
[20:16:27.822] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:15:0) after 9m20s
[20:25:47.970] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:15:0)
[20:25:47.992] Build status: STARTED
[20:25:47.992] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:16:0) after 7m44s
[20:33:31.991] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:16:0)
[20:33:32.017] Build status: STARTED
[20:33:32.017] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:17:0) after 3m40s
[20:37:12.016] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:17:0)
[20:37:12.157] Build status: STARTED
[20:37:12.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:18:0) after 7m55s
[20:45:07.236] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:18:0)
[20:45:07.256] Build status: STARTED
[20:45:07.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:19:0) after 5m9s
[20:50:16.322] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:19:0)
[20:50:16.423] Build status: STARTED
[20:50:16.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:20:0) after 4m29s
[20:54:45.546] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:20:0)
[20:54:45.569] Build status: STARTED
[20:54:45.569] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug-tot-build_only:8913366693248857472:21:0) after 9m7s
[21:00:19.892] Received PubSub notification, asking Buildbucket for the build status
[21:00:19.915] Build:
{
"id": "8747936631320906977",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug-tot-build_only"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-14T19:22:15.367185067Z",
"startTime": "2024-05-14T19:22:20.036457965Z",
"endTime": "2024-05-14T21:00:19.551086826Z",
"updateTime": "2024-05-14T21:00:19.551086826Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f89b1b8a68065c4b880417abb0563bce21399b52",
"ref": "refs/heads/main"
}
}
}
[21:00:19.915] Invocation finished in 1h38m5.770286534s with status SUCCEEDED