[08:09:04.735] New invocation is queued and will start shortly
[08:09:04.735] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[08:09:05.859] Starting the invocation (attempt 1)
[08:09:05.895] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a19e5aedd9b15ecf0b05bafb7d20e13c952b4531"
[08:09:05.895] Reconstructed gitiles commit from tags
[08:09:05.895] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:09:05.895] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:09:05.896] Buildbucket request:
{
"requestId": "8907520241813968928",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "913d40946bbc19b369716ebde2dfcb4804c0741a7fd756f59dd58a18be19010a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "1ffcb519b38791d654b85998492159ffb2cb43f8",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907520241813968928",
"job": "fuchsia/clang_toolchain.ci.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "f820aa05a0d502d7c4551123b4364736de34e66fff1a4a95d8b7a0a0699f2f2c/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "162bf6c670084c7cd34e6811093d3b2eda4856c9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "27ee33d1368b9772f75285932c00479a0fae82ee"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/27ee33d1368b9772f75285932c00479a0fae82ee",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "744ce855-99ef-4695-9d04-efb3e8ed2477",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "79a611ba33ce8093c06cb4d5f246fce731fcdd3ca90fe430617aea2a68cfeceb/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "162bf6c670084c7cd34e6811093d3b2eda4856c9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "0e986e395f9cd759b859ba0c934c0d73de4554c8"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0e986e395f9cd759b859ba0c934c0d73de4554c8",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "5fcebfd9-9d40-42be-9fc9-7d0b8ac5bad6",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "0509c36c82baa8f158e8bac4a3228252bdf986e6b5afb80438550141ddba327c/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "162bf6c670084c7cd34e6811093d3b2eda4856c9",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "f36331770267501e157ac34afc3ca7d7a0bfb52c"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f36331770267501e157ac34afc3ca7d7a0bfb52c",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "4ff74700-7745-48e8-8591-338adbadf6c6",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "fce520dc350ed72ad92a2083aa705fab0d6fd533de2dc0d23dd5a69328ccfb0c/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "1ffcb519b38791d654b85998492159ffb2cb43f8",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "14c323cfd66454c65324c4d5b9d9b6a9c5651eca"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/14c323cfd66454c65324c4d5b9d9b6a9c5651eca",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "353c6325-d8d6-4dcb-b5c8-4ae4e69adb8a",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "913d40946bbc19b369716ebde2dfcb4804c0741a7fd756f59dd58a18be19010a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "1ffcb519b38791d654b85998492159ffb2cb43f8",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a19e5aedd9b15ecf0b05bafb7d20e13c952b4531"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a19e5aedd9b15ecf0b05bafb7d20e13c952b4531",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "2aa18abb-17c7-4a6a-a77c-438638e646cd",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a19e5aedd9b15ecf0b05bafb7d20e13c952b4531"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a19e5aedd9b15ecf0b05bafb7d20e13c952b4531",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907520241813968928"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-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"
}
}
[08:09:06.443] Scheduled build:
{
"id": "8742090179862747729",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-18T08:09:05.965049481Z",
"updateTime": "2024-07-18T08:09:05.965049481Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a19e5aedd9b15ecf0b05bafb7d20e13c952b4531",
"ref": "refs/heads/main"
}
}
}
[08:09:06.443] Task URL: https://cr-buildbucket.appspot.com/build/8742090179862747729
[08:09:06.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:2:0) after 8m8s
[08:09:13.035] Received PubSub notification, asking Buildbucket for the build status
[08:09:13.073] Build status: STARTED
[08:09:18.416] Received PubSub notification, asking Buildbucket for the build status
[08:09:18.480] Build status: STARTED
[08:17:14.482] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:2:0)
[08:17:14.507] Build status: STARTED
[08:17:14.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:5:0) after 1m9s
[08:18:23.628] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:5:0)
[08:18:23.665] Build status: STARTED
[08:18:23.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:6:0) after 4m5s
[08:22:28.692] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:6:0)
[08:22:28.719] Build status: STARTED
[08:22:28.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:7:0) after 3m33s
[08:26:01.745] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:7:0)
[08:26:01.812] Build status: STARTED
[08:26:01.812] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:8:0) after 9m50s
[08:35:52.110] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:8:0)
[08:35:52.159] Build status: STARTED
[08:35:52.159] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:9:0) after 2m6s
[08:37:58.693] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:9:0)
[08:37:58.710] Build status: STARTED
[08:37:58.710] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:10:0) after 1m56s
[08:39:54.748] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:10:0)
[08:39:54.776] Build status: STARTED
[08:39:54.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:11:0) after 7m5s
[08:46:59.803] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:11:0)
[08:46:59.823] Build status: STARTED
[08:46:59.823] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:12:0) after 8m49s
[08:55:49.306] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:12:0)
[08:55:49.329] Build status: STARTED
[08:55:49.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:13:0) after 6m51s
[09:02:40.821] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:13:0)
[09:02:40.845] Build status: STARTED
[09:02:40.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:14:0) after 6m37s
[09:09:17.864] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:14:0)
[09:09:17.891] Build status: STARTED
[09:09:17.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:15:0) after 1m15s
[09:10:32.908] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:15:0)
[09:10:32.925] Build status: STARTED
[09:10:32.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:16:0) after 2m8s
[09:12:41.049] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:16:0)
[09:12:41.067] Build status: STARTED
[09:12:41.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:17:0) after 1m49s
[09:14:30.119] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:17:0)
[09:14:30.143] Build status: STARTED
[09:14:30.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:18:0) after 5m43s
[09:20:13.219] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:18:0)
[09:20:13.236] Build status: STARTED
[09:20:13.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:19:0) after 8m41s
[09:28:54.510] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:19:0)
[09:28:54.530] Build status: STARTED
[09:28:54.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:20:0) after 1m40s
[09:30:34.551] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:20:0)
[09:30:34.661] Build status: STARTED
[09:30:34.661] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:21:0) after 9m4s
[09:39:38.965] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:21:0)
[09:39:38.987] Build status: STARTED
[09:39:38.987] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:22:0) after 5m49s
[09:45:28.057] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:22:0)
[09:45:28.079] Build status: STARTED
[09:45:28.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:23:0) after 2m38s
[09:48:06.350] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:23:0)
[09:48:06.372] Build status: STARTED
[09:48:06.373] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:24:0) after 8m9s
[09:56:15.442] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:24:0)
[09:56:15.462] Build status: STARTED
[09:56:15.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:25:0) after 1m39s
[09:57:54.448] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:25:0)
[09:57:54.469] Build status: STARTED
[09:57:54.469] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:26:0) after 1m31s
[09:59:25.492] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:26:0)
[09:59:25.653] Build status: STARTED
[09:59:25.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:27:0) after 5m14s
[10:04:39.724] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:27:0)
[10:04:39.865] Build status: STARTED
[10:04:39.865] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:28:0) after 9m52s
[10:14:31.872] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:28:0)
[10:14:31.892] Build status: STARTED
[10:14:31.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:29:0) after 9m13s
[10:23:45.111] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:29:0)
[10:23:45.145] Build status: STARTED
[10:23:45.145] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:30:0) after 3m9s
[10:26:54.170] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:30:0)
[10:26:54.190] Build status: STARTED
[10:26:54.190] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:31:0) after 7m42s
[10:34:36.262] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:31:0)
[10:34:36.315] Build status: STARTED
[10:34:36.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8907520241813968928:32:0) after 7m44s
[10:35:46.095] Received PubSub notification, asking Buildbucket for the build status
[10:35:46.112] Build:
{
"id": "8742090179862747729",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-18T08:09:05.965049481Z",
"startTime": "2024-07-18T08:09:11.883433970Z",
"endTime": "2024-07-18T10:35:10.550806770Z",
"updateTime": "2024-07-18T10:35:10.550806770Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a19e5aedd9b15ecf0b05bafb7d20e13c952b4531",
"ref": "refs/heads/main"
}
}
}
[10:35:46.112] Invocation finished in 2h26m41.390814168s with status SUCCEEDED