[03:24:22.956] New invocation is queued and will start shortly
[03:24:22.956] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[03:24:24.056] Starting the invocation (attempt 1)
[03:24:24.131] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2d92f7de800a1b1b3dca3dab1e11da712cd55f2b"
[03:24:24.131] Reconstructed gitiles commit from tags
[03:24:24.131] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:24:24.131] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:24:24.132] Buildbucket request:
{
"requestId": "8924026801233893040",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d296e6d25a153d4303f24010cf138fbe6a528eb719159f21a8cdf01178c53324/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "dd0a164c31b74722be37e1f0eeba236a65f44cd9",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8924026801233893040",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b54fe9cc58f60501f2b5f6f4c1f2a5a9c64f32a318e37a64474ab5d2df5e1f8c/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "dd0a164c31b74722be37e1f0eeba236a65f44cd9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "aa02002491333c42060373bc84f1ff5d2c76b4ce"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/aa02002491333c42060373bc84f1ff5d2c76b4ce",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "0bcd1e5b-9376-438b-9de4-cbd53f0a6a43",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "88c2c8712a97284f9651b90c696163ec97898cfbcdd1c82cd3ec2e153265c442/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "dd0a164c31b74722be37e1f0eeba236a65f44cd9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f6617091a982c0802e9b980f2ce7e11a1355c38b"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f6617091a982c0802e9b980f2ce7e11a1355c38b",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "b974cfc9-cfb9-4efb-b795-b86f79d5da62",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "d296e6d25a153d4303f24010cf138fbe6a528eb719159f21a8cdf01178c53324/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "dd0a164c31b74722be37e1f0eeba236a65f44cd9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2d92f7de800a1b1b3dca3dab1e11da712cd55f2b"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2d92f7de800a1b1b3dca3dab1e11da712cd55f2b",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "6f041ba0-c3ee-41f7-87ab-39e7f1e0054c",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2d92f7de800a1b1b3dca3dab1e11da712cd55f2b"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2d92f7de800a1b1b3dca3dab1e11da712cd55f2b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8924026801233893040"
},
{
"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"
}
}
[03:24:24.577] Scheduled build:
{
"id": "8758596739276803473",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-18T03:24:24.200849419Z",
"updateTime": "2024-01-18T03:24:24.200849419Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2d92f7de800a1b1b3dca3dab1e11da712cd55f2b",
"ref": "refs/heads/main"
}
}
}
[03:24:24.577] Task URL: https://cr-buildbucket.appspot.com/build/8758596739276803473
[03:24:24.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:2:0) after 9m13s
[03:24:25.504] Received PubSub notification, asking Buildbucket for the build status
[03:24:25.526] Build status: SCHEDULED
[03:25:40.749] Received PubSub notification, asking Buildbucket for the build status
[03:25:40.779] Build status: STARTED
[03:33:37.605] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:2:0)
[03:33:37.633] Build status: STARTED
[03:33:37.633] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:5:0) after 4m12s
[03:37:49.706] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:5:0)
[03:37:49.722] Build status: STARTED
[03:37:49.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:6:0) after 2m54s
[03:40:43.712] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:6:0)
[03:40:43.732] Build status: STARTED
[03:40:43.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:7:0) after 6m7s
[03:46:50.962] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:7:0)
[03:46:50.989] Build status: STARTED
[03:46:50.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:8:0) after 1m24s
[03:48:15.123] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:8:0)
[03:48:15.154] Build status: STARTED
[03:48:15.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:9:0) after 1m4s
[03:49:19.251] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:9:0)
[03:49:19.265] Build status: STARTED
[03:49:19.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:10:0) after 3m36s
[03:52:55.304] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:10:0)
[03:52:55.321] Build status: STARTED
[03:52:55.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:11:0) after 4m23s
[03:57:18.437] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:11:0)
[03:57:18.457] Build status: STARTED
[03:57:18.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:12:0) after 9m18s
[04:06:36.513] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:12:0)
[04:06:36.534] Build status: STARTED
[04:06:36.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:13:0) after 9m58s
[04:16:34.563] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:13:0)
[04:16:34.586] Build status: STARTED
[04:16:34.586] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:14:0) after 4m26s
[04:21:00.806] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:14:0)
[04:21:00.829] Build status: STARTED
[04:21:00.829] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:15:0) after 3m27s
[04:24:28.075] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:15:0)
[04:24:28.095] Build status: STARTED
[04:24:28.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:16:0) after 6m40s
[04:31:08.294] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:16:0)
[04:31:08.508] Build status: STARTED
[04:31:08.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:17:0) after 9m23s
[04:40:31.526] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:17:0)
[04:40:31.542] Build status: STARTED
[04:40:31.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:18:0) after 5m4s
[04:45:35.692] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:18:0)
[04:45:35.849] Build status: STARTED
[04:45:35.849] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:19:0) after 6m34s
[04:52:10.015] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:19:0)
[04:52:10.039] Build status: STARTED
[04:52:10.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:20:0) after 6m8s
[04:58:18.066] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:20:0)
[04:58:18.084] Build status: STARTED
[04:58:18.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:21:0) after 1m20s
[04:59:38.227] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:21:0)
[04:59:38.244] Build status: STARTED
[04:59:38.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:22:0) after 9m23s
[05:09:01.363] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:22:0)
[05:09:01.390] Build status: STARTED
[05:09:01.390] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:23:0) after 6m20s
[05:15:21.406] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:23:0)
[05:15:21.430] Build status: STARTED
[05:15:21.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:24:0) after 4m58s
[05:20:19.449] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:24:0)
[05:20:19.498] Build status: STARTED
[05:20:19.498] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8924026801233893040:25:0) after 4m2s
[05:22:33.773] Received PubSub notification, asking Buildbucket for the build status
[05:22:33.791] Build:
{
"id": "8758596739276803473",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-18T03:24:24.200849419Z",
"startTime": "2024-01-18T03:25:40.274754557Z",
"endTime": "2024-01-18T05:22:32.809016Z",
"updateTime": "2024-01-18T05:22:32.809016Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2d92f7de800a1b1b3dca3dab1e11da712cd55f2b",
"ref": "refs/heads/main"
}
}
}
[05:22:33.791] Invocation finished in 1h58m10.840704769s with status SUCCEEDED