[05:52:01.369] New invocation is queued and will start shortly
[05:52:02.471] Starting the invocation (attempt 1)
[05:52:02.502] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/f28408f3af0d4533dd1d8048c5fdcdb14b934d05"
[05:52:02.502] Popped gitiles commit info from properties and tags
[05:52:02.502] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:52:02.502] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:52:02.503] Buildbucket request:
{
"requestId": "8882705295848770480",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882705295848770480",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "49dfd72de0131e4c3f1270ef60ea54af43a3c96b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@49dfd72de0131e4c3f1270ef60ea54af43a3c96b",
"title": "49dfd72de0131e4c3f1270ef60ea54af43a3c96b",
"url": "https://llvm.googlesource.com/llvm-project/+/49dfd72de0131e4c3f1270ef60ea54af43a3c96b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7088910b9f74d49a7e0a107a2261be90c1c8bd1b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7088910b9f74d49a7e0a107a2261be90c1c8bd1b",
"title": "7088910b9f74d49a7e0a107a2261be90c1c8bd1b",
"url": "https://llvm.googlesource.com/llvm-project/+/7088910b9f74d49a7e0a107a2261be90c1c8bd1b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d5f94c3915ace438359524b40cf84f3f54a0afae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d5f94c3915ace438359524b40cf84f3f54a0afae",
"title": "d5f94c3915ace438359524b40cf84f3f54a0afae",
"url": "https://llvm.googlesource.com/llvm-project/+/d5f94c3915ace438359524b40cf84f3f54a0afae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "65d16a8101f98199b5d2505c1e9fdf2df519814b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@65d16a8101f98199b5d2505c1e9fdf2df519814b",
"title": "65d16a8101f98199b5d2505c1e9fdf2df519814b",
"url": "https://llvm.googlesource.com/llvm-project/+/65d16a8101f98199b5d2505c1e9fdf2df519814b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "59288761c9a8a3d5ecc70543ba09246497117f9e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@59288761c9a8a3d5ecc70543ba09246497117f9e",
"title": "59288761c9a8a3d5ecc70543ba09246497117f9e",
"url": "https://llvm.googlesource.com/llvm-project/+/59288761c9a8a3d5ecc70543ba09246497117f9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b07ee6acffd4c6c19093f8a5e9f8c6c594f3c90a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b07ee6acffd4c6c19093f8a5e9f8c6c594f3c90a",
"title": "b07ee6acffd4c6c19093f8a5e9f8c6c594f3c90a",
"url": "https://llvm.googlesource.com/llvm-project/+/b07ee6acffd4c6c19093f8a5e9f8c6c594f3c90a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "155fc76f20fec106d59701b3d320b74d46894b37"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@155fc76f20fec106d59701b3d320b74d46894b37",
"title": "155fc76f20fec106d59701b3d320b74d46894b37",
"url": "https://llvm.googlesource.com/llvm-project/+/155fc76f20fec106d59701b3d320b74d46894b37"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2b002d68044e6b482a898c1deff578f76fa9b8a1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2b002d68044e6b482a898c1deff578f76fa9b8a1",
"title": "2b002d68044e6b482a898c1deff578f76fa9b8a1",
"url": "https://llvm.googlesource.com/llvm-project/+/2b002d68044e6b482a898c1deff578f76fa9b8a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f28408f3af0d4533dd1d8048c5fdcdb14b934d05"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f28408f3af0d4533dd1d8048c5fdcdb14b934d05",
"title": "f28408f3af0d4533dd1d8048c5fdcdb14b934d05",
"url": "https://llvm.googlesource.com/llvm-project/+/f28408f3af0d4533dd1d8048c5fdcdb14b934d05"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f28408f3af0d4533dd1d8048c5fdcdb14b934d05",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882705295848770480"
},
{
"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"
}
}
[05:52:02.922] Scheduled build:
{
"id": "8717275233877148609",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-18T05:52:02.615653530Z",
"updateTime": "2025-04-18T05:52:02.615653530Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f28408f3af0d4533dd1d8048c5fdcdb14b934d05",
"ref": "refs/heads/main"
}
}
}
[05:52:02.922] Task URL: https://cr-buildbucket.appspot.com/build/8717275233877148609
[05:52:02.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:2:0) after 9m46s
[05:52:03.954] Received PubSub notification, asking Buildbucket for the build status
[05:52:03.982] Build status: SCHEDULED
[05:52:06.934] Received PubSub notification, asking Buildbucket for the build status
[05:52:06.959] Build status: STARTED
[06:01:48.944] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:2:0)
[06:01:48.973] Build status: STARTED
[06:01:48.973] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:5:0) after 1m21s
[06:03:10.172] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:5:0)
[06:03:10.198] Build status: STARTED
[06:03:10.198] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:6:0) after 6m33s
[06:09:43.262] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:6:0)
[06:09:43.282] Build status: STARTED
[06:09:43.282] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:7:0) after 6m31s
[06:16:14.277] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:7:0)
[06:16:14.305] Build status: STARTED
[06:16:14.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:8:0) after 5m35s
[06:21:49.300] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:8:0)
[06:21:49.338] Build status: STARTED
[06:21:49.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:9:0) after 6m27s
[06:28:16.361] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:9:0)
[06:28:16.380] Build status: STARTED
[06:28:16.380] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:10:0) after 9m1s
[06:37:17.399] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:10:0)
[06:37:17.457] Build status: STARTED
[06:37:17.457] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:11:0) after 3m18s
[06:40:35.476] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:11:0)
[06:40:35.492] Build status: STARTED
[06:40:35.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:12:0) after 8m51s
[06:49:26.511] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:12:0)
[06:49:26.535] Build status: STARTED
[06:49:26.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:13:0) after 3m4s
[06:52:30.580] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:13:0)
[06:52:30.596] Build status: STARTED
[06:52:30.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:14:0) after 4m28s
[06:56:58.619] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:14:0)
[06:56:58.645] Build status: STARTED
[06:56:58.645] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:15:0) after 3m41s
[07:00:39.668] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:15:0)
[07:00:39.685] Build status: STARTED
[07:00:39.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:16:0) after 9m43s
[07:10:22.757] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:16:0)
[07:10:22.787] Build status: STARTED
[07:10:22.787] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:17:0) after 3m28s
[07:13:50.827] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:17:0)
[07:13:50.844] Build status: STARTED
[07:13:50.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:18:0) after 3m22s
[07:17:12.859] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:18:0)
[07:17:12.890] Build status: STARTED
[07:17:12.890] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:19:0) after 4m9s
[07:21:22.458] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:19:0)
[07:21:22.483] Build status: STARTED
[07:21:22.483] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:20:0) after 7m0s
[07:28:22.532] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:20:0)
[07:28:22.556] Build status: STARTED
[07:28:22.556] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:21:0) after 2m16s
[07:30:38.569] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:21:0)
[07:30:38.587] Build status: STARTED
[07:30:38.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:22:0) after 7m35s
[07:38:13.671] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:22:0)
[07:38:13.706] Build status: STARTED
[07:38:13.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:23:0) after 4m30s
[07:42:43.727] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:23:0)
[07:42:43.751] Build status: STARTED
[07:42:43.751] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8882705295848770480:24:0) after 9m23s
[07:44:53.989] Received PubSub notification, asking Buildbucket for the build status
[07:44:54.014] Build:
{
"id": "8717275233877148609",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-18T05:52:02.615653530Z",
"startTime": "2025-04-18T05:52:06.683387429Z",
"endTime": "2025-04-18T07:44:53.669664527Z",
"updateTime": "2025-04-18T07:44:53.669664527Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "f28408f3af0d4533dd1d8048c5fdcdb14b934d05",
"ref": "refs/heads/main"
}
}
}
[07:44:54.014] Invocation finished in 1h52m52.662609283s with status SUCCEEDED