[05:57:55.068] New invocation is queued and will start shortly
[05:57:56.249] Starting the invocation (attempt 1)
[05:57:56.277] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/a8e4c68dcb4dc1e48a0db294c5323cab0227fcb9"
[05:57:56.277] Popped gitiles commit info from properties and tags
[05:57:56.277] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:57:56.277] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:57:56.277] Buildbucket request:
{
"requestId": "8879805822034496976",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8879805822034496976",
"job": "fuchsia/toolchain.ci-rust_test-x64-linux-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "0dec3fee34c5044f68579fedfa6882e0f69ff2cf"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@0dec3fee34c5044f68579fedfa6882e0f69ff2cf",
"title": "0dec3fee34c5044f68579fedfa6882e0f69ff2cf",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/0dec3fee34c5044f68579fedfa6882e0f69ff2cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8ecb128a2241dfe45ff27ce9765fd7653c6d50ad"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8ecb128a2241dfe45ff27ce9765fd7653c6d50ad",
"title": "8ecb128a2241dfe45ff27ce9765fd7653c6d50ad",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8ecb128a2241dfe45ff27ce9765fd7653c6d50ad"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7600453bd5afdd46d8e414a4ef325754d9bbfdac"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7600453bd5afdd46d8e414a4ef325754d9bbfdac",
"title": "7600453bd5afdd46d8e414a4ef325754d9bbfdac",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7600453bd5afdd46d8e414a4ef325754d9bbfdac"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c99c4b17b2a28f4056cbd460bfbf8cb27bc0be64"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c99c4b17b2a28f4056cbd460bfbf8cb27bc0be64",
"title": "c99c4b17b2a28f4056cbd460bfbf8cb27bc0be64",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c99c4b17b2a28f4056cbd460bfbf8cb27bc0be64"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9478598fc907e54d3df3f167620ef1aaaec233a1"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9478598fc907e54d3df3f167620ef1aaaec233a1",
"title": "9478598fc907e54d3df3f167620ef1aaaec233a1",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9478598fc907e54d3df3f167620ef1aaaec233a1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "66388d98929ce8b1fb7c09c7e221664c0357393d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@66388d98929ce8b1fb7c09c7e221664c0357393d",
"title": "66388d98929ce8b1fb7c09c7e221664c0357393d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/66388d98929ce8b1fb7c09c7e221664c0357393d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "41afd0433b4edfe8c91021466e5194577b1d42fa"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@41afd0433b4edfe8c91021466e5194577b1d42fa",
"title": "41afd0433b4edfe8c91021466e5194577b1d42fa",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/41afd0433b4edfe8c91021466e5194577b1d42fa"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "3aec6fad6a35421d7687616667f1fa945a31c35a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@3aec6fad6a35421d7687616667f1fa945a31c35a",
"title": "3aec6fad6a35421d7687616667f1fa945a31c35a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/3aec6fad6a35421d7687616667f1fa945a31c35a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6461160e8d1ac4f70894b5d8c8957e003b0609f9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6461160e8d1ac4f70894b5d8c8957e003b0609f9",
"title": "6461160e8d1ac4f70894b5d8c8957e003b0609f9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6461160e8d1ac4f70894b5d8c8957e003b0609f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "4a47234132015e7f0ad1b3e83d5ab61292e9af17"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@4a47234132015e7f0ad1b3e83d5ab61292e9af17",
"title": "4a47234132015e7f0ad1b3e83d5ab61292e9af17",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/4a47234132015e7f0ad1b3e83d5ab61292e9af17"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a8e4c68dcb4dc1e48a0db294c5323cab0227fcb9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a8e4c68dcb4dc1e48a0db294c5323cab0227fcb9",
"title": "a8e4c68dcb4dc1e48a0db294c5323cab0227fcb9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a8e4c68dcb4dc1e48a0db294c5323cab0227fcb9"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a8e4c68dcb4dc1e48a0db294c5323cab0227fcb9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8879805822034496976"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-rust_test-x64-linux-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:57:56.926] Scheduled build:
{
"id": "8714375760041612129",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-20T05:57:56.343173624Z",
"updateTime": "2025-05-20T05:57:56.343173624Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a8e4c68dcb4dc1e48a0db294c5323cab0227fcb9",
"ref": "refs/heads/main"
}
}
}
[05:57:56.926] Task URL: https://cr-buildbucket.appspot.com/build/8714375760041612129
[05:57:56.926] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:2:0) after 5m56s
[05:57:57.878] Received PubSub notification, asking Buildbucket for the build status
[05:57:57.901] Build status: SCHEDULED
[05:58:00.533] Received PubSub notification, asking Buildbucket for the build status
[05:58:00.562] Build status: STARTED
[06:03:53.183] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:2:0)
[06:03:53.205] Build status: STARTED
[06:03:53.205] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:5:0) after 3m17s
[06:07:10.228] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:5:0)
[06:07:10.320] Build status: STARTED
[06:07:10.320] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:6:0) after 5m52s
[06:13:02.430] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:6:0)
[06:13:02.446] Build status: STARTED
[06:13:02.446] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:7:0) after 3m6s
[06:16:08.581] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:7:0)
[06:16:08.627] Build status: STARTED
[06:16:08.627] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:8:0) after 8m57s
[06:25:05.704] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:8:0)
[06:25:05.719] Build status: STARTED
[06:25:05.719] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:9:0) after 3m17s
[06:28:22.839] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:9:0)
[06:28:22.859] Build status: STARTED
[06:28:22.859] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:10:0) after 5m35s
[06:33:57.896] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:10:0)
[06:33:57.920] Build status: STARTED
[06:33:57.921] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:11:0) after 7m8s
[06:41:06.060] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:11:0)
[06:41:06.080] Build status: STARTED
[06:41:06.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:12:0) after 8m27s
[06:49:33.320] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:12:0)
[06:49:33.340] Build status: STARTED
[06:49:33.340] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:13:0) after 1m56s
[06:51:29.442] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:13:0)
[06:51:29.460] Build status: STARTED
[06:51:29.460] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:14:0) after 8m8s
[06:59:37.480] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:14:0)
[06:59:37.510] Build status: STARTED
[06:59:37.510] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:15:0) after 1m25s
[07:01:02.535] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:15:0)
[07:01:02.592] Build status: STARTED
[07:01:02.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:16:0) after 1m27s
[07:02:29.632] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:16:0)
[07:02:29.658] Build status: STARTED
[07:02:29.658] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:17:0) after 1m34s
[07:04:03.736] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:17:0)
[07:04:03.780] Build status: STARTED
[07:04:03.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:18:0) after 1m38s
[07:05:41.803] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:18:0)
[07:05:41.828] Build status: STARTED
[07:05:41.828] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:19:0) after 4m18s
[07:09:59.874] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:19:0)
[07:09:59.896] Build status: STARTED
[07:09:59.896] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:20:0) after 1m40s
[07:11:40.017] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:20:0)
[07:11:40.057] Build status: STARTED
[07:11:40.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:21:0) after 2m6s
[07:13:46.143] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:21:0)
[07:13:46.166] Build status: STARTED
[07:13:46.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8879805822034496976:22:0) after 5m49s
[07:18:58.142] Received PubSub notification, asking Buildbucket for the build status
[07:18:58.214] Build:
{
"id": "8714375760041612129",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2025-05-20T05:57:56.343173624Z",
"startTime": "2025-05-20T05:57:59.859889704Z",
"endTime": "2025-05-20T07:18:57.517742723Z",
"updateTime": "2025-05-20T07:18:57.517742723Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "a8e4c68dcb4dc1e48a0db294c5323cab0227fcb9",
"ref": "refs/heads/main"
}
}
}
[07:18:58.214] Invocation finished in 1h21m3.155304317s with status SUCCEEDED