[11:45:08.931] New invocation is queued and will start shortly
[11:45:08.931] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[11:45:10.500] Starting the invocation (attempt 1)
[11:45:10.580] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8c7f10eadbcf1271b6da52ccac43c241f9b8f06e"
[11:45:10.580] Reconstructed gitiles commit from tags
[11:45:10.580] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:45:10.581] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:45:10.582] Buildbucket request:
{
"requestId": "8925173056321098224",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "1f3e74f40981f5c06164a6e9a9d10c76d0013b410907f720f630d4f2f9402900/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "6b00d9b51dd3127d499c6e26ab7b321da1be860e",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8925173056321098224",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7d2b82e522a1dd444fcaa42b67b9f2d6607428f47a2151bc1488f27757be72be/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "6b00d9b51dd3127d499c6e26ab7b321da1be860e",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "67963d384b23a2d46967b8f39ec2df3375731f4f"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/67963d384b23a2d46967b8f39ec2df3375731f4f",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "ead88bd5-7479-497e-ac30-be040ce9a7d0",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "740882392a456b139c2ca59577f8c28a733d59a08181b7f54eed07c59f9759ad/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "6b00d9b51dd3127d499c6e26ab7b321da1be860e",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2952fb349567fd95c4df020c9092e21972481710"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2952fb349567fd95c4df020c9092e21972481710",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "04610af7-ebb0-4f9e-96bc-53be19c5e7b7",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "4d0861025cf2fb4abae2914ecf87d06a602323bd8d4b3d9396890e9ca858a391/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "6b00d9b51dd3127d499c6e26ab7b321da1be860e",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "c458f928fad7bbcf08ab1da9949eb2969fc9f89c"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c458f928fad7bbcf08ab1da9949eb2969fc9f89c",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "d310ff9d-3a03-4479-bd7c-9382338282b3",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "1f3e74f40981f5c06164a6e9a9d10c76d0013b410907f720f630d4f2f9402900/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "6b00d9b51dd3127d499c6e26ab7b321da1be860e",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "8c7f10eadbcf1271b6da52ccac43c241f9b8f06e"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/8c7f10eadbcf1271b6da52ccac43c241f9b8f06e",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "cc4a7240-9d25-4add-9ac6-7ae60ef50255",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "8c7f10eadbcf1271b6da52ccac43c241f9b8f06e"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8c7f10eadbcf1271b6da52ccac43c241f9b8f06e",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8925173056321098224"
},
{
"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"
}
}
[11:45:11.026] Scheduled build:
{
"id": "8759742993856754033",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-05T11:45:10.647198667Z",
"updateTime": "2024-01-05T11:45:10.647198667Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8c7f10eadbcf1271b6da52ccac43c241f9b8f06e",
"ref": "refs/heads/main"
}
}
}
[11:45:11.026] Task URL: https://cr-buildbucket.appspot.com/build/8759742993856754033
[11:45:11.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:2:0) after 1m19s
[11:45:14.603] Received PubSub notification, asking Buildbucket for the build status
[11:45:14.624] Build status: SCHEDULED
[11:45:19.028] Received PubSub notification, asking Buildbucket for the build status
[11:45:19.058] Build status: STARTED
[11:46:30.238] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:2:0)
[11:46:30.265] Build status: STARTED
[11:46:30.265] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:5:0) after 2m20s
[11:48:50.304] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:5:0)
[11:48:50.321] Build status: STARTED
[11:48:50.321] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:6:0) after 9m36s
[11:58:26.341] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:6:0)
[11:58:26.363] Build status: STARTED
[11:58:26.363] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:7:0) after 7m51s
[12:06:17.387] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:7:0)
[12:06:17.432] Build status: STARTED
[12:06:17.432] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:8:0) after 2m34s
[12:08:51.509] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:8:0)
[12:08:51.535] Build status: STARTED
[12:08:51.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:9:0) after 2m26s
[12:11:17.552] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:9:0)
[12:11:17.574] Build status: STARTED
[12:11:17.574] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:10:0) after 6m14s
[12:17:31.666] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:10:0)
[12:17:31.697] Build status: STARTED
[12:17:31.697] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:11:0) after 5m49s
[12:23:20.990] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:11:0)
[12:23:22.423] Build status: STARTED
[12:23:22.423] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:12:0) after 5m32s
[12:28:54.495] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:12:0)
[12:28:54.513] Build status: STARTED
[12:28:54.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:13:0) after 2m58s
[12:31:52.621] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:13:0)
[12:31:52.808] Build status: STARTED
[12:31:52.808] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:14:0) after 4m26s
[12:36:19.138] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:14:0)
[12:36:19.155] Build status: STARTED
[12:36:19.155] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:15:0) after 6m7s
[12:42:26.207] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:15:0)
[12:42:26.227] Build status: STARTED
[12:42:26.227] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:16:0) after 5m10s
[12:47:36.340] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:16:0)
[12:47:36.366] Build status: STARTED
[12:47:36.366] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:17:0) after 3m14s
[12:50:51.072] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:17:0)
[12:50:51.091] Build status: STARTED
[12:50:51.091] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:18:0) after 6m46s
[12:57:37.188] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:18:0)
[12:57:37.259] Build status: STARTED
[12:57:37.259] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:19:0) after 1m56s
[12:59:33.364] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:19:0)
[12:59:33.530] Build status: STARTED
[12:59:33.531] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:20:0) after 8m58s
[13:08:31.659] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:20:0)
[13:08:31.736] Build status: STARTED
[13:08:31.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:21:0) after 7m5s
[13:15:36.766] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:21:0)
[13:15:36.788] Build status: STARTED
[13:15:36.788] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:22:0) after 8m10s
[13:23:46.812] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:22:0)
[13:23:46.839] Build status: STARTED
[13:23:46.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:23:0) after 2m30s
[13:26:16.884] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:23:0)
[13:26:16.914] Build status: STARTED
[13:26:16.914] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:24:0) after 4m38s
[13:30:55.022] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:24:0)
[13:30:55.043] Build status: STARTED
[13:30:55.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:25:0) after 9m18s
[13:40:13.071] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:25:0)
[13:40:13.110] Build status: STARTED
[13:40:13.110] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:26:0) after 4m15s
[13:44:28.537] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:26:0)
[13:44:28.588] Build status: STARTED
[13:44:28.588] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:27:0) after 5m42s
[13:50:10.745] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:27:0)
[13:50:10.765] Build status: STARTED
[13:50:10.765] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:28:0) after 1m42s
[13:51:52.905] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:28:0)
[13:51:52.941] Build status: STARTED
[13:51:52.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8925173056321098224:29:0) after 7m36s
[13:53:17.809] Received PubSub notification, asking Buildbucket for the build status
[13:53:17.885] Build:
{
"id": "8759742993856754033",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-05T11:45:10.647198667Z",
"startTime": "2024-01-05T11:45:15.061666Z",
"endTime": "2024-01-05T13:53:16.973458Z",
"updateTime": "2024-01-05T13:53:16.973458Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "8c7f10eadbcf1271b6da52ccac43c241f9b8f06e",
"ref": "refs/heads/main"
}
}
}
[13:53:17.885] Invocation finished in 2h8m8.972063047s with status SUCCEEDED