[07:30:30.210] New invocation is queued and will start shortly
[07:30:31.753] Starting the invocation (attempt 1)
[07:30:31.775] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f5cae7b805946337f30437871ea6e13844507775"
[07:30:31.775] Popped gitiles commit info from properties and tags
[07:30:31.775] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:30:31.775] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:30:31.775] Buildbucket request:
{
"requestId": "8862767767356118368",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8862767767356118368",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d124675e27a6abbce0bfea6a25ab9dfe66e9d657"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d124675e27a6abbce0bfea6a25ab9dfe66e9d657",
"title": "d124675e27a6abbce0bfea6a25ab9dfe66e9d657",
"url": "https://llvm.googlesource.com/llvm-project/+/d124675e27a6abbce0bfea6a25ab9dfe66e9d657"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "54db657b9ebdbce70f902313e6b303d85d68a4dc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@54db657b9ebdbce70f902313e6b303d85d68a4dc",
"title": "54db657b9ebdbce70f902313e6b303d85d68a4dc",
"url": "https://llvm.googlesource.com/llvm-project/+/54db657b9ebdbce70f902313e6b303d85d68a4dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "67391fc039b27f4e82624a6de4493cdd0907878b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@67391fc039b27f4e82624a6de4493cdd0907878b",
"title": "67391fc039b27f4e82624a6de4493cdd0907878b",
"url": "https://llvm.googlesource.com/llvm-project/+/67391fc039b27f4e82624a6de4493cdd0907878b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2b81e9e8fea0cdb2eac1537c1f882b695615b141"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2b81e9e8fea0cdb2eac1537c1f882b695615b141",
"title": "2b81e9e8fea0cdb2eac1537c1f882b695615b141",
"url": "https://llvm.googlesource.com/llvm-project/+/2b81e9e8fea0cdb2eac1537c1f882b695615b141"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7dd531f428614a310b6715fe9181432393d9095b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7dd531f428614a310b6715fe9181432393d9095b",
"title": "7dd531f428614a310b6715fe9181432393d9095b",
"url": "https://llvm.googlesource.com/llvm-project/+/7dd531f428614a310b6715fe9181432393d9095b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9ce6fadbcaf60ed88302617b6301f68989d44e3e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9ce6fadbcaf60ed88302617b6301f68989d44e3e",
"title": "9ce6fadbcaf60ed88302617b6301f68989d44e3e",
"url": "https://llvm.googlesource.com/llvm-project/+/9ce6fadbcaf60ed88302617b6301f68989d44e3e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "95f0fab7fab48bbf37d3c02c0ea8b01ca73c30dd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@95f0fab7fab48bbf37d3c02c0ea8b01ca73c30dd",
"title": "95f0fab7fab48bbf37d3c02c0ea8b01ca73c30dd",
"url": "https://llvm.googlesource.com/llvm-project/+/95f0fab7fab48bbf37d3c02c0ea8b01ca73c30dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f5cae7b805946337f30437871ea6e13844507775"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f5cae7b805946337f30437871ea6e13844507775",
"title": "f5cae7b805946337f30437871ea6e13844507775",
"url": "https://llvm.googlesource.com/llvm-project/+/f5cae7b805946337f30437871ea6e13844507775"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f5cae7b805946337f30437871ea6e13844507775",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8862767767356118368"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-clang-ci-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[07:30:32.084] Scheduled build:
{
"id": "8697337705021242321",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-24T07:30:31.817831548Z",
"updateTime": "2025-11-24T07:30:31.817831548Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f5cae7b805946337f30437871ea6e13844507775",
"ref": "refs/heads/main"
}
}
}
[07:30:32.084] Task URL: https://cr-buildbucket.appspot.com/build/8697337705021242321
[07:30:32.084] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:2:0) after 3m30s
[07:30:33.040] Received PubSub notification, asking Buildbucket for the build status
[07:30:33.056] Build status: SCHEDULED
[07:30:35.809] Received PubSub notification, asking Buildbucket for the build status
[07:30:35.830] Build status: STARTED
[07:34:02.154] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:2:0)
[07:34:02.221] Build status: STARTED
[07:34:02.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:5:0) after 8m46s
[07:42:48.414] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:5:0)
[07:42:48.465] Build status: STARTED
[07:42:48.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:6:0) after 2m35s
[07:45:23.751] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:6:0)
[07:45:23.779] Build status: STARTED
[07:45:23.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:7:0) after 4m23s
[07:49:46.810] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:7:0)
[07:49:46.830] Build status: STARTED
[07:49:46.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:8:0) after 9m9s
[07:58:55.967] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:8:0)
[07:58:55.999] Build status: STARTED
[07:58:55.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:9:0) after 4m16s
[08:03:12.018] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:9:0)
[08:03:12.038] Build status: STARTED
[08:03:12.038] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:10:0) after 9m53s
[08:13:05.056] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:10:0)
[08:13:05.075] Build status: STARTED
[08:13:05.075] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:11:0) after 2m35s
[08:15:40.092] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:11:0)
[08:15:40.108] Build status: STARTED
[08:15:40.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:12:0) after 6m54s
[08:22:34.441] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:12:0)
[08:22:34.462] Build status: STARTED
[08:22:34.462] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:13:0) after 6m32s
[08:29:06.476] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:13:0)
[08:29:06.497] Build status: STARTED
[08:29:06.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:14:0) after 2m9s
[08:31:16.099] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:14:0)
[08:31:16.123] Build status: STARTED
[08:31:16.124] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:15:0) after 8m45s
[08:40:01.551] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:15:0)
[08:40:01.576] Build status: STARTED
[08:40:01.576] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:16:0) after 5m2s
[08:45:03.651] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:16:0)
[08:45:03.671] Build status: STARTED
[08:45:03.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8862767767356118368:17:0) after 9m41s
[08:50:25.137] Received PubSub notification, asking Buildbucket for the build status
[08:50:25.238] Build:
{
"id": "8697337705021242321",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-24T07:30:31.817831548Z",
"startTime": "2025-11-24T07:30:35.628064457Z",
"endTime": "2025-11-24T08:50:24.895299938Z",
"updateTime": "2025-11-24T08:50:24.895299938Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f5cae7b805946337f30437871ea6e13844507775",
"ref": "refs/heads/main"
}
}
}
[08:50:25.238] Invocation finished in 1h19m55.030879193s with status SUCCEEDED