[15:36:54.687] New invocation is queued and will start shortly
[15:36:58.538] Starting the invocation (attempt 1)
[15:36:58.565] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/6e3e21d2032216b5d01b47a0442638225e66dc1b"
[15:36:58.565] Popped gitiles commit info from properties and tags
[15:36:58.565] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:36:58.565] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:36:58.566] Buildbucket request:
{
"requestId": "8931772053620340624",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8931772053620340624",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "34c33bbb8bfddf743fd9b077fd42f76bcce1e0f3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@34c33bbb8bfddf743fd9b077fd42f76bcce1e0f3",
"title": "34c33bbb8bfddf743fd9b077fd42f76bcce1e0f3",
"url": "https://llvm.googlesource.com/llvm-project/+/34c33bbb8bfddf743fd9b077fd42f76bcce1e0f3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1a7061c1ad9f4218d0f52b3210e7b025091908db"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1a7061c1ad9f4218d0f52b3210e7b025091908db",
"title": "1a7061c1ad9f4218d0f52b3210e7b025091908db",
"url": "https://llvm.googlesource.com/llvm-project/+/1a7061c1ad9f4218d0f52b3210e7b025091908db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f07718b708e95c1ba0608eab458e9b37eaa8bbe3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f07718b708e95c1ba0608eab458e9b37eaa8bbe3",
"title": "f07718b708e95c1ba0608eab458e9b37eaa8bbe3",
"url": "https://llvm.googlesource.com/llvm-project/+/f07718b708e95c1ba0608eab458e9b37eaa8bbe3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1f02743851d82d6515f49f5b4379b9793d5ff5c9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1f02743851d82d6515f49f5b4379b9793d5ff5c9",
"title": "1f02743851d82d6515f49f5b4379b9793d5ff5c9",
"url": "https://llvm.googlesource.com/llvm-project/+/1f02743851d82d6515f49f5b4379b9793d5ff5c9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b901acad541ad44511ba7ba394ab736376e01113"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b901acad541ad44511ba7ba394ab736376e01113",
"title": "b901acad541ad44511ba7ba394ab736376e01113",
"url": "https://llvm.googlesource.com/llvm-project/+/b901acad541ad44511ba7ba394ab736376e01113"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d8a5c79e8e006cf878e05aa316367c9684193117"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d8a5c79e8e006cf878e05aa316367c9684193117",
"title": "d8a5c79e8e006cf878e05aa316367c9684193117",
"url": "https://llvm.googlesource.com/llvm-project/+/d8a5c79e8e006cf878e05aa316367c9684193117"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8edcfa0d00de904558a700ccd250ddb073c6f1cd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8edcfa0d00de904558a700ccd250ddb073c6f1cd",
"title": "8edcfa0d00de904558a700ccd250ddb073c6f1cd",
"url": "https://llvm.googlesource.com/llvm-project/+/8edcfa0d00de904558a700ccd250ddb073c6f1cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8875f78b5d11688f2cabd916b3e04552659c5e17"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8875f78b5d11688f2cabd916b3e04552659c5e17",
"title": "8875f78b5d11688f2cabd916b3e04552659c5e17",
"url": "https://llvm.googlesource.com/llvm-project/+/8875f78b5d11688f2cabd916b3e04552659c5e17"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7cce908367faddd44443812ff2fba4e12561a083"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7cce908367faddd44443812ff2fba4e12561a083",
"title": "7cce908367faddd44443812ff2fba4e12561a083",
"url": "https://llvm.googlesource.com/llvm-project/+/7cce908367faddd44443812ff2fba4e12561a083"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "14b0ae439ff8c92bce47f0b5dbe6d5a9f02de338"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@14b0ae439ff8c92bce47f0b5dbe6d5a9f02de338",
"title": "14b0ae439ff8c92bce47f0b5dbe6d5a9f02de338",
"url": "https://llvm.googlesource.com/llvm-project/+/14b0ae439ff8c92bce47f0b5dbe6d5a9f02de338"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b5c44564e55e93321e224937b817a40d69de59fd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b5c44564e55e93321e224937b817a40d69de59fd",
"title": "b5c44564e55e93321e224937b817a40d69de59fd",
"url": "https://llvm.googlesource.com/llvm-project/+/b5c44564e55e93321e224937b817a40d69de59fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "95e4ad3f0f6a948176e278f8e147d1667dbf58b7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@95e4ad3f0f6a948176e278f8e147d1667dbf58b7",
"title": "95e4ad3f0f6a948176e278f8e147d1667dbf58b7",
"url": "https://llvm.googlesource.com/llvm-project/+/95e4ad3f0f6a948176e278f8e147d1667dbf58b7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8d307f59eed3ab6de688a555b0c6720fd8f18d10"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8d307f59eed3ab6de688a555b0c6720fd8f18d10",
"title": "8d307f59eed3ab6de688a555b0c6720fd8f18d10",
"url": "https://llvm.googlesource.com/llvm-project/+/8d307f59eed3ab6de688a555b0c6720fd8f18d10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6e3e21d2032216b5d01b47a0442638225e66dc1b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6e3e21d2032216b5d01b47a0442638225e66dc1b",
"title": "6e3e21d2032216b5d01b47a0442638225e66dc1b",
"url": "https://llvm.googlesource.com/llvm-project/+/6e3e21d2032216b5d01b47a0442638225e66dc1b"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6e3e21d2032216b5d01b47a0442638225e66dc1b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931772053620340624"
},
{
"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"
}
}
[15:36:59.092] Scheduled build:
{
"id": "8766341988824383601",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-24T15:36:58.632108436Z",
"updateTime": "2023-10-24T15:36:58.632108436Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6e3e21d2032216b5d01b47a0442638225e66dc1b",
"ref": "refs/heads/main"
}
}
}
[15:36:59.092] Task URL: https://cr-buildbucket.appspot.com/build/8766341988824383601
[15:36:59.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:2:0) after 3m58s
[15:37:00.005] Received PubSub notification, asking Buildbucket for the build status
[15:37:00.938] Build status: SCHEDULED
[15:38:50.607] Received PubSub notification, asking Buildbucket for the build status
[15:38:50.645] Build status: STARTED
[15:40:57.099] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:2:0)
[15:40:57.125] Build status: STARTED
[15:40:57.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:5:0) after 9m3s
[15:50:00.143] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:5:0)
[15:50:00.159] Build status: STARTED
[15:50:00.159] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:6:0) after 8m12s
[15:58:12.182] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:6:0)
[15:58:12.212] Build status: STARTED
[15:58:12.212] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:7:0) after 1m9s
[15:59:21.214] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:7:0)
[15:59:21.265] Build status: STARTED
[15:59:21.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:8:0) after 3m12s
[16:02:33.323] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:8:0)
[16:02:33.369] Build status: STARTED
[16:02:33.369] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:9:0) after 4m27s
[16:07:00.390] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:9:0)
[16:07:00.424] Build status: STARTED
[16:07:00.424] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:10:0) after 7m16s
[16:14:16.496] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:10:0)
[16:14:16.520] Build status: STARTED
[16:14:16.520] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:11:0) after 4m50s
[16:19:06.686] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:11:0)
[16:19:06.704] Build status: STARTED
[16:19:06.704] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:12:0) after 5m45s
[16:24:51.724] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:12:0)
[16:24:51.772] Build status: STARTED
[16:24:51.772] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:13:0) after 2m18s
[16:27:09.793] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:13:0)
[16:27:09.814] Build status: STARTED
[16:27:09.814] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:14:0) after 9m48s
[16:36:57.833] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:14:0)
[16:36:57.853] Build status: STARTED
[16:36:57.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:15:0) after 2m12s
[16:39:09.936] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:15:0)
[16:39:09.959] Build status: STARTED
[16:39:09.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:16:0) after 2m59s
[16:42:08.983] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:16:0)
[16:42:09.088] Build status: STARTED
[16:42:09.089] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8931772053620340624:17:0) after 6m21s
[16:48:26.212] Received PubSub notification, asking Buildbucket for the build status
[16:48:26.239] Build:
{
"id": "8766341988824383601",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-10-24T15:36:58.632108436Z",
"startTime": "2023-10-24T15:38:50.093884Z",
"endTime": "2023-10-24T16:48:16.215894169Z",
"updateTime": "2023-10-24T16:48:16.215894169Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6e3e21d2032216b5d01b47a0442638225e66dc1b",
"ref": "refs/heads/main"
}
}
}
[16:48:26.239] Invocation finished in 1h11m31.563458364s with status SUCCEEDED