[12:15:38.636] New invocation is queued and will start shortly
[12:15:41.916] Starting the invocation (attempt 1)
[12:15:41.945] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/0a5012f00857308bdbf3e156764c585dd29db9a3"
[12:15:41.945] Popped gitiles commit info from properties and tags
[12:15:41.945] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:15:41.946] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:15:41.946] Buildbucket request:
{
"requestId": "8869635197326991424",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8869635197326991424",
"job": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5544afd25368413fd663362cd4eb58811bf558d2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5544afd25368413fd663362cd4eb58811bf558d2",
"title": "5544afd25368413fd663362cd4eb58811bf558d2",
"url": "https://llvm.googlesource.com/llvm-project/+/5544afd25368413fd663362cd4eb58811bf558d2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "38a7161a29431bdfa7be8e4154ef81d3ac80a2bd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@38a7161a29431bdfa7be8e4154ef81d3ac80a2bd",
"title": "38a7161a29431bdfa7be8e4154ef81d3ac80a2bd",
"url": "https://llvm.googlesource.com/llvm-project/+/38a7161a29431bdfa7be8e4154ef81d3ac80a2bd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "150f3c3fd3e50584fb9944cd6934f999b0ddd0e0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@150f3c3fd3e50584fb9944cd6934f999b0ddd0e0",
"title": "150f3c3fd3e50584fb9944cd6934f999b0ddd0e0",
"url": "https://llvm.googlesource.com/llvm-project/+/150f3c3fd3e50584fb9944cd6934f999b0ddd0e0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "abe96a21bb9fbfe2acd0d5ec78b54019aa27fd4f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@abe96a21bb9fbfe2acd0d5ec78b54019aa27fd4f",
"title": "abe96a21bb9fbfe2acd0d5ec78b54019aa27fd4f",
"url": "https://llvm.googlesource.com/llvm-project/+/abe96a21bb9fbfe2acd0d5ec78b54019aa27fd4f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b4075c4869e5bb212f7dc066a7441316ba43ec12"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b4075c4869e5bb212f7dc066a7441316ba43ec12",
"title": "b4075c4869e5bb212f7dc066a7441316ba43ec12",
"url": "https://llvm.googlesource.com/llvm-project/+/b4075c4869e5bb212f7dc066a7441316ba43ec12"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d200275f684d8ec2e689addd689891300c11f93"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d200275f684d8ec2e689addd689891300c11f93",
"title": "4d200275f684d8ec2e689addd689891300c11f93",
"url": "https://llvm.googlesource.com/llvm-project/+/4d200275f684d8ec2e689addd689891300c11f93"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0a5012f00857308bdbf3e156764c585dd29db9a3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0a5012f00857308bdbf3e156764c585dd29db9a3",
"title": "0a5012f00857308bdbf3e156764c585dd29db9a3",
"url": "https://llvm.googlesource.com/llvm-project/+/0a5012f00857308bdbf3e156764c585dd29db9a3"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0a5012f00857308bdbf3e156764c585dd29db9a3",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8869635197326991424"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[12:15:42.351] Scheduled build:
{
"id": "8704205133133668385",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-09T12:15:42.006500504Z",
"updateTime": "2025-09-09T12:15:42.006500504Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0a5012f00857308bdbf3e156764c585dd29db9a3",
"ref": "refs/heads/main"
}
}
}
[12:15:42.351] Task URL: https://cr-buildbucket.appspot.com/build/8704205133133668385
[12:15:42.351] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:2:0) after 4m21s
[12:15:42.451] Received PubSub notification, asking Buildbucket for the build status
[12:15:42.473] Build status: SCHEDULED
[12:16:36.434] Received PubSub notification, asking Buildbucket for the build status
[12:16:36.467] Build status: STARTED
[12:20:03.371] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:2:0)
[12:20:03.389] Build status: STARTED
[12:20:03.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:5:0) after 3m9s
[12:23:12.405] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:5:0)
[12:23:12.549] Build status: STARTED
[12:23:12.549] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:6:0) after 8m2s
[12:31:14.601] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:6:0)
[12:31:14.634] Build status: STARTED
[12:31:14.634] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:7:0) after 5m50s
[12:37:04.653] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:7:0)
[12:37:04.724] Build status: STARTED
[12:37:04.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:8:0) after 9m40s
[12:46:44.789] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:8:0)
[12:46:44.839] Build status: STARTED
[12:46:44.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:9:0) after 2m11s
[12:48:55.840] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:9:0)
[12:48:55.864] Build status: STARTED
[12:48:55.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:10:0) after 5m48s
[12:54:43.883] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:10:0)
[12:54:43.898] Build status: STARTED
[12:54:43.898] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:11:0) after 2m45s
[12:57:28.998] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:11:0)
[12:57:29.016] Build status: STARTED
[12:57:29.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-host-mac-x64-40be1bb5:8869635197326991424:12:0) after 6m35s
[13:00:56.992] Received PubSub notification, asking Buildbucket for the build status
[13:00:57.008] Build:
{
"id": "8704205133133668385",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-host-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-09T12:15:42.006500504Z",
"startTime": "2025-09-09T12:16:35.124757403Z",
"endTime": "2025-09-09T13:00:56.478565561Z",
"updateTime": "2025-09-09T13:00:56.478565561Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "0a5012f00857308bdbf3e156764c585dd29db9a3",
"ref": "refs/heads/main"
}
}
}
[13:00:57.008] Invocation finished in 45m18.384133456s with status SUCCEEDED