[22:31:24.385] New invocation is queued and will start shortly
[22:31:25.467] Starting the invocation (attempt 1)
[22:31:25.502] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d0ee82040cb22ae38c92eb83b0c9ae71ca51a517"
[22:31:25.502] Popped gitiles commit info from properties and tags
[22:31:25.502] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:31:25.506] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:31:25.507] Buildbucket request:
{
"requestId": "8872133171961855952",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8872133171961855952",
"job": "fuchsia/prod-rust-llvm-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1ffc38ca4920e6fdf0e640d09f50f397d6831a09"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1ffc38ca4920e6fdf0e640d09f50f397d6831a09",
"title": "1ffc38ca4920e6fdf0e640d09f50f397d6831a09",
"url": "https://llvm.googlesource.com/llvm-project/+/1ffc38ca4920e6fdf0e640d09f50f397d6831a09"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "76f1c7a39eb95525845dfce153a62831da02657f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@76f1c7a39eb95525845dfce153a62831da02657f",
"title": "76f1c7a39eb95525845dfce153a62831da02657f",
"url": "https://llvm.googlesource.com/llvm-project/+/76f1c7a39eb95525845dfce153a62831da02657f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a8e0dba3192ad08e6d91bf89dda63cb5f82f141e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a8e0dba3192ad08e6d91bf89dda63cb5f82f141e",
"title": "a8e0dba3192ad08e6d91bf89dda63cb5f82f141e",
"url": "https://llvm.googlesource.com/llvm-project/+/a8e0dba3192ad08e6d91bf89dda63cb5f82f141e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "6f939da60e0ad44d8810afffde415de5daa8d305"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@6f939da60e0ad44d8810afffde415de5daa8d305",
"title": "6f939da60e0ad44d8810afffde415de5daa8d305",
"url": "https://llvm.googlesource.com/llvm-project/+/6f939da60e0ad44d8810afffde415de5daa8d305"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ca05058b4995663d7081dd76b1ac186b3929e1cb"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ca05058b4995663d7081dd76b1ac186b3929e1cb",
"title": "ca05058b4995663d7081dd76b1ac186b3929e1cb",
"url": "https://llvm.googlesource.com/llvm-project/+/ca05058b4995663d7081dd76b1ac186b3929e1cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8cdab07aaa05928eb84c21e13b59d6fd9da26f12"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8cdab07aaa05928eb84c21e13b59d6fd9da26f12",
"title": "8cdab07aaa05928eb84c21e13b59d6fd9da26f12",
"url": "https://llvm.googlesource.com/llvm-project/+/8cdab07aaa05928eb84c21e13b59d6fd9da26f12"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "919021b0df8c91417784bfd84a6ad4869a0d2206"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@919021b0df8c91417784bfd84a6ad4869a0d2206",
"title": "919021b0df8c91417784bfd84a6ad4869a0d2206",
"url": "https://llvm.googlesource.com/llvm-project/+/919021b0df8c91417784bfd84a6ad4869a0d2206"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "49b17a0c1c3cead80c1ee5f6e054409c85e7ef97"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@49b17a0c1c3cead80c1ee5f6e054409c85e7ef97",
"title": "49b17a0c1c3cead80c1ee5f6e054409c85e7ef97",
"url": "https://llvm.googlesource.com/llvm-project/+/49b17a0c1c3cead80c1ee5f6e054409c85e7ef97"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "af67e0f94f568a096168ce228ee0eaa4c00bd140"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@af67e0f94f568a096168ce228ee0eaa4c00bd140",
"title": "af67e0f94f568a096168ce228ee0eaa4c00bd140",
"url": "https://llvm.googlesource.com/llvm-project/+/af67e0f94f568a096168ce228ee0eaa4c00bd140"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "116c318225b1d6b198baf22312a6bd980b80b135"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@116c318225b1d6b198baf22312a6bd980b80b135",
"title": "116c318225b1d6b198baf22312a6bd980b80b135",
"url": "https://llvm.googlesource.com/llvm-project/+/116c318225b1d6b198baf22312a6bd980b80b135"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1ca8ad29dbbe4255cb19fb1193a88040dda515a9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1ca8ad29dbbe4255cb19fb1193a88040dda515a9",
"title": "1ca8ad29dbbe4255cb19fb1193a88040dda515a9",
"url": "https://llvm.googlesource.com/llvm-project/+/1ca8ad29dbbe4255cb19fb1193a88040dda515a9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "da3182a288bb25184594e9f2642f15fa42768f42"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@da3182a288bb25184594e9f2642f15fa42768f42",
"title": "da3182a288bb25184594e9f2642f15fa42768f42",
"url": "https://llvm.googlesource.com/llvm-project/+/da3182a288bb25184594e9f2642f15fa42768f42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a40f47c9725f3aed6752f050f3010f3701d0cff7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a40f47c9725f3aed6752f050f3010f3701d0cff7",
"title": "a40f47c9725f3aed6752f050f3010f3701d0cff7",
"url": "https://llvm.googlesource.com/llvm-project/+/a40f47c9725f3aed6752f050f3010f3701d0cff7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9526d3b0b92e9ce1a537227abdab4801488343a6"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9526d3b0b92e9ce1a537227abdab4801488343a6",
"title": "9526d3b0b92e9ce1a537227abdab4801488343a6",
"url": "https://llvm.googlesource.com/llvm-project/+/9526d3b0b92e9ce1a537227abdab4801488343a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8710571aba2bacf73bcde58270f9b166c66f32e5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8710571aba2bacf73bcde58270f9b166c66f32e5",
"title": "8710571aba2bacf73bcde58270f9b166c66f32e5",
"url": "https://llvm.googlesource.com/llvm-project/+/8710571aba2bacf73bcde58270f9b166c66f32e5"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d0ee82040cb22ae38c92eb83b0c9ae71ca51a517"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d0ee82040cb22ae38c92eb83b0c9ae71ca51a517",
"title": "d0ee82040cb22ae38c92eb83b0c9ae71ca51a517",
"url": "https://llvm.googlesource.com/llvm-project/+/d0ee82040cb22ae38c92eb83b0c9ae71ca51a517"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d0ee82040cb22ae38c92eb83b0c9ae71ca51a517",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8872133171961855952"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-rust-llvm-ci-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[22:31:25.883] Scheduled build:
{
"id": "8706703110038000161",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-12T22:31:25.590120917Z",
"updateTime": "2025-08-12T22:31:25.590120917Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d0ee82040cb22ae38c92eb83b0c9ae71ca51a517",
"ref": "refs/heads/main"
}
}
}
[22:31:25.883] Task URL: https://cr-buildbucket.appspot.com/build/8706703110038000161
[22:31:25.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:2:0) after 2m10s
[22:31:30.846] Received PubSub notification, asking Buildbucket for the build status
[22:31:30.931] Build status: SCHEDULED
[22:32:47.536] Received PubSub notification, asking Buildbucket for the build status
[22:32:47.560] Build status: STARTED
[22:33:35.947] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:2:0)
[22:33:35.970] Build status: STARTED
[22:33:35.970] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:5:0) after 1m44s
[22:35:19.985] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:5:0)
[22:35:20.008] Build status: STARTED
[22:35:20.008] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:6:0) after 7m51s
[22:43:11.107] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:6:0)
[22:43:11.126] Build status: STARTED
[22:43:11.126] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:7:0) after 1m7s
[22:44:18.142] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:7:0)
[22:44:18.180] Build status: STARTED
[22:44:18.180] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:8:0) after 2m24s
[22:46:42.200] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:8:0)
[22:46:42.217] Build status: STARTED
[22:46:42.217] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:9:0) after 1m53s
[22:48:35.331] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:9:0)
[22:48:35.347] Build status: STARTED
[22:48:35.347] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:10:0) after 1m18s
[22:49:53.436] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:10:0)
[22:49:53.465] Build status: STARTED
[22:49:53.465] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:11:0) after 3m32s
[22:53:25.512] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:11:0)
[22:53:25.530] Build status: STARTED
[22:53:25.530] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:12:0) after 7m30s
[23:00:55.568] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:12:0)
[23:00:55.587] Build status: STARTED
[23:00:55.587] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:13:0) after 5m18s
[23:06:13.605] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:13:0)
[23:06:13.628] Build status: STARTED
[23:06:13.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:14:0) after 8m4s
[23:14:17.688] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:14:0)
[23:14:17.706] Build status: STARTED
[23:14:17.706] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:15:0) after 3m5s
[23:17:22.729] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:15:0)
[23:17:22.750] Build status: STARTED
[23:17:22.750] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:16:0) after 8m54s
[23:26:16.771] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:16:0)
[23:26:16.791] Build status: STARTED
[23:26:16.791] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:17:0) after 5m9s
[23:31:25.871] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:17:0)
[23:31:25.937] Build status: STARTED
[23:31:25.937] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:18:0) after 7m26s
[23:38:51.979] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:18:0)
[23:38:52.001] Build status: STARTED
[23:38:52.001] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:19:0) after 9m28s
[23:48:20.022] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:19:0)
[23:48:20.041] Build status: STARTED
[23:48:20.041] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:20:0) after 8m32s
[23:56:52.114] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:20:0)
[23:56:52.137] Build status: STARTED
[23:56:52.137] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:21:0) after 9m15s
[00:06:07.200] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:21:0)
[00:06:07.221] Build status: STARTED
[00:06:07.221] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:22:0) after 1m10s
[00:07:17.361] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:22:0)
[00:07:17.377] Build status: STARTED
[00:07:17.377] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:23:0) after 6m30s
[00:13:47.408] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:23:0)
[00:13:47.430] Build status: STARTED
[00:13:47.430] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:24:0) after 9m7s
[00:22:54.473] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:24:0)
[00:22:54.497] Build status: STARTED
[00:22:54.497] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:25:0) after 2m49s
[00:25:43.517] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:25:0)
[00:25:43.534] Build status: STARTED
[00:25:43.534] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:26:0) after 3m55s
[00:29:38.561] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:26:0)
[00:29:38.643] Build status: STARTED
[00:29:38.643] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:27:0) after 1m12s
[00:30:50.677] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:27:0)
[00:30:50.708] Build status: STARTED
[00:30:50.708] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:28:0) after 1m55s
[00:32:45.811] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:28:0)
[00:32:45.872] Build status: STARTED
[00:32:45.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:29:0) after 4m31s
[00:37:16.878] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:29:0)
[00:37:16.941] Build status: STARTED
[00:37:16.941] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8872133171961855952:30:0) after 4m31s
[00:38:41.812] Received PubSub notification, asking Buildbucket for the build status
[00:38:41.880] Build:
{
"id": "8706703110038000161",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-08-12T22:31:25.590120917Z",
"startTime": "2025-08-12T22:32:42.240026143Z",
"endTime": "2025-08-13T00:38:41.525373545Z",
"updateTime": "2025-08-13T00:38:41.525373545Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d0ee82040cb22ae38c92eb83b0c9ae71ca51a517",
"ref": "refs/heads/main"
}
}
}
[00:38:41.880] Invocation finished in 2h7m17.508571278s with status SUCCEEDED