[10:05:42.548] New invocation is queued and will start shortly
[10:05:43.696] Starting the invocation (attempt 1)
[10:05:43.724] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5b8e1a6ebf11b6e93bcc96a0d009febe4bb3d7bc"
[10:05:43.724] Popped gitiles commit info from properties and tags
[10:05:43.724] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:05:43.724] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:05:43.725] Buildbucket request:
{
"requestId": "8922642597458259792",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8922642597458259792",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "237a799e938aca86dc7e62def792b26974bbae5d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@237a799e938aca86dc7e62def792b26974bbae5d",
"title": "237a799e938aca86dc7e62def792b26974bbae5d",
"url": "https://llvm.googlesource.com/llvm-project/+/237a799e938aca86dc7e62def792b26974bbae5d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a792cb6e3e03aff22dabb6cc94db68d15d953a55"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a792cb6e3e03aff22dabb6cc94db68d15d953a55",
"title": "a792cb6e3e03aff22dabb6cc94db68d15d953a55",
"url": "https://llvm.googlesource.com/llvm-project/+/a792cb6e3e03aff22dabb6cc94db68d15d953a55"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c07fcd45f140bb95fb0f1ed10468db2bb6b1a77b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c07fcd45f140bb95fb0f1ed10468db2bb6b1a77b",
"title": "c07fcd45f140bb95fb0f1ed10468db2bb6b1a77b",
"url": "https://llvm.googlesource.com/llvm-project/+/c07fcd45f140bb95fb0f1ed10468db2bb6b1a77b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b840d2968391dd610b792a65133a1edc1bcc397c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b840d2968391dd610b792a65133a1edc1bcc397c",
"title": "b840d2968391dd610b792a65133a1edc1bcc397c",
"url": "https://llvm.googlesource.com/llvm-project/+/b840d2968391dd610b792a65133a1edc1bcc397c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "73e546625d6567e5a33454741d257b6929c89635"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@73e546625d6567e5a33454741d257b6929c89635",
"title": "73e546625d6567e5a33454741d257b6929c89635",
"url": "https://llvm.googlesource.com/llvm-project/+/73e546625d6567e5a33454741d257b6929c89635"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9efdccb26f35e9b32aa0f303eb0cfcec1e7c2c71"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9efdccb26f35e9b32aa0f303eb0cfcec1e7c2c71",
"title": "9efdccb26f35e9b32aa0f303eb0cfcec1e7c2c71",
"url": "https://llvm.googlesource.com/llvm-project/+/9efdccb26f35e9b32aa0f303eb0cfcec1e7c2c71"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9e649518e6038a5b9ea38cfa424468657d3be59e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9e649518e6038a5b9ea38cfa424468657d3be59e",
"title": "9e649518e6038a5b9ea38cfa424468657d3be59e",
"url": "https://llvm.googlesource.com/llvm-project/+/9e649518e6038a5b9ea38cfa424468657d3be59e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "438fe1db09b0c20708ea1020519d8073c37feae8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@438fe1db09b0c20708ea1020519d8073c37feae8",
"title": "438fe1db09b0c20708ea1020519d8073c37feae8",
"url": "https://llvm.googlesource.com/llvm-project/+/438fe1db09b0c20708ea1020519d8073c37feae8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "acf6811d0f2b6b453be46ddf7e046e1346991c98"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@acf6811d0f2b6b453be46ddf7e046e1346991c98",
"title": "acf6811d0f2b6b453be46ddf7e046e1346991c98",
"url": "https://llvm.googlesource.com/llvm-project/+/acf6811d0f2b6b453be46ddf7e046e1346991c98"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a52e9eca3001b23c7952300e5a32b5c58ef2e0e2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a52e9eca3001b23c7952300e5a32b5c58ef2e0e2",
"title": "a52e9eca3001b23c7952300e5a32b5c58ef2e0e2",
"url": "https://llvm.googlesource.com/llvm-project/+/a52e9eca3001b23c7952300e5a32b5c58ef2e0e2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "42ec9934e1079742e0b5d839e420bc3f746fc73b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@42ec9934e1079742e0b5d839e420bc3f746fc73b",
"title": "42ec9934e1079742e0b5d839e420bc3f746fc73b",
"url": "https://llvm.googlesource.com/llvm-project/+/42ec9934e1079742e0b5d839e420bc3f746fc73b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5b8e1a6ebf11b6e93bcc96a0d009febe4bb3d7bc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5b8e1a6ebf11b6e93bcc96a0d009febe4bb3d7bc",
"title": "5b8e1a6ebf11b6e93bcc96a0d009febe4bb3d7bc",
"url": "https://llvm.googlesource.com/llvm-project/+/5b8e1a6ebf11b6e93bcc96a0d009febe4bb3d7bc"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5b8e1a6ebf11b6e93bcc96a0d009febe4bb3d7bc",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8922642597458259792"
},
{
"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"
}
}
[10:05:44.509] Scheduled build:
{
"id": "8757212535493333169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-02T10:05:43.797643654Z",
"updateTime": "2024-02-02T10:05:43.797643654Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5b8e1a6ebf11b6e93bcc96a0d009febe4bb3d7bc",
"ref": "refs/heads/main"
}
}
}
[10:05:44.509] Task URL: https://cr-buildbucket.appspot.com/build/8757212535493333169
[10:05:44.509] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:2:0) after 1m22s
[10:05:45.188] Received PubSub notification, asking Buildbucket for the build status
[10:05:45.207] Build status: SCHEDULED
[10:05:46.385] Received PubSub notification, asking Buildbucket for the build status
[10:05:46.490] Build status: STARTED
[10:07:06.541] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:2:0)
[10:07:06.620] Build status: STARTED
[10:07:06.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:5:0) after 5m9s
[10:12:15.746] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:5:0)
[10:12:15.776] Build status: STARTED
[10:12:15.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:6:0) after 6m21s
[10:18:36.895] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:6:0)
[10:18:36.961] Build status: STARTED
[10:18:36.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:7:0) after 9m56s
[10:28:33.140] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:7:0)
[10:28:33.161] Build status: STARTED
[10:28:33.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:8:0) after 4m36s
[10:33:09.401] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:8:0)
[10:33:09.422] Build status: STARTED
[10:33:09.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:9:0) after 5m30s
[10:38:39.746] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:9:0)
[10:38:39.831] Build status: STARTED
[10:38:39.831] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:10:0) after 5m35s
[10:44:14.838] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:10:0)
[10:44:14.858] Build status: STARTED
[10:44:14.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:11:0) after 2m57s
[10:47:11.998] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:11:0)
[10:47:12.071] Build status: STARTED
[10:47:12.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:12:0) after 4m29s
[10:51:41.060] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:12:0)
[10:51:41.080] Build status: STARTED
[10:51:41.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:13:0) after 1m49s
[10:53:30.120] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:13:0)
[10:53:30.143] Build status: STARTED
[10:53:30.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:14:0) after 3m24s
[10:56:54.369] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:14:0)
[10:56:54.389] Build status: STARTED
[10:56:54.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:15:0) after 4m55s
[11:01:49.522] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:15:0)
[11:01:49.542] Build status: STARTED
[11:01:49.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:16:0) after 8m25s
[11:10:14.561] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:16:0)
[11:10:14.576] Build status: STARTED
[11:10:14.576] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:17:0) after 5m0s
[11:15:14.595] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:17:0)
[11:15:14.658] Build status: STARTED
[11:15:14.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8922642597458259792:18:0) after 8m59s
[11:15:59.129] Received PubSub notification, asking Buildbucket for the build status
[11:15:59.297] Build:
{
"id": "8757212535493333169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-02-02T10:05:43.797643654Z",
"startTime": "2024-02-02T10:05:45.589414Z",
"endTime": "2024-02-02T11:15:58.270702Z",
"updateTime": "2024-02-02T11:15:58.270702Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5b8e1a6ebf11b6e93bcc96a0d009febe4bb3d7bc",
"ref": "refs/heads/main"
}
}
}
[11:15:59.297] Invocation finished in 1h10m16.758396771s with status SUCCEEDED