[16:05:21.017] New invocation is queued and will start shortly
[16:05:22.141] Starting the invocation (attempt 1)
[16:05:22.165] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/48fb51b14cdbbfe99abcef9bce0ba7e042b35bf5"
[16:05:22.165] Popped gitiles commit info from properties and tags
[16:05:22.165] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:05:22.165] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:05:22.166] Buildbucket request:
{
"requestId": "8857299558014138208",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8857299558014138208",
"job": "fuchsia/prod-clang-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f010621809b3fab9f3d64fa39699ea5c0c11e699"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f010621809b3fab9f3d64fa39699ea5c0c11e699",
"title": "f010621809b3fab9f3d64fa39699ea5c0c11e699",
"url": "https://llvm.googlesource.com/llvm-project/+/f010621809b3fab9f3d64fa39699ea5c0c11e699"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a3ebe650d3f3751786af10b4d6b17a3a59b9a332"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a3ebe650d3f3751786af10b4d6b17a3a59b9a332",
"title": "a3ebe650d3f3751786af10b4d6b17a3a59b9a332",
"url": "https://llvm.googlesource.com/llvm-project/+/a3ebe650d3f3751786af10b4d6b17a3a59b9a332"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "17a17fa81c48ad2c1cd36f27c317d964e86ecf1b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@17a17fa81c48ad2c1cd36f27c317d964e86ecf1b",
"title": "17a17fa81c48ad2c1cd36f27c317d964e86ecf1b",
"url": "https://llvm.googlesource.com/llvm-project/+/17a17fa81c48ad2c1cd36f27c317d964e86ecf1b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "afec4c28d55acc81315a4ef4fb7bcf319da7c830"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@afec4c28d55acc81315a4ef4fb7bcf319da7c830",
"title": "afec4c28d55acc81315a4ef4fb7bcf319da7c830",
"url": "https://llvm.googlesource.com/llvm-project/+/afec4c28d55acc81315a4ef4fb7bcf319da7c830"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0df9098c2563a7c2cf2a78b1514492f057bec1c8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0df9098c2563a7c2cf2a78b1514492f057bec1c8",
"title": "0df9098c2563a7c2cf2a78b1514492f057bec1c8",
"url": "https://llvm.googlesource.com/llvm-project/+/0df9098c2563a7c2cf2a78b1514492f057bec1c8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6e738e187055bbd33b6c3d203b6b55904dfcb624"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6e738e187055bbd33b6c3d203b6b55904dfcb624",
"title": "6e738e187055bbd33b6c3d203b6b55904dfcb624",
"url": "https://llvm.googlesource.com/llvm-project/+/6e738e187055bbd33b6c3d203b6b55904dfcb624"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a71ca9b27c675a6b37c64089f6d742206ad7e8d0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a71ca9b27c675a6b37c64089f6d742206ad7e8d0",
"title": "a71ca9b27c675a6b37c64089f6d742206ad7e8d0",
"url": "https://llvm.googlesource.com/llvm-project/+/a71ca9b27c675a6b37c64089f6d742206ad7e8d0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "0145a643ccaf55adf33f117e50ff587a4d2b8d9c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@0145a643ccaf55adf33f117e50ff587a4d2b8d9c",
"title": "0145a643ccaf55adf33f117e50ff587a4d2b8d9c",
"url": "https://llvm.googlesource.com/llvm-project/+/0145a643ccaf55adf33f117e50ff587a4d2b8d9c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a10062d675128fc03476ea01cb42d723701a6677"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a10062d675128fc03476ea01cb42d723701a6677",
"title": "a10062d675128fc03476ea01cb42d723701a6677",
"url": "https://llvm.googlesource.com/llvm-project/+/a10062d675128fc03476ea01cb42d723701a6677"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b74e1bca6d77b3de5c05822d1631006ce2a30cc6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b74e1bca6d77b3de5c05822d1631006ce2a30cc6",
"title": "b74e1bca6d77b3de5c05822d1631006ce2a30cc6",
"url": "https://llvm.googlesource.com/llvm-project/+/b74e1bca6d77b3de5c05822d1631006ce2a30cc6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "70ee6e4427c8f55a910193bbda2eadf75e8a75f2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@70ee6e4427c8f55a910193bbda2eadf75e8a75f2",
"title": "70ee6e4427c8f55a910193bbda2eadf75e8a75f2",
"url": "https://llvm.googlesource.com/llvm-project/+/70ee6e4427c8f55a910193bbda2eadf75e8a75f2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "48fb51b14cdbbfe99abcef9bce0ba7e042b35bf5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@48fb51b14cdbbfe99abcef9bce0ba7e042b35bf5",
"title": "48fb51b14cdbbfe99abcef9bce0ba7e042b35bf5",
"url": "https://llvm.googlesource.com/llvm-project/+/48fb51b14cdbbfe99abcef9bce0ba7e042b35bf5"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "48fb51b14cdbbfe99abcef9bce0ba7e042b35bf5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8857299558014138208"
},
{
"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"
}
}
[16:05:22.575] Scheduled build:
{
"id": "8691869496092316465",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-23T16:05:22.229729084Z",
"updateTime": "2026-01-23T16:05:22.229729084Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "48fb51b14cdbbfe99abcef9bce0ba7e042b35bf5",
"ref": "refs/heads/main"
}
},
"canary": true
}
[16:05:22.575] Task URL: https://cr-buildbucket.appspot.com/build/8691869496092316465
[16:05:22.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:2:0) after 2m40s
[16:05:23.535] Received PubSub notification, asking Buildbucket for the build status
[16:05:23.582] Build status: SCHEDULED
[16:05:27.311] Received PubSub notification, asking Buildbucket for the build status
[16:05:27.398] Build status: STARTED
[16:08:02.656] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:2:0)
[16:08:02.694] Build status: STARTED
[16:08:02.694] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:5:0) after 8m39s
[16:16:41.718] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:5:0)
[16:16:41.745] Build status: STARTED
[16:16:41.745] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:6:0) after 8m50s
[16:25:31.763] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:6:0)
[16:25:31.809] Build status: STARTED
[16:25:31.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:7:0) after 9m9s
[16:34:40.878] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:7:0)
[16:34:40.901] Build status: STARTED
[16:34:40.901] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:8:0) after 3m5s
[16:37:45.933] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:8:0)
[16:37:45.978] Build status: STARTED
[16:37:45.978] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:9:0) after 1m42s
[16:39:28.081] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:9:0)
[16:39:28.193] Build status: STARTED
[16:39:28.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:10:0) after 3m26s
[16:42:54.245] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:10:0)
[16:42:54.266] Build status: STARTED
[16:42:54.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:11:0) after 1m30s
[16:44:24.486] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:11:0)
[16:44:24.531] Build status: STARTED
[16:44:24.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:12:0) after 2m50s
[16:47:14.594] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:12:0)
[16:47:14.627] Build status: STARTED
[16:47:14.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:13:0) after 5m22s
[16:52:36.642] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:13:0)
[16:52:36.702] Build status: STARTED
[16:52:36.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:14:0) after 4m0s
[16:56:36.780] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:14:0)
[16:56:36.835] Build status: STARTED
[16:56:36.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:15:0) after 7m42s
[17:04:18.849] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:15:0)
[17:04:18.891] Build status: STARTED
[17:04:18.891] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:16:0) after 3m42s
[17:08:01.012] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:16:0)
[17:08:01.027] Build status: STARTED
[17:08:01.028] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:17:0) after 5m20s
[17:13:21.044] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:17:0)
[17:13:21.124] Build status: STARTED
[17:13:21.124] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:18:0) after 9m55s
[17:23:16.140] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:18:0)
[17:23:16.198] Build status: STARTED
[17:23:16.198] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:19:0) after 5m13s
[17:28:29.249] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:19:0)
[17:28:29.271] Build status: STARTED
[17:28:29.271] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:20:0) after 5m57s
[17:35:53.150] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:20:0)
[17:35:53.172] Build status: STARTED
[17:35:53.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:21:0) after 1m29s
[17:37:22.195] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:21:0)
[17:37:22.225] Build status: STARTED
[17:37:22.225] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:22:0) after 1m47s
[17:39:09.271] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:22:0)
[17:39:09.321] Build status: STARTED
[17:39:09.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:23:0) after 7m10s
[17:46:19.315] Handling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:23:0)
[17:46:19.340] Build status: STARTED
[17:46:19.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-clang-ci-trigger-40be1bb5:8857299558014138208:24:0) after 6m44s
[17:47:23.721] Received PubSub notification, asking Buildbucket for the build status
[17:47:23.784] Build:
{
"id": "8691869496092316465",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "clang-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2026-01-23T16:05:22.229729084Z",
"startTime": "2026-01-23T16:05:26.970035904Z",
"endTime": "2026-01-23T17:47:23.437190625Z",
"updateTime": "2026-01-23T17:47:23.437190625Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "48fb51b14cdbbfe99abcef9bce0ba7e042b35bf5",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:47:23.784] Invocation finished in 1h42m2.770846204s with status SUCCEEDED