[08:29:14.097] New invocation is queued and will start shortly
[08:29:15.207] Starting the invocation (attempt 1)
[08:29:15.302] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/d1408667de830da8817c24cb9788da6caae551c7"
[08:29:15.302] Popped gitiles commit info from properties and tags
[08:29:15.302] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:29:15.302] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:29:15.302] Buildbucket request:
{
"requestId": "8870102426572934400",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8870102426572934400",
"job": "fuchsia/prod-rust-llvm-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e8fa13ca4edcae7da083555a1cb561e6f298c80c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e8fa13ca4edcae7da083555a1cb561e6f298c80c",
"title": "e8fa13ca4edcae7da083555a1cb561e6f298c80c",
"url": "https://llvm.googlesource.com/llvm-project/+/e8fa13ca4edcae7da083555a1cb561e6f298c80c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "34d4f0c13666ea25b4d27dcb96dfc70da005f286"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@34d4f0c13666ea25b4d27dcb96dfc70da005f286",
"title": "34d4f0c13666ea25b4d27dcb96dfc70da005f286",
"url": "https://llvm.googlesource.com/llvm-project/+/34d4f0c13666ea25b4d27dcb96dfc70da005f286"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4d927a5faf42d025410586f0cdc3bf60ef198a86"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4d927a5faf42d025410586f0cdc3bf60ef198a86",
"title": "4d927a5faf42d025410586f0cdc3bf60ef198a86",
"url": "https://llvm.googlesource.com/llvm-project/+/4d927a5faf42d025410586f0cdc3bf60ef198a86"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "3f757a39f2855cd06c62a85b8e27fd56fa017e78"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@3f757a39f2855cd06c62a85b8e27fd56fa017e78",
"title": "3f757a39f2855cd06c62a85b8e27fd56fa017e78",
"url": "https://llvm.googlesource.com/llvm-project/+/3f757a39f2855cd06c62a85b8e27fd56fa017e78"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "010f1ea3b3f425a1ef8bf4d25b89eae990ef591a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@010f1ea3b3f425a1ef8bf4d25b89eae990ef591a",
"title": "010f1ea3b3f425a1ef8bf4d25b89eae990ef591a",
"url": "https://llvm.googlesource.com/llvm-project/+/010f1ea3b3f425a1ef8bf4d25b89eae990ef591a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "5a2499e3922997f7ebf06b23cdce9e83ce3b7f66"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@5a2499e3922997f7ebf06b23cdce9e83ce3b7f66",
"title": "5a2499e3922997f7ebf06b23cdce9e83ce3b7f66",
"url": "https://llvm.googlesource.com/llvm-project/+/5a2499e3922997f7ebf06b23cdce9e83ce3b7f66"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d0246fe1e79c6ea06b6b72f66a71a96a3342aa42"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d0246fe1e79c6ea06b6b72f66a71a96a3342aa42",
"title": "d0246fe1e79c6ea06b6b72f66a71a96a3342aa42",
"url": "https://llvm.googlesource.com/llvm-project/+/d0246fe1e79c6ea06b6b72f66a71a96a3342aa42"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "d1408667de830da8817c24cb9788da6caae551c7"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@d1408667de830da8817c24cb9788da6caae551c7",
"title": "d1408667de830da8817c24cb9788da6caae551c7",
"url": "https://llvm.googlesource.com/llvm-project/+/d1408667de830da8817c24cb9788da6caae551c7"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d1408667de830da8817c24cb9788da6caae551c7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8870102426572934400"
},
{
"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"
}
}
[08:29:15.675] Scheduled build:
{
"id": "8704672364555661665",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-04T08:29:15.400442672Z",
"updateTime": "2025-09-04T08:29:15.400442672Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d1408667de830da8817c24cb9788da6caae551c7",
"ref": "refs/heads/main"
}
}
}
[08:29:15.675] Task URL: https://cr-buildbucket.appspot.com/build/8704672364555661665
[08:29:15.675] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:2:0) after 1m42s
[08:29:16.006] Received PubSub notification, asking Buildbucket for the build status
[08:29:16.022] Build status: SCHEDULED
[08:30:57.743] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:2:0)
[08:30:57.761] Build status: SCHEDULED
[08:30:57.761] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:4:0) after 4m35s
[08:34:16.394] Received PubSub notification, asking Buildbucket for the build status
[08:34:16.410] Build status: STARTED
[08:35:32.826] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:4:0)
[08:35:32.850] Build status: STARTED
[08:35:32.850] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:6:0) after 8m46s
[08:44:18.867] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:6:0)
[08:44:18.883] Build status: STARTED
[08:44:18.883] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:7:0) after 5m57s
[08:50:15.899] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:7:0)
[08:50:15.916] Build status: STARTED
[08:50:15.916] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:8:0) after 6m47s
[08:57:02.933] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:8:0)
[08:57:02.951] Build status: STARTED
[08:57:02.951] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:9:0) after 9m51s
[09:06:53.967] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:9:0)
[09:06:53.993] Build status: STARTED
[09:06:53.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:10:0) after 5m22s
[09:12:16.009] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:10:0)
[09:12:16.026] Build status: STARTED
[09:12:16.026] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:11:0) after 1m35s
[09:13:51.346] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:11:0)
[09:13:51.407] Build status: STARTED
[09:13:51.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:12:0) after 1m47s
[09:15:38.448] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:12:0)
[09:15:38.463] Build status: STARTED
[09:15:38.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:13:0) after 6m54s
[09:22:32.479] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:13:0)
[09:22:32.504] Build status: STARTED
[09:22:32.504] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:14:0) after 4m57s
[09:27:29.542] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:14:0)
[09:27:29.599] Build status: STARTED
[09:27:29.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:15:0) after 5m50s
[09:33:19.667] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:15:0)
[09:33:19.710] Build status: STARTED
[09:33:19.711] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:16:0) after 8m45s
[09:42:04.977] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:16:0)
[09:42:04.999] Build status: STARTED
[09:42:04.999] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:17:0) after 1m29s
[09:43:34.013] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:17:0)
[09:43:34.031] Build status: STARTED
[09:43:34.031] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:18:0) after 5m58s
[09:49:32.050] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:18:0)
[09:49:32.065] Build status: STARTED
[09:49:32.065] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:19:0) after 2m48s
[09:52:20.119] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:19:0)
[09:52:20.168] Build status: STARTED
[09:52:20.169] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:20:0) after 2m46s
[09:55:06.190] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:20:0)
[09:55:06.207] Build status: STARTED
[09:55:06.208] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:21:0) after 3m36s
[09:58:42.296] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:21:0)
[09:58:42.314] Build status: STARTED
[09:58:42.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:22:0) after 1m3s
[09:59:45.446] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:22:0)
[09:59:45.467] Build status: STARTED
[09:59:45.467] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8870102426572934400:23:0) after 3m18s
[10:00:47.222] Received PubSub notification, asking Buildbucket for the build status
[10:00:47.343] Build:
{
"id": "8704672364555661665",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-09-04T08:29:15.400442672Z",
"startTime": "2025-09-04T08:33:51.930122213Z",
"endTime": "2025-09-04T10:00:46.769405626Z",
"updateTime": "2025-09-04T10:00:46.769405626Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "d1408667de830da8817c24cb9788da6caae551c7",
"ref": "refs/heads/main"
}
}
}
[10:00:47.343] Invocation finished in 1h31m33.250911835s with status SUCCEEDED