[10:22:46.266] New invocation is queued and will start shortly
[10:22:47.441] Starting the invocation (attempt 1)
[10:22:47.467] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2121e35ac2375b20a7c675c4e2108c1c94c1322f"
[10:22:47.467] Popped gitiles commit info from properties and tags
[10:22:47.467] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:22:47.467] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:22:47.468] Buildbucket request:
{
"requestId": "8937952411330759712",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8937952411330759712",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "240bbb3c13259cc60edb70c7ce08c8c12dc9dfa2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@240bbb3c13259cc60edb70c7ce08c8c12dc9dfa2",
"title": "240bbb3c13259cc60edb70c7ce08c8c12dc9dfa2",
"url": "https://llvm.googlesource.com/llvm-project/+/240bbb3c13259cc60edb70c7ce08c8c12dc9dfa2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a88732d98b0ccdb57c82635a3b97badd9755f99b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a88732d98b0ccdb57c82635a3b97badd9755f99b",
"title": "a88732d98b0ccdb57c82635a3b97badd9755f99b",
"url": "https://llvm.googlesource.com/llvm-project/+/a88732d98b0ccdb57c82635a3b97badd9755f99b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9ee4a740e3265bdce1f2246d9885be8b4ec988c0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9ee4a740e3265bdce1f2246d9885be8b4ec988c0",
"title": "9ee4a740e3265bdce1f2246d9885be8b4ec988c0",
"url": "https://llvm.googlesource.com/llvm-project/+/9ee4a740e3265bdce1f2246d9885be8b4ec988c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8fc6b1a18f4d9cc4d481c38bbc503a27acc7e461"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8fc6b1a18f4d9cc4d481c38bbc503a27acc7e461",
"title": "8fc6b1a18f4d9cc4d481c38bbc503a27acc7e461",
"url": "https://llvm.googlesource.com/llvm-project/+/8fc6b1a18f4d9cc4d481c38bbc503a27acc7e461"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d06608060c8f9d315f98314372110b7b3473f1b3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d06608060c8f9d315f98314372110b7b3473f1b3",
"title": "d06608060c8f9d315f98314372110b7b3473f1b3",
"url": "https://llvm.googlesource.com/llvm-project/+/d06608060c8f9d315f98314372110b7b3473f1b3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d43a3d6346961e639e29b8083b262416889e78ec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d43a3d6346961e639e29b8083b262416889e78ec",
"title": "d43a3d6346961e639e29b8083b262416889e78ec",
"url": "https://llvm.googlesource.com/llvm-project/+/d43a3d6346961e639e29b8083b262416889e78ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f8d1209f966ccd1dd0a19f3acef0871bf8fc3c94"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f8d1209f966ccd1dd0a19f3acef0871bf8fc3c94",
"title": "f8d1209f966ccd1dd0a19f3acef0871bf8fc3c94",
"url": "https://llvm.googlesource.com/llvm-project/+/f8d1209f966ccd1dd0a19f3acef0871bf8fc3c94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6f1d9fb987273067ded01cb7607d50e517746658"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6f1d9fb987273067ded01cb7607d50e517746658",
"title": "6f1d9fb987273067ded01cb7607d50e517746658",
"url": "https://llvm.googlesource.com/llvm-project/+/6f1d9fb987273067ded01cb7607d50e517746658"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "89361e2b98a9ce355bdde0ae02425ecbe5f9c06d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@89361e2b98a9ce355bdde0ae02425ecbe5f9c06d",
"title": "89361e2b98a9ce355bdde0ae02425ecbe5f9c06d",
"url": "https://llvm.googlesource.com/llvm-project/+/89361e2b98a9ce355bdde0ae02425ecbe5f9c06d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ca0d3c99e109e5ed81b244712f0fa2d24b8812b1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ca0d3c99e109e5ed81b244712f0fa2d24b8812b1",
"title": "ca0d3c99e109e5ed81b244712f0fa2d24b8812b1",
"url": "https://llvm.googlesource.com/llvm-project/+/ca0d3c99e109e5ed81b244712f0fa2d24b8812b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9851edfc6cca9193aeb36551563631dee51e98d2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9851edfc6cca9193aeb36551563631dee51e98d2",
"title": "9851edfc6cca9193aeb36551563631dee51e98d2",
"url": "https://llvm.googlesource.com/llvm-project/+/9851edfc6cca9193aeb36551563631dee51e98d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2121e35ac2375b20a7c675c4e2108c1c94c1322f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2121e35ac2375b20a7c675c4e2108c1c94c1322f",
"title": "2121e35ac2375b20a7c675c4e2108c1c94c1322f",
"url": "https://llvm.googlesource.com/llvm-project/+/2121e35ac2375b20a7c675c4e2108c1c94c1322f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2121e35ac2375b20a7c675c4e2108c1c94c1322f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8937952411330759712"
},
{
"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"
}
}
[10:22:47.898] Scheduled build:
{
"id": "8772522349365466289",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-17T10:22:47.518781796Z",
"updateTime": "2023-08-17T10:22:47.518781796Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2121e35ac2375b20a7c675c4e2108c1c94c1322f",
"ref": "refs/heads/main"
}
}
}
[10:22:47.898] Task URL: https://cr-buildbucket.appspot.com/build/8772522349365466289
[10:22:47.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:2:0) after 1m30s
[10:22:48.873] Received PubSub notification, asking Buildbucket for the build status
[10:22:48.894] Build status: SCHEDULED
[10:24:17.962] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:2:0)
[10:24:17.985] Build status: SCHEDULED
[10:24:17.985] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:4:0) after 6m43s
[10:24:35.242] Received PubSub notification, asking Buildbucket for the build status
[10:24:35.260] Build status: STARTED
[10:31:01.105] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:4:0)
[10:31:01.125] Build status: STARTED
[10:31:01.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:6:0) after 1m50s
[10:32:51.171] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:6:0)
[10:32:51.197] Build status: STARTED
[10:32:51.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:7:0) after 6m11s
[10:39:02.232] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:7:0)
[10:39:02.260] Build status: STARTED
[10:39:02.260] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:8:0) after 3m27s
[10:42:29.431] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:8:0)
[10:42:29.454] Build status: STARTED
[10:42:29.454] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:9:0) after 3m14s
[10:45:43.609] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:9:0)
[10:45:43.645] Build status: STARTED
[10:45:43.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:10:0) after 9m44s
[10:55:27.748] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:10:0)
[10:55:27.906] Build status: STARTED
[10:55:27.906] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:11:0) after 2m20s
[10:57:47.892] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:11:0)
[10:57:47.919] Build status: STARTED
[10:57:47.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:12:0) after 8m19s
[11:06:06.946] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:12:0)
[11:06:06.981] Build status: STARTED
[11:06:06.981] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:13:0) after 3m32s
[11:09:39.003] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:13:0)
[11:09:39.021] Build status: STARTED
[11:09:39.021] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:14:0) after 5m14s
[11:14:53.074] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:14:0)
[11:14:53.096] Build status: STARTED
[11:14:53.096] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:15:0) after 7m23s
[11:22:16.124] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:15:0)
[11:22:16.151] Build status: STARTED
[11:22:16.151] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:16:0) after 6m17s
[11:28:33.385] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:16:0)
[11:28:33.401] Build status: STARTED
[11:28:33.401] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8937952411330759712:17:0) after 7m49s
[11:28:59.635] Received PubSub notification, asking Buildbucket for the build status
[11:28:59.663] Build:
{
"id": "8772522349365466289",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2023-08-17T10:22:47.518781796Z",
"startTime": "2023-08-17T10:24:34.589777Z",
"endTime": "2023-08-17T11:28:59.282233108Z",
"updateTime": "2023-08-17T11:28:59.282233108Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2121e35ac2375b20a7c675c4e2108c1c94c1322f",
"ref": "refs/heads/main"
}
}
}
[11:28:59.663] Invocation finished in 1h6m13.403383963s with status SUCCEEDED