[08:49:56.428] New invocation is queued and will start shortly
[08:49:56.428] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[08:49:57.623] Starting the invocation (attempt 1)
[08:49:57.660] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/53d8b59307d4e1bbaa1632efbe762014c9f6575e"
[08:49:57.660] Reconstructed gitiles commit from tags
[08:49:57.660] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:49:57.660] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:49:57.660] Buildbucket request:
{
"requestId": "8949917051305779712",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "64161f23691235ab7169d0b05fb8c252808b6c7ee0f04c593c2ea4eb0dbae6b7/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "d9bc207f80a77d9d9eb839076cd14e49f945b1b6",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8949917051305779712",
"job": "fuchsia/clang_toolchain.ci.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "f66fe00037148d395bb54785d8b37465421762fd7594895402ce9fd4081ea95f/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "79f3541eceb9cc6b2f28c768e40a71f5d25183e1",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "ff0aabf14dfa0a369c38f6e267c56a83ee48d647"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ff0aabf14dfa0a369c38f6e267c56a83ee48d647",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7df5536f-a26f-41aa-b1f3-6145841dae2f",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "6dd4ad2cf508c9a33609899310d0bf5868a5d59dee6df9b0e8727858524ce25a/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "d9bc207f80a77d9d9eb839076cd14e49f945b1b6",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "10cff75f12b270d856a4ff36e76a1b8441d6e2ff"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/10cff75f12b270d856a4ff36e76a1b8441d6e2ff",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "c61e620f-b713-447b-873b-c62f653f8bd6",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "64161f23691235ab7169d0b05fb8c252808b6c7ee0f04c593c2ea4eb0dbae6b7/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "d9bc207f80a77d9d9eb839076cd14e49f945b1b6",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "53d8b59307d4e1bbaa1632efbe762014c9f6575e"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/53d8b59307d4e1bbaa1632efbe762014c9f6575e",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "404577fd-ea53-4b94-a60e-96939aae4924",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "53d8b59307d4e1bbaa1632efbe762014c9f6575e"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53d8b59307d4e1bbaa1632efbe762014c9f6575e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8949917051305779712"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.arm64-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"
}
}
[08:49:57.960] Scheduled build:
{
"id": "8784486989285727185",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-07T08:49:57.721289594Z",
"updateTime": "2023-04-07T08:49:57.721289594Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53d8b59307d4e1bbaa1632efbe762014c9f6575e",
"ref": "refs/heads/main"
}
}
}
[08:49:57.960] Task URL: https://cr-buildbucket.appspot.com/build/8784486989285727185
[08:49:57.961] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:2:0) after 7m32s
[08:49:58.917] Received PubSub notification, asking Buildbucket for the build status
[08:49:58.940] Build status: STARTED
[08:57:29.984] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:2:0)
[08:57:30.004] Build status: STARTED
[08:57:30.004] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:4:0) after 1m10s
[08:58:39.989] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:4:0)
[08:58:40.056] Build status: STARTED
[08:58:40.056] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:5:0) after 6m52s
[09:05:32.080] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:5:0)
[09:05:32.102] Build status: STARTED
[09:05:32.102] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:6:0) after 3m30s
[09:09:02.137] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:6:0)
[09:09:02.181] Build status: STARTED
[09:09:02.181] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:7:0) after 4m25s
[09:13:27.353] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:7:0)
[09:13:27.389] Build status: STARTED
[09:13:27.389] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:8:0) after 8m43s
[09:22:10.412] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:8:0)
[09:22:10.434] Build status: STARTED
[09:22:10.434] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:9:0) after 4m37s
[09:26:47.421] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:9:0)
[09:26:47.464] Build status: STARTED
[09:26:47.464] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:10:0) after 7m4s
[09:33:51.531] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:10:0)
[09:33:51.553] Build status: STARTED
[09:33:51.553] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:11:0) after 4m21s
[09:38:12.570] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:11:0)
[09:38:12.599] Build status: STARTED
[09:38:12.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:12:0) after 9m41s
[09:47:53.625] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:12:0)
[09:47:53.653] Build status: STARTED
[09:47:53.653] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:13:0) after 2m40s
[09:50:33.682] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:13:0)
[09:50:33.703] Build status: STARTED
[09:50:33.703] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:14:0) after 4m0s
[09:54:33.808] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:14:0)
[09:54:33.844] Build status: STARTED
[09:54:33.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:15:0) after 1m53s
[09:56:26.865] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:15:0)
[09:56:26.884] Build status: STARTED
[09:56:26.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:16:0) after 9m37s
[10:06:03.940] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:16:0)
[10:06:04.000] Build status: STARTED
[10:06:04.000] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:17:0) after 1m22s
[10:07:26.104] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:17:0)
[10:07:26.128] Build status: STARTED
[10:07:26.128] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:18:0) after 2m2s
[10:09:28.686] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:18:0)
[10:09:28.721] Build status: STARTED
[10:09:28.721] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:19:0) after 3m10s
[10:12:39.076] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:19:0)
[10:12:39.169] Build status: STARTED
[10:12:39.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:20:0) after 5m36s
[10:18:15.153] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:20:0)
[10:18:15.172] Build status: STARTED
[10:18:15.172] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:21:0) after 1m38s
[10:19:53.194] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:21:0)
[10:19:53.215] Build status: STARTED
[10:19:53.215] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:22:0) after 3m30s
[10:23:23.406] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:22:0)
[10:23:23.429] Build status: STARTED
[10:23:23.429] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:23:0) after 2m21s
[10:25:44.720] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:23:0)
[10:25:44.742] Build status: STARTED
[10:25:44.742] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:24:0) after 2m43s
[10:28:27.851] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:24:0)
[10:28:27.872] Build status: STARTED
[10:28:27.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:25:0) after 2m18s
[10:30:45.943] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:25:0)
[10:30:45.966] Build status: STARTED
[10:30:45.966] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:26:0) after 8m19s
[10:39:04.990] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:26:0)
[10:39:05.015] Build status: STARTED
[10:39:05.015] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:27:0) after 2m15s
[10:41:20.054] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:27:0)
[10:41:20.075] Build status: STARTED
[10:41:20.075] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8949917051305779712:28:0) after 3m46s
[10:44:21.656] Received PubSub notification, asking Buildbucket for the build status
[10:44:21.684] Build:
{
"id": "8784486989285727185",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2023-04-07T08:49:57.721289594Z",
"startTime": "2023-04-07T08:49:58.479035Z",
"endTime": "2023-04-07T10:44:21.246938985Z",
"updateTime": "2023-04-07T10:44:21.246938985Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "53d8b59307d4e1bbaa1632efbe762014c9f6575e",
"ref": "refs/heads/main"
}
}
}
[10:44:21.684] Invocation finished in 1h54m25.27327632s with status SUCCEEDED