[10:12:11.402] New invocation is queued and will start shortly
[10:12:13.105] Starting the invocation (attempt 1)
[10:12:13.138] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c7df10643bda4acdc9a02406a2eee8aa4ced747f"
[10:12:13.138] Popped gitiles commit info from properties and tags
[10:12:13.138] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:12:13.138] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:12:13.139] Buildbucket request:
{
"requestId": "8896822054294192464",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8896822054294192464",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "12dcaa2e1e6c46d8a1b440d8a836d6b81ab92efb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@12dcaa2e1e6c46d8a1b440d8a836d6b81ab92efb",
"title": "12dcaa2e1e6c46d8a1b440d8a836d6b81ab92efb",
"url": "https://llvm.googlesource.com/llvm-project/+/12dcaa2e1e6c46d8a1b440d8a836d6b81ab92efb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "39b2979a434e70a4ce76d4adf91572dcfc9662ff"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@39b2979a434e70a4ce76d4adf91572dcfc9662ff",
"title": "39b2979a434e70a4ce76d4adf91572dcfc9662ff",
"url": "https://llvm.googlesource.com/llvm-project/+/39b2979a434e70a4ce76d4adf91572dcfc9662ff"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2c980310f67c13dd89c8702d40abeab47a4a2b4b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2c980310f67c13dd89c8702d40abeab47a4a2b4b",
"title": "2c980310f67c13dd89c8702d40abeab47a4a2b4b",
"url": "https://llvm.googlesource.com/llvm-project/+/2c980310f67c13dd89c8702d40abeab47a4a2b4b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "133f8fa233abf40508ea9e42c4c31f5f0c13485f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@133f8fa233abf40508ea9e42c4c31f5f0c13485f",
"title": "133f8fa233abf40508ea9e42c4c31f5f0c13485f",
"url": "https://llvm.googlesource.com/llvm-project/+/133f8fa233abf40508ea9e42c4c31f5f0c13485f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d7263d6d6d120a833fb45a17924117aad7412a99"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d7263d6d6d120a833fb45a17924117aad7412a99",
"title": "d7263d6d6d120a833fb45a17924117aad7412a99",
"url": "https://llvm.googlesource.com/llvm-project/+/d7263d6d6d120a833fb45a17924117aad7412a99"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "42da81582ea5a0e5bb0e18af74e6c101f0307f36"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@42da81582ea5a0e5bb0e18af74e6c101f0307f36",
"title": "42da81582ea5a0e5bb0e18af74e6c101f0307f36",
"url": "https://llvm.googlesource.com/llvm-project/+/42da81582ea5a0e5bb0e18af74e6c101f0307f36"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5845688e91d85d46c0f47daaf4edfdfc772853cf"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5845688e91d85d46c0f47daaf4edfdfc772853cf",
"title": "5845688e91d85d46c0f47daaf4edfdfc772853cf",
"url": "https://llvm.googlesource.com/llvm-project/+/5845688e91d85d46c0f47daaf4edfdfc772853cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2a1586dfb5a304830301cfcce8bd7d520b9d5a49"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2a1586dfb5a304830301cfcce8bd7d520b9d5a49",
"title": "2a1586dfb5a304830301cfcce8bd7d520b9d5a49",
"url": "https://llvm.googlesource.com/llvm-project/+/2a1586dfb5a304830301cfcce8bd7d520b9d5a49"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3e20bae827c0a314142fea74aa3d7ead039fab3d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3e20bae827c0a314142fea74aa3d7ead039fab3d",
"title": "3e20bae827c0a314142fea74aa3d7ead039fab3d",
"url": "https://llvm.googlesource.com/llvm-project/+/3e20bae827c0a314142fea74aa3d7ead039fab3d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c7df10643bda4acdc9a02406a2eee8aa4ced747f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c7df10643bda4acdc9a02406a2eee8aa4ced747f",
"title": "c7df10643bda4acdc9a02406a2eee8aa4ced747f",
"url": "https://llvm.googlesource.com/llvm-project/+/c7df10643bda4acdc9a02406a2eee8aa4ced747f"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c7df10643bda4acdc9a02406a2eee8aa4ced747f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8896822054294192464"
},
{
"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:12:13.615] Scheduled build:
{
"id": "8731391991735466273",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-13T10:12:13.214732289Z",
"updateTime": "2024-11-13T10:12:13.214732289Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c7df10643bda4acdc9a02406a2eee8aa4ced747f",
"ref": "refs/heads/main"
}
}
}
[10:12:13.615] Task URL: https://cr-buildbucket.appspot.com/build/8731391991735466273
[10:12:13.615] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:2:0) after 4m31s
[10:12:13.797] Received PubSub notification, asking Buildbucket for the build status
[10:12:13.828] Build status: SCHEDULED
[10:16:45.108] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:2:0)
[10:16:45.144] Build status: SCHEDULED
[10:16:45.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:4:0) after 3m56s
[10:20:41.376] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:4:0)
[10:20:41.395] Build status: SCHEDULED
[10:20:41.396] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:5:0) after 5m42s
[10:26:23.442] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:5:0)
[10:26:23.513] Build status: SCHEDULED
[10:26:23.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:6:0) after 1m7s
[10:27:30.580] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:6:0)
[10:27:30.597] Build status: SCHEDULED
[10:27:30.597] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:7:0) after 6m57s
[10:34:27.971] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:7:0)
[10:34:28.023] Build status: SCHEDULED
[10:34:28.023] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:8:0) after 6m26s
[10:36:23.387] Received PubSub notification, asking Buildbucket for the build status
[10:36:23.983] Build status: STARTED
[10:40:54.037] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:8:0)
[10:40:54.056] Build status: STARTED
[10:40:54.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:10:0) after 3m30s
[10:44:24.164] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:10:0)
[10:44:24.186] Build status: STARTED
[10:44:24.186] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:11:0) after 5m50s
[10:50:14.259] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:11:0)
[10:50:14.278] Build status: STARTED
[10:50:14.278] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:12:0) after 1m47s
[10:52:01.305] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:12:0)
[10:52:01.327] Build status: STARTED
[10:52:01.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:13:0) after 3m19s
[10:55:20.318] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:13:0)
[10:55:20.342] Build status: STARTED
[10:55:20.342] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:14:0) after 1m9s
[10:56:29.362] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:14:0)
[10:56:29.381] Build status: STARTED
[10:56:29.381] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:15:0) after 7m33s
[11:04:02.438] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:15:0)
[11:04:02.459] Build status: STARTED
[11:04:02.459] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:16:0) after 4m55s
[11:08:57.545] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:16:0)
[11:08:57.566] Build status: STARTED
[11:08:57.566] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:17:0) after 9m30s
[11:18:27.603] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:17:0)
[11:18:27.623] Build status: STARTED
[11:18:27.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:18:0) after 5m0s
[11:23:28.070] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:18:0)
[11:23:28.090] Build status: STARTED
[11:23:28.090] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:19:0) after 9m20s
[11:32:48.107] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:19:0)
[11:32:48.171] Build status: STARTED
[11:32:48.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:20:0) after 2m56s
[11:35:44.189] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:20:0)
[11:35:44.315] Build status: STARTED
[11:35:44.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:21:0) after 9m40s
[11:45:24.545] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:21:0)
[11:45:24.564] Build status: STARTED
[11:45:24.564] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:22:0) after 5m1s
[11:50:25.626] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:22:0)
[11:50:25.645] Build status: STARTED
[11:50:25.646] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:23:0) after 4m28s
[11:54:53.673] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:23:0)
[11:54:53.692] Build status: STARTED
[11:54:53.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8896822054294192464:24:0) after 8m33s
[11:56:01.945] Received PubSub notification, asking Buildbucket for the build status
[11:56:01.966] Build:
{
"id": "8731391991735466273",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-11-13T10:12:13.214732289Z",
"startTime": "2024-11-13T10:36:18.714830915Z",
"endTime": "2024-11-13T11:56:01.539624599Z",
"updateTime": "2024-11-13T11:56:01.539624599Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c7df10643bda4acdc9a02406a2eee8aa4ced747f",
"ref": "refs/heads/main"
}
}
}
[11:56:01.966] Invocation finished in 1h43m50.575752941s with status SUCCEEDED