[19:48:37.374] New invocation is queued and will start shortly
[19:48:39.889] Starting the invocation (attempt 1)
[19:48:39.928] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b3b408bbb379a1cfdac66a71534d86c23a9cf3f1"
[19:48:39.928] Popped gitiles commit info from properties and tags
[19:48:39.928] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:48:39.928] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:48:39.929] Buildbucket request:
{
"requestId": "8919706820779305152",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8919706820779305152",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1b812f9cd64c14ab7600626c147da88f21e0217c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1b812f9cd64c14ab7600626c147da88f21e0217c",
"title": "1b812f9cd64c14ab7600626c147da88f21e0217c",
"url": "https://llvm.googlesource.com/llvm-project/+/1b812f9cd64c14ab7600626c147da88f21e0217c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3cef82d60796b1f18deebf0d844f38d6e85cd4e7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3cef82d60796b1f18deebf0d844f38d6e85cd4e7",
"title": "3cef82d60796b1f18deebf0d844f38d6e85cd4e7",
"url": "https://llvm.googlesource.com/llvm-project/+/3cef82d60796b1f18deebf0d844f38d6e85cd4e7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "61c06775c96a93bf2b6ac0145b78b4ecb1a858b6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@61c06775c96a93bf2b6ac0145b78b4ecb1a858b6",
"title": "61c06775c96a93bf2b6ac0145b78b4ecb1a858b6",
"url": "https://llvm.googlesource.com/llvm-project/+/61c06775c96a93bf2b6ac0145b78b4ecb1a858b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "17162b61c2e6968482fab928f89bdca8b4ac06d9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@17162b61c2e6968482fab928f89bdca8b4ac06d9",
"title": "17162b61c2e6968482fab928f89bdca8b4ac06d9",
"url": "https://llvm.googlesource.com/llvm-project/+/17162b61c2e6968482fab928f89bdca8b4ac06d9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9a20612d960bbcbf6bd59d2d94400574a3cccde0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9a20612d960bbcbf6bd59d2d94400574a3cccde0",
"title": "9a20612d960bbcbf6bd59d2d94400574a3cccde0",
"url": "https://llvm.googlesource.com/llvm-project/+/9a20612d960bbcbf6bd59d2d94400574a3cccde0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d35f2c439a12b8e97e1bad02b6cc4349c9914345"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d35f2c439a12b8e97e1bad02b6cc4349c9914345",
"title": "d35f2c439a12b8e97e1bad02b6cc4349c9914345",
"url": "https://llvm.googlesource.com/llvm-project/+/d35f2c439a12b8e97e1bad02b6cc4349c9914345"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "069aee0793064b800f130e740e37dd7d264b7802"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@069aee0793064b800f130e740e37dd7d264b7802",
"title": "069aee0793064b800f130e740e37dd7d264b7802",
"url": "https://llvm.googlesource.com/llvm-project/+/069aee0793064b800f130e740e37dd7d264b7802"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cc7544e230f8943e52b779d7f1e4392fd30a0c1a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cc7544e230f8943e52b779d7f1e4392fd30a0c1a",
"title": "cc7544e230f8943e52b779d7f1e4392fd30a0c1a",
"url": "https://llvm.googlesource.com/llvm-project/+/cc7544e230f8943e52b779d7f1e4392fd30a0c1a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a9304edf20756dd63f896a98bad89e9eac54aebd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a9304edf20756dd63f896a98bad89e9eac54aebd",
"title": "a9304edf20756dd63f896a98bad89e9eac54aebd",
"url": "https://llvm.googlesource.com/llvm-project/+/a9304edf20756dd63f896a98bad89e9eac54aebd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "13cd0a905beab77fc31e08282c466246aae7eda6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@13cd0a905beab77fc31e08282c466246aae7eda6",
"title": "13cd0a905beab77fc31e08282c466246aae7eda6",
"url": "https://llvm.googlesource.com/llvm-project/+/13cd0a905beab77fc31e08282c466246aae7eda6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3b408bbb379a1cfdac66a71534d86c23a9cf3f1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3b408bbb379a1cfdac66a71534d86c23a9cf3f1",
"title": "b3b408bbb379a1cfdac66a71534d86c23a9cf3f1",
"url": "https://llvm.googlesource.com/llvm-project/+/b3b408bbb379a1cfdac66a71534d86c23a9cf3f1"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b3b408bbb379a1cfdac66a71534d86c23a9cf3f1",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8919706820779305152"
},
{
"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"
}
}
[19:48:40.618] Scheduled build:
{
"id": "8754276757333529345",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-05T19:48:40.026810921Z",
"updateTime": "2024-03-05T19:48:40.026810921Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b3b408bbb379a1cfdac66a71534d86c23a9cf3f1",
"ref": "refs/heads/main"
}
}
}
[19:48:40.618] Task URL: https://cr-buildbucket.appspot.com/build/8754276757333529345
[19:48:40.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:2:0) after 2m12s
[19:48:41.646] Received PubSub notification, asking Buildbucket for the build status
[19:48:41.666] Build status: SCHEDULED
[19:48:42.807] Received PubSub notification, asking Buildbucket for the build status
[19:48:42.836] Build status: STARTED
[19:50:52.642] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:2:0)
[19:50:52.677] Build status: STARTED
[19:50:52.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:5:0) after 7m52s
[19:58:44.709] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:5:0)
[19:58:44.726] Build status: STARTED
[19:58:44.726] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:6:0) after 3m48s
[20:02:32.797] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:6:0)
[20:02:32.856] Build status: STARTED
[20:02:32.856] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:7:0) after 1m53s
[20:04:25.921] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:7:0)
[20:04:25.944] Build status: STARTED
[20:04:25.944] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:8:0) after 7m41s
[20:12:06.960] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:8:0)
[20:12:06.989] Build status: STARTED
[20:12:06.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:9:0) after 3m11s
[20:15:18.031] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:9:0)
[20:15:18.125] Build status: STARTED
[20:15:18.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:10:0) after 5m51s
[20:21:09.198] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:10:0)
[20:21:09.223] Build status: STARTED
[20:21:09.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:11:0) after 5m2s
[20:26:11.318] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:11:0)
[20:26:11.355] Build status: STARTED
[20:26:11.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:12:0) after 6m12s
[20:32:23.503] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:12:0)
[20:32:23.646] Build status: STARTED
[20:32:23.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:13:0) after 2m15s
[20:34:38.661] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:13:0)
[20:34:38.679] Build status: STARTED
[20:34:38.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:14:0) after 5m51s
[20:40:29.700] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:14:0)
[20:40:29.745] Build status: STARTED
[20:40:29.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:15:0) after 9m42s
[20:50:11.814] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:15:0)
[20:50:11.872] Build status: STARTED
[20:50:11.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:16:0) after 9m19s
[20:59:30.889] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:16:0)
[20:59:30.912] Build status: STARTED
[20:59:30.912] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:17:0) after 7m55s
[21:07:25.977] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:17:0)
[21:07:25.997] Build status: STARTED
[21:07:25.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:18:0) after 8m6s
[21:15:32.044] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:18:0)
[21:15:32.065] Build status: STARTED
[21:15:32.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:19:0) after 4m22s
[21:19:54.087] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:19:0)
[21:19:54.194] Build status: STARTED
[21:19:54.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8919706820779305152:20:0) after 4m44s
[21:22:15.176] Received PubSub notification, asking Buildbucket for the build status
[21:22:15.200] Build:
{
"id": "8754276757333529345",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-05T19:48:40.026810921Z",
"startTime": "2024-03-05T19:48:41.667427Z",
"endTime": "2024-03-05T21:22:14.524539Z",
"updateTime": "2024-03-05T21:22:14.524539Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b3b408bbb379a1cfdac66a71534d86c23a9cf3f1",
"ref": "refs/heads/main"
}
}
}
[21:22:15.200] Invocation finished in 1h33m37.843351437s with status SUCCEEDED