[12:35:33.444] New invocation is queued and will start shortly
[12:35:34.617] Starting the invocation (attempt 1)
[12:35:34.648] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a45080f09181517c9c5eb5099a6b6ac67a48424a"
[12:35:34.648] Popped gitiles commit info from properties and tags
[12:35:34.648] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:35:34.648] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:35:34.649] Buildbucket request:
{
"requestId": "8910855564189545168",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8910855564189545168",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "424188abe4956d51c852668d206dfc9919290fbf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@424188abe4956d51c852668d206dfc9919290fbf",
"title": "424188abe4956d51c852668d206dfc9919290fbf",
"url": "https://llvm.googlesource.com/llvm-project/+/424188abe4956d51c852668d206dfc9919290fbf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "00262ab7e3b409ab59d6c6c2c6462215a1f27c5f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@00262ab7e3b409ab59d6c6c2c6462215a1f27c5f",
"title": "00262ab7e3b409ab59d6c6c2c6462215a1f27c5f",
"url": "https://llvm.googlesource.com/llvm-project/+/00262ab7e3b409ab59d6c6c2c6462215a1f27c5f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "264bcbe1c8b3e885d896f0181d1ed54a7a4467bd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@264bcbe1c8b3e885d896f0181d1ed54a7a4467bd",
"title": "264bcbe1c8b3e885d896f0181d1ed54a7a4467bd",
"url": "https://llvm.googlesource.com/llvm-project/+/264bcbe1c8b3e885d896f0181d1ed54a7a4467bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "efbd64cbd90f4cc4eb5b1166eb9840af3ec1bba8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@efbd64cbd90f4cc4eb5b1166eb9840af3ec1bba8",
"title": "efbd64cbd90f4cc4eb5b1166eb9840af3ec1bba8",
"url": "https://llvm.googlesource.com/llvm-project/+/efbd64cbd90f4cc4eb5b1166eb9840af3ec1bba8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9b225d01f8edf08153aa704f534a5a6676384fc2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9b225d01f8edf08153aa704f534a5a6676384fc2",
"title": "9b225d01f8edf08153aa704f534a5a6676384fc2",
"url": "https://llvm.googlesource.com/llvm-project/+/9b225d01f8edf08153aa704f534a5a6676384fc2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa9745e8d39498a7090b108dd2717ca0466189e3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa9745e8d39498a7090b108dd2717ca0466189e3",
"title": "fa9745e8d39498a7090b108dd2717ca0466189e3",
"url": "https://llvm.googlesource.com/llvm-project/+/fa9745e8d39498a7090b108dd2717ca0466189e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3f883111243c4abfc06670190771b9cafc092bd8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3f883111243c4abfc06670190771b9cafc092bd8",
"title": "3f883111243c4abfc06670190771b9cafc092bd8",
"url": "https://llvm.googlesource.com/llvm-project/+/3f883111243c4abfc06670190771b9cafc092bd8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a141a28c0cf415d8ca410a636c3aacf3d683ab38"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a141a28c0cf415d8ca410a636c3aacf3d683ab38",
"title": "a141a28c0cf415d8ca410a636c3aacf3d683ab38",
"url": "https://llvm.googlesource.com/llvm-project/+/a141a28c0cf415d8ca410a636c3aacf3d683ab38"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ca920bb6285e9995f5a202d040af79363e98ab28"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ca920bb6285e9995f5a202d040af79363e98ab28",
"title": "ca920bb6285e9995f5a202d040af79363e98ab28",
"url": "https://llvm.googlesource.com/llvm-project/+/ca920bb6285e9995f5a202d040af79363e98ab28"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "546c816a529835a4cf89deecff957ea336a94fa2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@546c816a529835a4cf89deecff957ea336a94fa2",
"title": "546c816a529835a4cf89deecff957ea336a94fa2",
"url": "https://llvm.googlesource.com/llvm-project/+/546c816a529835a4cf89deecff957ea336a94fa2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d4b8b7217f31827f8536c9340b55ecb21e540621"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d4b8b7217f31827f8536c9340b55ecb21e540621",
"title": "d4b8b7217f31827f8536c9340b55ecb21e540621",
"url": "https://llvm.googlesource.com/llvm-project/+/d4b8b7217f31827f8536c9340b55ecb21e540621"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ffc3a6b286ee619ab8f662cb7174705734eb1ce1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ffc3a6b286ee619ab8f662cb7174705734eb1ce1",
"title": "ffc3a6b286ee619ab8f662cb7174705734eb1ce1",
"url": "https://llvm.googlesource.com/llvm-project/+/ffc3a6b286ee619ab8f662cb7174705734eb1ce1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8c5d9c79b96ed8297b381e00d3a706a432cd6c9d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8c5d9c79b96ed8297b381e00d3a706a432cd6c9d",
"title": "8c5d9c79b96ed8297b381e00d3a706a432cd6c9d",
"url": "https://llvm.googlesource.com/llvm-project/+/8c5d9c79b96ed8297b381e00d3a706a432cd6c9d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a45080f09181517c9c5eb5099a6b6ac67a48424a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a45080f09181517c9c5eb5099a6b6ac67a48424a",
"title": "a45080f09181517c9c5eb5099a6b6ac67a48424a",
"url": "https://llvm.googlesource.com/llvm-project/+/a45080f09181517c9c5eb5099a6b6ac67a48424a"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a45080f09181517c9c5eb5099a6b6ac67a48424a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8910855564189545168"
},
{
"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"
}
}
[12:35:35.252] Scheduled build:
{
"id": "8745425502153733441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-11T12:35:34.759901357Z",
"updateTime": "2024-06-11T12:35:34.759901357Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a45080f09181517c9c5eb5099a6b6ac67a48424a",
"ref": "refs/heads/main"
}
}
}
[12:35:35.253] Task URL: https://cr-buildbucket.appspot.com/build/8745425502153733441
[12:35:35.253] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:2:0) after 5m5s
[12:35:35.454] Received PubSub notification, asking Buildbucket for the build status
[12:35:35.474] Build status: SCHEDULED
[12:35:39.514] Received PubSub notification, asking Buildbucket for the build status
[12:35:39.541] Build status: STARTED
[12:40:40.288] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:2:0)
[12:40:40.316] Build status: STARTED
[12:40:40.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:5:0) after 6m9s
[12:46:49.352] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:5:0)
[12:46:49.375] Build status: STARTED
[12:46:49.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:6:0) after 1m0s
[12:47:49.519] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:6:0)
[12:47:49.548] Build status: STARTED
[12:47:49.548] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:7:0) after 7m18s
[12:55:07.626] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:7:0)
[12:55:07.651] Build status: STARTED
[12:55:07.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:8:0) after 7m41s
[13:02:48.679] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:8:0)
[13:02:48.951] Build status: STARTED
[13:02:48.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:9:0) after 5m58s
[13:08:46.980] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:9:0)
[13:08:47.001] Build status: STARTED
[13:08:47.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:10:0) after 8m36s
[13:17:22.970] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:10:0)
[13:17:22.990] Build status: STARTED
[13:17:22.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:11:0) after 5m51s
[13:23:14.009] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:11:0)
[13:23:14.034] Build status: STARTED
[13:23:14.034] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:12:0) after 6m21s
[13:29:35.025] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:12:0)
[13:29:35.059] Build status: STARTED
[13:29:35.059] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:13:0) after 5m1s
[13:34:36.082] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:13:0)
[13:34:36.109] Build status: STARTED
[13:34:36.109] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:14:0) after 4m7s
[13:38:43.593] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:14:0)
[13:38:43.617] Build status: STARTED
[13:38:43.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8910855564189545168:15:0) after 6m12s
[13:39:35.706] Received PubSub notification, asking Buildbucket for the build status
[13:39:35.724] Build:
{
"id": "8745425502153733441",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-06-11T12:35:34.759901357Z",
"startTime": "2024-06-11T12:35:39.125347360Z",
"endTime": "2024-06-11T13:39:35.260299745Z",
"updateTime": "2024-06-11T13:39:35.260299745Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a45080f09181517c9c5eb5099a6b6ac67a48424a",
"ref": "refs/heads/main"
}
}
}
[13:39:35.724] Invocation finished in 1h4m2.289613216s with status SUCCEEDED