[00:46:52.065] New invocation is queued and will start shortly
[00:46:53.126] Starting the invocation (attempt 1)
[00:46:53.152] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c56410fdc7aab4efd8024ed1cc83d30ccc04b5b6"
[00:46:53.153] Popped gitiles commit info from properties and tags
[00:46:53.153] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:46:53.153] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:46:53.153] Buildbucket request:
{
"requestId": "8853008689569962624",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8853008689569962624",
"job": "fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eeef27e8a7545b0f8677df6405b1225658f358a7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eeef27e8a7545b0f8677df6405b1225658f358a7",
"title": "eeef27e8a7545b0f8677df6405b1225658f358a7",
"url": "https://llvm.googlesource.com/llvm-project/+/eeef27e8a7545b0f8677df6405b1225658f358a7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "077991463253b9295f291d4e4d2078521e518717"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@077991463253b9295f291d4e4d2078521e518717",
"title": "077991463253b9295f291d4e4d2078521e518717",
"url": "https://llvm.googlesource.com/llvm-project/+/077991463253b9295f291d4e4d2078521e518717"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7c134b4edbee671749a8dd955347f096f3e2c5f4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7c134b4edbee671749a8dd955347f096f3e2c5f4",
"title": "7c134b4edbee671749a8dd955347f096f3e2c5f4",
"url": "https://llvm.googlesource.com/llvm-project/+/7c134b4edbee671749a8dd955347f096f3e2c5f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6903a5887047e8af8ada9c87e513d520be024bfe"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6903a5887047e8af8ada9c87e513d520be024bfe",
"title": "6903a5887047e8af8ada9c87e513d520be024bfe",
"url": "https://llvm.googlesource.com/llvm-project/+/6903a5887047e8af8ada9c87e513d520be024bfe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "eae80c6bfdfd851de4c025dd976134d3121e0fec"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@eae80c6bfdfd851de4c025dd976134d3121e0fec",
"title": "eae80c6bfdfd851de4c025dd976134d3121e0fec",
"url": "https://llvm.googlesource.com/llvm-project/+/eae80c6bfdfd851de4c025dd976134d3121e0fec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6e93c4a19d3c9ada5cf29a9164a0a5f39cc7ff50"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6e93c4a19d3c9ada5cf29a9164a0a5f39cc7ff50",
"title": "6e93c4a19d3c9ada5cf29a9164a0a5f39cc7ff50",
"url": "https://llvm.googlesource.com/llvm-project/+/6e93c4a19d3c9ada5cf29a9164a0a5f39cc7ff50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "49a8f37e4b39bf82ca0424e040a10e8fbfcc5571"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@49a8f37e4b39bf82ca0424e040a10e8fbfcc5571",
"title": "49a8f37e4b39bf82ca0424e040a10e8fbfcc5571",
"url": "https://llvm.googlesource.com/llvm-project/+/49a8f37e4b39bf82ca0424e040a10e8fbfcc5571"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "85bdc271e556905531ae64279424bed7d70696de"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@85bdc271e556905531ae64279424bed7d70696de",
"title": "85bdc271e556905531ae64279424bed7d70696de",
"url": "https://llvm.googlesource.com/llvm-project/+/85bdc271e556905531ae64279424bed7d70696de"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c30e11c634422efed1a5fd2c0070db1fef0d66e1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c30e11c634422efed1a5fd2c0070db1fef0d66e1",
"title": "c30e11c634422efed1a5fd2c0070db1fef0d66e1",
"url": "https://llvm.googlesource.com/llvm-project/+/c30e11c634422efed1a5fd2c0070db1fef0d66e1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6c217bb7713f2a7e7713f25067ac56429ba69f97"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6c217bb7713f2a7e7713f25067ac56429ba69f97",
"title": "6c217bb7713f2a7e7713f25067ac56429ba69f97",
"url": "https://llvm.googlesource.com/llvm-project/+/6c217bb7713f2a7e7713f25067ac56429ba69f97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "79026d22e29c301edf9fc6bf5e8da89daf793f3f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@79026d22e29c301edf9fc6bf5e8da89daf793f3f",
"title": "79026d22e29c301edf9fc6bf5e8da89daf793f3f",
"url": "https://llvm.googlesource.com/llvm-project/+/79026d22e29c301edf9fc6bf5e8da89daf793f3f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "92623c5cc6941e7131d32374bd9c8ff58be330e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@92623c5cc6941e7131d32374bd9c8ff58be330e9",
"title": "92623c5cc6941e7131d32374bd9c8ff58be330e9",
"url": "https://llvm.googlesource.com/llvm-project/+/92623c5cc6941e7131d32374bd9c8ff58be330e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "472c8f8d9696664bfe1429e34dbfce1ec584f2cc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@472c8f8d9696664bfe1429e34dbfce1ec584f2cc",
"title": "472c8f8d9696664bfe1429e34dbfce1ec584f2cc",
"url": "https://llvm.googlesource.com/llvm-project/+/472c8f8d9696664bfe1429e34dbfce1ec584f2cc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c56410fdc7aab4efd8024ed1cc83d30ccc04b5b6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c56410fdc7aab4efd8024ed1cc83d30ccc04b5b6",
"title": "c56410fdc7aab4efd8024ed1cc83d30ccc04b5b6",
"url": "https://llvm.googlesource.com/llvm-project/+/c56410fdc7aab4efd8024ed1cc83d30ccc04b5b6"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c56410fdc7aab4efd8024ed1cc83d30ccc04b5b6",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8853008689569962624"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:46:53.563] Scheduled build:
{
"id": "8687578627689787473",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-03-12T00:46:53.220140601Z",
"updateTime": "2026-03-12T00:46:53.220140601Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c56410fdc7aab4efd8024ed1cc83d30ccc04b5b6",
"ref": "refs/heads/main"
}
}
}
[00:46:53.563] Task URL: https://cr-buildbucket.appspot.com/build/8687578627689787473
[00:46:53.564] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:2:0) after 8m56s
[00:47:06.145] Received PubSub notification, asking Buildbucket for the build status
[00:47:06.172] Build status: STARTED
[00:47:11.239] Received PubSub notification, asking Buildbucket for the build status
[00:47:11.256] Build status: STARTED
[00:55:49.658] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:2:0)
[00:55:49.755] Build status: STARTED
[00:55:49.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:5:0) after 2m56s
[00:58:45.776] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:5:0)
[00:58:45.798] Build status: STARTED
[00:58:45.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:6:0) after 3m32s
[01:02:17.818] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:6:0)
[01:02:17.875] Build status: STARTED
[01:02:17.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:7:0) after 6m46s
[01:09:04.061] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:7:0)
[01:09:04.079] Build status: STARTED
[01:09:04.079] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:8:0) after 8m34s
[01:17:38.122] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:8:0)
[01:17:38.139] Build status: STARTED
[01:17:38.139] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:9:0) after 4m10s
[01:21:48.172] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:9:0)
[01:21:48.193] Build status: STARTED
[01:21:48.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:10:0) after 5m47s
[01:27:35.211] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:10:0)
[01:27:35.244] Build status: STARTED
[01:27:35.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:11:0) after 7m7s
[01:34:42.322] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:11:0)
[01:34:42.362] Build status: STARTED
[01:34:42.362] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:12:0) after 9m51s
[01:44:33.489] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:12:0)
[01:44:33.508] Build status: STARTED
[01:44:33.508] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:13:0) after 3m27s
[01:48:00.522] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:13:0)
[01:48:00.542] Build status: STARTED
[01:48:00.542] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:14:0) after 2m42s
[01:50:42.596] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:14:0)
[01:50:42.618] Build status: STARTED
[01:50:42.618] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:15:0) after 1m1s
[01:51:43.676] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:15:0)
[01:51:43.707] Build status: STARTED
[01:51:43.707] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:16:0) after 5m24s
[01:57:07.707] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:16:0)
[01:57:07.733] Build status: STARTED
[01:57:07.733] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:17:0) after 9m47s
[02:06:54.746] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:17:0)
[02:06:54.767] Build status: STARTED
[02:06:54.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:18:0) after 9m30s
[02:16:24.884] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:18:0)
[02:16:24.901] Build status: STARTED
[02:16:24.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:19:0) after 4m3s
[02:20:27.922] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:19:0)
[02:20:27.939] Build status: STARTED
[02:20:27.939] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:20:0) after 2m24s
[02:22:51.957] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:20:0)
[02:22:51.990] Build status: STARTED
[02:22:51.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:21:0) after 9m46s
[02:32:38.100] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:21:0)
[02:32:38.118] Build status: STARTED
[02:32:38.119] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:22:0) after 8m44s
[02:41:22.138] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:22:0)
[02:41:22.157] Build status: STARTED
[02:41:22.157] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:23:0) after 5m50s
[02:47:12.224] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:23:0)
[02:47:12.243] Build status: STARTED
[02:47:12.243] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:24:0) after 5m38s
[02:52:50.228] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:24:0)
[02:52:50.309] Build status: STARTED
[02:52:50.309] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:25:0) after 4m23s
[02:57:13.339] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:25:0)
[02:57:13.360] Build status: STARTED
[02:57:13.360] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:26:0) after 4m55s
[03:02:08.401] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:26:0)
[03:02:08.507] Build status: STARTED
[03:02:08.507] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:27:0) after 4m44s
[03:06:52.806] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:27:0)
[03:06:52.825] Build status: STARTED
[03:06:52.825] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:28:0) after 8m5s
[03:14:57.837] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:28:0)
[03:14:57.851] Build status: STARTED
[03:14:57.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:29:0) after 5m13s
[03:20:10.917] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:29:0)
[03:20:10.939] Build status: STARTED
[03:20:10.939] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:30:0) after 8m49s
[03:29:00.026] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:30:0)
[03:29:00.049] Build status: STARTED
[03:29:00.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:31:0) after 2m1s
[03:31:01.127] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:31:0)
[03:31:01.160] Build status: STARTED
[03:31:01.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:32:0) after 1m57s
[03:32:58.226] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:32:0)
[03:32:58.280] Build status: STARTED
[03:32:58.280] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:33:0) after 1m24s
[03:34:22.467] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:33:0)
[03:34:22.486] Build status: STARTED
[03:34:22.486] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-prod-unbounded-trigger-40be1bb5:8853008689569962624:34:0) after 6m42s
[03:40:28.775] Received PubSub notification, asking Buildbucket for the build status
[03:40:28.819] Build:
{
"id": "8687578627689787473",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-prod-unbounded-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-03-12T00:46:53.220140601Z",
"startTime": "2026-03-12T00:46:57.741347815Z",
"endTime": "2026-03-12T03:39:27.774263595Z",
"updateTime": "2026-03-12T03:39:27.774263595Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "c56410fdc7aab4efd8024ed1cc83d30ccc04b5b6",
"ref": "refs/heads/main"
}
}
}
[03:40:28.819] Invocation finished in 2h53m36.776322631s with status SUCCEEDED