[13:56:11.297] New invocation is queued and will start shortly
[13:56:11.297] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[13:56:12.401] Starting the invocation (attempt 1)
[13:56:12.434] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/bf7a0f9958b93d9979e0adf93b80ad056615706d"
[13:56:12.434] Reconstructed gitiles commit from tags
[13:56:12.434] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:56:12.434] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:56:12.436] Buildbucket request:
{
"requestId": "8913387206401115776",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "cfd14dad640c9b852b744d934d8b0ecc4b0626fb0a4b62aa537e0e7d800b68a1/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "739b170903c26c6ecf5e863742ffd642bb99a91c",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913387206401115776",
"job": "fuchsia/clang_toolchain.ci.core.arm64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "556502349ff46014c08b09b3cf04e33b988f14bacb2c2d29cca23369f60d4d30/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "739b170903c26c6ecf5e863742ffd642bb99a91c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "363258a3ccbb752ec23f681d19b6a874c4db99ab"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/363258a3ccbb752ec23f681d19b6a874c4db99ab",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "3d2d8a7b-31a2-441b-8cda-7b22f70a8e21",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "a0b0a55382570802b3459d7acf00e5b0586dd96faeb99002cfe5fa153a6e2800/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "739b170903c26c6ecf5e863742ffd642bb99a91c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e6d3a4212d20b49a8e63f11fedea79cccf261479"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e6d3a4212d20b49a8e63f11fedea79cccf261479",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "cfdb993b-aa4d-4597-9d14-30df7d022890",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7267b42e46aca4b49aea6128f50e3a90c462978d596d145e0e18d0e1309dcf58/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "739b170903c26c6ecf5e863742ffd642bb99a91c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "292b300c5131e54b9977305bb4aca9a03e1b4fed"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/292b300c5131e54b9977305bb4aca9a03e1b4fed",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "ad56167b-d763-42ce-9032-9e5524470f06",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e8e9be28c4efd1ba59a4c5a02c1aff881b218072f315dfc639fda98051461bd1/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "739b170903c26c6ecf5e863742ffd642bb99a91c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "415616daa0bdf6c0065c4c1967f1c4050e6ea836"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/415616daa0bdf6c0065c4c1967f1c4050e6ea836",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "95ea308f-eaf9-4bb7-92df-708d3b5aaf37",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "cfd14dad640c9b852b744d934d8b0ecc4b0626fb0a4b62aa537e0e7d800b68a1/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "739b170903c26c6ecf5e863742ffd642bb99a91c",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "bf7a0f9958b93d9979e0adf93b80ad056615706d"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/bf7a0f9958b93d9979e0adf93b80ad056615706d",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7438296d-c347-48bf-bba9-5a6ebb9f1fc0",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "bf7a0f9958b93d9979e0adf93b80ad056615706d"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bf7a0f9958b93d9979e0adf93b80ad056615706d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913387206401115776"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.arm64-release"
},
{
"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"
}
}
[13:56:12.985] Scheduled build:
{
"id": "8747957144440574033",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-14T13:56:12.532180325Z",
"updateTime": "2024-05-14T13:56:12.532180325Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bf7a0f9958b93d9979e0adf93b80ad056615706d",
"ref": "refs/heads/main"
}
}
}
[13:56:12.985] Task URL: https://cr-buildbucket.appspot.com/build/8747957144440574033
[13:56:12.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:2:0) after 7m16s
[13:56:13.093] Received PubSub notification, asking Buildbucket for the build status
[13:56:13.127] Build status: SCHEDULED
[13:56:19.151] Received PubSub notification, asking Buildbucket for the build status
[13:56:19.208] Build status: STARTED
[14:03:29.078] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:2:0)
[14:03:29.278] Build status: STARTED
[14:03:29.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:5:0) after 4m35s
[14:08:04.325] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:5:0)
[14:08:04.355] Build status: STARTED
[14:08:04.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:6:0) after 3m0s
[14:11:04.390] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:6:0)
[14:11:04.427] Build status: STARTED
[14:11:04.428] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:7:0) after 7m51s
[14:18:55.495] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:7:0)
[14:18:55.535] Build status: STARTED
[14:18:55.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:8:0) after 2m29s
[14:21:24.620] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:8:0)
[14:21:24.664] Build status: STARTED
[14:21:24.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:9:0) after 1m55s
[14:23:19.682] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:9:0)
[14:23:19.723] Build status: STARTED
[14:23:19.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:10:0) after 9m38s
[14:32:57.964] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:10:0)
[14:32:57.994] Build status: STARTED
[14:32:57.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:11:0) after 9m11s
[14:42:09.014] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:11:0)
[14:42:09.135] Build status: STARTED
[14:42:09.135] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:12:0) after 8m48s
[14:50:57.164] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:12:0)
[14:50:57.183] Build status: STARTED
[14:50:57.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:13:0) after 2m54s
[14:53:51.200] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:13:0)
[14:53:51.221] Build status: STARTED
[14:53:51.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:14:0) after 6m7s
[14:59:58.482] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:14:0)
[14:59:58.500] Build status: STARTED
[14:59:58.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:15:0) after 5m6s
[15:05:04.539] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:15:0)
[15:05:04.586] Build status: STARTED
[15:05:04.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:16:0) after 1m53s
[15:06:57.606] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:16:0)
[15:06:57.648] Build status: STARTED
[15:06:57.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:17:0) after 5m5s
[15:12:02.731] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:17:0)
[15:12:02.753] Build status: STARTED
[15:12:02.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:18:0) after 9m42s
[15:21:44.775] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:18:0)
[15:21:44.810] Build status: STARTED
[15:21:44.810] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:19:0) after 2m33s
[15:24:17.881] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:19:0)
[15:24:17.913] Build status: STARTED
[15:24:17.913] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:20:0) after 7m33s
[15:31:51.031] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:20:0)
[15:31:51.069] Build status: STARTED
[15:31:51.069] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:21:0) after 6m44s
[15:38:35.109] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:21:0)
[15:38:35.133] Build status: STARTED
[15:38:35.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:22:0) after 6m40s
[15:45:15.174] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:22:0)
[15:45:15.194] Build status: STARTED
[15:45:15.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:23:0) after 8m55s
[15:54:10.223] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:23:0)
[15:54:10.278] Build status: STARTED
[15:54:10.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:24:0) after 6m54s
[16:01:04.507] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:24:0)
[16:01:04.528] Build status: STARTED
[16:01:04.528] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:25:0) after 7m34s
[16:08:39.006] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:25:0)
[16:08:39.044] Build status: STARTED
[16:08:39.044] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:26:0) after 1m10s
[16:09:49.132] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:26:0)
[16:09:49.161] Build status: STARTED
[16:09:49.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:27:0) after 1m31s
[16:11:20.581] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:27:0)
[16:11:20.628] Build status: STARTED
[16:11:20.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:28:0) after 6m42s
[16:18:02.831] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:28:0)
[16:18:02.860] Build status: STARTED
[16:18:02.860] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:29:0) after 4m32s
[16:22:35.014] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:29:0)
[16:22:35.049] Build status: STARTED
[16:22:35.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:30:0) after 1m31s
[16:24:06.100] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:30:0)
[16:24:06.127] Build status: STARTED
[16:24:06.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8913387206401115776:31:0) after 6m7s
[16:30:10.081] Received PubSub notification, asking Buildbucket for the build status
[16:30:10.107] Build:
{
"id": "8747957144440574033",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-14T13:56:12.532180325Z",
"startTime": "2024-05-14T13:56:18.684824065Z",
"endTime": "2024-05-14T16:30:09.388190929Z",
"updateTime": "2024-05-14T16:30:09.388190929Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "bf7a0f9958b93d9979e0adf93b80ad056615706d",
"ref": "refs/heads/main"
}
}
}
[16:30:10.107] Invocation finished in 2h33m58.830689647s with status SUCCEEDED