[00:16:31.520] New invocation is queued and will start shortly
[00:16:32.776] Starting the invocation (attempt 1)
[00:16:32.820] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/68f6e7467651f38e0b97343bfbc49e0ce69eaedf"
[00:16:32.820] Popped gitiles commit info from properties and tags
[00:16:32.820] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:16:32.820] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:16:32.820] Buildbucket request:
{
"requestId": "8904922660287190848",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8904922660287190848",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7156bcf2867f4ca98c8c9166e1ecb77daab08aa5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7156bcf2867f4ca98c8c9166e1ecb77daab08aa5",
"title": "7156bcf2867f4ca98c8c9166e1ecb77daab08aa5",
"url": "https://llvm.googlesource.com/llvm-project/+/7156bcf2867f4ca98c8c9166e1ecb77daab08aa5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3333ec1183803fa5a2353e710b8b22db6a72e292"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3333ec1183803fa5a2353e710b8b22db6a72e292",
"title": "3333ec1183803fa5a2353e710b8b22db6a72e292",
"url": "https://llvm.googlesource.com/llvm-project/+/3333ec1183803fa5a2353e710b8b22db6a72e292"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "157c3fb8c794eaade5fb2a9b08a27c912603b085"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@157c3fb8c794eaade5fb2a9b08a27c912603b085",
"title": "157c3fb8c794eaade5fb2a9b08a27c912603b085",
"url": "https://llvm.googlesource.com/llvm-project/+/157c3fb8c794eaade5fb2a9b08a27c912603b085"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3c0a4f2645288e600e31c6753e9d237b3edb4542"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3c0a4f2645288e600e31c6753e9d237b3edb4542",
"title": "3c0a4f2645288e600e31c6753e9d237b3edb4542",
"url": "https://llvm.googlesource.com/llvm-project/+/3c0a4f2645288e600e31c6753e9d237b3edb4542"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1f0834ad7192d8a73bbf15bb4ad8aa71f9a92ec6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1f0834ad7192d8a73bbf15bb4ad8aa71f9a92ec6",
"title": "1f0834ad7192d8a73bbf15bb4ad8aa71f9a92ec6",
"url": "https://llvm.googlesource.com/llvm-project/+/1f0834ad7192d8a73bbf15bb4ad8aa71f9a92ec6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6dcfc84e903ca6b0fb652962bdbd054a05befc2b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6dcfc84e903ca6b0fb652962bdbd054a05befc2b",
"title": "6dcfc84e903ca6b0fb652962bdbd054a05befc2b",
"url": "https://llvm.googlesource.com/llvm-project/+/6dcfc84e903ca6b0fb652962bdbd054a05befc2b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d156a5a1cb3b3405a6c1e941d112f262c29e15cf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d156a5a1cb3b3405a6c1e941d112f262c29e15cf",
"title": "d156a5a1cb3b3405a6c1e941d112f262c29e15cf",
"url": "https://llvm.googlesource.com/llvm-project/+/d156a5a1cb3b3405a6c1e941d112f262c29e15cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "572943e79080962cd70d30fe58a17a8bd0579fd7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@572943e79080962cd70d30fe58a17a8bd0579fd7",
"title": "572943e79080962cd70d30fe58a17a8bd0579fd7",
"url": "https://llvm.googlesource.com/llvm-project/+/572943e79080962cd70d30fe58a17a8bd0579fd7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "039a86d057b144c963f7a30f9b4b8d3da200576d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@039a86d057b144c963f7a30f9b4b8d3da200576d",
"title": "039a86d057b144c963f7a30f9b4b8d3da200576d",
"url": "https://llvm.googlesource.com/llvm-project/+/039a86d057b144c963f7a30f9b4b8d3da200576d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3e1d4ec671c59204e3e556cc58fd948894af1e1b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3e1d4ec671c59204e3e556cc58fd948894af1e1b",
"title": "3e1d4ec671c59204e3e556cc58fd948894af1e1b",
"url": "https://llvm.googlesource.com/llvm-project/+/3e1d4ec671c59204e3e556cc58fd948894af1e1b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ec29660c44e5e73d3b78f4884f9178036563fb25"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ec29660c44e5e73d3b78f4884f9178036563fb25",
"title": "ec29660c44e5e73d3b78f4884f9178036563fb25",
"url": "https://llvm.googlesource.com/llvm-project/+/ec29660c44e5e73d3b78f4884f9178036563fb25"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9d63a09b452b641e3cc5d88066464b8250bd2bf7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9d63a09b452b641e3cc5d88066464b8250bd2bf7",
"title": "9d63a09b452b641e3cc5d88066464b8250bd2bf7",
"url": "https://llvm.googlesource.com/llvm-project/+/9d63a09b452b641e3cc5d88066464b8250bd2bf7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "84efc8ed463cd0ae90ecd02418442cb62b9a3ad2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@84efc8ed463cd0ae90ecd02418442cb62b9a3ad2",
"title": "84efc8ed463cd0ae90ecd02418442cb62b9a3ad2",
"url": "https://llvm.googlesource.com/llvm-project/+/84efc8ed463cd0ae90ecd02418442cb62b9a3ad2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "68f6e7467651f38e0b97343bfbc49e0ce69eaedf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@68f6e7467651f38e0b97343bfbc49e0ce69eaedf",
"title": "68f6e7467651f38e0b97343bfbc49e0ce69eaedf",
"url": "https://llvm.googlesource.com/llvm-project/+/68f6e7467651f38e0b97343bfbc49e0ce69eaedf"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "68f6e7467651f38e0b97343bfbc49e0ce69eaedf",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8904922660287190848"
},
{
"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"
}
}
[00:16:33.225] Scheduled build:
{
"id": "8739492598205571169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-16T00:16:32.876667507Z",
"updateTime": "2024-08-16T00:16:32.876667507Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "68f6e7467651f38e0b97343bfbc49e0ce69eaedf",
"ref": "refs/heads/main"
}
}
}
[00:16:33.225] Task URL: https://cr-buildbucket.appspot.com/build/8739492598205571169
[00:16:33.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:2:0) after 9m23s
[00:16:33.794] Received PubSub notification, asking Buildbucket for the build status
[00:16:33.822] Build status: SCHEDULED
[00:16:37.597] Received PubSub notification, asking Buildbucket for the build status
[00:16:37.626] Build status: STARTED
[00:25:56.286] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:2:0)
[00:25:56.315] Build status: STARTED
[00:25:56.316] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:5:0) after 4m55s
[00:30:51.369] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:5:0)
[00:30:51.388] Build status: STARTED
[00:30:51.388] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:6:0) after 9m18s
[00:40:09.466] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:6:0)
[00:40:09.505] Build status: STARTED
[00:40:09.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:7:0) after 3m49s
[00:43:58.706] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:7:0)
[00:43:58.724] Build status: STARTED
[00:43:58.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:8:0) after 2m18s
[00:46:16.972] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:8:0)
[00:46:16.994] Build status: STARTED
[00:46:16.994] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:9:0) after 2m42s
[00:48:58.963] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:9:0)
[00:48:58.997] Build status: STARTED
[00:48:58.997] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:10:0) after 5m47s
[00:54:46.016] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:10:0)
[00:54:46.043] Build status: STARTED
[00:54:46.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:11:0) after 7m21s
[01:02:07.113] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:11:0)
[01:02:07.134] Build status: STARTED
[01:02:07.134] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:12:0) after 1m53s
[01:04:00.167] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:12:0)
[01:04:00.194] Build status: STARTED
[01:04:00.194] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:13:0) after 8m34s
[01:12:34.211] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:13:0)
[01:12:34.237] Build status: STARTED
[01:12:34.237] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:14:0) after 9m43s
[01:22:17.257] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:14:0)
[01:22:17.276] Build status: STARTED
[01:22:17.276] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:15:0) after 5m10s
[01:27:27.291] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:15:0)
[01:27:27.329] Build status: STARTED
[01:27:27.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:16:0) after 4m1s
[01:31:28.345] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:16:0)
[01:31:28.370] Build status: STARTED
[01:31:28.370] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:17:0) after 1m35s
[01:33:03.411] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:17:0)
[01:33:03.442] Build status: STARTED
[01:33:03.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:18:0) after 4m47s
[01:37:50.539] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:18:0)
[01:37:50.556] Build status: STARTED
[01:37:50.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8904922660287190848:19:0) after 9m3s
[01:43:31.715] Received PubSub notification, asking Buildbucket for the build status
[01:43:31.773] Build:
{
"id": "8739492598205571169",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-08-16T00:16:32.876667507Z",
"startTime": "2024-08-16T00:16:37.368269351Z",
"endTime": "2024-08-16T01:43:31.147820081Z",
"updateTime": "2024-08-16T01:43:31.147820081Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "68f6e7467651f38e0b97343bfbc49e0ce69eaedf",
"ref": "refs/heads/main"
}
}
}
[01:43:31.773] Invocation finished in 1h27m0.26515068s with status SUCCEEDED