[14:01:03.378] New invocation is queued and will start shortly
[14:01:03.378] Triggered by user:clang-ci-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[14:01:04.420] Starting the invocation (attempt 1)
[14:01:04.457] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8149cbfecdaf0ac8e5a9f38a87f30c89ddc001a4"
[14:01:04.457] Reconstructed gitiles commit from tags
[14:01:04.457] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:01:04.457] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:01:04.458] Buildbucket request:
{
"requestId": "8889288107062208544",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "42dea854f093df23db4d2bf5df7c3ca18f207b8b6e0cdddaad9ec0f5dcec47f5/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "1f366162b33cec1d93e41e243be961b26770d1d8",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8889288107062208544",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "c8991021c86539971fbdeeec1b79575c08571f0275b3977a19da309d4b8b8818/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "1f366162b33cec1d93e41e243be961b26770d1d8",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "d9af03ba80475df5edcab7e4d63004f6115aab3a"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d9af03ba80475df5edcab7e4d63004f6115aab3a",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7eb8ac0d-73e2-461c-b3f1-96a2c6554084",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "de56054a628678ab7466fe3ececbffa99fea3b9681354ef4ae7a53fc0979474b/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "1f366162b33cec1d93e41e243be961b26770d1d8",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "64927af52a3bedf2b20d6cdd98bb47d9bba630f9"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/64927af52a3bedf2b20d6cdd98bb47d9bba630f9",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "e82d9fc9-6b1c-4b55-974d-1e3742408a9a",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "48a1644e669c366f55e996814e0cfdb36663ec83c5e10bc285e248ee709fa71c/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "1f366162b33cec1d93e41e243be961b26770d1d8",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "227b32f6a1329c449f1222a42471190eededa433"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/227b32f6a1329c449f1222a42471190eededa433",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "ee066708-7e37-4839-8a74-fefdbbd71cfc",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "401dfb48106283d48ec2b850214936a07576167b66597bb2f5b9eedcc4e31afd/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "1f366162b33cec1d93e41e243be961b26770d1d8",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "d7aa6e379e612be4f5de3fc7bae53a5d19498049"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d7aa6e379e612be4f5de3fc7bae53a5d19498049",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "e1332a27-1750-4958-aa67-fe883046b229",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "42dea854f093df23db4d2bf5df7c3ca18f207b8b6e0cdddaad9ec0f5dcec47f5/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "1f366162b33cec1d93e41e243be961b26770d1d8",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "8149cbfecdaf0ac8e5a9f38a87f30c89ddc001a4"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8149cbfecdaf0ac8e5a9f38a87f30c89ddc001a4",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f8eb8a84-6e9e-4097-88aa-33f54e0d3201",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "8149cbfecdaf0ac8e5a9f38a87f30c89ddc001a4"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8149cbfecdaf0ac8e5a9f38a87f30c89ddc001a4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8889288107062208544"
},
{
"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"
}
}
[14:01:04.886] Scheduled build:
{
"id": "8723858045183886641",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-04T14:01:04.542985974Z",
"updateTime": "2025-02-04T14:01:04.542985974Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8149cbfecdaf0ac8e5a9f38a87f30c89ddc001a4",
"ref": "refs/heads/main"
}
}
}
[14:01:04.886] Task URL: https://cr-buildbucket.appspot.com/build/8723858045183886641
[14:01:04.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:2:0) after 8m34s
[14:01:05.887] Received PubSub notification, asking Buildbucket for the build status
[14:01:05.911] Build status: SCHEDULED
[14:01:10.698] Received PubSub notification, asking Buildbucket for the build status
[14:01:10.730] Build status: STARTED
[14:09:39.084] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:2:0)
[14:09:39.111] Build status: STARTED
[14:09:39.111] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:5:0) after 5m22s
[14:15:01.128] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:5:0)
[14:15:01.153] Build status: STARTED
[14:15:01.153] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:6:0) after 9m1s
[14:24:02.730] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:6:0)
[14:24:02.761] Build status: STARTED
[14:24:02.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:7:0) after 9m5s
[14:33:07.791] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:7:0)
[14:33:07.809] Build status: STARTED
[14:33:07.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:8:0) after 3m30s
[14:36:37.829] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:8:0)
[14:36:37.856] Build status: STARTED
[14:36:37.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:9:0) after 3m55s
[14:40:33.173] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:9:0)
[14:40:33.199] Build status: STARTED
[14:40:33.199] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:10:0) after 3m3s
[14:43:36.324] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:10:0)
[14:43:36.473] Build status: STARTED
[14:43:36.473] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:11:0) after 1m5s
[14:44:41.712] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:11:0)
[14:44:41.740] Build status: STARTED
[14:44:41.740] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:12:0) after 8m40s
[14:53:21.763] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:12:0)
[14:53:21.790] Build status: STARTED
[14:53:21.790] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:13:0) after 5m28s
[14:58:50.068] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:13:0)
[14:58:50.087] Build status: STARTED
[14:58:50.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:14:0) after 9m8s
[15:07:58.191] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:14:0)
[15:07:58.256] Build status: STARTED
[15:07:58.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:15:0) after 6m1s
[15:13:59.278] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:15:0)
[15:13:59.304] Build status: STARTED
[15:13:59.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:16:0) after 9m2s
[15:23:01.328] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:16:0)
[15:23:01.343] Build status: STARTED
[15:23:01.343] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:17:0) after 6m4s
[15:29:05.371] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:17:0)
[15:29:05.428] Build status: STARTED
[15:29:05.428] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:18:0) after 6m13s
[15:35:18.445] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:18:0)
[15:35:18.470] Build status: STARTED
[15:35:18.470] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:19:0) after 4m58s
[15:40:16.600] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:19:0)
[15:40:16.624] Build status: STARTED
[15:40:16.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:20:0) after 2m13s
[15:42:29.650] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:20:0)
[15:42:29.668] Build status: STARTED
[15:42:29.668] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:21:0) after 7m26s
[15:49:55.748] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:21:0)
[15:49:55.767] Build status: STARTED
[15:49:55.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:22:0) after 7m51s
[15:57:46.897] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:22:0)
[15:57:46.921] Build status: STARTED
[15:57:46.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:23:0) after 3m17s
[16:01:03.982] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:23:0)
[16:01:04.010] Build status: STARTED
[16:01:04.010] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:24:0) after 8m6s
[16:09:10.051] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:24:0)
[16:09:10.085] Build status: STARTED
[16:09:10.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:25:0) after 8m2s
[16:17:12.111] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:25:0)
[16:17:12.139] Build status: STARTED
[16:17:12.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:26:0) after 9m12s
[16:26:24.145] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:26:0)
[16:26:24.183] Build status: STARTED
[16:26:24.184] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:27:0) after 3m36s
[16:30:00.211] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:27:0)
[16:30:00.260] Build status: STARTED
[16:30:00.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:28:0) after 5m47s
[16:35:47.362] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:28:0)
[16:35:47.388] Build status: STARTED
[16:35:47.388] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:29:0) after 9m12s
[16:44:59.587] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:29:0)
[16:44:59.609] Build status: STARTED
[16:44:59.609] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:30:0) after 6m20s
[16:51:19.682] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:30:0)
[16:51:19.702] Build status: STARTED
[16:51:19.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:31:0) after 8m46s
[17:00:05.754] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:31:0)
[17:00:05.798] Build status: STARTED
[17:00:05.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889288107062208544:32:0) after 8m21s
[17:07:48.667] Received PubSub notification, asking Buildbucket for the build status
[17:07:48.690] Build:
{
"id": "8723858045183886641",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-04T14:01:04.542985974Z",
"startTime": "2025-02-04T14:01:10.087333220Z",
"endTime": "2025-02-04T17:07:47.105690879Z",
"updateTime": "2025-02-04T17:07:47.105690879Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8149cbfecdaf0ac8e5a9f38a87f30c89ddc001a4",
"ref": "refs/heads/main"
}
}
}
[17:07:48.690] Invocation finished in 3h6m45.322954701s with status SUCCEEDED