[16:50:03.530] New invocation is queued and will start shortly
[16:50:04.868] Starting the invocation (attempt 1)
[16:50:04.925] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1138a4964adf76cc4af82b3f43dbc8db0b91cd46"
[16:50:04.925] Popped gitiles commit info from properties and tags
[16:50:04.925] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:50:04.929] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:50:04.929] Buildbucket request:
{
"requestId": "8888462101644360240",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8888462101644360240",
"job": "fuchsia/clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2ad816648f2719e6c0da507a1a371f2cad4a3f1c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2ad816648f2719e6c0da507a1a371f2cad4a3f1c",
"title": "2ad816648f2719e6c0da507a1a371f2cad4a3f1c",
"url": "https://llvm.googlesource.com/llvm-project/+/2ad816648f2719e6c0da507a1a371f2cad4a3f1c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a1345eb240c9456ce1c339106f066217eb5e6984"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a1345eb240c9456ce1c339106f066217eb5e6984",
"title": "a1345eb240c9456ce1c339106f066217eb5e6984",
"url": "https://llvm.googlesource.com/llvm-project/+/a1345eb240c9456ce1c339106f066217eb5e6984"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "de09986596c9bbc89262456dda319715fb49353f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@de09986596c9bbc89262456dda319715fb49353f",
"title": "de09986596c9bbc89262456dda319715fb49353f",
"url": "https://llvm.googlesource.com/llvm-project/+/de09986596c9bbc89262456dda319715fb49353f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b2165f214efab833a4b1a9e8268b1030fc5ebaeb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b2165f214efab833a4b1a9e8268b1030fc5ebaeb",
"title": "b2165f214efab833a4b1a9e8268b1030fc5ebaeb",
"url": "https://llvm.googlesource.com/llvm-project/+/b2165f214efab833a4b1a9e8268b1030fc5ebaeb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "21811818d6c1a50051032fdb2d350ffe89e1421a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@21811818d6c1a50051032fdb2d350ffe89e1421a",
"title": "21811818d6c1a50051032fdb2d350ffe89e1421a",
"url": "https://llvm.googlesource.com/llvm-project/+/21811818d6c1a50051032fdb2d350ffe89e1421a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8da8ff8768bc0115f21d7d8fe8d47872190f8de1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8da8ff8768bc0115f21d7d8fe8d47872190f8de1",
"title": "8da8ff8768bc0115f21d7d8fe8d47872190f8de1",
"url": "https://llvm.googlesource.com/llvm-project/+/8da8ff8768bc0115f21d7d8fe8d47872190f8de1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "88015d12ca600cf2a74ba3641f319c7ba056223b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@88015d12ca600cf2a74ba3641f319c7ba056223b",
"title": "88015d12ca600cf2a74ba3641f319c7ba056223b",
"url": "https://llvm.googlesource.com/llvm-project/+/88015d12ca600cf2a74ba3641f319c7ba056223b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ba45592377703f99e1955a51f19922522446caec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ba45592377703f99e1955a51f19922522446caec",
"title": "ba45592377703f99e1955a51f19922522446caec",
"url": "https://llvm.googlesource.com/llvm-project/+/ba45592377703f99e1955a51f19922522446caec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2f8de7b466efc613111904ee36d13ec95976739a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2f8de7b466efc613111904ee36d13ec95976739a",
"title": "2f8de7b466efc613111904ee36d13ec95976739a",
"url": "https://llvm.googlesource.com/llvm-project/+/2f8de7b466efc613111904ee36d13ec95976739a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1138a4964adf76cc4af82b3f43dbc8db0b91cd46"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1138a4964adf76cc4af82b3f43dbc8db0b91cd46",
"title": "1138a4964adf76cc4af82b3f43dbc8db0b91cd46",
"url": "https://llvm.googlesource.com/llvm-project/+/1138a4964adf76cc4af82b3f43dbc8db0b91cd46"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1138a4964adf76cc4af82b3f43dbc8db0b91cd46",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8888462101644360240"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang-ci-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:50:05.425] Scheduled build:
{
"id": "8723032039357690609",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-13T16:50:05.083587841Z",
"updateTime": "2025-02-13T16:50:05.083587841Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1138a4964adf76cc4af82b3f43dbc8db0b91cd46",
"ref": "refs/heads/main"
}
}
}
[16:50:05.425] Task URL: https://cr-buildbucket.appspot.com/build/8723032039357690609
[16:50:05.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:2:0) after 5m25s
[16:50:06.441] Received PubSub notification, asking Buildbucket for the build status
[16:50:06.472] Build status: SCHEDULED
[16:50:11.483] Received PubSub notification, asking Buildbucket for the build status
[16:50:11.507] Build status: STARTED
[16:55:30.506] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:2:0)
[16:55:30.533] Build status: STARTED
[16:55:30.533] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:5:0) after 7m33s
[17:03:03.690] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:5:0)
[17:03:03.712] Build status: STARTED
[17:03:03.712] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:6:0) after 2m1s
[17:05:04.745] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:6:0)
[17:05:04.784] Build status: STARTED
[17:05:04.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:7:0) after 2m53s
[17:07:57.804] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:7:0)
[17:07:57.828] Build status: STARTED
[17:07:57.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:8:0) after 1m19s
[17:09:16.894] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:8:0)
[17:09:16.923] Build status: STARTED
[17:09:16.923] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:9:0) after 2m44s
[17:12:01.053] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:9:0)
[17:12:01.083] Build status: STARTED
[17:12:01.083] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:10:0) after 8m57s
[17:20:58.099] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:10:0)
[17:20:58.127] Build status: STARTED
[17:20:58.127] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:11:0) after 5m31s
[17:26:29.186] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:11:0)
[17:26:29.210] Build status: STARTED
[17:26:29.210] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:12:0) after 8m16s
[17:34:45.327] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:12:0)
[17:34:45.348] Build status: STARTED
[17:34:45.348] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:13:0) after 8m9s
[17:42:54.442] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:13:0)
[17:42:54.464] Build status: STARTED
[17:42:54.464] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:14:0) after 5m55s
[17:48:49.529] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:14:0)
[17:48:49.565] Build status: STARTED
[17:48:49.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:15:0) after 2m40s
[17:51:29.601] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:15:0)
[17:51:29.617] Build status: STARTED
[17:51:29.617] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:16:0) after 6m33s
[17:58:02.639] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:16:0)
[17:58:02.655] Build status: STARTED
[17:58:02.655] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:17:0) after 7m34s
[18:05:36.896] Handling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:17:0)
[18:05:36.920] Build status: STARTED
[18:05:36.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang-ci-trigger-40be1bb5:8888462101644360240:18:0) after 9m3s
[18:08:54.697] Received PubSub notification, asking Buildbucket for the build status
[18:08:54.718] Build:
{
"id": "8723032039357690609",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-02-13T16:50:05.083587841Z",
"startTime": "2025-02-13T16:50:11.233125217Z",
"endTime": "2025-02-13T18:08:53.942620164Z",
"updateTime": "2025-02-13T18:08:53.942620164Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "1138a4964adf76cc4af82b3f43dbc8db0b91cd46",
"ref": "refs/heads/main"
}
}
}
[18:08:54.718] Invocation finished in 1h18m51.198920962s with status SUCCEEDED