[22:16:31.127] New invocation is queued and will start shortly
[22:16:32.457] Starting the invocation (attempt 1)
[22:16:32.483] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0d7c340c2cc89b71d398479c9adcac77f0336c6e"
[22:16:32.483] Popped gitiles commit info from properties and tags
[22:16:32.483] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:16:32.483] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:16:32.483] Buildbucket request:
{
"requestId": "8934374224530099872",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8934374224530099872",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d034c18e7c7d24b4b32817b9051f41d5cd92d7ec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d034c18e7c7d24b4b32817b9051f41d5cd92d7ec",
"title": "d034c18e7c7d24b4b32817b9051f41d5cd92d7ec",
"url": "https://llvm.googlesource.com/llvm-project/+/d034c18e7c7d24b4b32817b9051f41d5cd92d7ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "62f5636838ac80ebe8db9c31cdf9c5566db8f0c9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@62f5636838ac80ebe8db9c31cdf9c5566db8f0c9",
"title": "62f5636838ac80ebe8db9c31cdf9c5566db8f0c9",
"url": "https://llvm.googlesource.com/llvm-project/+/62f5636838ac80ebe8db9c31cdf9c5566db8f0c9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a9ea11b694c17a5f94077036f8bb5d21ea922863"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a9ea11b694c17a5f94077036f8bb5d21ea922863",
"title": "a9ea11b694c17a5f94077036f8bb5d21ea922863",
"url": "https://llvm.googlesource.com/llvm-project/+/a9ea11b694c17a5f94077036f8bb5d21ea922863"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4ca00a568658fef8af4c8691117cc3ca4b62f2f3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4ca00a568658fef8af4c8691117cc3ca4b62f2f3",
"title": "4ca00a568658fef8af4c8691117cc3ca4b62f2f3",
"url": "https://llvm.googlesource.com/llvm-project/+/4ca00a568658fef8af4c8691117cc3ca4b62f2f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "671e2ba45bf35a7c96a1a374c4956cce7e5d4d55"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@671e2ba45bf35a7c96a1a374c4956cce7e5d4d55",
"title": "671e2ba45bf35a7c96a1a374c4956cce7e5d4d55",
"url": "https://llvm.googlesource.com/llvm-project/+/671e2ba45bf35a7c96a1a374c4956cce7e5d4d55"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ea7157ff4f5848454ef3762bd6f60ecb9749ae08"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ea7157ff4f5848454ef3762bd6f60ecb9749ae08",
"title": "ea7157ff4f5848454ef3762bd6f60ecb9749ae08",
"url": "https://llvm.googlesource.com/llvm-project/+/ea7157ff4f5848454ef3762bd6f60ecb9749ae08"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "580d26ae462e80d63d1d3c7f9c0c885613a529d8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@580d26ae462e80d63d1d3c7f9c0c885613a529d8",
"title": "580d26ae462e80d63d1d3c7f9c0c885613a529d8",
"url": "https://llvm.googlesource.com/llvm-project/+/580d26ae462e80d63d1d3c7f9c0c885613a529d8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "23552fe22047f47f22c959579a3799530ef2a405"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@23552fe22047f47f22c959579a3799530ef2a405",
"title": "23552fe22047f47f22c959579a3799530ef2a405",
"url": "https://llvm.googlesource.com/llvm-project/+/23552fe22047f47f22c959579a3799530ef2a405"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f9583815e7e9bd5d57ef27232e6cbbc426e03824"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f9583815e7e9bd5d57ef27232e6cbbc426e03824",
"title": "f9583815e7e9bd5d57ef27232e6cbbc426e03824",
"url": "https://llvm.googlesource.com/llvm-project/+/f9583815e7e9bd5d57ef27232e6cbbc426e03824"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0d7c340c2cc89b71d398479c9adcac77f0336c6e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0d7c340c2cc89b71d398479c9adcac77f0336c6e",
"title": "0d7c340c2cc89b71d398479c9adcac77f0336c6e",
"url": "https://llvm.googlesource.com/llvm-project/+/0d7c340c2cc89b71d398479c9adcac77f0336c6e"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0d7c340c2cc89b71d398479c9adcac77f0336c6e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934374224530099872"
},
{
"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"
}
}
[22:16:33.018] Scheduled build:
{
"id": "8768944162341166785",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-25T22:16:32.582293142Z",
"updateTime": "2023-09-25T22:16:32.582293142Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0d7c340c2cc89b71d398479c9adcac77f0336c6e",
"ref": "refs/heads/main"
}
}
}
[22:16:33.018] Task URL: https://cr-buildbucket.appspot.com/build/8768944162341166785
[22:16:33.018] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:2:0) after 3m32s
[22:16:33.971] Received PubSub notification, asking Buildbucket for the build status
[22:16:33.988] Build status: SCHEDULED
[22:18:35.325] Received PubSub notification, asking Buildbucket for the build status
[22:18:35.347] Build status: STARTED
[22:23:54.796] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:2:0)
[22:23:54.821] Build status: STARTED
[22:23:54.821] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:5:0) after 9m13s
[22:33:07.845] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:5:0)
[22:33:07.867] Build status: STARTED
[22:33:07.867] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:6:0) after 7m38s
[22:40:45.921] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:6:0)
[22:40:45.948] Build status: STARTED
[22:40:45.948] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:7:0) after 8m22s
[22:49:08.095] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:7:0)
[22:49:08.120] Build status: STARTED
[22:49:08.120] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:8:0) after 6m45s
[22:55:53.461] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:8:0)
[22:55:53.477] Build status: STARTED
[22:55:53.477] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:9:0) after 1m16s
[22:57:09.802] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:9:0)
[22:57:09.819] Build status: STARTED
[22:57:09.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:10:0) after 9m58s
[23:07:07.856] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:10:0)
[23:07:07.872] Build status: STARTED
[23:07:07.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:11:0) after 5m31s
[23:12:39.374] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:11:0)
[23:12:39.471] Build status: STARTED
[23:12:39.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:12:0) after 7m6s
[23:19:45.500] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:12:0)
[23:19:45.520] Build status: STARTED
[23:19:45.520] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8934374224530099872:13:0) after 8m49s
[23:25:36.190] Received PubSub notification, asking Buildbucket for the build status
[23:25:36.266] Build:
{
"id": "8768944162341166785",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-09-25T22:16:32.582293142Z",
"startTime": "2023-09-25T22:18:34.458352Z",
"endTime": "2023-09-25T23:25:35.852571908Z",
"updateTime": "2023-09-25T23:25:35.852571908Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0d7c340c2cc89b71d398479c9adcac77f0336c6e",
"ref": "refs/heads/main"
}
}
}
[23:25:36.266] Invocation finished in 1h9m5.154769889s with status SUCCEEDED