[14:03:18.159] New invocation is queued and will start shortly
[14:03:19.220] Starting the invocation (attempt 1)
[14:03:19.252] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/267cae5bdbd602dd13f3851b9c96ce93697e59a0"
[14:03:19.252] Popped gitiles commit info from properties and tags
[14:03:19.252] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:03:19.252] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:03:19.253] Buildbucket request:
{
"requestId": "8881859014484316688",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8881859014484316688",
"job": "fuchsia/toolchain.ci-rust_test-x64-linux-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "12dd4a190866a94b1802b3b5d9b60055308e15bb"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@12dd4a190866a94b1802b3b5d9b60055308e15bb",
"title": "12dd4a190866a94b1802b3b5d9b60055308e15bb",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/12dd4a190866a94b1802b3b5d9b60055308e15bb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6be84b1f3863c93f87946a1efd86120966d703dc"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6be84b1f3863c93f87946a1efd86120966d703dc",
"title": "6be84b1f3863c93f87946a1efd86120966d703dc",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6be84b1f3863c93f87946a1efd86120966d703dc"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "781949d68b7393d35e02e7acca6a7d523af1cef8"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@781949d68b7393d35e02e7acca6a7d523af1cef8",
"title": "781949d68b7393d35e02e7acca6a7d523af1cef8",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/781949d68b7393d35e02e7acca6a7d523af1cef8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "676e29ba7fa756f21f6072f6ca58985dd998e377"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@676e29ba7fa756f21f6072f6ca58985dd998e377",
"title": "676e29ba7fa756f21f6072f6ca58985dd998e377",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/676e29ba7fa756f21f6072f6ca58985dd998e377"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "43d8d89b9ef6ce10d3310fdb56fb850dc8b42c91"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@43d8d89b9ef6ce10d3310fdb56fb850dc8b42c91",
"title": "43d8d89b9ef6ce10d3310fdb56fb850dc8b42c91",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/43d8d89b9ef6ce10d3310fdb56fb850dc8b42c91"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "86969dbe773b6e3f05ab34e9a2f8ba08441ebf88"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@86969dbe773b6e3f05ab34e9a2f8ba08441ebf88",
"title": "86969dbe773b6e3f05ab34e9a2f8ba08441ebf88",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/86969dbe773b6e3f05ab34e9a2f8ba08441ebf88"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9112c86f4226a6922f07bb44b49cedb75d1ee2f9"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9112c86f4226a6922f07bb44b49cedb75d1ee2f9",
"title": "9112c86f4226a6922f07bb44b49cedb75d1ee2f9",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9112c86f4226a6922f07bb44b49cedb75d1ee2f9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "2e8c53cf07d5441f55ac3cf3072c49978578d75e"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@2e8c53cf07d5441f55ac3cf3072c49978578d75e",
"title": "2e8c53cf07d5441f55ac3cf3072c49978578d75e",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/2e8c53cf07d5441f55ac3cf3072c49978578d75e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c7ad140473b70f3d6eab633832d15aaa42bfa371"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c7ad140473b70f3d6eab633832d15aaa42bfa371",
"title": "c7ad140473b70f3d6eab633832d15aaa42bfa371",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c7ad140473b70f3d6eab633832d15aaa42bfa371"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "7148908ace4ee9c1b4f75aa61293dca0fbc6a8f0"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@7148908ace4ee9c1b4f75aa61293dca0fbc6a8f0",
"title": "7148908ace4ee9c1b4f75aa61293dca0fbc6a8f0",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/7148908ace4ee9c1b4f75aa61293dca0fbc6a8f0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "bfdd947bbd5a2d242d0cbd728b3cbf2a30206b74"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@bfdd947bbd5a2d242d0cbd728b3cbf2a30206b74",
"title": "bfdd947bbd5a2d242d0cbd728b3cbf2a30206b74",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/bfdd947bbd5a2d242d0cbd728b3cbf2a30206b74"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9630242e5ee6b0c7eaaee7b9d9a1a5b567b66761"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9630242e5ee6b0c7eaaee7b9d9a1a5b567b66761",
"title": "9630242e5ee6b0c7eaaee7b9d9a1a5b567b66761",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9630242e5ee6b0c7eaaee7b9d9a1a5b567b66761"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "bd3af53489275cab11870d3cab915ed9ae9f0484"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@bd3af53489275cab11870d3cab915ed9ae9f0484",
"title": "bd3af53489275cab11870d3cab915ed9ae9f0484",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/bd3af53489275cab11870d3cab915ed9ae9f0484"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "2b0ce2cf920e7afec602b23518bbbc14d29d6e1d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@2b0ce2cf920e7afec602b23518bbbc14d29d6e1d",
"title": "2b0ce2cf920e7afec602b23518bbbc14d29d6e1d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/2b0ce2cf920e7afec602b23518bbbc14d29d6e1d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "766340b26e7f00c9d32be4918c918724a82bd030"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@766340b26e7f00c9d32be4918c918724a82bd030",
"title": "766340b26e7f00c9d32be4918c918724a82bd030",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/766340b26e7f00c9d32be4918c918724a82bd030"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "3af00f0889907d27234de1952c73764f922d60df"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@3af00f0889907d27234de1952c73764f922d60df",
"title": "3af00f0889907d27234de1952c73764f922d60df",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/3af00f0889907d27234de1952c73764f922d60df"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "2575c7d2dcc8545c1d0ccae891b033e162094f7f"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@2575c7d2dcc8545c1d0ccae891b033e162094f7f",
"title": "2575c7d2dcc8545c1d0ccae891b033e162094f7f",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/2575c7d2dcc8545c1d0ccae891b033e162094f7f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "1e677438f819f8e39d847d79b514b1e998db93da"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@1e677438f819f8e39d847d79b514b1e998db93da",
"title": "1e677438f819f8e39d847d79b514b1e998db93da",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/1e677438f819f8e39d847d79b514b1e998db93da"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "aa5c6d44cf53d77b6e12984235782bb2045f0ad4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@aa5c6d44cf53d77b6e12984235782bb2045f0ad4",
"title": "aa5c6d44cf53d77b6e12984235782bb2045f0ad4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/aa5c6d44cf53d77b6e12984235782bb2045f0ad4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "267cae5bdbd602dd13f3851b9c96ce93697e59a0"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@267cae5bdbd602dd13f3851b9c96ce93697e59a0",
"title": "267cae5bdbd602dd13f3851b9c96ce93697e59a0",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/267cae5bdbd602dd13f3851b9c96ce93697e59a0"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "267cae5bdbd602dd13f3851b9c96ce93697e59a0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8881859014484316688"
},
{
"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"
}
}
[14:03:19.625] Scheduled build:
{
"id": "8716428952615655313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-27T14:03:19.318982961Z",
"updateTime": "2025-04-27T14:03:19.318982961Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "267cae5bdbd602dd13f3851b9c96ce93697e59a0",
"ref": "refs/heads/main"
}
}
}
[14:03:19.625] Task URL: https://cr-buildbucket.appspot.com/build/8716428952615655313
[14:03:19.625] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:2:0) after 3m31s
[14:03:22.030] Received PubSub notification, asking Buildbucket for the build status
[14:03:22.054] Build status: SCHEDULED
[14:03:31.632] Received PubSub notification, asking Buildbucket for the build status
[14:03:31.654] Build status: STARTED
[14:06:50.701] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:2:0)
[14:06:50.814] Build status: STARTED
[14:06:50.814] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:5:0) after 3m32s
[14:10:22.839] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:5:0)
[14:10:22.861] Build status: STARTED
[14:10:22.861] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:6:0) after 2m52s
[14:13:14.882] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:6:0)
[14:13:14.968] Build status: STARTED
[14:13:14.968] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:7:0) after 6m44s
[14:19:59.204] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:7:0)
[14:19:59.234] Build status: STARTED
[14:19:59.235] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:8:0) after 2m59s
[14:22:58.456] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:8:0)
[14:22:58.480] Build status: STARTED
[14:22:58.480] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:9:0) after 2m33s
[14:25:31.495] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:9:0)
[14:25:31.521] Build status: STARTED
[14:25:31.521] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:10:0) after 7m26s
[14:32:57.563] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:10:0)
[14:32:57.592] Build status: STARTED
[14:32:57.592] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:11:0) after 4m42s
[14:37:39.735] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:11:0)
[14:37:39.767] Build status: STARTED
[14:37:39.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:12:0) after 5m35s
[14:43:14.786] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:12:0)
[14:43:14.835] Build status: STARTED
[14:43:14.835] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:13:0) after 5m41s
[14:48:55.949] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:13:0)
[14:48:55.972] Build status: STARTED
[14:48:55.972] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:14:0) after 6m33s
[14:55:29.135] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:14:0)
[14:55:29.161] Build status: STARTED
[14:55:29.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:15:0) after 4m23s
[14:59:52.139] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:15:0)
[14:59:52.161] Build status: STARTED
[14:59:52.161] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:16:0) after 2m30s
[15:02:22.171] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:16:0)
[15:02:22.435] Build status: STARTED
[15:02:22.435] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:17:0) after 6m59s
[15:09:21.705] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:17:0)
[15:09:21.724] Build status: STARTED
[15:09:21.724] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8881859014484316688:18:0) after 8m47s
[15:16:47.941] Received PubSub notification, asking Buildbucket for the build status
[15:16:47.965] Build:
{
"id": "8716428952615655313",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-27T14:03:19.318982961Z",
"startTime": "2025-04-27T14:03:31.411558416Z",
"endTime": "2025-04-27T15:16:47.617929967Z",
"updateTime": "2025-04-27T15:16:47.617929967Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "267cae5bdbd602dd13f3851b9c96ce93697e59a0",
"ref": "refs/heads/main"
}
}
}
[15:16:47.965] Invocation finished in 1h13m29.812810135s with status SUCCEEDED