[17:25:44.634] New invocation is queued and will start shortly
[17:25:46.204] Starting the invocation (attempt 1)
[17:25:46.238] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f4042077e2e3946ee35c1df8cab8237de6086480"
[17:25:46.238] Popped gitiles commit info from properties and tags
[17:25:46.238] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:25:46.238] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:25:46.239] Buildbucket request:
{
"requestId": "8901324625770139568",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8901324625770139568",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "679c9717dfc9687a3bca78b45d9fd104b67e16f9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@679c9717dfc9687a3bca78b45d9fd104b67e16f9",
"title": "679c9717dfc9687a3bca78b45d9fd104b67e16f9",
"url": "https://llvm.googlesource.com/llvm-project/+/679c9717dfc9687a3bca78b45d9fd104b67e16f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "206408732bca2ef464732a39c8319d47c8a1dbea"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@206408732bca2ef464732a39c8319d47c8a1dbea",
"title": "206408732bca2ef464732a39c8319d47c8a1dbea",
"url": "https://llvm.googlesource.com/llvm-project/+/206408732bca2ef464732a39c8319d47c8a1dbea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7773243d9916f98ba0ffce0c3a960e4aa9f03e81"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7773243d9916f98ba0ffce0c3a960e4aa9f03e81",
"title": "7773243d9916f98ba0ffce0c3a960e4aa9f03e81",
"url": "https://llvm.googlesource.com/llvm-project/+/7773243d9916f98ba0ffce0c3a960e4aa9f03e81"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fe6a3d46aa658fdd1e9a6cbb2031a597a3e59536"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fe6a3d46aa658fdd1e9a6cbb2031a597a3e59536",
"title": "fe6a3d46aa658fdd1e9a6cbb2031a597a3e59536",
"url": "https://llvm.googlesource.com/llvm-project/+/fe6a3d46aa658fdd1e9a6cbb2031a597a3e59536"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8e68a512ef568324da60c8b2705e9b087d06ebcf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8e68a512ef568324da60c8b2705e9b087d06ebcf",
"title": "8e68a512ef568324da60c8b2705e9b087d06ebcf",
"url": "https://llvm.googlesource.com/llvm-project/+/8e68a512ef568324da60c8b2705e9b087d06ebcf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "01be0252c834bc7be222057049d697f488493543"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@01be0252c834bc7be222057049d697f488493543",
"title": "01be0252c834bc7be222057049d697f488493543",
"url": "https://llvm.googlesource.com/llvm-project/+/01be0252c834bc7be222057049d697f488493543"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9e60a6ad4242274c39242079d5351fcb9d6d99e6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9e60a6ad4242274c39242079d5351fcb9d6d99e6",
"title": "9e60a6ad4242274c39242079d5351fcb9d6d99e6",
"url": "https://llvm.googlesource.com/llvm-project/+/9e60a6ad4242274c39242079d5351fcb9d6d99e6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "406a2128f57b1e86748cd6de6d3eab6b1e2db2ad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@406a2128f57b1e86748cd6de6d3eab6b1e2db2ad",
"title": "406a2128f57b1e86748cd6de6d3eab6b1e2db2ad",
"url": "https://llvm.googlesource.com/llvm-project/+/406a2128f57b1e86748cd6de6d3eab6b1e2db2ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e64673d3174af941eb3c9f1ad822792154aa1d31"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e64673d3174af941eb3c9f1ad822792154aa1d31",
"title": "e64673d3174af941eb3c9f1ad822792154aa1d31",
"url": "https://llvm.googlesource.com/llvm-project/+/e64673d3174af941eb3c9f1ad822792154aa1d31"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c6bf59f26b2d74474a66182db6ebd576273bfb00"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c6bf59f26b2d74474a66182db6ebd576273bfb00",
"title": "c6bf59f26b2d74474a66182db6ebd576273bfb00",
"url": "https://llvm.googlesource.com/llvm-project/+/c6bf59f26b2d74474a66182db6ebd576273bfb00"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04b443e77845cd20ab5acc4356cee509316135dd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04b443e77845cd20ab5acc4356cee509316135dd",
"title": "04b443e77845cd20ab5acc4356cee509316135dd",
"url": "https://llvm.googlesource.com/llvm-project/+/04b443e77845cd20ab5acc4356cee509316135dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "090755234e5033de67be994e99e31f4d13dcdcc5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@090755234e5033de67be994e99e31f4d13dcdcc5",
"title": "090755234e5033de67be994e99e31f4d13dcdcc5",
"url": "https://llvm.googlesource.com/llvm-project/+/090755234e5033de67be994e99e31f4d13dcdcc5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f4042077e2e3946ee35c1df8cab8237de6086480"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f4042077e2e3946ee35c1df8cab8237de6086480",
"title": "f4042077e2e3946ee35c1df8cab8237de6086480",
"url": "https://llvm.googlesource.com/llvm-project/+/f4042077e2e3946ee35c1df8cab8237de6086480"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f4042077e2e3946ee35c1df8cab8237de6086480",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8901324625770139568"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:25:47.316] Scheduled build:
{
"id": "8735894563350047617",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-24T17:25:46.308916628Z",
"updateTime": "2024-09-24T17:25:46.308916628Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f4042077e2e3946ee35c1df8cab8237de6086480",
"ref": "refs/heads/main"
}
}
}
[17:25:47.316] Task URL: https://cr-buildbucket.appspot.com/build/8735894563350047617
[17:25:47.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:2:0) after 6m12s
[17:25:47.655] Received PubSub notification, asking Buildbucket for the build status
[17:25:47.676] Build status: SCHEDULED
[17:25:53.708] Received PubSub notification, asking Buildbucket for the build status
[17:25:53.743] Build status: STARTED
[17:31:59.549] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:2:0)
[17:31:59.620] Build status: STARTED
[17:31:59.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:5:0) after 8m47s
[17:40:46.669] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:5:0)
[17:40:46.686] Build status: STARTED
[17:40:46.686] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:6:0) after 8m36s
[17:49:22.704] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:6:0)
[17:49:22.719] Build status: STARTED
[17:49:22.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:7:0) after 1m28s
[17:50:50.751] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:7:0)
[17:50:50.777] Build status: STARTED
[17:50:50.777] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:8:0) after 6m10s
[17:57:00.802] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:8:0)
[17:57:00.830] Build status: STARTED
[17:57:00.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:9:0) after 4m40s
[18:01:40.850] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:9:0)
[18:01:40.892] Build status: STARTED
[18:01:40.892] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:10:0) after 5m4s
[18:06:44.913] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:10:0)
[18:06:44.973] Build status: STARTED
[18:06:44.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:11:0) after 4m39s
[18:11:24.044] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:11:0)
[18:11:24.115] Build status: STARTED
[18:11:24.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:12:0) after 9m12s
[18:20:36.238] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:12:0)
[18:20:36.261] Build status: STARTED
[18:20:36.261] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:13:0) after 1m32s
[18:22:08.310] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:13:0)
[18:22:08.331] Build status: STARTED
[18:22:08.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:14:0) after 7m45s
[18:29:53.439] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:14:0)
[18:29:53.526] Build status: STARTED
[18:29:53.526] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:15:0) after 5m9s
[18:35:02.548] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:15:0)
[18:35:02.566] Build status: STARTED
[18:35:02.566] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:16:0) after 1m28s
[18:36:30.587] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:16:0)
[18:36:30.608] Build status: STARTED
[18:36:30.608] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8901324625770139568:17:0) after 9m27s
[18:41:51.969] Received PubSub notification, asking Buildbucket for the build status
[18:41:51.988] Build:
{
"id": "8735894563350047617",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-09-24T17:25:46.308916628Z",
"startTime": "2024-09-24T17:25:53.176799664Z",
"endTime": "2024-09-24T18:41:51.359056570Z",
"updateTime": "2024-09-24T18:41:51.359056570Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f4042077e2e3946ee35c1df8cab8237de6086480",
"ref": "refs/heads/main"
}
}
}
[18:41:51.988] Invocation finished in 1h16m7.37187301s with status SUCCEEDED