[17:34:16.846] New invocation is queued and will start shortly
[17:34:18.543] Starting the invocation (attempt 1)
[17:34:18.572] Popped buildset tag "buildset:commit/gitiles/llvm.googlesource.com/llvm-project/+/ab17ff05621f3029c1afae0d62093287f9d1e2b5"
[17:34:18.572] Popped gitiles commit info from properties and tags
[17:34:18.572] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:34:18.572] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:34:18.573] Buildbucket request:
{
"requestId": "8876681713806654048",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-integration-trigger"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8876681713806654048",
"job": "fuchsia/prod-rust-integration-trigger-40be1bb5",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "10b61fea8a1a458b6b9e4a4b375883d21f096468"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@10b61fea8a1a458b6b9e4a4b375883d21f096468",
"title": "10b61fea8a1a458b6b9e4a4b375883d21f096468",
"url": "https://llvm.googlesource.com/llvm-project/+/10b61fea8a1a458b6b9e4a4b375883d21f096468"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c0ce9adf603c2a49f685b1c1846a01e3253adb29"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c0ce9adf603c2a49f685b1c1846a01e3253adb29",
"title": "c0ce9adf603c2a49f685b1c1846a01e3253adb29",
"url": "https://llvm.googlesource.com/llvm-project/+/c0ce9adf603c2a49f685b1c1846a01e3253adb29"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "909cbcf988fe7454660ce316ec1102a5591606a8"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@909cbcf988fe7454660ce316ec1102a5591606a8",
"title": "909cbcf988fe7454660ce316ec1102a5591606a8",
"url": "https://llvm.googlesource.com/llvm-project/+/909cbcf988fe7454660ce316ec1102a5591606a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c594f6e697435fbb2458104c51e1bbbfd9df6689"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c594f6e697435fbb2458104c51e1bbbfd9df6689",
"title": "c594f6e697435fbb2458104c51e1bbbfd9df6689",
"url": "https://llvm.googlesource.com/llvm-project/+/c594f6e697435fbb2458104c51e1bbbfd9df6689"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "a0329eaa0cdcc86046c66533feb002b227553c33"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@a0329eaa0cdcc86046c66533feb002b227553c33",
"title": "a0329eaa0cdcc86046c66533feb002b227553c33",
"url": "https://llvm.googlesource.com/llvm-project/+/a0329eaa0cdcc86046c66533feb002b227553c33"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "13bb7948c91404d03bad017b601386493bbb1760"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@13bb7948c91404d03bad017b601386493bbb1760",
"title": "13bb7948c91404d03bad017b601386493bbb1760",
"url": "https://llvm.googlesource.com/llvm-project/+/13bb7948c91404d03bad017b601386493bbb1760"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "7a33569510535f0b917a2e50f644bf57490aee24"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@7a33569510535f0b917a2e50f644bf57490aee24",
"title": "7a33569510535f0b917a2e50f644bf57490aee24",
"url": "https://llvm.googlesource.com/llvm-project/+/7a33569510535f0b917a2e50f644bf57490aee24"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "081adc15e8985057ee9ecd655029752afdd3a304"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@081adc15e8985057ee9ecd655029752afdd3a304",
"title": "081adc15e8985057ee9ecd655029752afdd3a304",
"url": "https://llvm.googlesource.com/llvm-project/+/081adc15e8985057ee9ecd655029752afdd3a304"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "1bc63265afbe007b9ec023e35a10fa0a8143e95b"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@1bc63265afbe007b9ec023e35a10fa0a8143e95b",
"title": "1bc63265afbe007b9ec023e35a10fa0a8143e95b",
"url": "https://llvm.googlesource.com/llvm-project/+/1bc63265afbe007b9ec023e35a10fa0a8143e95b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "8d83d046376e7b57c1aa0c5bdd8958b21bbaf0ca"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@8d83d046376e7b57c1aa0c5bdd8958b21bbaf0ca",
"title": "8d83d046376e7b57c1aa0c5bdd8958b21bbaf0ca",
"url": "https://llvm.googlesource.com/llvm-project/+/8d83d046376e7b57c1aa0c5bdd8958b21bbaf0ca"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "f40909f605fdd7c049d50b6483db9e769fb933c0"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@f40909f605fdd7c049d50b6483db9e769fb933c0",
"title": "f40909f605fdd7c049d50b6483db9e769fb933c0",
"url": "https://llvm.googlesource.com/llvm-project/+/f40909f605fdd7c049d50b6483db9e769fb933c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ed75e55a70aaf898c35ad4ca0f5936bf72e4fc11"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ed75e55a70aaf898c35ad4ca0f5936bf72e4fc11",
"title": "ed75e55a70aaf898c35ad4ca0f5936bf72e4fc11",
"url": "https://llvm.googlesource.com/llvm-project/+/ed75e55a70aaf898c35ad4ca0f5936bf72e4fc11"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "c445ca5412a7ee1bf7a598e860b50f29602e1981"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@c445ca5412a7ee1bf7a598e860b50f29602e1981",
"title": "c445ca5412a7ee1bf7a598e860b50f29602e1981",
"url": "https://llvm.googlesource.com/llvm-project/+/c445ca5412a7ee1bf7a598e860b50f29602e1981"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "836ff367d0bca9369fd2db237e9b5d7b929bb593"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@836ff367d0bca9369fd2db237e9b5d7b929bb593",
"title": "836ff367d0bca9369fd2db237e9b5d7b929bb593",
"url": "https://llvm.googlesource.com/llvm-project/+/836ff367d0bca9369fd2db237e9b5d7b929bb593"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "319a51a5ffb807b88ae7f73676894bf306a0d134"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@319a51a5ffb807b88ae7f73676894bf306a0d134",
"title": "319a51a5ffb807b88ae7f73676894bf306a0d134",
"url": "https://llvm.googlesource.com/llvm-project/+/319a51a5ffb807b88ae7f73676894bf306a0d134"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "735d721de451067c3a618b309703d0b8beb9cacc"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@735d721de451067c3a618b309703d0b8beb9cacc",
"title": "735d721de451067c3a618b309703d0b8beb9cacc",
"url": "https://llvm.googlesource.com/llvm-project/+/735d721de451067c3a618b309703d0b8beb9cacc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "53edba8091dfd24e2b44204ae8263b009d95414f"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@53edba8091dfd24e2b44204ae8263b009d95414f",
"title": "53edba8091dfd24e2b44204ae8263b009d95414f",
"url": "https://llvm.googlesource.com/llvm-project/+/53edba8091dfd24e2b44204ae8263b009d95414f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://llvm.googlesource.com/llvm-project",
"revision": "ab17ff05621f3029c1afae0d62093287f9d1e2b5"
},
"id": "https://llvm.googlesource.com/llvm-project/+/refs/heads/main@ab17ff05621f3029c1afae0d62093287f9d1e2b5",
"title": "ab17ff05621f3029c1afae0d62093287f9d1e2b5",
"url": "https://llvm.googlesource.com/llvm-project/+/ab17ff05621f3029c1afae0d62093287f9d1e2b5"
}
]
}
},
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ab17ff05621f3029c1afae0d62093287f9d1e2b5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8876681713806654048"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-rust-integration-trigger-40be1bb5"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:34:18.952] Scheduled build:
{
"id": "8711251651272663441",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-integration-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-23T17:34:18.637730517Z",
"updateTime": "2025-06-23T17:34:18.637730517Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ab17ff05621f3029c1afae0d62093287f9d1e2b5",
"ref": "refs/heads/main"
}
}
}
[17:34:18.952] Task URL: https://cr-buildbucket.appspot.com/build/8711251651272663441
[17:34:18.952] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:2:0) after 5m32s
[17:34:19.947] Received PubSub notification, asking Buildbucket for the build status
[17:34:19.974] Build status: SCHEDULED
[17:39:50.976] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:2:0)
[17:39:51.005] Build status: SCHEDULED
[17:39:51.005] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:4:0) after 7m26s
[17:47:17.005] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:4:0)
[17:47:17.030] Build status: SCHEDULED
[17:47:17.030] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:5:0) after 8m34s
[17:55:51.035] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:5:0)
[17:55:51.067] Build status: SCHEDULED
[17:55:51.067] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:6:0) after 3m41s
[17:59:32.086] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:6:0)
[17:59:32.113] Build status: SCHEDULED
[17:59:32.113] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:7:0) after 8m15s
[18:07:47.142] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:7:0)
[18:07:47.161] Build status: SCHEDULED
[18:07:47.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:8:0) after 3m24s
[18:11:11.283] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:8:0)
[18:11:11.351] Build status: SCHEDULED
[18:11:11.352] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:9:0) after 8m29s
[18:19:40.369] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:9:0)
[18:19:40.396] Build status: SCHEDULED
[18:19:40.396] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:10:0) after 7m4s
[18:26:44.452] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:10:0)
[18:26:44.471] Build status: SCHEDULED
[18:26:44.471] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:11:0) after 3m6s
[18:29:50.582] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:11:0)
[18:29:50.600] Build status: SCHEDULED
[18:29:50.600] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:12:0) after 1m28s
[18:31:18.639] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:12:0)
[18:31:18.656] Build status: SCHEDULED
[18:31:18.656] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:13:0) after 7m25s
[18:38:43.673] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:13:0)
[18:38:43.783] Build status: SCHEDULED
[18:38:43.783] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:14:0) after 6m54s
[18:45:37.816] Handling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:14:0)
[18:45:37.840] Build status: SCHEDULED
[18:45:37.840] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-rust-integration-trigger-40be1bb5:8876681713806654048:15:0) after 4m16s
[18:46:16.708] Received PubSub notification, asking Buildbucket for the build status
[18:46:16.724] Build status: STARTED
[18:47:18.506] Received PubSub notification, asking Buildbucket for the build status
[18:47:18.670] Build:
{
"id": "8711251651272663441",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "rust-integration-trigger"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-23T17:34:18.637730517Z",
"startTime": "2025-06-23T18:46:16.473565927Z",
"endTime": "2025-06-23T18:47:18.127734810Z",
"updateTime": "2025-06-23T18:47:18.127734810Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "llvm.googlesource.com",
"project": "llvm-project",
"id": "ab17ff05621f3029c1afae0d62093287f9d1e2b5",
"ref": "refs/heads/main"
}
}
}
[18:47:18.670] Invocation finished in 1h13m1.832883777s with status SUCCEEDED