[00:02:36.699] New invocation is queued and will start shortly
[00:02:37.822] Starting the invocation (attempt 1)
[00:02:37.849] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/03b0ae8da8c4df28ad197ef21619288ead085687"
[00:02:37.849] Popped gitiles commit info from properties and tags
[00:02:37.849] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:02:37.849] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:02:37.849] Buildbucket request:
{
"requestId": "8875207730681814784",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875207730681814784",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "071e30220db187c47131a02ce36c3697f61ce393"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@071e30220db187c47131a02ce36c3697f61ce393",
"title": "071e30220db187c47131a02ce36c3697f61ce393",
"url": "https://llvm.googlesource.com/llvm-project/+/071e30220db187c47131a02ce36c3697f61ce393"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7f3afab9181d83f92771293ad3b6c00ac62800fd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7f3afab9181d83f92771293ad3b6c00ac62800fd",
"title": "7f3afab9181d83f92771293ad3b6c00ac62800fd",
"url": "https://llvm.googlesource.com/llvm-project/+/7f3afab9181d83f92771293ad3b6c00ac62800fd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ddf9b91f9fed8654c4649881f7db51f1e474701f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ddf9b91f9fed8654c4649881f7db51f1e474701f",
"title": "ddf9b91f9fed8654c4649881f7db51f1e474701f",
"url": "https://llvm.googlesource.com/llvm-project/+/ddf9b91f9fed8654c4649881f7db51f1e474701f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7c16a31aa593b9cc750e61b260c27ade74edb1dd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7c16a31aa593b9cc750e61b260c27ade74edb1dd",
"title": "7c16a31aa593b9cc750e61b260c27ade74edb1dd",
"url": "https://llvm.googlesource.com/llvm-project/+/7c16a31aa593b9cc750e61b260c27ade74edb1dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "20a68c6179da4bc1899e71809ff45e9dce5dd150"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@20a68c6179da4bc1899e71809ff45e9dce5dd150",
"title": "20a68c6179da4bc1899e71809ff45e9dce5dd150",
"url": "https://llvm.googlesource.com/llvm-project/+/20a68c6179da4bc1899e71809ff45e9dce5dd150"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5b1db59fb87b4146f827d17396f54ef30ae0dc40"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5b1db59fb87b4146f827d17396f54ef30ae0dc40",
"title": "5b1db59fb87b4146f827d17396f54ef30ae0dc40",
"url": "https://llvm.googlesource.com/llvm-project/+/5b1db59fb87b4146f827d17396f54ef30ae0dc40"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "574b66f2412f2466e1bd5e4d195f856a87c5ded0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@574b66f2412f2466e1bd5e4d195f856a87c5ded0",
"title": "574b66f2412f2466e1bd5e4d195f856a87c5ded0",
"url": "https://llvm.googlesource.com/llvm-project/+/574b66f2412f2466e1bd5e4d195f856a87c5ded0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a37f0a00a2edb0696f1055222610dc246f49b892"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a37f0a00a2edb0696f1055222610dc246f49b892",
"title": "a37f0a00a2edb0696f1055222610dc246f49b892",
"url": "https://llvm.googlesource.com/llvm-project/+/a37f0a00a2edb0696f1055222610dc246f49b892"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "cd65f8bf17ecfc9896fd9913905f182ad7ce1446"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@cd65f8bf17ecfc9896fd9913905f182ad7ce1446",
"title": "cd65f8bf17ecfc9896fd9913905f182ad7ce1446",
"url": "https://llvm.googlesource.com/llvm-project/+/cd65f8bf17ecfc9896fd9913905f182ad7ce1446"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "20daa73a0962efd22cee3bbf327ee35b22add39d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@20daa73a0962efd22cee3bbf327ee35b22add39d",
"title": "20daa73a0962efd22cee3bbf327ee35b22add39d",
"url": "https://llvm.googlesource.com/llvm-project/+/20daa73a0962efd22cee3bbf327ee35b22add39d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ac4a38e9bd573a173432b89cbef7cce7a48e7907"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ac4a38e9bd573a173432b89cbef7cce7a48e7907",
"title": "ac4a38e9bd573a173432b89cbef7cce7a48e7907",
"url": "https://llvm.googlesource.com/llvm-project/+/ac4a38e9bd573a173432b89cbef7cce7a48e7907"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d5436b0b951abe5ee724bed6617e76e736376e09"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d5436b0b951abe5ee724bed6617e76e736376e09",
"title": "d5436b0b951abe5ee724bed6617e76e736376e09",
"url": "https://llvm.googlesource.com/llvm-project/+/d5436b0b951abe5ee724bed6617e76e736376e09"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "03b0ae8da8c4df28ad197ef21619288ead085687"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@03b0ae8da8c4df28ad197ef21619288ead085687",
"title": "03b0ae8da8c4df28ad197ef21619288ead085687",
"url": "https://llvm.googlesource.com/llvm-project/+/03b0ae8da8c4df28ad197ef21619288ead085687"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "03b0ae8da8c4df28ad197ef21619288ead085687",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875207730681814784"
},
{
"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:02:38.426] Scheduled build:
{
"id": "8709777668724354289",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-10T00:02:37.936477143Z",
"updateTime": "2025-07-10T00:02:37.936477143Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "03b0ae8da8c4df28ad197ef21619288ead085687",
"ref": "refs/heads/main"
}
}
}
[00:02:38.426] Task URL: https://cr-buildbucket.appspot.com/build/8709777668724354289
[00:02:38.426] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:2:0) after 5m27s
[00:02:38.480] Received PubSub notification, asking Buildbucket for the build status
[00:02:38.521] Build status: SCHEDULED
[00:08:05.444] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:2:0)
[00:08:05.474] Build status: SCHEDULED
[00:08:05.474] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:4:0) after 2m9s
[00:10:14.495] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:4:0)
[00:10:14.523] Build status: SCHEDULED
[00:10:14.523] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:5:0) after 4m49s
[00:15:03.551] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:5:0)
[00:15:03.579] Build status: SCHEDULED
[00:15:03.579] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:6:0) after 1m50s
[00:16:53.655] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:6:0)
[00:16:53.682] Build status: SCHEDULED
[00:16:53.682] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:7:0) after 9m3s
[00:25:56.698] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:7:0)
[00:25:56.732] Build status: SCHEDULED
[00:25:56.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:8:0) after 8m58s
[00:34:54.759] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:8:0)
[00:34:54.785] Build status: SCHEDULED
[00:34:54.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:9:0) after 8m14s
[00:38:23.228] Received PubSub notification, asking Buildbucket for the build status
[00:38:23.259] Build status: STARTED
[00:43:08.856] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:9:0)
[00:43:08.883] Build status: STARTED
[00:43:08.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:11:0) after 6m4s
[00:49:12.930] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:11:0)
[00:49:12.951] Build status: STARTED
[00:49:12.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:12:0) after 5m18s
[00:54:30.994] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:12:0)
[00:54:31.013] Build status: STARTED
[00:54:31.013] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:13:0) after 3m43s
[00:58:14.033] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:13:0)
[00:58:14.066] Build status: STARTED
[00:58:14.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:14:0) after 7m13s
[01:05:27.068] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:14:0)
[01:05:27.098] Build status: STARTED
[01:05:27.098] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:15:0) after 5m47s
[01:11:14.128] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:15:0)
[01:11:14.149] Build status: STARTED
[01:11:14.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:16:0) after 5m47s
[01:17:01.163] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:16:0)
[01:17:01.183] Build status: STARTED
[01:17:01.183] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:17:0) after 9m4s
[01:26:05.211] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:17:0)
[01:26:05.234] Build status: STARTED
[01:26:05.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:18:0) after 9m1s
[01:35:06.311] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:18:0)
[01:35:06.331] Build status: STARTED
[01:35:06.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:19:0) after 7m52s
[01:42:58.314] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:19:0)
[01:42:58.341] Build status: STARTED
[01:42:58.341] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:20:0) after 4m34s
[01:47:32.364] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:20:0)
[01:47:32.383] Build status: STARTED
[01:47:32.383] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:21:0) after 7m54s
[01:55:26.415] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:21:0)
[01:55:26.442] Build status: STARTED
[01:55:26.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:22:0) after 9m55s
[02:05:21.571] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:22:0)
[02:05:21.642] Build status: STARTED
[02:05:21.642] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8875207730681814784:23:0) after 5m5s
[02:07:20.125] Received PubSub notification, asking Buildbucket for the build status
[02:07:20.145] Build:
{
"id": "8709777668724354289",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-10T00:02:37.936477143Z",
"startTime": "2025-07-10T00:38:23.028157173Z",
"endTime": "2025-07-10T02:07:19.680437309Z",
"updateTime": "2025-07-10T02:07:19.680437309Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "03b0ae8da8c4df28ad197ef21619288ead085687",
"ref": "refs/heads/main"
}
}
}
[02:07:20.145] Invocation finished in 2h4m43.458706588s with status SUCCEEDED