[10:36:56.647] New invocation is queued and will start shortly
[10:36:56.647] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[10:36:57.751] Starting the invocation (attempt 1)
[10:36:57.780] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/156da986834700890d606b9bd14d3e748c0a82b0"
[10:36:57.780] Reconstructed gitiles commit from tags
[10:36:57.780] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:36:57.780] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:36:57.781] Buildbucket request:
{
"requestId": "8894646169706621040",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "78a9103fc7e57e597efae5f83f710366592fdc01c090248ae3875ca3d362f6a6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ad783d08ff064208b472b35f51d23b159c936b17",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8894646169706621040",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "356d44fcd2ef0f81e5a8ec54b228c89b067508dd56edfba0730bc2bd06a627dd/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ad783d08ff064208b472b35f51d23b159c936b17",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e0ed0333f0fed2e73f805afd58b61176a87aa3ad"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e0ed0333f0fed2e73f805afd58b61176a87aa3ad",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "31eebb6e-239c-45f4-b023-20c7055bf86b",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "e2fa8f5d2fa428da1c36d0cdbeb670fe729f965beb453e3b33a04fd1dd211f29/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ad783d08ff064208b472b35f51d23b159c936b17",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "abc4183c731e0a352ebebc96106e3622e6ad5029"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/abc4183c731e0a352ebebc96106e3622e6ad5029",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "725025b0-efcf-45f4-82e9-46a67477c903",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7c6eba9fdd68787c4d1c5ef4ad480a4e3fa955ef8e1d94a6029f14193fa1a5ee/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ad783d08ff064208b472b35f51d23b159c936b17",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "d76650bced1de20cb79d1b4a0c1732339a5d0099"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d76650bced1de20cb79d1b4a0c1732339a5d0099",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "2e8b9f98-2f29-4037-a703-f0acc27b2462",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "78a9103fc7e57e597efae5f83f710366592fdc01c090248ae3875ca3d362f6a6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "ad783d08ff064208b472b35f51d23b159c936b17",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "156da986834700890d606b9bd14d3e748c0a82b0"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/156da986834700890d606b9bd14d3e748c0a82b0",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "01f679ec-e11a-4d23-878b-c3a0df694539",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "156da986834700890d606b9bd14d3e748c0a82b0"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "156da986834700890d606b9bd14d3e748c0a82b0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8894646169706621040"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-debug"
},
{
"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"
}
}
[10:36:58.188] Scheduled build:
{
"id": "8729216107791120753",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-07T10:36:57.847087287Z",
"updateTime": "2024-12-07T10:36:57.847087287Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "156da986834700890d606b9bd14d3e748c0a82b0",
"ref": "refs/heads/main"
}
}
}
[10:36:58.188] Task URL: https://cr-buildbucket.appspot.com/build/8729216107791120753
[10:36:58.188] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:2:0) after 7m43s
[10:37:12.137] Received PubSub notification, asking Buildbucket for the build status
[10:37:12.211] Build status: SCHEDULED
[10:37:22.567] Received PubSub notification, asking Buildbucket for the build status
[10:37:22.590] Build status: STARTED
[10:44:41.247] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:2:0)
[10:44:41.285] Build status: STARTED
[10:44:41.285] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:5:0) after 6m33s
[10:51:14.253] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:5:0)
[10:51:14.270] Build status: STARTED
[10:51:14.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:6:0) after 2m30s
[10:53:44.482] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:6:0)
[10:53:44.547] Build status: STARTED
[10:53:44.547] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:7:0) after 9m9s
[11:02:53.631] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:7:0)
[11:02:53.660] Build status: STARTED
[11:02:53.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:8:0) after 6m18s
[11:09:11.679] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:8:0)
[11:09:11.707] Build status: STARTED
[11:09:11.707] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:9:0) after 1m0s
[11:10:11.795] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:9:0)
[11:10:11.840] Build status: STARTED
[11:10:11.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:10:0) after 1m8s
[11:11:20.103] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:10:0)
[11:11:20.134] Build status: STARTED
[11:11:20.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:11:0) after 7m53s
[11:19:13.171] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:11:0)
[11:19:13.208] Build status: STARTED
[11:19:13.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:12:0) after 2m5s
[11:21:18.330] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:12:0)
[11:21:18.350] Build status: STARTED
[11:21:18.350] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:13:0) after 5m4s
[11:26:22.670] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:13:0)
[11:26:22.689] Build status: STARTED
[11:26:22.689] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:14:0) after 2m37s
[11:28:59.704] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:14:0)
[11:28:59.723] Build status: STARTED
[11:28:59.723] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:15:0) after 1m34s
[11:30:33.837] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:15:0)
[11:30:33.860] Build status: STARTED
[11:30:33.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:16:0) after 6m20s
[11:36:53.878] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:16:0)
[11:36:53.902] Build status: STARTED
[11:36:53.902] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:17:0) after 5m28s
[11:42:21.992] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:17:0)
[11:42:22.008] Build status: STARTED
[11:42:22.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:18:0) after 4m24s
[11:46:46.025] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:18:0)
[11:46:46.041] Build status: STARTED
[11:46:46.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:19:0) after 4m11s
[11:50:57.223] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:19:0)
[11:50:57.251] Build status: STARTED
[11:50:57.251] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:20:0) after 6m56s
[11:57:53.277] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:20:0)
[11:57:53.298] Build status: STARTED
[11:57:53.298] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:21:0) after 8m13s
[12:06:06.422] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:21:0)
[12:06:06.442] Build status: STARTED
[12:06:06.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:22:0) after 4m58s
[12:11:04.537] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:22:0)
[12:11:04.556] Build status: STARTED
[12:11:04.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:23:0) after 4m25s
[12:15:29.589] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:23:0)
[12:15:29.656] Build status: STARTED
[12:15:29.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:24:0) after 7m18s
[12:22:47.767] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:24:0)
[12:22:47.788] Build status: STARTED
[12:22:47.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:25:0) after 6m24s
[12:29:12.206] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:25:0)
[12:29:12.233] Build status: STARTED
[12:29:12.233] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:26:0) after 3m56s
[12:33:08.335] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:26:0)
[12:33:08.362] Build status: STARTED
[12:33:08.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:27:0) after 1m49s
[12:34:57.486] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:27:0)
[12:34:57.518] Build status: STARTED
[12:34:57.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:28:0) after 3m40s
[12:38:37.536] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:28:0)
[12:38:37.554] Build status: STARTED
[12:38:37.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:29:0) after 2m33s
[12:41:10.759] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:29:0)
[12:41:10.791] Build status: STARTED
[12:41:10.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:30:0) after 4m13s
[12:45:23.832] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:30:0)
[12:45:23.851] Build status: STARTED
[12:45:23.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:31:0) after 3m31s
[12:48:54.874] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:31:0)
[12:48:54.894] Build status: STARTED
[12:48:54.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:32:0) after 2m42s
[12:51:37.039] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:32:0)
[12:51:37.058] Build status: STARTED
[12:51:37.058] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:33:0) after 7m18s
[12:58:55.079] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:33:0)
[12:58:55.097] Build status: STARTED
[12:58:55.097] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:34:0) after 2m24s
[13:01:19.117] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:34:0)
[13:01:19.134] Build status: STARTED
[13:01:19.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:35:0) after 8m36s
[13:09:55.266] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:35:0)
[13:09:55.284] Build status: STARTED
[13:09:55.284] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:36:0) after 6m7s
[13:16:02.423] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:36:0)
[13:16:02.445] Build status: STARTED
[13:16:02.445] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:37:0) after 6m52s
[13:22:54.465] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:37:0)
[13:22:54.488] Build status: STARTED
[13:22:54.488] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:38:0) after 6m56s
[13:29:50.459] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:38:0)
[13:29:50.476] Build status: STARTED
[13:29:50.476] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:39:0) after 6m12s
[13:36:02.494] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:39:0)
[13:36:02.551] Build status: STARTED
[13:36:02.551] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8894646169706621040:40:0) after 1m53s
[13:36:39.686] Received PubSub notification, asking Buildbucket for the build status
[13:36:39.703] Build:
{
"id": "8729216107791120753",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-07T10:36:57.847087287Z",
"startTime": "2024-12-07T10:37:13.855397446Z",
"endTime": "2024-12-07T13:36:38.910914505Z",
"updateTime": "2024-12-07T13:36:38.910914505Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "156da986834700890d606b9bd14d3e748c0a82b0",
"ref": "refs/heads/main"
}
}
}
[13:36:39.703] Invocation finished in 2h59m43.066339263s with status SUCCEEDED