[17:36:05.020] New invocation is queued and will start shortly
[17:36:06.433] Starting the invocation (attempt 1)
[17:36:06.459] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/6f28eec6dc68c64ebe108be3fdb7d0affb1e3349"
[17:36:06.459] Popped gitiles commit info from properties and tags
[17:36:06.459] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:36:06.459] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:36:06.459] Buildbucket request:
{
"requestId": "8874507273183622896",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8874507273183622896",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "661cbd5a5254de22ba87a49e89f54b30e2874fb3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@661cbd5a5254de22ba87a49e89f54b30e2874fb3",
"title": "661cbd5a5254de22ba87a49e89f54b30e2874fb3",
"url": "https://llvm.googlesource.com/llvm-project/+/661cbd5a5254de22ba87a49e89f54b30e2874fb3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0dae924c1f668f74370b642ba91f818b728aca40"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0dae924c1f668f74370b642ba91f818b728aca40",
"title": "0dae924c1f668f74370b642ba91f818b728aca40",
"url": "https://llvm.googlesource.com/llvm-project/+/0dae924c1f668f74370b642ba91f818b728aca40"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b3a8d0efc907aae8198ff16e5bfb8dc48f08b6ca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b3a8d0efc907aae8198ff16e5bfb8dc48f08b6ca",
"title": "b3a8d0efc907aae8198ff16e5bfb8dc48f08b6ca",
"url": "https://llvm.googlesource.com/llvm-project/+/b3a8d0efc907aae8198ff16e5bfb8dc48f08b6ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e4a3541ff88af03c01007a94b6b5f5cea95ecf33"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e4a3541ff88af03c01007a94b6b5f5cea95ecf33",
"title": "e4a3541ff88af03c01007a94b6b5f5cea95ecf33",
"url": "https://llvm.googlesource.com/llvm-project/+/e4a3541ff88af03c01007a94b6b5f5cea95ecf33"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d35931c49e5b37243ace2b79bec87463772b6c94"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d35931c49e5b37243ace2b79bec87463772b6c94",
"title": "d35931c49e5b37243ace2b79bec87463772b6c94",
"url": "https://llvm.googlesource.com/llvm-project/+/d35931c49e5b37243ace2b79bec87463772b6c94"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ff5784bb9094f6035851dc7abc4a5760fdc21e45"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ff5784bb9094f6035851dc7abc4a5760fdc21e45",
"title": "ff5784bb9094f6035851dc7abc4a5760fdc21e45",
"url": "https://llvm.googlesource.com/llvm-project/+/ff5784bb9094f6035851dc7abc4a5760fdc21e45"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "871d65bfdd580cec349e63d687e6829e0ef62824"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@871d65bfdd580cec349e63d687e6829e0ef62824",
"title": "871d65bfdd580cec349e63d687e6829e0ef62824",
"url": "https://llvm.googlesource.com/llvm-project/+/871d65bfdd580cec349e63d687e6829e0ef62824"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fcb7ed69d0b4b0eb6cf7802b660d92a29bca718f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fcb7ed69d0b4b0eb6cf7802b660d92a29bca718f",
"title": "fcb7ed69d0b4b0eb6cf7802b660d92a29bca718f",
"url": "https://llvm.googlesource.com/llvm-project/+/fcb7ed69d0b4b0eb6cf7802b660d92a29bca718f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b84f72a7f51e2ea829feb12ecbb8be0cfc835e2c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b84f72a7f51e2ea829feb12ecbb8be0cfc835e2c",
"title": "b84f72a7f51e2ea829feb12ecbb8be0cfc835e2c",
"url": "https://llvm.googlesource.com/llvm-project/+/b84f72a7f51e2ea829feb12ecbb8be0cfc835e2c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "46c059f925d18afc99db90dd9b9be989f7f62536"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@46c059f925d18afc99db90dd9b9be989f7f62536",
"title": "46c059f925d18afc99db90dd9b9be989f7f62536",
"url": "https://llvm.googlesource.com/llvm-project/+/46c059f925d18afc99db90dd9b9be989f7f62536"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b8bc3ff9bedf0b8f1d38273f7920cb0bba1a5a9e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b8bc3ff9bedf0b8f1d38273f7920cb0bba1a5a9e",
"title": "b8bc3ff9bedf0b8f1d38273f7920cb0bba1a5a9e",
"url": "https://llvm.googlesource.com/llvm-project/+/b8bc3ff9bedf0b8f1d38273f7920cb0bba1a5a9e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "13549fd90af45d2200159cac14a12cf01db56aa1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@13549fd90af45d2200159cac14a12cf01db56aa1",
"title": "13549fd90af45d2200159cac14a12cf01db56aa1",
"url": "https://llvm.googlesource.com/llvm-project/+/13549fd90af45d2200159cac14a12cf01db56aa1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6f28eec6dc68c64ebe108be3fdb7d0affb1e3349"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6f28eec6dc68c64ebe108be3fdb7d0affb1e3349",
"title": "6f28eec6dc68c64ebe108be3fdb7d0affb1e3349",
"url": "https://llvm.googlesource.com/llvm-project/+/6f28eec6dc68c64ebe108be3fdb7d0affb1e3349"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6f28eec6dc68c64ebe108be3fdb7d0affb1e3349",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8874507273183622896"
},
{
"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"
}
}
[17:36:06.908] Scheduled build:
{
"id": "8709077210949173249",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-17T17:36:06.526148956Z",
"updateTime": "2025-07-17T17:36:06.526148956Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6f28eec6dc68c64ebe108be3fdb7d0affb1e3349",
"ref": "refs/heads/main"
}
}
}
[17:36:06.908] Task URL: https://cr-buildbucket.appspot.com/build/8709077210949173249
[17:36:06.908] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:2:0) after 8m40s
[17:36:07.867] Received PubSub notification, asking Buildbucket for the build status
[17:36:07.901] Build status: SCHEDULED
[17:36:16.751] Received PubSub notification, asking Buildbucket for the build status
[17:36:16.773] Build status: STARTED
[17:44:46.953] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:2:0)
[17:44:46.975] Build status: STARTED
[17:44:46.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:5:0) after 1m31s
[17:46:18.042] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:5:0)
[17:46:18.074] Build status: STARTED
[17:46:18.074] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:6:0) after 4m13s
[17:50:31.169] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:6:0)
[17:50:31.219] Build status: STARTED
[17:50:31.219] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:7:0) after 7m17s
[17:57:48.239] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:7:0)
[17:57:48.281] Build status: STARTED
[17:57:48.281] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:8:0) after 3m49s
[18:01:37.374] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:8:0)
[18:01:37.436] Build status: STARTED
[18:01:37.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:9:0) after 5m27s
[18:07:04.533] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:9:0)
[18:07:04.559] Build status: STARTED
[18:07:04.559] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:10:0) after 6m42s
[18:13:46.536] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:10:0)
[18:13:46.596] Build status: STARTED
[18:13:46.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:11:0) after 5m9s
[18:18:55.627] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:11:0)
[18:18:55.703] Build status: STARTED
[18:18:55.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:12:0) after 9m52s
[18:28:47.838] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:12:0)
[18:28:47.858] Build status: STARTED
[18:28:47.858] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:13:0) after 9m17s
[18:38:04.896] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:13:0)
[18:38:04.922] Build status: STARTED
[18:38:04.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:14:0) after 7m22s
[18:45:26.945] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:14:0)
[18:45:26.995] Build status: STARTED
[18:45:26.996] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:15:0) after 2m31s
[18:47:58.060] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:15:0)
[18:47:58.086] Build status: STARTED
[18:47:58.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:16:0) after 2m55s
[18:50:53.198] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:16:0)
[18:50:53.225] Build status: STARTED
[18:50:53.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8874507273183622896:17:0) after 5m23s
[18:55:13.365] Received PubSub notification, asking Buildbucket for the build status
[18:55:13.398] Build:
{
"id": "8709077210949173249",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-17T17:36:06.526148956Z",
"startTime": "2025-07-17T17:36:16.511186137Z",
"endTime": "2025-07-17T18:55:12.803543543Z",
"updateTime": "2025-07-17T18:55:12.803543543Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "6f28eec6dc68c64ebe108be3fdb7d0affb1e3349",
"ref": "refs/heads/main"
}
}
}
[18:55:13.398] Invocation finished in 1h19m8.385958775s with status SUCCEEDED