[18:18:30.167] New invocation is queued and will start shortly
[18:18:30.167] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[18:18:31.226] Starting the invocation (attempt 1)
[18:18:31.255] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d99b1481770e4f8454c7f238dcd40c8e977e6b70"
[18:18:31.255] Reconstructed gitiles commit from tags
[18:18:31.255] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:18:31.255] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:18:31.255] Buildbucket request:
{
"requestId": "8920527863339919600",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "c20d2bd644c760fec3b449c018c3957d5d4aceb144f26d11b5691b53eb618be3/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "cfaf8cdf69e5b23fad7d4b473b06a6b457cd1085",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8920527863339919600",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "3f7d9945c94b1777a9db259ed7f03588a6492116d3943e590ddfa9e19e8e8cde/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "cfaf8cdf69e5b23fad7d4b473b06a6b457cd1085",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "411c5dde59fa4c427941143ca0ec8cd8fdaee407"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/411c5dde59fa4c427941143ca0ec8cd8fdaee407",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f77221f7-4669-4017-ae78-2cec38240baa",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "b39d3fe209f8d04d8fb6e60ef047f87914b4ad9f6d29bf452c4851087d16ade4/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "cfaf8cdf69e5b23fad7d4b473b06a6b457cd1085",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "cb4f94db83d9c4373b485493ef079e318f63bf13"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/cb4f94db83d9c4373b485493ef079e318f63bf13",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d973c293-df56-42c9-aaec-8c4481123d82",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "c20d2bd644c760fec3b449c018c3957d5d4aceb144f26d11b5691b53eb618be3/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "cfaf8cdf69e5b23fad7d4b473b06a6b457cd1085",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "d99b1481770e4f8454c7f238dcd40c8e977e6b70"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d99b1481770e4f8454c7f238dcd40c8e977e6b70",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "82b81f17-c62a-4d87-9fe9-c85f0c5e47f0",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "d99b1481770e4f8454c7f238dcd40c8e977e6b70"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d99b1481770e4f8454c7f238dcd40c8e977e6b70",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8920527863339919600"
},
{
"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"
}
}
[18:18:31.758] Scheduled build:
{
"id": "8755097801464403809",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-25T18:18:31.326912547Z",
"updateTime": "2024-02-25T18:18:31.326912547Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d99b1481770e4f8454c7f238dcd40c8e977e6b70",
"ref": "refs/heads/main"
}
}
}
[18:18:31.758] Task URL: https://cr-buildbucket.appspot.com/build/8755097801464403809
[18:18:31.758] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:2:0) after 3m39s
[18:18:32.673] Received PubSub notification, asking Buildbucket for the build status
[18:18:32.711] Build status: SCHEDULED
[18:18:32.969] Received PubSub notification, asking Buildbucket for the build status
[18:18:33.118] Build status: STARTED
[18:22:10.789] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:2:0)
[18:22:10.820] Build status: STARTED
[18:22:10.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:5:0) after 7m56s
[18:30:06.848] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:5:0)
[18:30:06.911] Build status: STARTED
[18:30:06.911] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:6:0) after 1m13s
[18:31:19.932] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:6:0)
[18:31:19.949] Build status: STARTED
[18:31:19.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:7:0) after 5m58s
[18:37:17.964] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:7:0)
[18:37:17.984] Build status: STARTED
[18:37:17.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:8:0) after 3m44s
[18:41:02.234] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:8:0)
[18:41:02.256] Build status: STARTED
[18:41:02.256] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:9:0) after 1m31s
[18:42:33.468] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:9:0)
[18:42:33.490] Build status: STARTED
[18:42:33.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:10:0) after 8m40s
[18:51:13.580] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:10:0)
[18:51:13.600] Build status: STARTED
[18:51:13.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:11:0) after 9m41s
[19:00:54.617] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:11:0)
[19:00:54.639] Build status: STARTED
[19:00:54.639] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:12:0) after 1m40s
[19:02:34.654] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:12:0)
[19:02:34.672] Build status: STARTED
[19:02:34.672] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:13:0) after 6m59s
[19:09:33.687] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:13:0)
[19:09:33.715] Build status: STARTED
[19:09:33.715] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:14:0) after 8m40s
[19:18:13.763] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:14:0)
[19:18:13.783] Build status: STARTED
[19:18:13.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:15:0) after 3m18s
[19:21:31.894] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:15:0)
[19:21:31.914] Build status: STARTED
[19:21:31.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:16:0) after 2m41s
[19:24:12.949] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:16:0)
[19:24:12.973] Build status: STARTED
[19:24:12.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:17:0) after 4m21s
[19:28:34.115] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:17:0)
[19:28:34.138] Build status: STARTED
[19:28:34.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:18:0) after 1m9s
[19:29:43.247] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:18:0)
[19:29:43.304] Build status: STARTED
[19:29:43.304] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:19:0) after 1m37s
[19:31:20.419] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:19:0)
[19:31:20.438] Build status: STARTED
[19:31:20.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:20:0) after 5m42s
[19:37:02.456] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:20:0)
[19:37:02.501] Build status: STARTED
[19:37:02.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:21:0) after 2m41s
[19:39:43.519] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:21:0)
[19:39:43.534] Build status: STARTED
[19:39:43.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:22:0) after 3m27s
[19:43:10.552] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:22:0)
[19:43:10.573] Build status: STARTED
[19:43:10.573] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:23:0) after 3m57s
[19:47:08.034] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:23:0)
[19:47:08.052] Build status: STARTED
[19:47:08.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:24:0) after 1m20s
[19:48:28.486] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:24:0)
[19:48:28.514] Build status: STARTED
[19:48:28.514] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:25:0) after 2m15s
[19:50:43.803] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:25:0)
[19:50:43.877] Build status: STARTED
[19:50:43.877] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:26:0) after 3m24s
[19:54:07.906] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:26:0)
[19:54:07.949] Build status: STARTED
[19:54:07.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:27:0) after 4m6s
[19:58:14.110] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:27:0)
[19:58:14.146] Build status: STARTED
[19:58:14.146] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:28:0) after 4m14s
[20:02:28.293] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:28:0)
[20:02:28.318] Build status: STARTED
[20:02:28.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:29:0) after 5m23s
[20:07:51.538] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:29:0)
[20:07:51.559] Build status: STARTED
[20:07:51.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:30:0) after 9m5s
[20:16:56.868] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:30:0)
[20:16:56.963] Build status: STARTED
[20:16:56.964] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:31:0) after 2m31s
[20:19:27.982] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:31:0)
[20:19:28.003] Build status: STARTED
[20:19:28.003] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8920527863339919600:32:0) after 5m49s
[20:22:58.440] Received PubSub notification, asking Buildbucket for the build status
[20:22:58.531] Build:
{
"id": "8755097801464403809",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-25T18:18:31.326912547Z",
"startTime": "2024-02-25T18:18:32.302234Z",
"endTime": "2024-02-25T20:22:57.144668Z",
"updateTime": "2024-02-25T20:22:57.144668Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d99b1481770e4f8454c7f238dcd40c8e977e6b70",
"ref": "refs/heads/main"
}
}
}
[20:22:58.531] Invocation finished in 2h4m28.377522776s with status SUCCEEDED