[13:11:19.048] New invocation is queued and will start shortly
[13:11:20.211] Starting the invocation (attempt 1)
[13:11:20.240] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/29e8bfc13c6078ed07e6474e8c9634c42aa2f6f4"
[13:11:20.240] Popped gitiles commit info from properties and tags
[13:11:20.240] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:11:20.240] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:11:20.240] Buildbucket request:
{
"requestId": "8917466892910477888",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8917466892910477888",
"job": "fuchsia/toolchain.ci-clang-mac-x64-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "631ae59d301496f86a8d46d28f7b12afbd12a3c1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@631ae59d301496f86a8d46d28f7b12afbd12a3c1",
"title": "631ae59d301496f86a8d46d28f7b12afbd12a3c1",
"url": "https://llvm.googlesource.com/llvm-project/+/631ae59d301496f86a8d46d28f7b12afbd12a3c1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "546dc2245ffc4cccd0b05b58b7a5955e355a3b27"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@546dc2245ffc4cccd0b05b58b7a5955e355a3b27",
"title": "546dc2245ffc4cccd0b05b58b7a5955e355a3b27",
"url": "https://llvm.googlesource.com/llvm-project/+/546dc2245ffc4cccd0b05b58b7a5955e355a3b27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b361b5369ed4bb186f2a11459b1bc1d54d73a33e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b361b5369ed4bb186f2a11459b1bc1d54d73a33e",
"title": "b361b5369ed4bb186f2a11459b1bc1d54d73a33e",
"url": "https://llvm.googlesource.com/llvm-project/+/b361b5369ed4bb186f2a11459b1bc1d54d73a33e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "29e8bfc13c6078ed07e6474e8c9634c42aa2f6f4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@29e8bfc13c6078ed07e6474e8c9634c42aa2f6f4",
"title": "29e8bfc13c6078ed07e6474e8c9634c42aa2f6f4",
"url": "https://llvm.googlesource.com/llvm-project/+/29e8bfc13c6078ed07e6474e8c9634c42aa2f6f4"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "29e8bfc13c6078ed07e6474e8c9634c42aa2f6f4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8917466892910477888"
},
{
"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"
}
}
[13:11:20.993] Scheduled build:
{
"id": "8752036830946272929",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-30T13:11:20.292915558Z",
"updateTime": "2024-03-30T13:11:20.292915558Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "29e8bfc13c6078ed07e6474e8c9634c42aa2f6f4",
"ref": "refs/heads/main"
}
}
}
[13:11:20.993] Task URL: https://cr-buildbucket.appspot.com/build/8752036830946272929
[13:11:20.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:2:0) after 8m13s
[13:11:28.075] Received PubSub notification, asking Buildbucket for the build status
[13:11:28.097] Build status: STARTED
[13:11:31.040] Received PubSub notification, asking Buildbucket for the build status
[13:11:31.078] Build status: STARTED
[13:19:34.011] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:2:0)
[13:19:34.032] Build status: STARTED
[13:19:34.032] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:5:0) after 2m38s
[13:22:12.172] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:5:0)
[13:22:12.206] Build status: STARTED
[13:22:12.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:6:0) after 4m37s
[13:26:49.238] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:6:0)
[13:26:49.262] Build status: STARTED
[13:26:49.262] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:7:0) after 3m36s
[13:30:25.345] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:7:0)
[13:30:25.402] Build status: STARTED
[13:30:25.402] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:8:0) after 7m7s
[13:37:32.831] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:8:0)
[13:37:32.939] Build status: STARTED
[13:37:32.939] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:9:0) after 4m57s
[13:42:30.067] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:9:0)
[13:42:30.112] Build status: STARTED
[13:42:30.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:10:0) after 6m57s
[13:49:27.136] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:10:0)
[13:49:27.164] Build status: STARTED
[13:49:27.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:11:0) after 9m13s
[13:58:40.445] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:11:0)
[13:58:40.462] Build status: STARTED
[13:58:40.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:12:0) after 6m41s
[14:05:21.492] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:12:0)
[14:05:21.511] Build status: STARTED
[14:05:21.511] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:13:0) after 8m57s
[14:14:18.503] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:13:0)
[14:14:18.524] Build status: STARTED
[14:14:18.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:14:0) after 6m10s
[14:20:28.733] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:14:0)
[14:20:28.753] Build status: STARTED
[14:20:28.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-clang-mac-x64-40be1bb5:8917466892910477888:15:0) after 8m30s
[14:25:53.896] Received PubSub notification, asking Buildbucket for the build status
[14:25:53.941] Build:
{
"id": "8752036830946272929",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "clang-mac-x64"
},
"createdBy": "project:fuchsia",
"createTime": "2024-03-30T13:11:20.292915558Z",
"startTime": "2024-03-30T13:11:22.244449Z",
"endTime": "2024-03-30T14:25:52.129075Z",
"updateTime": "2024-03-30T14:25:52.129075Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "29e8bfc13c6078ed07e6474e8c9634c42aa2f6f4",
"ref": "refs/heads/main"
}
}
}
[14:25:53.941] Invocation finished in 1h14m34.904889034s with status SUCCEEDED