[19:02:49.122] New invocation is queued and will start shortly
[19:02:49.122] Triggered by user:fuchsia-ci-builder@fuchsia-infra.iam.gserviceaccount.com
[19:02:50.363] Starting the invocation (attempt 1)
[19:02:50.393] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a960703466e937d99ab7a7a29f7448e1bc926e35"
[19:02:50.393] Reconstructed gitiles commit from tags
[19:02:50.393] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:02:50.393] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:02:50.394] Buildbucket request:
{
"requestId": "8925236117482635712",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "0fb2c1d19a6f5e6e5ff8e37e3064bc138a3c9ee7e4452fbbba70643f54e9f7f8/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "37bd6b082652538ee74f45f6caa27d236f9f3f00",
"project": "integration"
}
},
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8925236117482635712",
"job": "fuchsia/clang_toolchain.ci.core.x64-release",
"triggers": [
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "6cb2fe6be517296443921426b1ee9cb4766af74c47dbbd2aba3bb1d820e17210/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "37bd6b082652538ee74f45f6caa27d236f9f3f00",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "569ec185f5dc4a9e4a239948191977ecc2b2b475"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/569ec185f5dc4a9e4a239948191977ecc2b2b475",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "f41a0fd3-7e3f-47b2-bb32-e461635b770d",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "29b337c96f78e7eba3e4ea07af2f6689fc41d1631ac73d9352a395634b0e18a9/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "37bd6b082652538ee74f45f6caa27d236f9f3f00",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "c12a9fc2798cc74a6ea6a8c71826047f47c815ea"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/c12a9fc2798cc74a6ea6a8c71826047f47c815ea",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "5cbfd426-f101-4552-bebf-3c04cd7c8f79",
"title": "clang-linux-x64/0"
},
{
"buildbucket": {
"properties": {
"$fuchsia/checkout": {
"clang_toolchain": {
"cas_digest": "0fb2c1d19a6f5e6e5ff8e37e3064bc138a3c9ee7e4452fbbba70643f54e9f7f8/578"
},
"gitiles_commit": {
"host": "fuchsia.googlesource.com",
"id": "37bd6b082652538ee74f45f6caa27d236f9f3f00",
"project": "integration"
}
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a960703466e937d99ab7a7a29f7448e1bc926e35"
}
},
"tags": [
"buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/a960703466e937d99ab7a7a29f7448e1bc926e35",
"gitiles_ref:refs/heads/main",
"parent_buildername:clang-linux-x64",
"user_agent:recipe"
]
},
"id": "5c606e83-ab92-4ed7-9adb-7085e9ffc862",
"title": "clang-linux-x64/0"
}
]
},
"clang_toolchain": {
"git_repository": "https://llvm.googlesource.com/llvm-project",
"git_revision": "a960703466e937d99ab7a7a29f7448e1bc926e35"
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a960703466e937d99ab7a7a29f7448e1bc926e35",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8925236117482635712"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/clang_toolchain.ci.core.x64-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"
}
}
[19:02:51.133] Scheduled build:
{
"id": "8759806055341637889",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-04T19:02:50.528682891Z",
"updateTime": "2024-01-04T19:02:50.528682891Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a960703466e937d99ab7a7a29f7448e1bc926e35",
"ref": "refs/heads/main"
}
}
}
[19:02:51.133] Task URL: https://cr-buildbucket.appspot.com/build/8759806055341637889
[19:02:51.133] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:2:0) after 6m49s
[19:02:52.030] Received PubSub notification, asking Buildbucket for the build status
[19:02:52.049] Build status: SCHEDULED
[19:05:16.651] Received PubSub notification, asking Buildbucket for the build status
[19:05:16.699] Build status: STARTED
[19:09:40.152] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:2:0)
[19:09:40.232] Build status: STARTED
[19:09:40.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:5:0) after 6m28s
[19:16:08.198] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:5:0)
[19:16:08.232] Build status: STARTED
[19:16:08.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:6:0) after 4m43s
[19:20:51.544] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:6:0)
[19:20:51.720] Build status: STARTED
[19:20:51.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:7:0) after 3m22s
[19:24:13.734] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:7:0)
[19:24:13.755] Build status: STARTED
[19:24:13.755] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:8:0) after 3m31s
[19:27:45.077] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:8:0)
[19:27:45.098] Build status: STARTED
[19:27:45.099] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:9:0) after 7m1s
[19:34:46.121] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:9:0)
[19:34:46.140] Build status: STARTED
[19:34:46.140] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:10:0) after 2m24s
[19:37:10.286] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:10:0)
[19:37:10.329] Build status: STARTED
[19:37:10.329] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:11:0) after 1m28s
[19:38:38.446] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:11:0)
[19:38:38.475] Build status: STARTED
[19:38:38.475] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:12:0) after 2m18s
[19:40:56.781] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:12:0)
[19:40:56.798] Build status: STARTED
[19:40:56.798] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:13:0) after 9m31s
[19:50:27.916] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:13:0)
[19:50:27.990] Build status: STARTED
[19:50:27.990] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:14:0) after 1m26s
[19:51:54.306] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:14:0)
[19:51:54.328] Build status: STARTED
[19:51:54.328] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:15:0) after 4m0s
[19:55:54.389] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:15:0)
[19:55:54.410] Build status: STARTED
[19:55:54.410] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:16:0) after 3m52s
[19:59:46.440] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:16:0)
[19:59:46.493] Build status: STARTED
[19:59:46.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:17:0) after 5m48s
[20:05:34.510] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:17:0)
[20:05:34.535] Build status: STARTED
[20:05:34.535] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:18:0) after 4m3s
[20:09:37.649] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:18:0)
[20:09:37.677] Build status: STARTED
[20:09:37.677] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:19:0) after 1m23s
[20:11:00.934] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:19:0)
[20:11:00.960] Build status: STARTED
[20:11:00.960] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:20:0) after 2m33s
[20:13:34.141] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:20:0)
[20:13:34.161] Build status: STARTED
[20:13:34.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:21:0) after 3m34s
[20:17:08.416] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:21:0)
[20:17:08.436] Build status: STARTED
[20:17:08.436] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:22:0) after 3m30s
[20:20:38.495] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:22:0)
[20:20:38.519] Build status: STARTED
[20:20:38.520] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:23:0) after 2m1s
[20:22:39.547] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:23:0)
[20:22:39.639] Build status: STARTED
[20:22:39.639] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:24:0) after 9m47s
[20:32:26.658] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:24:0)
[20:32:26.679] Build status: STARTED
[20:32:26.679] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:25:0) after 3m19s
[20:35:45.797] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:25:0)
[20:35:45.815] Build status: STARTED
[20:35:45.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:26:0) after 9m39s
[20:45:24.962] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:26:0)
[20:45:24.983] Build status: STARTED
[20:45:24.983] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:27:0) after 3m46s
[20:49:10.987] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:27:0)
[20:49:11.005] Build status: STARTED
[20:49:11.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:28:0) after 5m36s
[20:55:27.833] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:28:0)
[20:55:27.875] Build status: STARTED
[20:55:27.875] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:29:0) after 2m30s
[20:57:57.871] Handling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:29:0)
[20:57:57.894] Build status: STARTED
[20:57:57.894] Scheduling timer "check-buildbucket-build-status" (fuchsia/clang_toolchain.ci.core.x64-release:8925236117482635712:30:0) after 7m37s
[21:00:56.355] Received PubSub notification, asking Buildbucket for the build status
[21:00:56.372] Build:
{
"id": "8759806055341637889",
"builder": {
"project": "fuchsia",
"bucket": "ci",
"builder": "clang_toolchain.ci.core.x64-release"
},
"createdBy": "project:fuchsia",
"createTime": "2024-01-04T19:02:50.528682891Z",
"startTime": "2024-01-04T19:05:15.812726Z",
"endTime": "2024-01-04T21:00:54.689303Z",
"updateTime": "2024-01-04T21:00:54.689303Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "a960703466e937d99ab7a7a29f7448e1bc926e35",
"ref": "refs/heads/main"
}
}
}
[21:00:56.372] Invocation finished in 1h58m7.268444534s with status SUCCEEDED