[18:39:26.206] New invocation is queued and will start shortly
[18:39:27.286] Starting the invocation (attempt 1)
[18:39:27.313] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/19b41f40a4b93a6243c816b80b6e664a4418f79f"
[18:39:27.313] Popped gitiles commit info from properties and tags
[18:39:27.313] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:39:27.313] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:39:27.314] Buildbucket request:
{
"requestId": "8913822370775166640",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8913822370775166640",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ecae3ed958481cba7d60868cf3504292f7f4fdf5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ecae3ed958481cba7d60868cf3504292f7f4fdf5",
"title": "ecae3ed958481cba7d60868cf3504292f7f4fdf5",
"url": "https://llvm.googlesource.com/llvm-project/+/ecae3ed958481cba7d60868cf3504292f7f4fdf5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "785b143a402a282822c3d5e30bb4e2b1980c0b1e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@785b143a402a282822c3d5e30bb4e2b1980c0b1e",
"title": "785b143a402a282822c3d5e30bb4e2b1980c0b1e",
"url": "https://llvm.googlesource.com/llvm-project/+/785b143a402a282822c3d5e30bb4e2b1980c0b1e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "22c59e01cd2f87164301415c93b60fc3c204dfb8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@22c59e01cd2f87164301415c93b60fc3c204dfb8",
"title": "22c59e01cd2f87164301415c93b60fc3c204dfb8",
"url": "https://llvm.googlesource.com/llvm-project/+/22c59e01cd2f87164301415c93b60fc3c204dfb8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8585bf7542f1098bd03a667a408d42d2a815d305"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8585bf7542f1098bd03a667a408d42d2a815d305",
"title": "8585bf7542f1098bd03a667a408d42d2a815d305",
"url": "https://llvm.googlesource.com/llvm-project/+/8585bf7542f1098bd03a667a408d42d2a815d305"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b9e3fa84d3fdfe718a4a3085f7adeda3d81f2568"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b9e3fa84d3fdfe718a4a3085f7adeda3d81f2568",
"title": "b9e3fa84d3fdfe718a4a3085f7adeda3d81f2568",
"url": "https://llvm.googlesource.com/llvm-project/+/b9e3fa84d3fdfe718a4a3085f7adeda3d81f2568"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7c1b2898302c9f84fa43952f746d79817e1ead40"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7c1b2898302c9f84fa43952f746d79817e1ead40",
"title": "7c1b2898302c9f84fa43952f746d79817e1ead40",
"url": "https://llvm.googlesource.com/llvm-project/+/7c1b2898302c9f84fa43952f746d79817e1ead40"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3a835e129ed8a67cf393f9ee26989b36a3eff1c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3a835e129ed8a67cf393f9ee26989b36a3eff1c",
"title": "b3a835e129ed8a67cf393f9ee26989b36a3eff1c",
"url": "https://llvm.googlesource.com/llvm-project/+/b3a835e129ed8a67cf393f9ee26989b36a3eff1c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "98c1ba460a697110c64f6d1dd362dcf7088a13ca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@98c1ba460a697110c64f6d1dd362dcf7088a13ca",
"title": "98c1ba460a697110c64f6d1dd362dcf7088a13ca",
"url": "https://llvm.googlesource.com/llvm-project/+/98c1ba460a697110c64f6d1dd362dcf7088a13ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7b25ddc559fad078b605c7b3c0d9f4a35a973a52"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7b25ddc559fad078b605c7b3c0d9f4a35a973a52",
"title": "7b25ddc559fad078b605c7b3c0d9f4a35a973a52",
"url": "https://llvm.googlesource.com/llvm-project/+/7b25ddc559fad078b605c7b3c0d9f4a35a973a52"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bce3132cd26c9546a7429da534aed332f4d05d27"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bce3132cd26c9546a7429da534aed332f4d05d27",
"title": "bce3132cd26c9546a7429da534aed332f4d05d27",
"url": "https://llvm.googlesource.com/llvm-project/+/bce3132cd26c9546a7429da534aed332f4d05d27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d742c2aa25226c2b48f3917ed86a5a224cf25734"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d742c2aa25226c2b48f3917ed86a5a224cf25734",
"title": "d742c2aa25226c2b48f3917ed86a5a224cf25734",
"url": "https://llvm.googlesource.com/llvm-project/+/d742c2aa25226c2b48f3917ed86a5a224cf25734"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5ad418b55c167fbdce31b92467e90eb3a03d85ce"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5ad418b55c167fbdce31b92467e90eb3a03d85ce",
"title": "5ad418b55c167fbdce31b92467e90eb3a03d85ce",
"url": "https://llvm.googlesource.com/llvm-project/+/5ad418b55c167fbdce31b92467e90eb3a03d85ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "90501be35b2c4ad314a45634062e0dfe878d8621"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@90501be35b2c4ad314a45634062e0dfe878d8621",
"title": "90501be35b2c4ad314a45634062e0dfe878d8621",
"url": "https://llvm.googlesource.com/llvm-project/+/90501be35b2c4ad314a45634062e0dfe878d8621"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8fd838a8c499b4ce2822d51d1c661058ccc08c7d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8fd838a8c499b4ce2822d51d1c661058ccc08c7d",
"title": "8fd838a8c499b4ce2822d51d1c661058ccc08c7d",
"url": "https://llvm.googlesource.com/llvm-project/+/8fd838a8c499b4ce2822d51d1c661058ccc08c7d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c3d2af0f4e180e67c4c5dd0f83bed1ea226f4565"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c3d2af0f4e180e67c4c5dd0f83bed1ea226f4565",
"title": "c3d2af0f4e180e67c4c5dd0f83bed1ea226f4565",
"url": "https://llvm.googlesource.com/llvm-project/+/c3d2af0f4e180e67c4c5dd0f83bed1ea226f4565"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b942c24845a39e6161c8623b1efc4e2083d879e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b942c24845a39e6161c8623b1efc4e2083d879e9",
"title": "b942c24845a39e6161c8623b1efc4e2083d879e9",
"url": "https://llvm.googlesource.com/llvm-project/+/b942c24845a39e6161c8623b1efc4e2083d879e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "19b41f40a4b93a6243c816b80b6e664a4418f79f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@19b41f40a4b93a6243c816b80b6e664a4418f79f",
"title": "19b41f40a4b93a6243c816b80b6e664a4418f79f",
"url": "https://llvm.googlesource.com/llvm-project/+/19b41f40a4b93a6243c816b80b6e664a4418f79f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "19b41f40a4b93a6243c816b80b6e664a4418f79f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8913822370775166640"
},
{
"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"
}
}
[18:39:27.977] Scheduled build:
{
"id": "8748392308884479185",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-09T18:39:27.378265753Z",
"updateTime": "2024-05-09T18:39:27.378265753Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "19b41f40a4b93a6243c816b80b6e664a4418f79f",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:39:27.977] Task URL: https://cr-buildbucket.appspot.com/build/8748392308884479185
[18:39:27.977] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:2:0) after 4m31s
[18:39:31.820] Received PubSub notification, asking Buildbucket for the build status
[18:39:31.860] Build status: SCHEDULED
[18:40:01.662] Received PubSub notification, asking Buildbucket for the build status
[18:40:01.724] Build status: STARTED
[18:43:58.998] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:2:0)
[18:43:59.021] Build status: STARTED
[18:43:59.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:5:0) after 1m54s
[18:45:53.157] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:5:0)
[18:45:53.259] Build status: STARTED
[18:45:53.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:6:0) after 1m37s
[18:47:30.292] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:6:0)
[18:47:30.326] Build status: STARTED
[18:47:30.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:7:0) after 7m44s
[18:55:14.325] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:7:0)
[18:55:14.344] Build status: STARTED
[18:55:14.344] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:8:0) after 4m3s
[18:59:17.386] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:8:0)
[18:59:17.437] Build status: STARTED
[18:59:17.437] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:9:0) after 6m12s
[19:05:29.464] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:9:0)
[19:05:29.512] Build status: STARTED
[19:05:29.512] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:10:0) after 8m17s
[19:13:46.530] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:10:0)
[19:13:46.553] Build status: STARTED
[19:13:46.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:11:0) after 4m40s
[19:18:26.575] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:11:0)
[19:18:26.601] Build status: STARTED
[19:18:26.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:12:0) after 8m31s
[19:26:57.623] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:12:0)
[19:26:57.650] Build status: STARTED
[19:26:57.650] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:13:0) after 3m21s
[19:30:18.891] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:13:0)
[19:30:18.910] Build status: STARTED
[19:30:18.910] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:14:0) after 3m43s
[19:34:01.963] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:14:0)
[19:34:01.983] Build status: STARTED
[19:34:01.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:15:0) after 9m41s
[19:43:43.332] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:15:0)
[19:43:43.353] Build status: STARTED
[19:43:43.353] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:16:0) after 3m25s
[19:47:08.701] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:16:0)
[19:47:08.721] Build status: STARTED
[19:47:08.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:17:0) after 2m16s
[19:49:24.911] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:17:0)
[19:49:24.944] Build status: STARTED
[19:49:24.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:18:0) after 1m43s
[19:51:08.371] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:18:0)
[19:51:08.398] Build status: STARTED
[19:51:08.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:19:0) after 2m56s
[19:54:04.598] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:19:0)
[19:54:04.621] Build status: STARTED
[19:54:04.621] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8913822370775166640:20:0) after 9m15s
[19:54:50.957] Received PubSub notification, asking Buildbucket for the build status
[19:54:50.978] Build:
{
"id": "8748392308884479185",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-05-09T18:39:27.378265753Z",
"startTime": "2024-05-09T18:40:00.089531862Z",
"endTime": "2024-05-09T19:54:50.551648330Z",
"updateTime": "2024-05-09T19:54:50.551648330Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "19b41f40a4b93a6243c816b80b6e664a4418f79f",
"ref": "refs/heads/main"
}
},
"canary": true
}
[19:54:50.978] Invocation finished in 1h15m24.786398662s with status SUCCEEDED