[03:17:52.151] New invocation is queued and will start shortly
[03:17:52.151] Triggered by user:clang-ci-builder@fuchsia-service-accounts.iam.gserviceaccount.com
[03:17:53.332] Starting the invocation (attempt 1)
[03:17:53.358] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/33c42f8bc5615b4dc46cb45ab41da97be52474ec"
[03:17:53.358] Reconstructed gitiles commit from tags
[03:17:53.358] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:17:53.358] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:17:53.359] Buildbucket request:
{
"requestId": "8889690960759826160",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "af639e9ee2f53f7656e8145dd97cfb20a19ea5c1022ff268d4f96a44d134cec9/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "28ce081e8a2c451302c7e8e5a1be3143dcf27726",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8889690960759826160",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "1dc858ddafa855fb0168bf07fa543115d493c0f9afaba5cb50261b1ddd03f493/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f71f0d5b707314f9332af926916ff1195926e998",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "012e0a0def4f4cd92266bc5b967532c6a3b8c533"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/012e0a0def4f4cd92266bc5b967532c6a3b8c533",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "97f95ec6-cf23-4240-9571-b8de0bf58093",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "008a9a6e0623e2d4ed3ef5620452d73132f44cbfdacbe42363f2ffd428f2e914/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f71f0d5b707314f9332af926916ff1195926e998",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "adb9ef035552d7fc42a34560677f89f4f6421295"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/adb9ef035552d7fc42a34560677f89f4f6421295",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "bc5e59ea-49d2-4ae4-bdf2-f7782af3bf8b",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "52524f314c4a5e68c2d051eac6d872e0f95eab52a82b4e6b2ef8fc92e0628a28/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "28ce081e8a2c451302c7e8e5a1be3143dcf27726",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "3874620ef7477c47abb07b7b68c410c1a9ed1b53"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/3874620ef7477c47abb07b7b68c410c1a9ed1b53",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "98d04693-002d-416a-a824-ae04da489e07",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "af639e9ee2f53f7656e8145dd97cfb20a19ea5c1022ff268d4f96a44d134cec9/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "28ce081e8a2c451302c7e8e5a1be3143dcf27726",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "33c42f8bc5615b4dc46cb45ab41da97be52474ec"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/33c42f8bc5615b4dc46cb45ab41da97be52474ec",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "be812821-87cd-4721-9e82-eba21f557476",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "33c42f8bc5615b4dc46cb45ab41da97be52474ec"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "33c42f8bc5615b4dc46cb45ab41da97be52474ec",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8889690960759826160"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
},
{
"key": "parent_buildername",
"value": "clang-linux-x64"
},
{
"key": "user_agent",
"value": "recipe"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[03:17:54.171] Scheduled build:
{
"id": "8724260898727549041",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-31T03:17:53.464871827Z",
"updateTime": "2025-01-31T03:17:53.464871827Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "33c42f8bc5615b4dc46cb45ab41da97be52474ec",
"ref": "refs/heads/main"
}
}
}
[03:17:54.171] Task URL: https://cr-buildbucket.appspot.com/build/8724260898727549041
[03:17:54.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:2:0) after 1m5s
[03:17:55.075] Received PubSub notification, asking Buildbucket for the build status
[03:17:55.097] Build status: SCHEDULED
[03:17:59.778] Received PubSub notification, asking Buildbucket for the build status
[03:17:59.807] Build status: STARTED
[03:18:59.193] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:2:0)
[03:18:59.234] Build status: STARTED
[03:18:59.234] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:5:0) after 2m51s
[03:21:50.257] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:5:0)
[03:21:50.294] Build status: STARTED
[03:21:50.294] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:6:0) after 3m1s
[03:24:51.354] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:6:0)
[03:24:51.377] Build status: STARTED
[03:24:51.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:7:0) after 7m14s
[03:32:05.567] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:7:0)
[03:32:05.596] Build status: STARTED
[03:32:05.596] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:8:0) after 5m21s
[03:37:26.999] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:8:0)
[03:37:27.025] Build status: STARTED
[03:37:27.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:9:0) after 6m42s
[03:44:09.051] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:9:0)
[03:44:09.073] Build status: STARTED
[03:44:09.073] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:10:0) after 2m44s
[03:46:53.097] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:10:0)
[03:46:53.125] Build status: STARTED
[03:46:53.125] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:11:0) after 2m40s
[03:49:33.187] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:11:0)
[03:49:33.217] Build status: STARTED
[03:49:33.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:12:0) after 5m21s
[03:54:54.238] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:12:0)
[03:54:54.252] Build status: STARTED
[03:54:54.252] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:13:0) after 9m40s
[04:04:34.323] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:13:0)
[04:04:34.346] Build status: STARTED
[04:04:34.346] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:14:0) after 5m2s
[04:09:36.461] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:14:0)
[04:09:36.520] Build status: STARTED
[04:09:36.520] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:15:0) after 1m0s
[04:10:36.640] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:15:0)
[04:10:36.665] Build status: STARTED
[04:10:36.665] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:16:0) after 4m20s
[04:14:56.759] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:16:0)
[04:14:56.775] Build status: STARTED
[04:14:56.775] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:17:0) after 4m0s
[04:18:57.097] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:17:0)
[04:18:57.213] Build status: STARTED
[04:18:57.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:18:0) after 6m7s
[04:25:04.331] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:18:0)
[04:25:04.349] Build status: STARTED
[04:25:04.349] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:19:0) after 2m43s
[04:27:47.427] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:19:0)
[04:27:47.444] Build status: STARTED
[04:27:47.444] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:20:0) after 5m10s
[04:32:57.472] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:20:0)
[04:32:57.541] Build status: STARTED
[04:32:57.541] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:21:0) after 3m4s
[04:36:01.540] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:21:0)
[04:36:01.586] Build status: STARTED
[04:36:01.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:22:0) after 1m18s
[04:37:19.766] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:22:0)
[04:37:19.782] Build status: STARTED
[04:37:19.782] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:23:0) after 8m5s
[04:45:24.904] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:23:0)
[04:45:24.922] Build status: STARTED
[04:45:24.922] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:24:0) after 5m33s
[04:50:58.482] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:24:0)
[04:50:58.501] Build status: STARTED
[04:50:58.501] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:25:0) after 2m56s
[04:53:54.717] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:25:0)
[04:53:54.797] Build status: STARTED
[04:53:54.797] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:26:0) after 8m3s
[05:01:57.797] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:26:0)
[05:01:57.862] Build status: STARTED
[05:01:57.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:27:0) after 4m12s
[05:06:09.881] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:27:0)
[05:06:09.900] Build status: STARTED
[05:06:09.900] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:28:0) after 7m23s
[05:13:33.021] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:28:0)
[05:13:33.112] Build status: STARTED
[05:13:33.112] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:29:0) after 8m59s
[05:22:32.134] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:29:0)
[05:22:32.164] Build status: STARTED
[05:22:32.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:30:0) after 6m50s
[05:29:22.176] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:30:0)
[05:29:22.205] Build status: STARTED
[05:29:22.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:31:0) after 2m54s
[05:32:16.218] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:31:0)
[05:32:16.244] Build status: STARTED
[05:32:16.244] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:32:0) after 8m8s
[05:40:24.246] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:32:0)
[05:40:24.297] Build status: STARTED
[05:40:24.297] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:33:0) after 1m28s
[05:41:52.505] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:33:0)
[05:41:52.543] Build status: STARTED
[05:41:52.543] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:34:0) after 6m35s
[05:48:27.669] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:34:0)
[05:48:27.690] Build status: STARTED
[05:48:27.690] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:35:0) after 2m41s
[05:51:08.859] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:35:0)
[05:51:08.883] Build status: STARTED
[05:51:08.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:36:0) after 4m49s
[05:55:58.028] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:36:0)
[05:55:58.052] Build status: STARTED
[05:55:58.052] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:37:0) after 7m2s
[06:03:00.084] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:37:0)
[06:03:00.105] Build status: STARTED
[06:03:00.105] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:38:0) after 9m45s
[06:12:45.132] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:38:0)
[06:12:45.154] Build status: STARTED
[06:12:45.154] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:39:0) after 9m53s
[06:22:38.212] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:39:0)
[06:22:38.228] Build status: STARTED
[06:22:38.228] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8889690960759826160:40:0) after 8m0s
[06:25:44.162] Received PubSub notification, asking Buildbucket for the build status
[06:25:44.183] Build:
{
"id": "8724260898727549041",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-31T03:17:53.464871827Z",
"startTime": "2025-01-31T03:17:59.264132496Z",
"endTime": "2025-01-31T06:25:43.656903900Z",
"updateTime": "2025-01-31T06:25:43.656903900Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "33c42f8bc5615b4dc46cb45ab41da97be52474ec",
"ref": "refs/heads/main"
}
}
}
[06:25:44.183] Invocation finished in 3h7m52.041562404s with status SUCCEEDED