[18:03:07.106] New invocation is queued and will start shortly
[18:03:08.286] Starting the invocation (attempt 1)
[18:03:08.316] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5482ef76f5b3d5ffcaded397fa924569e83f0b2d"
[18:03:08.316] Popped gitiles commit info from properties and tags
[18:03:08.316] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:03:08.316] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:03:08.316] Buildbucket request:
{
"requestId": "8873237214769921152",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8873237214769921152",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4adce336f46235aa74c95a3664fe8150c640e4f5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4adce336f46235aa74c95a3664fe8150c640e4f5",
"title": "4adce336f46235aa74c95a3664fe8150c640e4f5",
"url": "https://llvm.googlesource.com/llvm-project/+/4adce336f46235aa74c95a3664fe8150c640e4f5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "69751196a99646eb692da74522b72f0cc3d33b01"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@69751196a99646eb692da74522b72f0cc3d33b01",
"title": "69751196a99646eb692da74522b72f0cc3d33b01",
"url": "https://llvm.googlesource.com/llvm-project/+/69751196a99646eb692da74522b72f0cc3d33b01"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b59cb281c1578443edabd6e0ab69e3d2357f60d6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b59cb281c1578443edabd6e0ab69e3d2357f60d6",
"title": "b59cb281c1578443edabd6e0ab69e3d2357f60d6",
"url": "https://llvm.googlesource.com/llvm-project/+/b59cb281c1578443edabd6e0ab69e3d2357f60d6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3ca2050aa62bde68c74ddbb6c2501bd49831dd22"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3ca2050aa62bde68c74ddbb6c2501bd49831dd22",
"title": "3ca2050aa62bde68c74ddbb6c2501bd49831dd22",
"url": "https://llvm.googlesource.com/llvm-project/+/3ca2050aa62bde68c74ddbb6c2501bd49831dd22"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "69f3ea08522eca4b8617145fdafb8fc6595ddf97"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@69f3ea08522eca4b8617145fdafb8fc6595ddf97",
"title": "69f3ea08522eca4b8617145fdafb8fc6595ddf97",
"url": "https://llvm.googlesource.com/llvm-project/+/69f3ea08522eca4b8617145fdafb8fc6595ddf97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7cdc9781d45ce6eb27041a3aaeb756f00b9058e3"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7cdc9781d45ce6eb27041a3aaeb756f00b9058e3",
"title": "7cdc9781d45ce6eb27041a3aaeb756f00b9058e3",
"url": "https://llvm.googlesource.com/llvm-project/+/7cdc9781d45ce6eb27041a3aaeb756f00b9058e3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "90e710b513dd4b2e117ba13604270c337bfca7b6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@90e710b513dd4b2e117ba13604270c337bfca7b6",
"title": "90e710b513dd4b2e117ba13604270c337bfca7b6",
"url": "https://llvm.googlesource.com/llvm-project/+/90e710b513dd4b2e117ba13604270c337bfca7b6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "03e54a148fc2dad50bce59b63929f35afdab0344"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@03e54a148fc2dad50bce59b63929f35afdab0344",
"title": "03e54a148fc2dad50bce59b63929f35afdab0344",
"url": "https://llvm.googlesource.com/llvm-project/+/03e54a148fc2dad50bce59b63929f35afdab0344"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fc12fc635b96e9fa521a33eb31336c539eed1918"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fc12fc635b96e9fa521a33eb31336c539eed1918",
"title": "fc12fc635b96e9fa521a33eb31336c539eed1918",
"url": "https://llvm.googlesource.com/llvm-project/+/fc12fc635b96e9fa521a33eb31336c539eed1918"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "38fa11f5b4cad7aec3697b913f8c54f987049060"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@38fa11f5b4cad7aec3697b913f8c54f987049060",
"title": "38fa11f5b4cad7aec3697b913f8c54f987049060",
"url": "https://llvm.googlesource.com/llvm-project/+/38fa11f5b4cad7aec3697b913f8c54f987049060"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5d489b82a1d0ae8e28fccdc4a28b36923a5f3959"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5d489b82a1d0ae8e28fccdc4a28b36923a5f3959",
"title": "5d489b82a1d0ae8e28fccdc4a28b36923a5f3959",
"url": "https://llvm.googlesource.com/llvm-project/+/5d489b82a1d0ae8e28fccdc4a28b36923a5f3959"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f23c10f9e68efae7df10745234bf879a84b2d02b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f23c10f9e68efae7df10745234bf879a84b2d02b",
"title": "f23c10f9e68efae7df10745234bf879a84b2d02b",
"url": "https://llvm.googlesource.com/llvm-project/+/f23c10f9e68efae7df10745234bf879a84b2d02b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "91e0055c7c46d26356765a0e641c77920d85a26f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@91e0055c7c46d26356765a0e641c77920d85a26f",
"title": "91e0055c7c46d26356765a0e641c77920d85a26f",
"url": "https://llvm.googlesource.com/llvm-project/+/91e0055c7c46d26356765a0e641c77920d85a26f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "441f5b0e367ceee5b8b12d14c0d1ebb1c29fa414"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@441f5b0e367ceee5b8b12d14c0d1ebb1c29fa414",
"title": "441f5b0e367ceee5b8b12d14c0d1ebb1c29fa414",
"url": "https://llvm.googlesource.com/llvm-project/+/441f5b0e367ceee5b8b12d14c0d1ebb1c29fa414"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e5402c977f5a2eeae037103d2fd68df10d5c6650"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e5402c977f5a2eeae037103d2fd68df10d5c6650",
"title": "e5402c977f5a2eeae037103d2fd68df10d5c6650",
"url": "https://llvm.googlesource.com/llvm-project/+/e5402c977f5a2eeae037103d2fd68df10d5c6650"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7f93487862d98bf1c168babba87daf6224d8a46f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7f93487862d98bf1c168babba87daf6224d8a46f",
"title": "7f93487862d98bf1c168babba87daf6224d8a46f",
"url": "https://llvm.googlesource.com/llvm-project/+/7f93487862d98bf1c168babba87daf6224d8a46f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1bc58851868ad1f8ac6313d9f2337ec827b85019"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1bc58851868ad1f8ac6313d9f2337ec827b85019",
"title": "1bc58851868ad1f8ac6313d9f2337ec827b85019",
"url": "https://llvm.googlesource.com/llvm-project/+/1bc58851868ad1f8ac6313d9f2337ec827b85019"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5482ef76f5b3d5ffcaded397fa924569e83f0b2d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5482ef76f5b3d5ffcaded397fa924569e83f0b2d",
"title": "5482ef76f5b3d5ffcaded397fa924569e83f0b2d",
"url": "https://llvm.googlesource.com/llvm-project/+/5482ef76f5b3d5ffcaded397fa924569e83f0b2d"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5482ef76f5b3d5ffcaded397fa924569e83f0b2d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8873237214769921152"
},
{
"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"
}
}
[18:03:08.819] Scheduled build:
{
"id": "8707807152708003393",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-31T18:03:08.451249141Z",
"updateTime": "2025-07-31T18:03:08.451249141Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5482ef76f5b3d5ffcaded397fa924569e83f0b2d",
"ref": "refs/heads/main"
}
}
}
[18:03:08.819] Task URL: https://cr-buildbucket.appspot.com/build/8707807152708003393
[18:03:08.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:2:0) after 7m55s
[18:03:09.789] Received PubSub notification, asking Buildbucket for the build status
[18:03:09.808] Build status: SCHEDULED
[18:11:03.956] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:2:0)
[18:11:03.989] Build status: SCHEDULED
[18:11:03.989] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:4:0) after 7m27s
[18:18:31.011] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:4:0)
[18:18:31.039] Build status: SCHEDULED
[18:18:31.039] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:5:0) after 1m42s
[18:20:13.032] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:5:0)
[18:20:13.057] Build status: SCHEDULED
[18:20:13.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:6:0) after 5m38s
[18:21:42.841] Received PubSub notification, asking Buildbucket for the build status
[18:21:42.863] Build status: STARTED
[18:25:51.055] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:6:0)
[18:25:51.138] Build status: STARTED
[18:25:51.138] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:8:0) after 2m38s
[18:28:29.157] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:8:0)
[18:28:29.176] Build status: STARTED
[18:28:29.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:9:0) after 2m38s
[18:31:07.201] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:9:0)
[18:31:07.232] Build status: STARTED
[18:31:07.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:10:0) after 7m37s
[18:38:44.248] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:10:0)
[18:38:44.277] Build status: STARTED
[18:38:44.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:11:0) after 9m34s
[18:48:18.335] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:11:0)
[18:48:18.430] Build status: STARTED
[18:48:18.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:12:0) after 4m6s
[18:52:24.518] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:12:0)
[18:52:24.536] Build status: STARTED
[18:52:24.536] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:13:0) after 7m28s
[18:59:52.601] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:13:0)
[18:59:52.622] Build status: STARTED
[18:59:52.622] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:14:0) after 4m14s
[19:04:06.705] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:14:0)
[19:04:06.722] Build status: STARTED
[19:04:06.722] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:15:0) after 7m17s
[19:11:23.741] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:15:0)
[19:11:26.255] Build status: STARTED
[19:11:26.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:16:0) after 4m49s
[19:16:15.396] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:16:0)
[19:16:15.413] Build status: STARTED
[19:16:15.413] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:17:0) after 8m43s
[19:24:58.485] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:17:0)
[19:24:58.506] Build status: STARTED
[19:24:58.506] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:18:0) after 2m14s
[19:27:12.490] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:18:0)
[19:27:12.546] Build status: STARTED
[19:27:12.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:19:0) after 4m19s
[19:31:31.620] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:19:0)
[19:31:31.650] Build status: STARTED
[19:31:31.650] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8873237214769921152:20:0) after 4m59s
[19:31:38.962] Received PubSub notification, asking Buildbucket for the build status
[19:31:38.985] Build:
{
"id": "8707807152708003393",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-31T18:03:08.451249141Z",
"startTime": "2025-07-31T18:21:42.537752117Z",
"endTime": "2025-07-31T19:31:38.596513313Z",
"updateTime": "2025-07-31T19:31:38.596513313Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "5482ef76f5b3d5ffcaded397fa924569e83f0b2d",
"ref": "refs/heads/main"
}
}
}
[19:31:38.985] Invocation finished in 1h28m31.88446905s with status SUCCEEDED