[01:46:36.480] New invocation is queued and will start shortly
[01:46:37.718] Starting the invocation (attempt 1)
[01:46:37.745] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/50e38cc85663de27cfed59b8f09edf3437fbf164"
[01:46:37.745] Popped gitiles commit info from properties and tags
[01:46:37.745] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:46:37.745] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:46:37.745] Buildbucket request:
{
"requestId": "8896219683996132096",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896219683996132096",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e72209db3586ee03f433fe30c3bfac6c9c4d9d6f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e72209db3586ee03f433fe30c3bfac6c9c4d9d6f",
"title": "e72209db3586ee03f433fe30c3bfac6c9c4d9d6f",
"url": "https://llvm.googlesource.com/llvm-project/+/e72209db3586ee03f433fe30c3bfac6c9c4d9d6f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "73216cd71229fc7ccd380c334d45f809787f41b1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@73216cd71229fc7ccd380c334d45f809787f41b1",
"title": "73216cd71229fc7ccd380c334d45f809787f41b1",
"url": "https://llvm.googlesource.com/llvm-project/+/73216cd71229fc7ccd380c334d45f809787f41b1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "300370c27b31ced572b957b6efdbb2bcee277392"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@300370c27b31ced572b957b6efdbb2bcee277392",
"title": "300370c27b31ced572b957b6efdbb2bcee277392",
"url": "https://llvm.googlesource.com/llvm-project/+/300370c27b31ced572b957b6efdbb2bcee277392"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d20f55fbd5786f056ff8417bddc7c47df6c7f90b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d20f55fbd5786f056ff8417bddc7c47df6c7f90b",
"title": "d20f55fbd5786f056ff8417bddc7c47df6c7f90b",
"url": "https://llvm.googlesource.com/llvm-project/+/d20f55fbd5786f056ff8417bddc7c47df6c7f90b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a54e8b2cc45f079881ee8013143494e9a1315929"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a54e8b2cc45f079881ee8013143494e9a1315929",
"title": "a54e8b2cc45f079881ee8013143494e9a1315929",
"url": "https://llvm.googlesource.com/llvm-project/+/a54e8b2cc45f079881ee8013143494e9a1315929"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6e4821487fcab23bf9ca7f7c667826956bee4d1b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6e4821487fcab23bf9ca7f7c667826956bee4d1b",
"title": "6e4821487fcab23bf9ca7f7c667826956bee4d1b",
"url": "https://llvm.googlesource.com/llvm-project/+/6e4821487fcab23bf9ca7f7c667826956bee4d1b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e394fecd5b351e9108d0600c872759d8dea88a42"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e394fecd5b351e9108d0600c872759d8dea88a42",
"title": "e394fecd5b351e9108d0600c872759d8dea88a42",
"url": "https://llvm.googlesource.com/llvm-project/+/e394fecd5b351e9108d0600c872759d8dea88a42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "066dd91ad8c5d80bf7a301cd9d77aa8267cd4dcd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@066dd91ad8c5d80bf7a301cd9d77aa8267cd4dcd",
"title": "066dd91ad8c5d80bf7a301cd9d77aa8267cd4dcd",
"url": "https://llvm.googlesource.com/llvm-project/+/066dd91ad8c5d80bf7a301cd9d77aa8267cd4dcd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f981ee7efc3e0be0d91d2163c0e04e01a134b4a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f981ee7efc3e0be0d91d2163c0e04e01a134b4a6",
"title": "f981ee7efc3e0be0d91d2163c0e04e01a134b4a6",
"url": "https://llvm.googlesource.com/llvm-project/+/f981ee7efc3e0be0d91d2163c0e04e01a134b4a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "673b5dd380e8457c887d5b321195d81ea90f134d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@673b5dd380e8457c887d5b321195d81ea90f134d",
"title": "673b5dd380e8457c887d5b321195d81ea90f134d",
"url": "https://llvm.googlesource.com/llvm-project/+/673b5dd380e8457c887d5b321195d81ea90f134d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2187738508478372409132ee636393086b46746f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2187738508478372409132ee636393086b46746f",
"title": "2187738508478372409132ee636393086b46746f",
"url": "https://llvm.googlesource.com/llvm-project/+/2187738508478372409132ee636393086b46746f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "01cd7ad2ba222b0fc400a820a9ef176131a82a06"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@01cd7ad2ba222b0fc400a820a9ef176131a82a06",
"title": "01cd7ad2ba222b0fc400a820a9ef176131a82a06",
"url": "https://llvm.googlesource.com/llvm-project/+/01cd7ad2ba222b0fc400a820a9ef176131a82a06"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "46389ebc4f4185700ed3322db533fdbd5de7f9a3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@46389ebc4f4185700ed3322db533fdbd5de7f9a3",
"title": "46389ebc4f4185700ed3322db533fdbd5de7f9a3",
"url": "https://llvm.googlesource.com/llvm-project/+/46389ebc4f4185700ed3322db533fdbd5de7f9a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "58280c0e97ee8f843db0fc2719c7e599831d6626"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@58280c0e97ee8f843db0fc2719c7e599831d6626",
"title": "58280c0e97ee8f843db0fc2719c7e599831d6626",
"url": "https://llvm.googlesource.com/llvm-project/+/58280c0e97ee8f843db0fc2719c7e599831d6626"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04de524c7e5d4dfe3ec6cdd83dcb6dfed46f3e8b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04de524c7e5d4dfe3ec6cdd83dcb6dfed46f3e8b",
"title": "04de524c7e5d4dfe3ec6cdd83dcb6dfed46f3e8b",
"url": "https://llvm.googlesource.com/llvm-project/+/04de524c7e5d4dfe3ec6cdd83dcb6dfed46f3e8b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1df199812296d6f4d1698ac228f3e85d29e96e29"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1df199812296d6f4d1698ac228f3e85d29e96e29",
"title": "1df199812296d6f4d1698ac228f3e85d29e96e29",
"url": "https://llvm.googlesource.com/llvm-project/+/1df199812296d6f4d1698ac228f3e85d29e96e29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "50e38cc85663de27cfed59b8f09edf3437fbf164"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@50e38cc85663de27cfed59b8f09edf3437fbf164",
"title": "50e38cc85663de27cfed59b8f09edf3437fbf164",
"url": "https://llvm.googlesource.com/llvm-project/+/50e38cc85663de27cfed59b8f09edf3437fbf164"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "50e38cc85663de27cfed59b8f09edf3437fbf164",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896219683996132096"
},
{
"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"
}
}
[01:46:38.150] Scheduled build:
{
"id": "8730789621917640561",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-20T01:46:37.838605192Z",
"updateTime": "2024-11-20T01:46:37.838605192Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "50e38cc85663de27cfed59b8f09edf3437fbf164",
"ref": "refs/heads/main"
}
}
}
[01:46:38.150] Task URL: https://cr-buildbucket.appspot.com/build/8730789621917640561
[01:46:38.150] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:2:0) after 6m29s
[01:46:54.391] Received PubSub notification, asking Buildbucket for the build status
[01:46:54.414] Build status: SCHEDULED
[01:53:07.219] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:2:0)
[01:53:07.317] Build status: SCHEDULED
[01:53:07.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:4:0) after 6m51s
[01:59:58.387] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:4:0)
[01:59:58.407] Build status: SCHEDULED
[01:59:58.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:5:0) after 4m23s
[02:00:17.069] Received PubSub notification, asking Buildbucket for the build status
[02:00:17.098] Build status: STARTED
[02:04:21.424] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:5:0)
[02:04:21.441] Build status: STARTED
[02:04:21.441] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:7:0) after 3m28s
[02:07:49.459] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:7:0)
[02:07:49.481] Build status: STARTED
[02:07:49.481] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:8:0) after 1m0s
[02:08:49.491] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:8:0)
[02:08:49.516] Build status: STARTED
[02:08:49.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:9:0) after 2m14s
[02:11:03.536] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:9:0)
[02:11:03.552] Build status: STARTED
[02:11:03.552] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:10:0) after 8m18s
[02:19:21.571] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:10:0)
[02:19:21.592] Build status: STARTED
[02:19:21.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:11:0) after 3m37s
[02:22:58.634] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:11:0)
[02:22:58.655] Build status: STARTED
[02:22:58.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:12:0) after 8m9s
[02:31:07.684] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:12:0)
[02:31:07.702] Build status: STARTED
[02:31:07.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:13:0) after 3m57s
[02:35:04.669] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:13:0)
[02:35:04.691] Build status: STARTED
[02:35:04.691] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:14:0) after 3m43s
[02:38:47.738] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:14:0)
[02:38:47.760] Build status: STARTED
[02:38:47.760] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:15:0) after 1m30s
[02:40:17.734] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:15:0)
[02:40:17.761] Build status: STARTED
[02:40:17.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:16:0) after 7m15s
[02:47:32.896] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:16:0)
[02:47:32.993] Build status: STARTED
[02:47:32.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:17:0) after 4m51s
[02:52:24.023] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:17:0)
[02:52:24.043] Build status: STARTED
[02:52:24.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:18:0) after 4m49s
[02:57:13.116] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:18:0)
[02:57:13.133] Build status: STARTED
[02:57:13.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:19:0) after 8m37s
[03:05:50.195] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:19:0)
[03:05:50.211] Build status: STARTED
[03:05:50.211] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:20:0) after 6m50s
[03:12:40.342] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:20:0)
[03:12:40.356] Build status: STARTED
[03:12:40.356] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:21:0) after 1m35s
[03:14:15.438] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:21:0)
[03:14:15.506] Build status: STARTED
[03:14:15.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:22:0) after 5m51s
[03:20:06.524] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:22:0)
[03:20:06.541] Build status: STARTED
[03:20:06.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896219683996132096:23:0) after 6m9s
[03:23:49.116] Received PubSub notification, asking Buildbucket for the build status
[03:23:49.155] Build:
{
"id": "8730789621917640561",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-20T01:46:37.838605192Z",
"startTime": "2024-11-20T02:00:16.479631812Z",
"endTime": "2024-11-20T03:23:48.607725628Z",
"updateTime": "2024-11-20T03:23:48.607725628Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "50e38cc85663de27cfed59b8f09edf3437fbf164",
"ref": "refs/heads/main"
}
}
}
[03:23:49.155] Invocation finished in 1h37m12.681710623s with status SUCCEEDED