[23:07:27.092] New invocation is queued and will start shortly
[23:07:27.092] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[23:07:28.273] Starting the invocation (attempt 1)
[23:07:28.306] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e5cebec521a7cf86ff21dedb8a2c96b3f8331c9d"
[23:07:28.306] Reconstructed gitiles commit from tags
[23:07:28.306] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:07:28.306] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:07:28.307] Buildbucket request:
{
"requestId": "8922865205387330384",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "28b46324ddbde947c755c680bc89e9a5f3b1bdefc70a3fe5e01f41bf9c4ec1ae/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "366b8e24363ec7de7eecec13c9db51f3764b9337",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8922865205387330384",
"job": "fuchsia/clang_toolchain.ci.core.x64-debug",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "7e21eb18b6b5caea93e7dd9657057a6e0a17312dd6a4b9536a3061b26e84fa9a/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "366b8e24363ec7de7eecec13c9db51f3764b9337",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "30b9140c148923e31a6dbcb2202ef3908481bb29"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/30b9140c148923e31a6dbcb2202ef3908481bb29",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "70114ac6-1102-4fb8-8765-06533b97f3d8",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "52118ae8baf164c2800f95d0f270a2173d1d0fd2a39b50e153ad9adffbe83665/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "366b8e24363ec7de7eecec13c9db51f3764b9337",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "2c5a0d392592982bb9c73cbc10c64390b9045873"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/2c5a0d392592982bb9c73cbc10c64390b9045873",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "37d09aa8-29ef-4ed8-bc8d-3f6d277f7acc",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "da76a662127afe2970cfbb73e8d14dbed836f064eb7231f43ad529e4ab400fa3/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "366b8e24363ec7de7eecec13c9db51f3764b9337",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "9b91c54d9bd3227a49e146c055fb0165567f7f8d"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/9b91c54d9bd3227a49e146c055fb0165567f7f8d",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "7304c277-56bc-415a-a14a-d78599eb151c",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "28b46324ddbde947c755c680bc89e9a5f3b1bdefc70a3fe5e01f41bf9c4ec1ae/578",
"cas_instance": "projects/chromium-swarm/instances/default_instance"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "366b8e24363ec7de7eecec13c9db51f3764b9337",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e5cebec521a7cf86ff21dedb8a2c96b3f8331c9d"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/e5cebec521a7cf86ff21dedb8a2c96b3f8331c9d",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "6f039c40-18f5-4bd9-93c3-e4c741aa72ad",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "e5cebec521a7cf86ff21dedb8a2c96b3f8331c9d"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e5cebec521a7cf86ff21dedb8a2c96b3f8331c9d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8922865205387330384"
},
{
"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"
}
}
[23:07:28.802] Scheduled build:
{
"id": "8757435143384817681",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-30T23:07:28.368750057Z",
"updateTime": "2024-01-30T23:07:28.368750057Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e5cebec521a7cf86ff21dedb8a2c96b3f8331c9d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[23:07:28.802] Task URL: https://cr-buildbucket.appspot.com/build/8757435143384817681
[23:07:28.802] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:2:0) after 8m59s
[23:07:29.562] Received PubSub notification, asking Buildbucket for the build status
[23:07:29.623] Build status: SCHEDULED
[23:07:30.373] Received PubSub notification, asking Buildbucket for the build status
[23:07:30.406] Build status: STARTED
[23:16:27.810] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:2:0)
[23:16:27.829] Build status: STARTED
[23:16:27.830] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:5:0) after 4m41s
[23:21:08.848] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:5:0)
[23:21:08.864] Build status: STARTED
[23:21:08.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:6:0) after 9m42s
[23:30:51.310] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:6:0)
[23:30:51.330] Build status: STARTED
[23:30:51.330] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:7:0) after 3m1s
[23:33:52.362] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:7:0)
[23:33:52.378] Build status: STARTED
[23:33:52.379] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:8:0) after 9m22s
[23:43:14.395] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:8:0)
[23:43:14.422] Build status: STARTED
[23:43:14.422] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:9:0) after 6m20s
[23:49:34.437] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:9:0)
[23:49:34.458] Build status: STARTED
[23:49:34.458] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:10:0) after 6m49s
[23:56:23.475] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:10:0)
[23:56:23.504] Build status: STARTED
[23:56:23.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:11:0) after 9m32s
[00:05:55.521] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:11:0)
[00:05:55.577] Build status: STARTED
[00:05:55.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:12:0) after 8m41s
[00:14:36.613] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:12:0)
[00:14:36.634] Build status: STARTED
[00:14:36.634] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:13:0) after 6m44s
[00:21:20.654] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:13:0)
[00:21:20.675] Build status: STARTED
[00:21:20.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:14:0) after 7m47s
[00:29:07.705] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:14:0)
[00:29:07.727] Build status: STARTED
[00:29:07.727] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:15:0) after 1m34s
[00:30:41.750] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:15:0)
[00:30:41.785] Build status: STARTED
[00:30:41.785] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:16:0) after 9m39s
[00:40:21.062] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:16:0)
[00:40:21.086] Build status: STARTED
[00:40:21.086] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:17:0) after 5m32s
[00:45:53.282] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:17:0)
[00:45:53.336] Build status: STARTED
[00:45:53.336] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:18:0) after 8m46s
[00:54:39.496] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:18:0)
[00:54:39.530] Build status: STARTED
[00:54:39.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:19:0) after 4m24s
[00:59:03.684] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:19:0)
[00:59:03.702] Build status: STARTED
[00:59:03.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:20:0) after 7m4s
[01:06:08.046] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:20:0)
[01:06:08.071] Build status: STARTED
[01:06:08.071] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:21:0) after 2m16s
[01:08:24.091] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:21:0)
[01:08:24.115] Build status: STARTED
[01:08:24.115] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-debug:8922865205387330384:22:0) after 7m5s
[01:08:25.667] Received PubSub notification, asking Buildbucket for the build status
[01:08:25.689] Build:
{
"id": "8757435143384817681",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-debug"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-30T23:07:28.368750057Z",
"startTime": "2024-01-30T23:07:29.597569Z",
"endTime": "2024-01-31T01:08:24.922411Z",
"updateTime": "2024-01-31T01:08:24.922411Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "e5cebec521a7cf86ff21dedb8a2c96b3f8331c9d",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:08:25.689] Invocation finished in 2h0m58.613481119s with status SUCCEEDED