[22:40:32.157] New invocation is queued and will start shortly
[22:40:32.157] Triggered by user:fuchsia-prod-builder@fuchsia-infra.iam.gserviceaccount.com
[22:40:33.227] Starting the invocation (attempt 1)
[22:40:33.259] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a31e25396e8eca4eab2b5604912ad4c15496dc4a"
[22:40:33.259] Reconstructed gitiles commit from tags
[22:40:33.260] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:40:33.260] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:40:33.260] Buildbucket request:
{
"requestId": "8890523781751412608",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "74afd40cc67fd151107396a219eb822bf653c5c7e1f14751a10fa9075d3b21a6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4b6d94ed3a8105f62ec489de3e4b704ea2862cfa",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8890523781751412608",
"job": "fuchsia/clang_toolchain.prod.core.arm64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "74afd40cc67fd151107396a219eb822bf653c5c7e1f14751a10fa9075d3b21a6/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "4b6d94ed3a8105f62ec489de3e4b704ea2862cfa",
"project": "integration",
"ref": "refs/heads/releases/canary"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a31e25396e8eca4eab2b5604912ad4c15496dc4a"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a31e25396e8eca4eab2b5604912ad4c15496dc4a",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f1598385-5ee2-4c4b-a951-f8481e323777",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a31e25396e8eca4eab2b5604912ad4c15496dc4a"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a31e25396e8eca4eab2b5604912ad4c15496dc4a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8890523781751412608"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.prod.core.arm64-release"
},
{
"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"
}
}
[22:40:33.659] Scheduled build:
{
"id": "8725093719878186161",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-21T22:40:33.322927058Z",
"updateTime": "2025-01-21T22:40:33.322927058Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a31e25396e8eca4eab2b5604912ad4c15496dc4a",
"ref": "refs/heads/main"
}
}
}
[22:40:33.659] Task URL: https://cr-buildbucket.appspot.com/build/8725093719878186161
[22:40:33.659] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:2:0) after 3m56s
[22:41:09.839] Received PubSub notification, asking Buildbucket for the build status
[22:41:09.868] Build status: STARTED
[22:41:20.877] Received PubSub notification, asking Buildbucket for the build status
[22:41:20.903] Build status: STARTED
[22:44:29.739] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:2:0)
[22:44:29.754] Build status: STARTED
[22:44:29.754] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:5:0) after 4m39s
[22:49:08.779] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:5:0)
[22:49:08.811] Build status: STARTED
[22:49:08.811] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:6:0) after 3m27s
[22:52:35.833] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:6:0)
[22:52:35.852] Build status: STARTED
[22:52:35.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:7:0) after 6m58s
[22:59:33.873] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:7:0)
[22:59:33.896] Build status: STARTED
[22:59:33.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:8:0) after 6m32s
[23:06:05.921] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:8:0)
[23:06:05.949] Build status: STARTED
[23:06:05.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:9:0) after 5m33s
[23:11:39.049] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:9:0)
[23:11:39.092] Build status: STARTED
[23:11:39.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:10:0) after 6m12s
[23:17:51.114] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:10:0)
[23:17:51.143] Build status: STARTED
[23:17:51.143] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:11:0) after 1m5s
[23:18:56.165] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:11:0)
[23:18:56.197] Build status: STARTED
[23:18:56.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:12:0) after 2m25s
[23:21:21.208] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:12:0)
[23:21:21.238] Build status: STARTED
[23:21:21.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:13:0) after 1m19s
[23:22:40.240] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:13:0)
[23:22:40.270] Build status: STARTED
[23:22:40.270] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:14:0) after 6m7s
[23:28:47.361] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:14:0)
[23:28:47.402] Build status: STARTED
[23:28:47.402] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:15:0) after 2m27s
[23:31:14.508] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:15:0)
[23:31:14.592] Build status: STARTED
[23:31:14.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:16:0) after 6m18s
[23:37:32.611] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:16:0)
[23:37:32.641] Build status: STARTED
[23:37:32.641] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:17:0) after 2m11s
[23:39:43.661] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:17:0)
[23:39:43.685] Build status: STARTED
[23:39:43.685] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:18:0) after 3m9s
[23:42:52.751] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:18:0)
[23:42:52.773] Build status: STARTED
[23:42:52.773] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:19:0) after 3m40s
[23:46:32.790] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:19:0)
[23:46:32.861] Build status: STARTED
[23:46:32.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:20:0) after 4m6s
[23:50:38.932] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:20:0)
[23:50:38.960] Build status: STARTED
[23:50:38.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:21:0) after 9m5s
[23:59:43.984] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:21:0)
[23:59:44.006] Build status: STARTED
[23:59:44.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:22:0) after 1m54s
[00:01:38.039] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:22:0)
[00:01:38.066] Build status: STARTED
[00:01:38.066] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:23:0) after 4m25s
[00:06:03.105] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:23:0)
[00:06:03.123] Build status: STARTED
[00:06:03.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:24:0) after 7m39s
[00:13:42.139] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:24:0)
[00:13:42.172] Build status: STARTED
[00:13:42.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:25:0) after 1m30s
[00:15:12.296] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:25:0)
[00:15:12.324] Build status: STARTED
[00:15:12.324] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:26:0) after 9m11s
[00:24:23.449] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:26:0)
[00:24:23.468] Build status: STARTED
[00:24:23.468] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:27:0) after 7m21s
[00:31:44.684] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:27:0)
[00:31:44.789] Build status: STARTED
[00:31:44.789] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:28:0) after 3m34s
[00:35:18.804] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:28:0)
[00:35:18.843] Build status: STARTED
[00:35:18.843] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:29:0) after 3m49s
[00:39:07.859] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:29:0)
[00:39:08.171] Build status: STARTED
[00:39:08.171] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:30:0) after 1m36s
[00:40:44.198] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:30:0)
[00:40:44.230] Build status: STARTED
[00:40:44.231] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:31:0) after 4m7s
[00:44:51.254] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:31:0)
[00:44:51.273] Build status: STARTED
[00:44:51.273] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:32:0) after 3m0s
[00:47:51.289] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:32:0)
[00:47:51.305] Build status: STARTED
[00:47:51.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:33:0) after 5m44s
[00:53:35.338] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:33:0)
[00:53:35.363] Build status: STARTED
[00:53:35.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:34:0) after 6m6s
[00:59:41.394] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:34:0)
[00:59:41.410] Build status: STARTED
[00:59:41.410] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:35:0) after 2m34s
[01:02:15.427] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:35:0)
[01:02:15.664] Build status: STARTED
[01:02:15.664] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:36:0) after 4m38s
[01:06:53.652] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:36:0)
[01:06:53.698] Build status: STARTED
[01:06:53.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:37:0) after 2m57s
[01:09:50.714] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:37:0)
[01:09:50.732] Build status: STARTED
[01:09:50.732] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:38:0) after 2m0s
[01:11:50.817] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:38:0)
[01:11:50.850] Build status: STARTED
[01:11:50.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:39:0) after 3m15s
[01:15:05.871] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:39:0)
[01:15:05.886] Build status: STARTED
[01:15:05.886] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:40:0) after 6m54s
[01:21:59.924] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:40:0)
[01:21:59.949] Build status: STARTED
[01:21:59.949] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.prod.core.arm64-release:8890523781751412608:41:0) after 7m9s
[01:26:50.127] Received PubSub notification, asking Buildbucket for the build status
[01:26:50.177] Build:
{
"id": "8725093719878186161",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.prod.core.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2025-01-21T22:40:33.322927058Z",
"startTime": "2025-01-21T22:40:39.133325897Z",
"endTime": "2025-01-22T01:26:49.645780277Z",
"updateTime": "2025-01-22T01:26:49.645780277Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a31e25396e8eca4eab2b5604912ad4c15496dc4a",
"ref": "refs/heads/main"
}
}
}
[01:26:50.177] Invocation finished in 2h46m18.025722717s with status SUCCEEDED