[16:46:06.170] New invocation is queued and will start shortly
[16:46:07.325] Starting the invocation (attempt 1)
[16:46:07.350] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/b697b801b13d94aa88f19a9f7dc7197b1f658186"
[16:46:07.350] Popped gitiles commit info from properties and tags
[16:46:07.350] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:46:07.350] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:46:07.350] Buildbucket request:
{
"requestId": "8875959969169779856",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8875959969169779856",
"job": "fuchsia/prod-rust-llvm-ci-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "569ca0f69876ffbf7f27494b4bf212e8d236f7e9"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@569ca0f69876ffbf7f27494b4bf212e8d236f7e9",
"title": "569ca0f69876ffbf7f27494b4bf212e8d236f7e9",
"url": "https://llvm.googlesource.com/llvm-project/+/569ca0f69876ffbf7f27494b4bf212e8d236f7e9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "4dab0b23006017f6bbb3d7c6688f31d14625f86e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@4dab0b23006017f6bbb3d7c6688f31d14625f86e",
"title": "4dab0b23006017f6bbb3d7c6688f31d14625f86e",
"url": "https://llvm.googlesource.com/llvm-project/+/4dab0b23006017f6bbb3d7c6688f31d14625f86e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "04c614327c28339ed4204b3e100a695f14fe754c"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@04c614327c28339ed4204b3e100a695f14fe754c",
"title": "04c614327c28339ed4204b3e100a695f14fe754c",
"url": "https://llvm.googlesource.com/llvm-project/+/04c614327c28339ed4204b3e100a695f14fe754c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "47e28d9cd1c08690fa77d81b537594cb2e92f0f4"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@47e28d9cd1c08690fa77d81b537594cb2e92f0f4",
"title": "47e28d9cd1c08690fa77d81b537594cb2e92f0f4",
"url": "https://llvm.googlesource.com/llvm-project/+/47e28d9cd1c08690fa77d81b537594cb2e92f0f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07",
"title": "1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07",
"url": "https://llvm.googlesource.com/llvm-project/+/1a7b7e24bcc1041ae0fb90abcfb73d36d76f4a07"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ba116a8bed9ae093575bd316bf8847bb016177dd"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ba116a8bed9ae093575bd316bf8847bb016177dd",
"title": "ba116a8bed9ae093575bd316bf8847bb016177dd",
"url": "https://llvm.googlesource.com/llvm-project/+/ba116a8bed9ae093575bd316bf8847bb016177dd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "01a6c0853314f4a704f5003e4d3d188282fee775"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@01a6c0853314f4a704f5003e4d3d188282fee775",
"title": "01a6c0853314f4a704f5003e4d3d188282fee775",
"url": "https://llvm.googlesource.com/llvm-project/+/01a6c0853314f4a704f5003e4d3d188282fee775"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "13e6ea7b4c29a0d574a084a59c688c2731369b4b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@13e6ea7b4c29a0d574a084a59c688c2731369b4b",
"title": "13e6ea7b4c29a0d574a084a59c688c2731369b4b",
"url": "https://llvm.googlesource.com/llvm-project/+/13e6ea7b4c29a0d574a084a59c688c2731369b4b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a34a02481246482a490c320afb7375ec24cb634e"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a34a02481246482a490c320afb7375ec24cb634e",
"title": "a34a02481246482a490c320afb7375ec24cb634e",
"url": "https://llvm.googlesource.com/llvm-project/+/a34a02481246482a490c320afb7375ec24cb634e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "b697b801b13d94aa88f19a9f7dc7197b1f658186"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@b697b801b13d94aa88f19a9f7dc7197b1f658186",
"title": "b697b801b13d94aa88f19a9f7dc7197b1f658186",
"url": "https://llvm.googlesource.com/llvm-project/+/b697b801b13d94aa88f19a9f7dc7197b1f658186"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b697b801b13d94aa88f19a9f7dc7197b1f658186",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8875959969169779856"
},
{
"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"
}
}
[16:46:07.729] Scheduled build:
{
"id": "8710529907229181169",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-01T16:46:07.395211623Z",
"updateTime": "2025-07-01T16:46:07.395211623Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b697b801b13d94aa88f19a9f7dc7197b1f658186",
"ref": "refs/heads/main"
}
}
}
[16:46:07.729] Task URL: https://cr-buildbucket.appspot.com/build/8710529907229181169
[16:46:07.729] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:2:0) after 2m48s
[16:46:08.715] Received PubSub notification, asking Buildbucket for the build status
[16:46:08.734] Build status: SCHEDULED
[16:48:55.780] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:2:0)
[16:48:55.807] Build status: SCHEDULED
[16:48:55.807] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:4:0) after 8m1s
[16:56:56.833] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:4:0)
[16:56:56.857] Build status: SCHEDULED
[16:56:56.857] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:5:0) after 9m21s
[17:06:17.873] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:5:0)
[17:06:17.896] Build status: SCHEDULED
[17:06:17.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:6:0) after 1m17s
[17:07:34.887] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:6:0)
[17:07:34.909] Build status: SCHEDULED
[17:07:34.909] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:7:0) after 8m27s
[17:16:01.956] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:7:0)
[17:16:01.975] Build status: SCHEDULED
[17:16:01.975] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:8:0) after 5m3s
[17:21:05.059] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:8:0)
[17:21:05.081] Build status: SCHEDULED
[17:21:05.081] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:9:0) after 9m14s
[17:21:25.671] Received PubSub notification, asking Buildbucket for the build status
[17:21:25.826] Build status: STARTED
[17:30:19.096] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:9:0)
[17:30:19.126] Build status: STARTED
[17:30:19.126] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:11:0) after 8m7s
[17:38:26.252] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:11:0)
[17:38:26.272] Build status: STARTED
[17:38:26.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:12:0) after 3m5s
[17:41:31.290] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:12:0)
[17:41:31.314] Build status: STARTED
[17:41:31.314] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:13:0) after 3m23s
[17:44:54.340] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:13:0)
[17:44:54.361] Build status: STARTED
[17:44:54.361] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:14:0) after 7m9s
[17:52:03.374] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:14:0)
[17:52:03.399] Build status: STARTED
[17:52:03.399] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:15:0) after 9m39s
[18:01:42.465] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:15:0)
[18:01:42.493] Build status: STARTED
[18:01:42.493] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:16:0) after 8m33s
[18:10:15.517] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:16:0)
[18:10:15.533] Build status: STARTED
[18:10:15.533] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:17:0) after 3m31s
[18:13:46.606] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:17:0)
[18:13:46.637] Build status: STARTED
[18:13:46.637] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:18:0) after 8m29s
[18:22:15.691] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:18:0)
[18:22:15.713] Build status: STARTED
[18:22:15.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:19:0) after 2m19s
[18:24:34.844] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:19:0)
[18:24:34.862] Build status: STARTED
[18:24:34.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-llvm-ci-trigger-40be1bb5:8875959969169779856:20:0) after 1m1s
[18:25:14.543] Received PubSub notification, asking Buildbucket for the build status
[18:25:14.621] Build:
{
"id": "8710529907229181169",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-llvm-ci-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-07-01T16:46:07.395211623Z",
"startTime": "2025-07-01T17:21:25.496020810Z",
"endTime": "2025-07-01T18:25:14.078456118Z",
"updateTime": "2025-07-01T18:25:14.078456118Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "b697b801b13d94aa88f19a9f7dc7197b1f658186",
"ref": "refs/heads/main"
}
}
}
[18:25:14.621] Invocation finished in 1h39m8.461028028s with status SUCCEEDED