[02:20:51.257] New invocation is queued and will start shortly
[02:20:51.257] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[02:20:52.509] Starting the invocation (attempt 1)
[02:20:52.538] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/888b130bdfd98bda71e14fb10893113cbbd15733"
[02:20:52.538] Reconstructed gitiles commit from tags
[02:20:52.538] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:20:52.538] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:20:52.539] Buildbucket request:
{
"requestId": "8907542150207770640",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "48a17de9ae0e2a32c261adaff1846b3aa60026edbce04fbcde095fcf98f0b936/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f15993208e5a7ec96df810db47ab002fec809142",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8907542150207770640",
"job": "fuchsia/clang_toolchain.ci.core.arm64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6d80d7e1d236ad78371b5fbe7b8dd0fa33aee79a737583c9ba7d3968306401bc/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "08a57b5698e36e34ed0170c8764bfeb028d37c05",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "7647174738bf1b8e58c854c488183a849403d5db"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/7647174738bf1b8e58c854c488183a849403d5db",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "8fac0339-f951-4d21-98c8-a89af9995d2a",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "37a07c9491a36de117f3dc4cfffa968dde480dcfdb0a7ed345d6946219453a5a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f15993208e5a7ec96df810db47ab002fec809142",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "ab142c635e5edeb381fb3bd0222501cd2108c176"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ab142c635e5edeb381fb3bd0222501cd2108c176",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f17193d9-f246-47c5-bba6-726d96cfc14d",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "00850f00f786bd60686495327a1448b55cb564bdba7018cb14723e3cb74c0842/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f15993208e5a7ec96df810db47ab002fec809142",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "4283f1ad18db9878b98f98e7a36b4f94ab674d29"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4283f1ad18db9878b98f98e7a36b4f94ab674d29",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "25701bbd-d5f6-4c5a-a8ae-733b0206fc47",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "48a17de9ae0e2a32c261adaff1846b3aa60026edbce04fbcde095fcf98f0b936/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "f15993208e5a7ec96df810db47ab002fec809142",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "888b130bdfd98bda71e14fb10893113cbbd15733"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/888b130bdfd98bda71e14fb10893113cbbd15733",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d9fc1d37-95e0-4dcb-ac34-c5518479c2e5",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "888b130bdfd98bda71e14fb10893113cbbd15733"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "888b130bdfd98bda71e14fb10893113cbbd15733",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8907542150207770640"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.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"
}
}
[02:20:53.128] Scheduled build:
{
"id": "8742112088132287217",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-18T02:20:52.611520132Z",
"updateTime": "2024-07-18T02:20:52.611520132Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "888b130bdfd98bda71e14fb10893113cbbd15733",
"ref": "refs/heads/main"
}
},
"canary": true
}
[02:20:53.129] Task URL: https://cr-buildbucket.appspot.com/build/8742112088132287217
[02:20:53.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:2:0) after 6m22s
[02:20:54.097] Received PubSub notification, asking Buildbucket for the build status
[02:20:54.131] Build status: SCHEDULED
[02:20:58.405] Received PubSub notification, asking Buildbucket for the build status
[02:20:58.426] Build status: STARTED
[02:27:15.154] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:2:0)
[02:27:15.197] Build status: STARTED
[02:27:15.197] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:5:0) after 8m33s
[02:35:48.598] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:5:0)
[02:35:48.620] Build status: STARTED
[02:35:48.620] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:6:0) after 5m34s
[02:41:22.611] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:6:0)
[02:41:22.631] Build status: STARTED
[02:41:22.632] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:7:0) after 7m37s
[02:48:59.950] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:7:0)
[02:49:00.168] Build status: STARTED
[02:49:00.168] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:8:0) after 3m18s
[02:52:18.245] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:8:0)
[02:52:18.273] Build status: STARTED
[02:52:18.273] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:9:0) after 4m16s
[02:56:34.308] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:9:0)
[02:56:34.329] Build status: STARTED
[02:56:34.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:10:0) after 2m4s
[02:58:38.484] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:10:0)
[02:58:38.516] Build status: STARTED
[02:58:38.516] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:11:0) after 2m33s
[03:01:11.676] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:11:0)
[03:01:11.698] Build status: STARTED
[03:01:11.698] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:12:0) after 6m49s
[03:08:00.727] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:12:0)
[03:08:00.753] Build status: STARTED
[03:08:00.753] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:13:0) after 5m31s
[03:13:31.794] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:13:0)
[03:13:31.844] Build status: STARTED
[03:13:31.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:14:0) after 1m37s
[03:15:08.860] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:14:0)
[03:15:08.881] Build status: STARTED
[03:15:08.881] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:15:0) after 4m35s
[03:19:43.899] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:15:0)
[03:19:43.919] Build status: STARTED
[03:19:43.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:16:0) after 3m27s
[03:23:10.949] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:16:0)
[03:23:10.970] Build status: STARTED
[03:23:10.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:17:0) after 1m42s
[03:24:53.036] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:17:0)
[03:24:53.071] Build status: STARTED
[03:24:53.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:18:0) after 1m12s
[03:26:05.088] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:18:0)
[03:26:05.110] Build status: STARTED
[03:26:05.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:19:0) after 2m27s
[03:28:32.080] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:19:0)
[03:28:32.123] Build status: STARTED
[03:28:32.123] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:20:0) after 8m30s
[03:37:02.140] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:20:0)
[03:37:02.155] Build status: STARTED
[03:37:02.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:21:0) after 9m51s
[03:46:53.172] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:21:0)
[03:46:53.193] Build status: STARTED
[03:46:53.193] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:22:0) after 9m27s
[03:56:20.165] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:22:0)
[03:56:20.185] Build status: STARTED
[03:56:20.185] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:23:0) after 2m7s
[03:58:27.297] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:23:0)
[03:58:27.365] Build status: STARTED
[03:58:27.365] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:24:0) after 1m36s
[04:00:03.418] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:24:0)
[04:00:03.442] Build status: STARTED
[04:00:03.442] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:25:0) after 8m6s
[04:08:09.605] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:25:0)
[04:08:09.631] Build status: STARTED
[04:08:09.631] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:26:0) after 8m29s
[04:16:38.694] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:26:0)
[04:16:38.713] Build status: STARTED
[04:16:38.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:27:0) after 7m36s
[04:24:14.818] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:27:0)
[04:24:14.988] Build status: STARTED
[04:24:14.988] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:28:0) after 2m18s
[04:26:33.011] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:28:0)
[04:26:33.033] Build status: STARTED
[04:26:33.033] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:29:0) after 2m53s
[04:29:26.076] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:29:0)
[04:29:26.095] Build status: STARTED
[04:29:26.095] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:30:0) after 3m46s
[04:33:12.146] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:30:0)
[04:33:12.368] Build status: STARTED
[04:33:12.368] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:31:0) after 2m58s
[04:36:10.397] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:31:0)
[04:36:10.415] Build status: STARTED
[04:36:10.415] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:32:0) after 1m38s
[04:37:48.441] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:32:0)
[04:37:48.484] Build status: STARTED
[04:37:48.484] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:33:0) after 1m18s
[04:39:06.500] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:33:0)
[04:39:06.522] Build status: STARTED
[04:39:06.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:34:0) after 9m19s
[04:48:25.545] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:34:0)
[04:48:25.642] Build status: STARTED
[04:48:25.642] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:35:0) after 1m17s
[04:49:42.702] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:35:0)
[04:49:42.721] Build status: STARTED
[04:49:42.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:36:0) after 1m55s
[04:51:37.848] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:36:0)
[04:51:37.875] Build status: STARTED
[04:51:37.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:37:0) after 6m30s
[04:58:07.936] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:37:0)
[04:58:07.980] Build status: STARTED
[04:58:07.980] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-release:8907542150207770640:38:0) after 9m1s
[05:04:20.933] Received PubSub notification, asking Buildbucket for the build status
[05:04:20.969] Build:
{
"id": "8742112088132287217",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-07-18T02:20:52.611520132Z",
"startTime": "2024-07-18T02:20:58.189934518Z",
"endTime": "2024-07-18T05:04:20.523236188Z",
"updateTime": "2024-07-18T05:04:20.523236188Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "888b130bdfd98bda71e14fb10893113cbbd15733",
"ref": "refs/heads/main"
}
},
"canary": true
}
[05:04:20.969] Invocation finished in 2h43m29.720506286s with status SUCCEEDED