[00:43:06.723] New invocation is queued and will start shortly
[00:43:06.723] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[00:43:08.029] Starting the invocation (attempt 1)
[00:43:08.065] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4d1c5b946ad7f10d398b43e7f20a528407fb79b9"
[00:43:08.066] Reconstructed gitiles commit from tags
[00:43:08.066] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:43:08.066] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:43:08.067] Buildbucket request:
{
"requestId": "8960456927993281616",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "0670949a82e7b642ec8b3e763f51278f4152bbd78abcf6e8b72a902de35418d1/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0889a023e63928951faa148399b56696cd3b0d89",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8960456927993281616",
"job": "fuchsia/clang_toolchain.ci.core.arm64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "3c2a9c9418ba79eef2fd0df330cf2375ea27e9ef33672c771de6b3cbf39f59a5/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0889a023e63928951faa148399b56696cd3b0d89",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "1dfb0cd703fe1ada21681283fd75e6aba4b7f216"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/1dfb0cd703fe1ada21681283fd75e6aba4b7f216",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "95329c30-0365-4325-be92-7da7e99286ae",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "f19043f9e2fea6fd64085fbe756d5e0e8cefcf8ec9151eb202c64a4484e99e26/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0889a023e63928951faa148399b56696cd3b0d89",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "8d434235569fedddd4472c5de43d5f97e3a0bd1f"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8d434235569fedddd4472c5de43d5f97e3a0bd1f",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d61acf9d-bda2-4572-96df-c1c83295ace9",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/build": {
"clang_toolchain": {
"source": "isolated",
"version": "0670949a82e7b642ec8b3e763f51278f4152bbd78abcf6e8b72a902de35418d1/652"
}
},
"$fuchsia/checkout": {
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "0889a023e63928951faa148399b56696cd3b0d89",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "4d1c5b946ad7f10d398b43e7f20a528407fb79b9"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/4d1c5b946ad7f10d398b43e7f20a528407fb79b9",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "04d09d87-1c4a-4a86-99d7-a2cd8520b294",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "4d1c5b946ad7f10d398b43e7f20a528407fb79b9"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4d1c5b946ad7f10d398b43e7f20a528407fb79b9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8960456927993281616"
},
{
"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"
}
}
[00:43:08.977] Scheduled build:
{
"id": "8795026865823115409",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2022-12-12T00:43:08.169463394Z",
"updateTime": "2022-12-12T00:43:08.169463394Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4d1c5b946ad7f10d398b43e7f20a528407fb79b9",
"ref": "refs/heads/main"
}
}
}
[00:43:08.977] Task URL: https://cr-buildbucket.appspot.com/build/8795026865823115409
[00:43:08.977] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:2:0) after 9m42s
[00:43:09.860] Received PubSub notification, asking Buildbucket for the build status
[00:43:09.887] Build status: STARTED
[00:52:51.002] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:2:0)
[00:52:51.106] Build status: STARTED
[00:52:51.106] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:4:0) after 3m21s
[00:56:12.129] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:4:0)
[00:56:12.156] Build status: STARTED
[00:56:12.156] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:5:0) after 3m22s
[00:59:34.194] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:5:0)
[00:59:34.226] Build status: STARTED
[00:59:34.226] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:6:0) after 8m41s
[01:08:15.251] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:6:0)
[01:08:15.279] Build status: STARTED
[01:08:15.279] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:7:0) after 2m31s
[01:10:46.297] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:7:0)
[01:10:46.327] Build status: STARTED
[01:10:46.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:8:0) after 6m32s
[01:17:18.352] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:8:0)
[01:17:18.379] Build status: STARTED
[01:17:18.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:9:0) after 8m1s
[01:25:19.404] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:9:0)
[01:25:19.431] Build status: STARTED
[01:25:19.431] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:10:0) after 7m8s
[01:32:27.453] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:10:0)
[01:32:27.480] Build status: STARTED
[01:32:27.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:11:0) after 1m48s
[01:34:15.501] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:11:0)
[01:34:15.524] Build status: STARTED
[01:34:15.524] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:12:0) after 7m10s
[01:41:25.637] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:12:0)
[01:41:25.699] Build status: STARTED
[01:41:25.699] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:13:0) after 8m25s
[01:49:50.717] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:13:0)
[01:49:50.748] Build status: STARTED
[01:49:50.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:14:0) after 5m46s
[01:55:36.766] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:14:0)
[01:55:36.794] Build status: STARTED
[01:55:36.794] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:15:0) after 9m20s
[02:04:56.831] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:15:0)
[02:04:56.853] Build status: STARTED
[02:04:56.853] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:16:0) after 6m20s
[02:11:16.876] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:16:0)
[02:11:16.919] Build status: STARTED
[02:11:16.919] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:17:0) after 2m58s
[02:14:15.084] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:17:0)
[02:14:15.115] Build status: STARTED
[02:14:15.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:18:0) after 2m15s
[02:16:30.381] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:18:0)
[02:16:30.403] Build status: STARTED
[02:16:30.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:19:0) after 5m5s
[02:21:35.608] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:19:0)
[02:21:35.634] Build status: STARTED
[02:21:35.634] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:20:0) after 9m33s
[02:31:08.670] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:20:0)
[02:31:08.708] Build status: STARTED
[02:31:08.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:21:0) after 4m19s
[02:35:27.728] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:21:0)
[02:35:27.796] Build status: STARTED
[02:35:27.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:22:0) after 8m20s
[02:43:47.814] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:22:0)
[02:43:47.836] Build status: STARTED
[02:43:47.836] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:23:0) after 4m18s
[02:48:05.862] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:23:0)
[02:48:05.933] Build status: STARTED
[02:48:05.933] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.arm64-debug:8960456927993281616:24:0) after 5m18s
[02:48:08.904] Received PubSub notification, asking Buildbucket for the build status
[02:48:08.936] Build:
{
"id": "8795026865823115409",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.arm64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2022-12-12T00:43:08.169463394Z",
"startTime": "2022-12-12T00:43:09.243987Z",
"endTime": "2022-12-12T02:48:08.112158081Z",
"updateTime": "2022-12-12T02:48:08.112158081Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "4d1c5b946ad7f10d398b43e7f20a528407fb79b9",
"ref": "refs/heads/main"
}
}
}
[02:48:08.936] Invocation finished in 2h5m2.22054417s with status SUCCEEDED