[19:43:22.296] New invocation is queued and will start shortly
[19:43:23.420] Starting the invocation (attempt 1)
[19:43:23.455] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f020bf15263f71e76e8b64fd0c333fff9744beae"
[19:43:23.455] Popped gitiles commit info from properties and tags
[19:43:23.455] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:43:23.455] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:43:23.455] Buildbucket request:
{
"requestId": "8899957012480602448",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8899957012480602448",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1cfe5b89b70c8170da041e9507fd0801be766669"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1cfe5b89b70c8170da041e9507fd0801be766669",
"title": "1cfe5b89b70c8170da041e9507fd0801be766669",
"url": "https://llvm.googlesource.com/llvm-project/+/1cfe5b89b70c8170da041e9507fd0801be766669"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e82fcda1475b6708b7d314fd7a54e551306d5739"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e82fcda1475b6708b7d314fd7a54e551306d5739",
"title": "e82fcda1475b6708b7d314fd7a54e551306d5739",
"url": "https://llvm.googlesource.com/llvm-project/+/e82fcda1475b6708b7d314fd7a54e551306d5739"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9200adee266b5bfaa468c5ce2715ed9794e1a7a8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9200adee266b5bfaa468c5ce2715ed9794e1a7a8",
"title": "9200adee266b5bfaa468c5ce2715ed9794e1a7a8",
"url": "https://llvm.googlesource.com/llvm-project/+/9200adee266b5bfaa468c5ce2715ed9794e1a7a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "749e21860061a1b317916579252a864b92a134d7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@749e21860061a1b317916579252a864b92a134d7",
"title": "749e21860061a1b317916579252a864b92a134d7",
"url": "https://llvm.googlesource.com/llvm-project/+/749e21860061a1b317916579252a864b92a134d7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4605ba0437728ecf8233ba6dbb52ffba30a22743"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4605ba0437728ecf8233ba6dbb52ffba30a22743",
"title": "4605ba0437728ecf8233ba6dbb52ffba30a22743",
"url": "https://llvm.googlesource.com/llvm-project/+/4605ba0437728ecf8233ba6dbb52ffba30a22743"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e0737174f944e6da2d3052e57de04ad93503956b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e0737174f944e6da2d3052e57de04ad93503956b",
"title": "e0737174f944e6da2d3052e57de04ad93503956b",
"url": "https://llvm.googlesource.com/llvm-project/+/e0737174f944e6da2d3052e57de04ad93503956b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d602f935daebce2ae6a023420133b3fa7da3c923"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d602f935daebce2ae6a023420133b3fa7da3c923",
"title": "d602f935daebce2ae6a023420133b3fa7da3c923",
"url": "https://llvm.googlesource.com/llvm-project/+/d602f935daebce2ae6a023420133b3fa7da3c923"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f020bf15263f71e76e8b64fd0c333fff9744beae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f020bf15263f71e76e8b64fd0c333fff9744beae",
"title": "f020bf15263f71e76e8b64fd0c333fff9744beae",
"url": "https://llvm.googlesource.com/llvm-project/+/f020bf15263f71e76e8b64fd0c333fff9744beae"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f020bf15263f71e76e8b64fd0c333fff9744beae",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8899957012480602448"
},
{
"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"
}
}
[19:43:23.965] Scheduled build:
{
"id": "8734526950546550897",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-09T19:43:23.513643827Z",
"updateTime": "2024-10-09T19:43:23.513643827Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f020bf15263f71e76e8b64fd0c333fff9744beae",
"ref": "refs/heads/main"
}
}
}
[19:43:23.965] Task URL: https://cr-buildbucket.appspot.com/build/8734526950546550897
[19:43:23.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:2:0) after 4m27s
[19:43:24.933] Received PubSub notification, asking Buildbucket for the build status
[19:43:24.951] Build status: SCHEDULED
[19:47:51.116] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:2:0)
[19:47:51.187] Build status: SCHEDULED
[19:47:51.187] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:4:0) after 4m14s
[19:52:05.229] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:4:0)
[19:52:05.270] Build status: SCHEDULED
[19:52:05.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:5:0) after 9m31s
[19:54:27.196] Received PubSub notification, asking Buildbucket for the build status
[19:54:27.214] Build status: STARTED
[20:01:36.290] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:5:0)
[20:01:36.317] Build status: STARTED
[20:01:36.317] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:7:0) after 2m15s
[20:03:51.354] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:7:0)
[20:03:51.375] Build status: STARTED
[20:03:51.375] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:8:0) after 4m30s
[20:08:21.390] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:8:0)
[20:08:21.501] Build status: STARTED
[20:08:21.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:9:0) after 8m23s
[20:16:44.544] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:9:0)
[20:16:44.561] Build status: STARTED
[20:16:44.561] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:10:0) after 3m8s
[20:19:52.578] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:10:0)
[20:19:52.620] Build status: STARTED
[20:19:52.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:11:0) after 1m27s
[20:21:19.635] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:11:0)
[20:21:19.671] Build status: STARTED
[20:21:19.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:12:0) after 2m45s
[20:24:04.687] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:12:0)
[20:24:04.717] Build status: STARTED
[20:24:04.717] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:13:0) after 5m37s
[20:29:41.733] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:13:0)
[20:29:41.761] Build status: STARTED
[20:29:41.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:14:0) after 4m7s
[20:33:48.827] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:14:0)
[20:33:48.846] Build status: STARTED
[20:33:48.846] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:15:0) after 3m15s
[20:37:03.863] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:15:0)
[20:37:03.890] Build status: STARTED
[20:37:03.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:16:0) after 1m23s
[20:38:26.910] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:16:0)
[20:38:26.954] Build status: STARTED
[20:38:26.954] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:17:0) after 4m36s
[20:43:03.061] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:17:0)
[20:43:03.077] Build status: STARTED
[20:43:03.078] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:18:0) after 3m47s
[20:46:50.096] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:18:0)
[20:46:50.121] Build status: STARTED
[20:46:50.121] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:19:0) after 5m54s
[20:52:44.140] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:19:0)
[20:52:44.158] Build status: STARTED
[20:52:44.158] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:20:0) after 1m20s
[20:54:04.200] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:20:0)
[20:54:04.221] Build status: STARTED
[20:54:04.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:21:0) after 6m12s
[21:00:16.245] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:21:0)
[21:00:16.265] Build status: STARTED
[21:00:16.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:22:0) after 2m34s
[21:02:50.318] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:22:0)
[21:02:50.345] Build status: STARTED
[21:02:50.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:23:0) after 3m38s
[21:06:28.329] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:23:0)
[21:06:28.525] Build status: STARTED
[21:06:28.525] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8899957012480602448:24:0) after 9m46s
[21:13:48.521] Received PubSub notification, asking Buildbucket for the build status
[21:13:48.543] Build:
{
"id": "8734526950546550897",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-09T19:43:23.513643827Z",
"startTime": "2024-10-09T19:54:26.981323475Z",
"endTime": "2024-10-09T21:13:48.183719531Z",
"updateTime": "2024-10-09T21:13:48.183719531Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f020bf15263f71e76e8b64fd0c333fff9744beae",
"ref": "refs/heads/main"
}
}
}
[21:13:48.543] Invocation finished in 1h30m26.258135905s with status SUCCEEDED