[21:38:24.243] New invocation is queued and will start shortly
[21:38:25.307] Starting the invocation (attempt 1)
[21:38:25.329] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2fc0e2c888521489f4a286b0902a6896506f8d8e"
[21:38:25.329] Popped gitiles commit info from properties and tags
[21:38:25.329] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:38:25.329] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:38:25.330] Buildbucket request:
{
"requestId": "8870233970283746096",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8870233970283746096",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a24e11fd951d3396ccbb469b2c5dc707dc4196a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a24e11fd951d3396ccbb469b2c5dc707dc4196a6",
"title": "a24e11fd951d3396ccbb469b2c5dc707dc4196a6",
"url": "https://llvm.googlesource.com/llvm-project/+/a24e11fd951d3396ccbb469b2c5dc707dc4196a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cea2c8625e801bdabca5e73d050300dc4060df00"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cea2c8625e801bdabca5e73d050300dc4060df00",
"title": "cea2c8625e801bdabca5e73d050300dc4060df00",
"url": "https://llvm.googlesource.com/llvm-project/+/cea2c8625e801bdabca5e73d050300dc4060df00"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "005f0fa40ed3fe4657322f95916577c2f855719b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@005f0fa40ed3fe4657322f95916577c2f855719b",
"title": "005f0fa40ed3fe4657322f95916577c2f855719b",
"url": "https://llvm.googlesource.com/llvm-project/+/005f0fa40ed3fe4657322f95916577c2f855719b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "70a291f3225628d3479452829dc8b72d5d04e034"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@70a291f3225628d3479452829dc8b72d5d04e034",
"title": "70a291f3225628d3479452829dc8b72d5d04e034",
"url": "https://llvm.googlesource.com/llvm-project/+/70a291f3225628d3479452829dc8b72d5d04e034"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4efde3c8fddc30b853430fc154cac85cfecc5224"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4efde3c8fddc30b853430fc154cac85cfecc5224",
"title": "4efde3c8fddc30b853430fc154cac85cfecc5224",
"url": "https://llvm.googlesource.com/llvm-project/+/4efde3c8fddc30b853430fc154cac85cfecc5224"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b0f85beeefbfdf3eb3f66fed6c5aed13ac423bb4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b0f85beeefbfdf3eb3f66fed6c5aed13ac423bb4",
"title": "b0f85beeefbfdf3eb3f66fed6c5aed13ac423bb4",
"url": "https://llvm.googlesource.com/llvm-project/+/b0f85beeefbfdf3eb3f66fed6c5aed13ac423bb4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9f8988aaf4cc28ff534edd8c6bd7ec0300afd328"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9f8988aaf4cc28ff534edd8c6bd7ec0300afd328",
"title": "9f8988aaf4cc28ff534edd8c6bd7ec0300afd328",
"url": "https://llvm.googlesource.com/llvm-project/+/9f8988aaf4cc28ff534edd8c6bd7ec0300afd328"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2429a8f71ff2080116b8a0e46541d1fb80351219"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2429a8f71ff2080116b8a0e46541d1fb80351219",
"title": "2429a8f71ff2080116b8a0e46541d1fb80351219",
"url": "https://llvm.googlesource.com/llvm-project/+/2429a8f71ff2080116b8a0e46541d1fb80351219"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f0df1e3dd4ec064821f673ced7d83e5a2cf6afa1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f0df1e3dd4ec064821f673ced7d83e5a2cf6afa1",
"title": "f0df1e3dd4ec064821f673ced7d83e5a2cf6afa1",
"url": "https://llvm.googlesource.com/llvm-project/+/f0df1e3dd4ec064821f673ced7d83e5a2cf6afa1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3c7bf3b3c3a4871d13f7b7d5d60bbf190eaf8f3a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3c7bf3b3c3a4871d13f7b7d5d60bbf190eaf8f3a",
"title": "3c7bf3b3c3a4871d13f7b7d5d60bbf190eaf8f3a",
"url": "https://llvm.googlesource.com/llvm-project/+/3c7bf3b3c3a4871d13f7b7d5d60bbf190eaf8f3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "665e875f1a86be650e044bb20744bb272d03e11d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@665e875f1a86be650e044bb20744bb272d03e11d",
"title": "665e875f1a86be650e044bb20744bb272d03e11d",
"url": "https://llvm.googlesource.com/llvm-project/+/665e875f1a86be650e044bb20744bb272d03e11d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3e0b91b77c0e4a056b4d8be61a8b82a077d36644"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3e0b91b77c0e4a056b4d8be61a8b82a077d36644",
"title": "3e0b91b77c0e4a056b4d8be61a8b82a077d36644",
"url": "https://llvm.googlesource.com/llvm-project/+/3e0b91b77c0e4a056b4d8be61a8b82a077d36644"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fbb0f2dba040bbdd5de5e59201c1a6fb9be3e06d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fbb0f2dba040bbdd5de5e59201c1a6fb9be3e06d",
"title": "fbb0f2dba040bbdd5de5e59201c1a6fb9be3e06d",
"url": "https://llvm.googlesource.com/llvm-project/+/fbb0f2dba040bbdd5de5e59201c1a6fb9be3e06d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3ce0ea38c2328c373227f5f1237b8ed88f7ecf06"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3ce0ea38c2328c373227f5f1237b8ed88f7ecf06",
"title": "3ce0ea38c2328c373227f5f1237b8ed88f7ecf06",
"url": "https://llvm.googlesource.com/llvm-project/+/3ce0ea38c2328c373227f5f1237b8ed88f7ecf06"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "49fcfaa15aeeed147280e6e39d802ac712ed3d74"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@49fcfaa15aeeed147280e6e39d802ac712ed3d74",
"title": "49fcfaa15aeeed147280e6e39d802ac712ed3d74",
"url": "https://llvm.googlesource.com/llvm-project/+/49fcfaa15aeeed147280e6e39d802ac712ed3d74"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "81131f37455e9960ed22fa48d95e69f8a0149347"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@81131f37455e9960ed22fa48d95e69f8a0149347",
"title": "81131f37455e9960ed22fa48d95e69f8a0149347",
"url": "https://llvm.googlesource.com/llvm-project/+/81131f37455e9960ed22fa48d95e69f8a0149347"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cc9acb9df7f7e598a6c93eaa1f2b1405a6b73bad"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cc9acb9df7f7e598a6c93eaa1f2b1405a6b73bad",
"title": "cc9acb9df7f7e598a6c93eaa1f2b1405a6b73bad",
"url": "https://llvm.googlesource.com/llvm-project/+/cc9acb9df7f7e598a6c93eaa1f2b1405a6b73bad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "023a98c2ae8a260632f5fa71aaede95c4a981399"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@023a98c2ae8a260632f5fa71aaede95c4a981399",
"title": "023a98c2ae8a260632f5fa71aaede95c4a981399",
"url": "https://llvm.googlesource.com/llvm-project/+/023a98c2ae8a260632f5fa71aaede95c4a981399"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2fc0e2c888521489f4a286b0902a6896506f8d8e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2fc0e2c888521489f4a286b0902a6896506f8d8e",
"title": "2fc0e2c888521489f4a286b0902a6896506f8d8e",
"url": "https://llvm.googlesource.com/llvm-project/+/2fc0e2c888521489f4a286b0902a6896506f8d8e"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2fc0e2c888521489f4a286b0902a6896506f8d8e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8870233970283746096"
},
{
"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"
}
}
[21:38:25.794] Scheduled build:
{
"id": "8704803908428645809",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-02T21:38:25.386710595Z",
"updateTime": "2025-09-02T21:38:25.386710595Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2fc0e2c888521489f4a286b0902a6896506f8d8e",
"ref": "refs/heads/main"
}
}
}
[21:38:25.794] Task URL: https://cr-buildbucket.appspot.com/build/8704803908428645809
[21:38:25.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:2:0) after 8m51s
[21:38:26.729] Received PubSub notification, asking Buildbucket for the build status
[21:38:26.746] Build status: SCHEDULED
[21:38:30.580] Received PubSub notification, asking Buildbucket for the build status
[21:38:30.601] Build status: STARTED
[21:47:16.908] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:2:0)
[21:47:16.938] Build status: STARTED
[21:47:16.938] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:5:0) after 7m16s
[21:54:32.952] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:5:0)
[21:54:32.988] Build status: STARTED
[21:54:32.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:6:0) after 3m58s
[21:58:31.116] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:6:0)
[21:58:31.132] Build status: STARTED
[21:58:31.132] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:7:0) after 9m56s
[22:08:27.148] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:7:0)
[22:08:27.168] Build status: STARTED
[22:08:27.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:8:0) after 1m36s
[22:10:03.186] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:8:0)
[22:10:03.287] Build status: STARTED
[22:10:03.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:9:0) after 6m26s
[22:16:29.306] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:9:0)
[22:16:29.325] Build status: STARTED
[22:16:29.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:10:0) after 9m12s
[22:25:41.412] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:10:0)
[22:25:41.435] Build status: STARTED
[22:25:41.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:11:0) after 7m55s
[22:33:36.503] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:11:0)
[22:33:36.518] Build status: STARTED
[22:33:36.518] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:12:0) after 1m50s
[22:35:26.534] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:12:0)
[22:35:26.553] Build status: STARTED
[22:35:26.554] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:13:0) after 1m12s
[22:36:38.571] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:13:0)
[22:36:38.589] Build status: STARTED
[22:36:38.589] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:14:0) after 8m33s
[22:45:11.606] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:14:0)
[22:45:11.653] Build status: STARTED
[22:45:11.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:15:0) after 6m33s
[22:51:44.667] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:15:0)
[22:51:44.684] Build status: STARTED
[22:51:44.684] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:16:0) after 8m3s
[22:59:47.788] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:16:0)
[22:59:47.803] Build status: STARTED
[22:59:47.803] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:17:0) after 5m52s
[23:05:39.888] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:17:0)
[23:05:39.908] Build status: STARTED
[23:05:39.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:18:0) after 1m12s
[23:06:51.972] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:18:0)
[23:06:51.990] Build status: STARTED
[23:06:51.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:19:0) after 2m29s
[23:09:21.008] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:19:0)
[23:09:21.080] Build status: STARTED
[23:09:21.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8870233970283746096:20:0) after 9m2s
[23:11:10.486] Received PubSub notification, asking Buildbucket for the build status
[23:11:10.505] Build:
{
"id": "8704803908428645809",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-02T21:38:25.386710595Z",
"startTime": "2025-09-02T21:38:30.409653674Z",
"endTime": "2025-09-02T23:11:10.113088702Z",
"updateTime": "2025-09-02T23:11:10.113088702Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2fc0e2c888521489f4a286b0902a6896506f8d8e",
"ref": "refs/heads/main"
}
}
}
[23:11:10.505] Invocation finished in 1h32m46.270920573s with status SUCCEEDED