[13:00:23.377] New invocation is queued and will start shortly
[13:00:24.495] Starting the invocation (attempt 1)
[13:00:24.531] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2cf71fcb9751a347f39035739f8865ef7a53ee68"
[13:00:24.531] Popped gitiles commit info from properties and tags
[13:00:24.531] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:00:24.531] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:00:24.532] Buildbucket request:
{
"requestId": "8867911039803430736",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8867911039803430736",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6167f0c818051e378fd8b0efb6e93adf13e53fae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6167f0c818051e378fd8b0efb6e93adf13e53fae",
"title": "6167f0c818051e378fd8b0efb6e93adf13e53fae",
"url": "https://llvm.googlesource.com/llvm-project/+/6167f0c818051e378fd8b0efb6e93adf13e53fae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "062c0fcf4b8b29a12191d782f4e23623cef061db"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@062c0fcf4b8b29a12191d782f4e23623cef061db",
"title": "062c0fcf4b8b29a12191d782f4e23623cef061db",
"url": "https://llvm.googlesource.com/llvm-project/+/062c0fcf4b8b29a12191d782f4e23623cef061db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "60e41d241c3a4ba63e777986688ec75cc0612d0f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@60e41d241c3a4ba63e777986688ec75cc0612d0f",
"title": "60e41d241c3a4ba63e777986688ec75cc0612d0f",
"url": "https://llvm.googlesource.com/llvm-project/+/60e41d241c3a4ba63e777986688ec75cc0612d0f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c058ebda67ed85d3b45140bd25d504e1f7400441"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c058ebda67ed85d3b45140bd25d504e1f7400441",
"title": "c058ebda67ed85d3b45140bd25d504e1f7400441",
"url": "https://llvm.googlesource.com/llvm-project/+/c058ebda67ed85d3b45140bd25d504e1f7400441"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "47981627ddb5bfb49e383474fb1db0c95a2e3b86"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@47981627ddb5bfb49e383474fb1db0c95a2e3b86",
"title": "47981627ddb5bfb49e383474fb1db0c95a2e3b86",
"url": "https://llvm.googlesource.com/llvm-project/+/47981627ddb5bfb49e383474fb1db0c95a2e3b86"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "63d866e04b86f2bf18206f02acf4f25f7be44111"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@63d866e04b86f2bf18206f02acf4f25f7be44111",
"title": "63d866e04b86f2bf18206f02acf4f25f7be44111",
"url": "https://llvm.googlesource.com/llvm-project/+/63d866e04b86f2bf18206f02acf4f25f7be44111"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "aaf23f0887969130fbbfedc2b525921c1c7b687c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@aaf23f0887969130fbbfedc2b525921c1c7b687c",
"title": "aaf23f0887969130fbbfedc2b525921c1c7b687c",
"url": "https://llvm.googlesource.com/llvm-project/+/aaf23f0887969130fbbfedc2b525921c1c7b687c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dcfb904473dab6c45855b6ab364521124beb5ce1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dcfb904473dab6c45855b6ab364521124beb5ce1",
"title": "dcfb904473dab6c45855b6ab364521124beb5ce1",
"url": "https://llvm.googlesource.com/llvm-project/+/dcfb904473dab6c45855b6ab364521124beb5ce1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "047ddbf263f6e64c6ec1ef148596661d28544e3a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@047ddbf263f6e64c6ec1ef148596661d28544e3a",
"title": "047ddbf263f6e64c6ec1ef148596661d28544e3a",
"url": "https://llvm.googlesource.com/llvm-project/+/047ddbf263f6e64c6ec1ef148596661d28544e3a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0c1acc98140c642ff87c1a759bda3ddfaaf23964"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0c1acc98140c642ff87c1a759bda3ddfaaf23964",
"title": "0c1acc98140c642ff87c1a759bda3ddfaaf23964",
"url": "https://llvm.googlesource.com/llvm-project/+/0c1acc98140c642ff87c1a759bda3ddfaaf23964"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5d85d54feb4e17fa449fa9d9963aabac8b403d7b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5d85d54feb4e17fa449fa9d9963aabac8b403d7b",
"title": "5d85d54feb4e17fa449fa9d9963aabac8b403d7b",
"url": "https://llvm.googlesource.com/llvm-project/+/5d85d54feb4e17fa449fa9d9963aabac8b403d7b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0dbc1e2dff5a4ff0bdc05b310bd93d1eff9bae23"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0dbc1e2dff5a4ff0bdc05b310bd93d1eff9bae23",
"title": "0dbc1e2dff5a4ff0bdc05b310bd93d1eff9bae23",
"url": "https://llvm.googlesource.com/llvm-project/+/0dbc1e2dff5a4ff0bdc05b310bd93d1eff9bae23"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2cf71fcb9751a347f39035739f8865ef7a53ee68"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2cf71fcb9751a347f39035739f8865ef7a53ee68",
"title": "2cf71fcb9751a347f39035739f8865ef7a53ee68",
"url": "https://llvm.googlesource.com/llvm-project/+/2cf71fcb9751a347f39035739f8865ef7a53ee68"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2cf71fcb9751a347f39035739f8865ef7a53ee68",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8867911039803430736"
},
{
"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"
}
}
[13:00:24.907] Scheduled build:
{
"id": "8702480977872093265",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-28T13:00:24.597015588Z",
"updateTime": "2025-09-28T13:00:24.597015588Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2cf71fcb9751a347f39035739f8865ef7a53ee68",
"ref": "refs/heads/main"
}
}
}
[13:00:24.907] Task URL: https://cr-buildbucket.appspot.com/build/8702480977872093265
[13:00:24.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:2:0) after 1m47s
[13:00:25.577] Received PubSub notification, asking Buildbucket for the build status
[13:00:25.664] Build status: SCHEDULED
[13:00:28.566] Received PubSub notification, asking Buildbucket for the build status
[13:00:28.588] Build status: STARTED
[13:02:11.924] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:2:0)
[13:02:11.949] Build status: STARTED
[13:02:11.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:5:0) after 5m45s
[13:07:56.967] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:5:0)
[13:07:57.006] Build status: STARTED
[13:07:57.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:6:0) after 9m58s
[13:17:55.023] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:6:0)
[13:17:55.035] Build status: STARTED
[13:17:55.035] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:7:0) after 4m51s
[13:22:46.049] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:7:0)
[13:22:46.193] Build status: STARTED
[13:22:46.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:8:0) after 1m41s
[13:24:27.210] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:8:0)
[13:24:27.297] Build status: STARTED
[13:24:27.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:9:0) after 5m56s
[13:30:23.463] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:9:0)
[13:30:23.481] Build status: STARTED
[13:30:23.481] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:10:0) after 1m43s
[13:32:06.498] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:10:0)
[13:32:06.532] Build status: STARTED
[13:32:06.532] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:11:0) after 9m30s
[13:41:36.549] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:11:0)
[13:41:36.567] Build status: STARTED
[13:41:36.567] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:12:0) after 8m17s
[13:49:53.581] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:12:0)
[13:49:53.600] Build status: STARTED
[13:49:53.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:13:0) after 2m5s
[13:51:58.604] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:13:0)
[13:51:58.629] Build status: STARTED
[13:51:58.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:14:0) after 5m14s
[13:57:12.643] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:14:0)
[13:57:12.669] Build status: STARTED
[13:57:12.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:15:0) after 4m39s
[14:01:51.697] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:15:0)
[14:01:51.725] Build status: STARTED
[14:01:51.725] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:16:0) after 7m0s
[14:08:51.740] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:16:0)
[14:08:51.754] Build status: STARTED
[14:08:51.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:17:0) after 3m17s
[14:12:08.740] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:17:0)
[14:12:08.755] Build status: STARTED
[14:12:08.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8867911039803430736:18:0) after 9m2s
[14:20:14.136] Received PubSub notification, asking Buildbucket for the build status
[14:20:14.159] Build:
{
"id": "8702480977872093265",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-28T13:00:24.597015588Z",
"startTime": "2025-09-28T13:00:28.281560759Z",
"endTime": "2025-09-28T14:20:13.818303173Z",
"updateTime": "2025-09-28T14:20:13.818303173Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "2cf71fcb9751a347f39035739f8865ef7a53ee68",
"ref": "refs/heads/main"
}
}
}
[14:20:14.159] Invocation finished in 1h19m50.786489923s with status SUCCEEDED