[00:23:04.182] New invocation is queued and will start shortly
[00:23:05.277] Starting the invocation (attempt 1)
[00:23:05.308] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/45d5e7babab6042c4240b1853cefcc576a00e9c8"
[00:23:05.308] Popped gitiles commit info from properties and tags
[00:23:05.308] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:23:05.308] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:23:05.308] Buildbucket request:
{
"requestId": "8863791225805358048",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8863791225805358048",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b6bcfdea40de7eff820315b2030e6aa7ffdad241"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b6bcfdea40de7eff820315b2030e6aa7ffdad241",
"title": "b6bcfdea40de7eff820315b2030e6aa7ffdad241",
"url": "https://llvm.googlesource.com/llvm-project/+/b6bcfdea40de7eff820315b2030e6aa7ffdad241"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "bdf3f24ec0ec65fe83020119d0ef2336caab17cd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@bdf3f24ec0ec65fe83020119d0ef2336caab17cd",
"title": "bdf3f24ec0ec65fe83020119d0ef2336caab17cd",
"url": "https://llvm.googlesource.com/llvm-project/+/bdf3f24ec0ec65fe83020119d0ef2336caab17cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "2e489f77ba09ad1e10d644d95915e5d62fd3e19f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@2e489f77ba09ad1e10d644d95915e5d62fd3e19f",
"title": "2e489f77ba09ad1e10d644d95915e5d62fd3e19f",
"url": "https://llvm.googlesource.com/llvm-project/+/2e489f77ba09ad1e10d644d95915e5d62fd3e19f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "342bf5736457109031671b833eed6baf42d57746"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@342bf5736457109031671b833eed6baf42d57746",
"title": "342bf5736457109031671b833eed6baf42d57746",
"url": "https://llvm.googlesource.com/llvm-project/+/342bf5736457109031671b833eed6baf42d57746"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4b05581bae0e3432cfa514788418fb2fc2144904"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4b05581bae0e3432cfa514788418fb2fc2144904",
"title": "4b05581bae0e3432cfa514788418fb2fc2144904",
"url": "https://llvm.googlesource.com/llvm-project/+/4b05581bae0e3432cfa514788418fb2fc2144904"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "dbf77e4f5b77a719c2230e1c72e0298e23aff84e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@dbf77e4f5b77a719c2230e1c72e0298e23aff84e",
"title": "dbf77e4f5b77a719c2230e1c72e0298e23aff84e",
"url": "https://llvm.googlesource.com/llvm-project/+/dbf77e4f5b77a719c2230e1c72e0298e23aff84e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a01a921004c1c2e646d86a571aac2ffba57b90ae"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a01a921004c1c2e646d86a571aac2ffba57b90ae",
"title": "a01a921004c1c2e646d86a571aac2ffba57b90ae",
"url": "https://llvm.googlesource.com/llvm-project/+/a01a921004c1c2e646d86a571aac2ffba57b90ae"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "18d4da24220e2d189a0726f219724f762fa167cd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@18d4da24220e2d189a0726f219724f762fa167cd",
"title": "18d4da24220e2d189a0726f219724f762fa167cd",
"url": "https://llvm.googlesource.com/llvm-project/+/18d4da24220e2d189a0726f219724f762fa167cd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8c0dadf7b318031f8f7eb3b0cee9947ae3444a16"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8c0dadf7b318031f8f7eb3b0cee9947ae3444a16",
"title": "8c0dadf7b318031f8f7eb3b0cee9947ae3444a16",
"url": "https://llvm.googlesource.com/llvm-project/+/8c0dadf7b318031f8f7eb3b0cee9947ae3444a16"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "500e6d8b2884c27671c7cada645987f4e96dd181"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@500e6d8b2884c27671c7cada645987f4e96dd181",
"title": "500e6d8b2884c27671c7cada645987f4e96dd181",
"url": "https://llvm.googlesource.com/llvm-project/+/500e6d8b2884c27671c7cada645987f4e96dd181"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fa417d78b18f5a12e2be727efd2928cf775fe3ac"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fa417d78b18f5a12e2be727efd2928cf775fe3ac",
"title": "fa417d78b18f5a12e2be727efd2928cf775fe3ac",
"url": "https://llvm.googlesource.com/llvm-project/+/fa417d78b18f5a12e2be727efd2928cf775fe3ac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "141c2bf0beebf9b1ceea41649bc2e5d7a6026fb1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@141c2bf0beebf9b1ceea41649bc2e5d7a6026fb1",
"title": "141c2bf0beebf9b1ceea41649bc2e5d7a6026fb1",
"url": "https://llvm.googlesource.com/llvm-project/+/141c2bf0beebf9b1ceea41649bc2e5d7a6026fb1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "897cc3ee429a62e1dfd77a602db96e9884671f93"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@897cc3ee429a62e1dfd77a602db96e9884671f93",
"title": "897cc3ee429a62e1dfd77a602db96e9884671f93",
"url": "https://llvm.googlesource.com/llvm-project/+/897cc3ee429a62e1dfd77a602db96e9884671f93"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "45d5e7babab6042c4240b1853cefcc576a00e9c8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@45d5e7babab6042c4240b1853cefcc576a00e9c8",
"title": "45d5e7babab6042c4240b1853cefcc576a00e9c8",
"url": "https://llvm.googlesource.com/llvm-project/+/45d5e7babab6042c4240b1853cefcc576a00e9c8"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "45d5e7babab6042c4240b1853cefcc576a00e9c8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8863791225805358048"
},
{
"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"
}
}
[00:23:05.720] Scheduled build:
{
"id": "8698361163901358065",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-13T00:23:05.369850743Z",
"updateTime": "2025-11-13T00:23:05.369850743Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "45d5e7babab6042c4240b1853cefcc576a00e9c8",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:23:05.720] Task URL: https://cr-buildbucket.appspot.com/build/8698361163901358065
[00:23:05.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:2:0) after 3m19s
[00:23:06.740] Received PubSub notification, asking Buildbucket for the build status
[00:23:06.825] Build status: SCHEDULED
[00:26:24.752] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:2:0)
[00:26:24.769] Build status: SCHEDULED
[00:26:24.769] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:4:0) after 4m19s
[00:30:43.874] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:4:0)
[00:30:43.889] Build status: SCHEDULED
[00:30:43.889] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:5:0) after 3m52s
[00:34:35.906] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:5:0)
[00:34:35.920] Build status: SCHEDULED
[00:34:35.920] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:6:0) after 1m16s
[00:35:51.960] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:6:0)
[00:35:51.984] Build status: SCHEDULED
[00:35:51.984] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:7:0) after 5m56s
[00:41:26.970] Received PubSub notification, asking Buildbucket for the build status
[00:41:27.079] Build status: STARTED
[00:41:47.978] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:7:0)
[00:41:48.008] Build status: STARTED
[00:41:48.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:9:0) after 3m46s
[00:45:34.040] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:9:0)
[00:45:34.072] Build status: STARTED
[00:45:34.072] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:10:0) after 8m37s
[00:54:11.087] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:10:0)
[00:54:11.104] Build status: STARTED
[00:54:11.104] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:11:0) after 2m15s
[00:56:26.115] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:11:0)
[00:56:26.325] Build status: STARTED
[00:56:26.325] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:12:0) after 9m1s
[01:05:27.471] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:12:0)
[01:05:27.493] Build status: STARTED
[01:05:27.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:13:0) after 7m11s
[01:12:38.573] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:13:0)
[01:12:38.587] Build status: STARTED
[01:12:38.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:14:0) after 7m54s
[01:20:32.601] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:14:0)
[01:20:32.618] Build status: STARTED
[01:20:32.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:15:0) after 4m25s
[01:24:57.616] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:15:0)
[01:24:57.630] Build status: STARTED
[01:24:57.630] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:16:0) after 9m23s
[01:34:20.631] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:16:0)
[01:34:20.647] Build status: STARTED
[01:34:20.647] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:17:0) after 4m34s
[01:38:54.664] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:17:0)
[01:38:54.768] Build status: STARTED
[01:38:54.768] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:18:0) after 8m49s
[01:47:43.792] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:18:0)
[01:47:43.818] Build status: STARTED
[01:47:43.818] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:19:0) after 1m9s
[01:48:52.834] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:19:0)
[01:48:52.851] Build status: STARTED
[01:48:52.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:20:0) after 1m31s
[01:50:23.888] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:20:0)
[01:50:23.905] Build status: STARTED
[01:50:23.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8863791225805358048:21:0) after 5m24s
[01:55:11.977] Received PubSub notification, asking Buildbucket for the build status
[01:55:12.042] Build:
{
"id": "8698361163901358065",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-11-13T00:23:05.369850743Z",
"startTime": "2025-11-13T00:41:14.718024197Z",
"endTime": "2025-11-13T01:55:11.561226211Z",
"updateTime": "2025-11-13T01:55:11.561226211Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "45d5e7babab6042c4240b1853cefcc576a00e9c8",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:55:12.042] Invocation finished in 1h32m7.871661714s with status SUCCEEDED