[13:12:12.330] New invocation is queued and will start shortly
[13:12:13.547] Starting the invocation (attempt 1)
[13:12:13.576] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d865f32fe820f543f0a53bfeba08774f2c270589"
[13:12:13.576] Popped gitiles commit info from properties and tags
[13:12:13.576] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:12:13.576] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:12:13.576] Buildbucket request:
{
"requestId": "8880956259581991888",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8880956259581991888",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7157228667396f1c113a96e9e9ecb9f0ca82a645"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7157228667396f1c113a96e9e9ecb9f0ca82a645",
"title": "7157228667396f1c113a96e9e9ecb9f0ca82a645",
"url": "https://llvm.googlesource.com/llvm-project/+/7157228667396f1c113a96e9e9ecb9f0ca82a645"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a83bb35e9989f9d27bb6c0578caa4183b8cbefdc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a83bb35e9989f9d27bb6c0578caa4183b8cbefdc",
"title": "a83bb35e9989f9d27bb6c0578caa4183b8cbefdc",
"url": "https://llvm.googlesource.com/llvm-project/+/a83bb35e9989f9d27bb6c0578caa4183b8cbefdc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c3a638caabf96fedce09f4b58b4ba550a015e150"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c3a638caabf96fedce09f4b58b4ba550a015e150",
"title": "c3a638caabf96fedce09f4b58b4ba550a015e150",
"url": "https://llvm.googlesource.com/llvm-project/+/c3a638caabf96fedce09f4b58b4ba550a015e150"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c22081c320340d0e7542b247ee093ca515509b52"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c22081c320340d0e7542b247ee093ca515509b52",
"title": "c22081c320340d0e7542b247ee093ca515509b52",
"url": "https://llvm.googlesource.com/llvm-project/+/c22081c320340d0e7542b247ee093ca515509b52"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "17b2b6ddef4b1dc74a4b459d06510c25fa883329"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@17b2b6ddef4b1dc74a4b459d06510c25fa883329",
"title": "17b2b6ddef4b1dc74a4b459d06510c25fa883329",
"url": "https://llvm.googlesource.com/llvm-project/+/17b2b6ddef4b1dc74a4b459d06510c25fa883329"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c7b2d98c934c9578dd880370905b5abafdeccbe3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c7b2d98c934c9578dd880370905b5abafdeccbe3",
"title": "c7b2d98c934c9578dd880370905b5abafdeccbe3",
"url": "https://llvm.googlesource.com/llvm-project/+/c7b2d98c934c9578dd880370905b5abafdeccbe3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0db040576d4ccb313fc58a90e1b4149f7589cc8c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0db040576d4ccb313fc58a90e1b4149f7589cc8c",
"title": "0db040576d4ccb313fc58a90e1b4149f7589cc8c",
"url": "https://llvm.googlesource.com/llvm-project/+/0db040576d4ccb313fc58a90e1b4149f7589cc8c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "21501d1cf290a63760904fb125e77b432db49933"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@21501d1cf290a63760904fb125e77b432db49933",
"title": "21501d1cf290a63760904fb125e77b432db49933",
"url": "https://llvm.googlesource.com/llvm-project/+/21501d1cf290a63760904fb125e77b432db49933"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7c5f5f3ef83b1d1d43d63862a8431af3dded15bb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7c5f5f3ef83b1d1d43d63862a8431af3dded15bb",
"title": "7c5f5f3ef83b1d1d43d63862a8431af3dded15bb",
"url": "https://llvm.googlesource.com/llvm-project/+/7c5f5f3ef83b1d1d43d63862a8431af3dded15bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d865f32fe820f543f0a53bfeba08774f2c270589"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d865f32fe820f543f0a53bfeba08774f2c270589",
"title": "d865f32fe820f543f0a53bfeba08774f2c270589",
"url": "https://llvm.googlesource.com/llvm-project/+/d865f32fe820f543f0a53bfeba08774f2c270589"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d865f32fe820f543f0a53bfeba08774f2c270589",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8880956259581991888"
},
{
"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:12:13.993] Scheduled build:
{
"id": "8715526197510185265",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-07T13:12:13.676402764Z",
"updateTime": "2025-05-07T13:12:13.676402764Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d865f32fe820f543f0a53bfeba08774f2c270589",
"ref": "refs/heads/main"
}
}
}
[13:12:13.993] Task URL: https://cr-buildbucket.appspot.com/build/8715526197510185265
[13:12:13.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:2:0) after 7m40s
[13:12:14.982] Received PubSub notification, asking Buildbucket for the build status
[13:12:15.009] Build status: SCHEDULED
[13:14:16.075] Received PubSub notification, asking Buildbucket for the build status
[13:14:16.094] Build status: STARTED
[13:19:54.011] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:2:0)
[13:19:54.036] Build status: STARTED
[13:19:54.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:5:0) after 9m28s
[13:29:22.072] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:5:0)
[13:29:22.090] Build status: STARTED
[13:29:22.090] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:6:0) after 9m50s
[13:39:12.118] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:6:0)
[13:39:12.144] Build status: STARTED
[13:39:12.144] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:7:0) after 9m49s
[13:49:01.164] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:7:0)
[13:49:01.185] Build status: STARTED
[13:49:01.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:8:0) after 3m9s
[13:52:10.258] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:8:0)
[13:52:10.291] Build status: STARTED
[13:52:10.291] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:9:0) after 7m17s
[13:59:27.682] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:9:0)
[13:59:27.702] Build status: STARTED
[13:59:27.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:10:0) after 2m55s
[14:02:22.726] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:10:0)
[14:02:22.741] Build status: STARTED
[14:02:22.741] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:11:0) after 9m27s
[14:11:49.792] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:11:0)
[14:11:49.899] Build status: STARTED
[14:11:49.899] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:12:0) after 2m21s
[14:14:10.986] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:12:0)
[14:14:11.001] Build status: STARTED
[14:14:11.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:13:0) after 1m5s
[14:15:16.033] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:13:0)
[14:15:16.070] Build status: STARTED
[14:15:16.070] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:14:0) after 7m23s
[14:22:39.119] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:14:0)
[14:22:39.179] Build status: STARTED
[14:22:39.179] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:15:0) after 8m36s
[14:31:15.192] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:15:0)
[14:31:15.221] Build status: STARTED
[14:31:15.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:16:0) after 2m9s
[14:33:24.335] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:16:0)
[14:33:24.361] Build status: STARTED
[14:33:24.361] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:17:0) after 1m53s
[14:35:17.452] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:17:0)
[14:35:17.479] Build status: STARTED
[14:35:17.479] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:18:0) after 9m39s
[14:44:56.475] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:18:0)
[14:44:56.490] Build status: STARTED
[14:44:56.490] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:19:0) after 7m37s
[14:52:33.585] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:19:0)
[14:52:33.605] Build status: STARTED
[14:52:33.605] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:20:0) after 4m44s
[14:57:17.627] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:20:0)
[14:57:17.648] Build status: STARTED
[14:57:17.648] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8880956259581991888:21:0) after 9m14s
[15:06:08.560] Received PubSub notification, asking Buildbucket for the build status
[15:06:08.633] Build:
{
"id": "8715526197510185265",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-07T13:12:13.676402764Z",
"startTime": "2025-05-07T13:14:15.897738180Z",
"endTime": "2025-05-07T15:06:07.703871232Z",
"updateTime": "2025-05-07T15:06:07.703871232Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d865f32fe820f543f0a53bfeba08774f2c270589",
"ref": "refs/heads/main"
}
}
}
[15:06:08.633] Invocation finished in 1h53m56.315925641s with status SUCCEEDED