[15:20:31.399] New invocation is queued and will start shortly
[15:20:31.399] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[15:20:32.726] Starting the invocation (attempt 1)
[15:20:32.760] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9d6527bc12547e28b86d180b76fe934a96aa518e"
[15:20:32.760] Reconstructed gitiles commit from tags
[15:20:32.760] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:20:32.760] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:20:32.761] Buildbucket request:
{
"requestId": "8892182210353528816",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "cf03621134f95429b97062c89d1a99202ae1bd10c2e6214d88d57f253dc69f29/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4190570827bc33c8cc87d33190e2f641dcd10c33",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8892182210353528816",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "fe0d32b42b1161a896aa9bab7294a9637e8d5f549eeb7ca7abdec0502f545eed/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a3fa5efd896d048d8806e7ba62474c8fa5f47535",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "5cf138cfbaa8040100fed1d0d5e0a189759b24ab"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/5cf138cfbaa8040100fed1d0d5e0a189759b24ab",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "854ccac3-7513-4531-b656-7067b486f265",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "84834801a92680e5a5299f79480f199deb31555dbc1d25fcd9463a4a59450ed3/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a3fa5efd896d048d8806e7ba62474c8fa5f47535",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e53494c750246118c313b3cbf7479edb682f2208"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e53494c750246118c313b3cbf7479edb682f2208",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "e6bcb88b-ffee-42f4-acf7-00a7dc7f393e",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "40857978a06a49d1f5f8823336efb95cc327a656b7cd221f78675a2703919a19/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a3fa5efd896d048d8806e7ba62474c8fa5f47535",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "6cd171dc3330a055a8d8a1ddff63631d42150b8a"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/6cd171dc3330a055a8d8a1ddff63631d42150b8a",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "67ae01e1-42e2-459b-9e2f-5345953d815f",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "3942afef8c6dca38132a84c5bb084fbb9cbe1fa94af19b9ee8a407668171c4ef/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "a3fa5efd896d048d8806e7ba62474c8fa5f47535",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e576c5bed79f8a9528391756c8475cc3a6276adf"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e576c5bed79f8a9528391756c8475cc3a6276adf",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "3b01a5cd-da29-441a-8258-29945405f6a5",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "cf03621134f95429b97062c89d1a99202ae1bd10c2e6214d88d57f253dc69f29/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4190570827bc33c8cc87d33190e2f641dcd10c33",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9d6527bc12547e28b86d180b76fe934a96aa518e"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9d6527bc12547e28b86d180b76fe934a96aa518e",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "e83c8b68-7ddd-44ca-8f53-4b78d0fe4ff2",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9d6527bc12547e28b86d180b76fe934a96aa518e"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9d6527bc12547e28b86d180b76fe934a96aa518e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8892182210353528816"
},
{
"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"
}
}
[15:20:33.374] Scheduled build:
{
"id": "8726752148187563441",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-03T15:20:32.838282495Z",
"updateTime": "2025-01-03T15:20:32.838282495Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9d6527bc12547e28b86d180b76fe934a96aa518e",
"ref": "refs/heads/main"
}
},
"canary": true
}
[15:20:33.374] Task URL: https://cr-buildbucket.appspot.com/build/8726752148187563441
[15:20:33.374] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:2:0) after 4m58s
[15:20:34.349] Received PubSub notification, asking Buildbucket for the build status
[15:20:34.375] Build status: SCHEDULED
[15:20:39.161] Received PubSub notification, asking Buildbucket for the build status
[15:20:39.183] Build status: STARTED
[15:25:31.401] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:2:0)
[15:25:31.425] Build status: STARTED
[15:25:31.425] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:5:0) after 5m23s
[15:30:54.721] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:5:0)
[15:30:54.752] Build status: STARTED
[15:30:54.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:6:0) after 1m45s
[15:32:40.071] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:6:0)
[15:32:40.163] Build status: STARTED
[15:32:40.164] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:7:0) after 3m26s
[15:36:06.263] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:7:0)
[15:36:06.296] Build status: STARTED
[15:36:06.296] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:8:0) after 9m19s
[15:45:25.312] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:8:0)
[15:45:25.329] Build status: STARTED
[15:45:25.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:9:0) after 6m26s
[15:51:51.352] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:9:0)
[15:51:51.379] Build status: STARTED
[15:51:51.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:10:0) after 9m34s
[16:01:25.488] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:10:0)
[16:01:25.502] Build status: STARTED
[16:01:25.502] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:11:0) after 7m41s
[16:09:06.710] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:11:0)
[16:09:06.741] Build status: STARTED
[16:09:06.741] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:12:0) after 2m32s
[16:11:38.967] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:12:0)
[16:11:38.988] Build status: STARTED
[16:11:38.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:13:0) after 8m17s
[16:19:56.090] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:13:0)
[16:19:56.108] Build status: STARTED
[16:19:56.108] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:14:0) after 1m0s
[16:20:56.601] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:14:0)
[16:20:56.625] Build status: STARTED
[16:20:56.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:15:0) after 5m36s
[16:26:32.778] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:15:0)
[16:26:32.802] Build status: STARTED
[16:26:32.802] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:16:0) after 2m22s
[16:28:54.867] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:16:0)
[16:28:54.893] Build status: STARTED
[16:28:54.893] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:17:0) after 3m57s
[16:32:51.908] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:17:0)
[16:32:51.925] Build status: STARTED
[16:32:51.925] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:18:0) after 7m33s
[16:40:24.922] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:18:0)
[16:40:25.043] Build status: STARTED
[16:40:25.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:19:0) after 7m39s
[16:48:04.016] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:19:0)
[16:48:04.035] Build status: STARTED
[16:48:04.036] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:20:0) after 2m7s
[16:50:11.059] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:20:0)
[16:50:11.081] Build status: STARTED
[16:50:11.081] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:21:0) after 6m25s
[16:56:36.142] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:21:0)
[16:56:36.160] Build status: STARTED
[16:56:36.160] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:22:0) after 9m50s
[17:06:26.195] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:22:0)
[17:06:26.215] Build status: STARTED
[17:06:26.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:23:0) after 6m44s
[17:13:10.239] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:23:0)
[17:13:10.255] Build status: STARTED
[17:13:10.255] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:24:0) after 7m19s
[17:20:29.285] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:24:0)
[17:20:29.303] Build status: STARTED
[17:20:29.303] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:25:0) after 2m53s
[17:23:22.335] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:25:0)
[17:23:22.352] Build status: STARTED
[17:23:22.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:26:0) after 1m51s
[17:25:13.372] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:26:0)
[17:25:13.724] Build status: STARTED
[17:25:13.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:27:0) after 5m20s
[17:30:33.727] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:27:0)
[17:30:33.747] Build status: STARTED
[17:30:33.747] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:28:0) after 6m6s
[17:36:39.769] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:28:0)
[17:36:39.789] Build status: STARTED
[17:36:39.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:29:0) after 7m35s
[17:44:14.815] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:29:0)
[17:44:14.837] Build status: STARTED
[17:44:14.837] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:30:0) after 8m6s
[17:52:20.879] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:30:0)
[17:52:20.897] Build status: STARTED
[17:52:20.897] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:31:0) after 1m8s
[17:53:28.921] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:31:0)
[17:53:29.025] Build status: STARTED
[17:53:29.025] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:32:0) after 6m34s
[18:00:03.217] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:32:0)
[18:00:03.238] Build status: STARTED
[18:00:03.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:33:0) after 2m17s
[18:02:20.274] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:33:0)
[18:02:20.305] Build status: STARTED
[18:02:20.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:34:0) after 4m10s
[18:06:30.320] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:34:0)
[18:06:30.354] Build status: STARTED
[18:06:30.354] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:35:0) after 3m23s
[18:09:53.412] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:35:0)
[18:09:53.492] Build status: STARTED
[18:09:53.492] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8892182210353528816:36:0) after 5m19s
[18:14:32.428] Received PubSub notification, asking Buildbucket for the build status
[18:14:32.450] Build:
{
"id": "8726752148187563441",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-03T15:20:32.838282495Z",
"startTime": "2025-01-03T15:20:38.926756524Z",
"endTime": "2025-01-03T18:14:32.057092343Z",
"updateTime": "2025-01-03T18:14:32.057092343Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "9d6527bc12547e28b86d180b76fe934a96aa518e",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:14:32.450] Invocation finished in 2h54m1.061195476s with status SUCCEEDED