[00:11:55.103] New invocation is queued and will start shortly
[00:11:56.208] Starting the invocation (attempt 1)
[00:11:56.235] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/81d8c89da056a7751f6c7714fccb30c071dbc31a"
[00:11:56.235] Popped gitiles commit info from properties and tags
[00:11:56.235] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:11:56.235] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:11:56.236] Buildbucket request:
{
"requestId": "8877381472347500224",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8877381472347500224",
"job": "fuchsia/prod-rust-llvm-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "e3025c95090f74b26e36106d2aa394b213f713a1"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@e3025c95090f74b26e36106d2aa394b213f713a1",
"title": "e3025c95090f74b26e36106d2aa394b213f713a1",
"url": "https://llvm.googlesource.com/llvm-project/+/e3025c95090f74b26e36106d2aa394b213f713a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4635b6076dc1933b7ebd9fcca9f22ec93e2f9c0c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4635b6076dc1933b7ebd9fcca9f22ec93e2f9c0c",
"title": "4635b6076dc1933b7ebd9fcca9f22ec93e2f9c0c",
"url": "https://llvm.googlesource.com/llvm-project/+/4635b6076dc1933b7ebd9fcca9f22ec93e2f9c0c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "fedf6c68ddfb43730578837aad394afcd97fe65a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@fedf6c68ddfb43730578837aad394afcd97fe65a",
"title": "fedf6c68ddfb43730578837aad394afcd97fe65a",
"url": "https://llvm.googlesource.com/llvm-project/+/fedf6c68ddfb43730578837aad394afcd97fe65a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "51b63bbee56c2253643f41c53bc3592af261b82d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@51b63bbee56c2253643f41c53bc3592af261b82d",
"title": "51b63bbee56c2253643f41c53bc3592af261b82d",
"url": "https://llvm.googlesource.com/llvm-project/+/51b63bbee56c2253643f41c53bc3592af261b82d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f11dd116e0aa8cf35bdb82dba0a3a926538c05c2"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f11dd116e0aa8cf35bdb82dba0a3a926538c05c2",
"title": "f11dd116e0aa8cf35bdb82dba0a3a926538c05c2",
"url": "https://llvm.googlesource.com/llvm-project/+/f11dd116e0aa8cf35bdb82dba0a3a926538c05c2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "489dcc9e5233b52152272e6e5377784a56a12f1d"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@489dcc9e5233b52152272e6e5377784a56a12f1d",
"title": "489dcc9e5233b52152272e6e5377784a56a12f1d",
"url": "https://llvm.googlesource.com/llvm-project/+/489dcc9e5233b52152272e6e5377784a56a12f1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "9a87c94622863cf712c6ab432931dfdb704fae3e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@9a87c94622863cf712c6ab432931dfdb704fae3e",
"title": "9a87c94622863cf712c6ab432931dfdb704fae3e",
"url": "https://llvm.googlesource.com/llvm-project/+/9a87c94622863cf712c6ab432931dfdb704fae3e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "81d8c89da056a7751f6c7714fccb30c071dbc31a"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@81d8c89da056a7751f6c7714fccb30c071dbc31a",
"title": "81d8c89da056a7751f6c7714fccb30c071dbc31a",
"url": "https://llvm.googlesource.com/llvm-project/+/81d8c89da056a7751f6c7714fccb30c071dbc31a"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "81d8c89da056a7751f6c7714fccb30c071dbc31a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8877381472347500224"
},
{
"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"
}
}
[00:11:56.624] Scheduled build:
{
"id": "8711951410408292305",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-16T00:11:56.322808242Z",
"updateTime": "2025-06-16T00:11:56.322808242Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "81d8c89da056a7751f6c7714fccb30c071dbc31a",
"ref": "refs/heads/main"
}
},
"canary": true
}
[00:11:56.624] Task URL: https://cr-buildbucket.appspot.com/build/8711951410408292305
[00:11:56.624] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:2:0) after 1m51s
[00:11:57.607] Received PubSub notification, asking Buildbucket for the build status
[00:11:57.627] Build status: SCHEDULED
[00:12:05.159] Received PubSub notification, asking Buildbucket for the build status
[00:12:05.234] Build status: STARTED
[00:13:47.776] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:2:0)
[00:13:47.801] Build status: STARTED
[00:13:47.801] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:5:0) after 3m20s
[00:17:07.840] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:5:0)
[00:17:07.864] Build status: STARTED
[00:17:07.864] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:6:0) after 6m37s
[00:23:45.089] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:6:0)
[00:23:45.111] Build status: STARTED
[00:23:45.111] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:7:0) after 7m5s
[00:30:50.135] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:7:0)
[00:30:50.176] Build status: STARTED
[00:30:50.176] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:8:0) after 7m52s
[00:38:42.461] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:8:0)
[00:38:42.487] Build status: STARTED
[00:38:42.487] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:9:0) after 3m45s
[00:42:27.470] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:9:0)
[00:42:27.577] Build status: STARTED
[00:42:27.577] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:10:0) after 6m26s
[00:48:53.638] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:10:0)
[00:48:53.670] Build status: STARTED
[00:48:53.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:11:0) after 5m39s
[00:54:32.822] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:11:0)
[00:54:32.844] Build status: STARTED
[00:54:32.844] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:12:0) after 1m40s
[00:56:13.054] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:12:0)
[00:56:13.236] Build status: STARTED
[00:56:13.236] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:13:0) after 3m35s
[00:59:48.265] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:13:0)
[00:59:48.295] Build status: STARTED
[00:59:48.295] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:14:0) after 6m10s
[01:05:58.332] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:14:0)
[01:05:58.358] Build status: STARTED
[01:05:58.358] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:15:0) after 5m36s
[01:11:34.612] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:15:0)
[01:11:34.688] Build status: STARTED
[01:11:34.688] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8877381472347500224:16:0) after 6m21s
[01:17:08.480] Received PubSub notification, asking Buildbucket for the build status
[01:17:08.516] Build:
{
"id": "8711951410408292305",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-16T00:11:56.322808242Z",
"startTime": "2025-06-16T00:12:04.639545304Z",
"endTime": "2025-06-16T01:17:08.173985217Z",
"updateTime": "2025-06-16T01:17:08.173985217Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "81d8c89da056a7751f6c7714fccb30c071dbc31a",
"ref": "refs/heads/main"
}
},
"canary": true
}
[01:17:08.516] Invocation finished in 1h5m13.427417291s with status SUCCEEDED