[20:29:41.382] New invocation is queued and will start shortly
[20:29:43.732] Starting the invocation (attempt 1)
[20:29:43.762] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9ec6c5d26321f5d32d97218f850ae7cafda32b2e"
[20:29:43.762] Popped gitiles commit info from properties and tags
[20:29:43.762] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:29:43.762] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:29:43.762] Buildbucket request:
{
"requestId": "8915899164487649888",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8915899164487649888",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9a0a28f8384b2cb534953df33bf124f01f0e0d0e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9a0a28f8384b2cb534953df33bf124f01f0e0d0e",
"title": "9a0a28f8384b2cb534953df33bf124f01f0e0d0e",
"url": "https://llvm.googlesource.com/llvm-project/+/9a0a28f8384b2cb534953df33bf124f01f0e0d0e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ed7038ef334eaccdd4104053005cab52804fbfad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ed7038ef334eaccdd4104053005cab52804fbfad",
"title": "ed7038ef334eaccdd4104053005cab52804fbfad",
"url": "https://llvm.googlesource.com/llvm-project/+/ed7038ef334eaccdd4104053005cab52804fbfad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "13ea36db166b7007f8b1e84e0827faaf24eb448e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@13ea36db166b7007f8b1e84e0827faaf24eb448e",
"title": "13ea36db166b7007f8b1e84e0827faaf24eb448e",
"url": "https://llvm.googlesource.com/llvm-project/+/13ea36db166b7007f8b1e84e0827faaf24eb448e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f430e374462efd94d891fcf9fa09d606343c780f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f430e374462efd94d891fcf9fa09d606343c780f",
"title": "f430e374462efd94d891fcf9fa09d606343c780f",
"url": "https://llvm.googlesource.com/llvm-project/+/f430e374462efd94d891fcf9fa09d606343c780f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "281d71604f418eb952e967d9dc4b26241b7f96aa"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@281d71604f418eb952e967d9dc4b26241b7f96aa",
"title": "281d71604f418eb952e967d9dc4b26241b7f96aa",
"url": "https://llvm.googlesource.com/llvm-project/+/281d71604f418eb952e967d9dc4b26241b7f96aa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "191be2a8a8531129c779bf23c4eec86f32c69bf9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@191be2a8a8531129c779bf23c4eec86f32c69bf9",
"title": "191be2a8a8531129c779bf23c4eec86f32c69bf9",
"url": "https://llvm.googlesource.com/llvm-project/+/191be2a8a8531129c779bf23c4eec86f32c69bf9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e770249d955e06f205e91017cd394d8670996168"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e770249d955e06f205e91017cd394d8670996168",
"title": "e770249d955e06f205e91017cd394d8670996168",
"url": "https://llvm.googlesource.com/llvm-project/+/e770249d955e06f205e91017cd394d8670996168"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "377a2767a9951659b5ec7309abb78da719a4f93b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@377a2767a9951659b5ec7309abb78da719a4f93b",
"title": "377a2767a9951659b5ec7309abb78da719a4f93b",
"url": "https://llvm.googlesource.com/llvm-project/+/377a2767a9951659b5ec7309abb78da719a4f93b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9ec6c5d26321f5d32d97218f850ae7cafda32b2e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9ec6c5d26321f5d32d97218f850ae7cafda32b2e",
"title": "9ec6c5d26321f5d32d97218f850ae7cafda32b2e",
"url": "https://llvm.googlesource.com/llvm-project/+/9ec6c5d26321f5d32d97218f850ae7cafda32b2e"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9ec6c5d26321f5d32d97218f850ae7cafda32b2e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8915899164487649888"
},
{
"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"
}
}
[20:29:44.306] Scheduled build:
{
"id": "8750469101251575617",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-16T20:29:43.837654802Z",
"updateTime": "2024-04-16T20:29:43.837654802Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9ec6c5d26321f5d32d97218f850ae7cafda32b2e",
"ref": "refs/heads/main"
}
}
}
[20:29:44.306] Task URL: https://cr-buildbucket.appspot.com/build/8750469101251575617
[20:29:44.306] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:2:0) after 5m20s
[20:29:53.378] Received PubSub notification, asking Buildbucket for the build status
[20:29:53.409] Build status: SCHEDULED
[20:34:24.526] Received PubSub notification, asking Buildbucket for the build status
[20:34:24.548] Build status: STARTED
[20:35:04.433] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:2:0)
[20:35:04.641] Build status: STARTED
[20:35:04.641] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:5:0) after 2m45s
[20:37:49.660] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:5:0)
[20:37:49.708] Build status: STARTED
[20:37:49.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:6:0) after 3m40s
[20:41:29.732] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:6:0)
[20:41:29.757] Build status: STARTED
[20:41:29.757] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:7:0) after 2m21s
[20:43:50.836] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:7:0)
[20:43:50.853] Build status: STARTED
[20:43:50.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:8:0) after 7m19s
[20:51:09.880] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:8:0)
[20:51:09.907] Build status: STARTED
[20:51:09.907] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:9:0) after 7m45s
[20:58:55.312] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:9:0)
[20:58:55.331] Build status: STARTED
[20:58:55.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:10:0) after 2m7s
[21:01:02.859] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:10:0)
[21:01:02.926] Build status: STARTED
[21:01:02.926] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:11:0) after 3m3s
[21:04:05.964] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:11:0)
[21:04:06.006] Build status: STARTED
[21:04:06.007] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:12:0) after 4m25s
[21:08:31.100] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:12:0)
[21:08:31.120] Build status: STARTED
[21:08:31.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:13:0) after 7m29s
[21:16:00.141] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:13:0)
[21:16:00.162] Build status: STARTED
[21:16:00.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:14:0) after 9m10s
[21:25:10.251] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:14:0)
[21:25:10.335] Build status: STARTED
[21:25:10.335] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:15:0) after 7m48s
[21:32:58.494] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:15:0)
[21:32:58.512] Build status: STARTED
[21:32:58.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:16:0) after 9m2s
[21:42:00.680] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:16:0)
[21:42:00.699] Build status: STARTED
[21:42:00.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8915899164487649888:17:0) after 6m13s
[21:47:48.473] Received PubSub notification, asking Buildbucket for the build status
[21:47:48.509] Build:
{
"id": "8750469101251575617",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-04-16T20:29:43.837654802Z",
"startTime": "2024-04-16T20:33:51.961284576Z",
"endTime": "2024-04-16T21:47:47.504830986Z",
"updateTime": "2024-04-16T21:47:47.504830986Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9ec6c5d26321f5d32d97218f850ae7cafda32b2e",
"ref": "refs/heads/main"
}
}
}
[21:47:48.510] Invocation finished in 1h18m7.141520645s with status SUCCEEDED