[01:02:50.639] New invocation is queued and will start shortly
[01:02:51.734] Starting the invocation (attempt 1)
[01:02:51.761] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/31d0d2123d36de10c2611b842299cce5f447ddf7"
[01:02:51.761] Popped gitiles commit info from properties and tags
[01:02:51.761] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:02:51.761] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:02:51.762] Buildbucket request:
{
"requestId": "8877740656241411792",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8877740656241411792",
"job": "fuchsia/toolchain.ci-rust_test-x64-linux-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6f958ac88fbf83a1b45d2eff59aedf681b4f6723"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6f958ac88fbf83a1b45d2eff59aedf681b4f6723",
"title": "6f958ac88fbf83a1b45d2eff59aedf681b4f6723",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6f958ac88fbf83a1b45d2eff59aedf681b4f6723"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "296f9f2513b4540631455d8baec3910ea5ba4c1a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@296f9f2513b4540631455d8baec3910ea5ba4c1a",
"title": "296f9f2513b4540631455d8baec3910ea5ba4c1a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/296f9f2513b4540631455d8baec3910ea5ba4c1a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "9dd7c019fe9a31450b08e2639e777a40ae426c64"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@9dd7c019fe9a31450b08e2639e777a40ae426c64",
"title": "9dd7c019fe9a31450b08e2639e777a40ae426c64",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/9dd7c019fe9a31450b08e2639e777a40ae426c64"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "103d668e697bc0b76eacc446968f989e9193c5a3"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@103d668e697bc0b76eacc446968f989e9193c5a3",
"title": "103d668e697bc0b76eacc446968f989e9193c5a3",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/103d668e697bc0b76eacc446968f989e9193c5a3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "052a7c56188030effb7c9fd34524cd65a5849fb4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@052a7c56188030effb7c9fd34524cd65a5849fb4",
"title": "052a7c56188030effb7c9fd34524cd65a5849fb4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/052a7c56188030effb7c9fd34524cd65a5849fb4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8c236ab51e9d0df6501a59a1bf8e680dd05bf8ec"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8c236ab51e9d0df6501a59a1bf8e680dd05bf8ec",
"title": "8c236ab51e9d0df6501a59a1bf8e680dd05bf8ec",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8c236ab51e9d0df6501a59a1bf8e680dd05bf8ec"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "cd04717899c3266ca0f1a8af8829ff6187a2266c"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@cd04717899c3266ca0f1a8af8829ff6187a2266c",
"title": "cd04717899c3266ca0f1a8af8829ff6187a2266c",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/cd04717899c3266ca0f1a8af8829ff6187a2266c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d4d90ca3d26f9f620a55561e31f3ee3923efe190"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d4d90ca3d26f9f620a55561e31f3ee3923efe190",
"title": "d4d90ca3d26f9f620a55561e31f3ee3923efe190",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d4d90ca3d26f9f620a55561e31f3ee3923efe190"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "796ee4ff6cbcad73a21dc94ea715364e426475cb"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@796ee4ff6cbcad73a21dc94ea715364e426475cb",
"title": "796ee4ff6cbcad73a21dc94ea715364e426475cb",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/796ee4ff6cbcad73a21dc94ea715364e426475cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "edc405d383b896c0417ad1ba33558cf1c506af48"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@edc405d383b896c0417ad1ba33558cf1c506af48",
"title": "edc405d383b896c0417ad1ba33558cf1c506af48",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/edc405d383b896c0417ad1ba33558cf1c506af48"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "34241e539717e210a2a8336b28c7c0dbaceb2914"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@34241e539717e210a2a8336b28c7c0dbaceb2914",
"title": "34241e539717e210a2a8336b28c7c0dbaceb2914",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/34241e539717e210a2a8336b28c7c0dbaceb2914"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "ce0438684da2e67e715e2711fbbb304f394c2703"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@ce0438684da2e67e715e2711fbbb304f394c2703",
"title": "ce0438684da2e67e715e2711fbbb304f394c2703",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/ce0438684da2e67e715e2711fbbb304f394c2703"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "87b068ccb7d36e494a1cb4cfd104bf782eeac088"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@87b068ccb7d36e494a1cb4cfd104bf782eeac088",
"title": "87b068ccb7d36e494a1cb4cfd104bf782eeac088",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/87b068ccb7d36e494a1cb4cfd104bf782eeac088"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b29c9a3588fb5cad281a1fb006bed87a7f956a44"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b29c9a3588fb5cad281a1fb006bed87a7f956a44",
"title": "b29c9a3588fb5cad281a1fb006bed87a7f956a44",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b29c9a3588fb5cad281a1fb006bed87a7f956a44"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "deea0677f4c3236db40066bc9b45d2ba2fb13b27"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@deea0677f4c3236db40066bc9b45d2ba2fb13b27",
"title": "deea0677f4c3236db40066bc9b45d2ba2fb13b27",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/deea0677f4c3236db40066bc9b45d2ba2fb13b27"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "13f95426fdf405748a43b97fa4e1552279c5fbb4"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@13f95426fdf405748a43b97fa4e1552279c5fbb4",
"title": "13f95426fdf405748a43b97fa4e1552279c5fbb4",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/13f95426fdf405748a43b97fa4e1552279c5fbb4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "507c57554d776c533c411fcb4585cfbe0bbe6b35"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@507c57554d776c533c411fcb4585cfbe0bbe6b35",
"title": "507c57554d776c533c411fcb4585cfbe0bbe6b35",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/507c57554d776c533c411fcb4585cfbe0bbe6b35"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "e2846d6b75c088f3eca75a4fee474fa677b62399"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@e2846d6b75c088f3eca75a4fee474fa677b62399",
"title": "e2846d6b75c088f3eca75a4fee474fa677b62399",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/e2846d6b75c088f3eca75a4fee474fa677b62399"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "e78b619cad4f8b642028ec02def0f8cc4be0abdd"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@e78b619cad4f8b642028ec02def0f8cc4be0abdd",
"title": "e78b619cad4f8b642028ec02def0f8cc4be0abdd",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/e78b619cad4f8b642028ec02def0f8cc4be0abdd"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "e80be0bcba74261583c230cfdfda2a049e9f0079"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@e80be0bcba74261583c230cfdfda2a049e9f0079",
"title": "e80be0bcba74261583c230cfdfda2a049e9f0079",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/e80be0bcba74261583c230cfdfda2a049e9f0079"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "f417620160990a9a3fd943b834045e37e99e9a4a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@f417620160990a9a3fd943b834045e37e99e9a4a",
"title": "f417620160990a9a3fd943b834045e37e99e9a4a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/f417620160990a9a3fd943b834045e37e99e9a4a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c97dca69897a656895141ca708a4ed64c26fb304"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c97dca69897a656895141ca708a4ed64c26fb304",
"title": "c97dca69897a656895141ca708a4ed64c26fb304",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c97dca69897a656895141ca708a4ed64c26fb304"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "31d0d2123d36de10c2611b842299cce5f447ddf7"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@31d0d2123d36de10c2611b842299cce5f447ddf7",
"title": "31d0d2123d36de10c2611b842299cce5f447ddf7",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/31d0d2123d36de10c2611b842299cce5f447ddf7"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "31d0d2123d36de10c2611b842299cce5f447ddf7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8877740656241411792"
},
{
"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"
}
}
[01:02:52.344] Scheduled build:
{
"id": "8712310594234964273",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-12T01:02:51.932877422Z",
"updateTime": "2025-06-12T01:02:51.932877422Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "31d0d2123d36de10c2611b842299cce5f447ddf7",
"ref": "refs/heads/main"
}
}
}
[01:02:52.344] Task URL: https://cr-buildbucket.appspot.com/build/8712310594234964273
[01:02:52.345] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:2:0) after 3m34s
[01:02:53.424] Received PubSub notification, asking Buildbucket for the build status
[01:02:53.449] Build status: SCHEDULED
[01:02:55.146] Received PubSub notification, asking Buildbucket for the build status
[01:02:55.193] Build status: STARTED
[01:06:26.366] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:2:0)
[01:06:26.393] Build status: STARTED
[01:06:26.393] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:5:0) after 9m2s
[01:15:28.469] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:5:0)
[01:15:28.491] Build status: STARTED
[01:15:28.491] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:6:0) after 2m6s
[01:17:34.601] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:6:0)
[01:17:34.629] Build status: STARTED
[01:17:34.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:7:0) after 1m38s
[01:19:12.658] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:7:0)
[01:19:12.686] Build status: STARTED
[01:19:12.686] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:8:0) after 5m25s
[01:24:37.730] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:8:0)
[01:24:37.748] Build status: STARTED
[01:24:37.748] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:9:0) after 2m9s
[01:26:46.751] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:9:0)
[01:26:46.851] Build status: STARTED
[01:26:46.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:10:0) after 3m11s
[01:29:57.888] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:10:0)
[01:29:57.956] Build status: STARTED
[01:29:57.956] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:11:0) after 7m54s
[01:37:52.025] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:11:0)
[01:37:52.050] Build status: STARTED
[01:37:52.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:12:0) after 4m36s
[01:42:28.206] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:12:0)
[01:42:28.226] Build status: STARTED
[01:42:28.226] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:13:0) after 7m32s
[01:50:00.252] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:13:0)
[01:50:00.440] Build status: STARTED
[01:50:00.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:14:0) after 6m46s
[01:56:46.563] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:14:0)
[01:56:46.580] Build status: STARTED
[01:56:46.580] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:15:0) after 2m37s
[01:59:24.268] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:15:0)
[01:59:24.287] Build status: STARTED
[01:59:24.287] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:16:0) after 1m55s
[02:01:19.307] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:16:0)
[02:01:19.357] Build status: STARTED
[02:01:19.357] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:17:0) after 2m24s
[02:03:43.439] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:17:0)
[02:03:43.461] Build status: STARTED
[02:03:43.461] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:18:0) after 8m20s
[02:12:03.545] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:18:0)
[02:12:03.565] Build status: STARTED
[02:12:03.565] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:19:0) after 6m53s
[02:18:56.586] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:19:0)
[02:18:56.601] Build status: STARTED
[02:18:56.601] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:20:0) after 3m4s
[02:22:00.647] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:20:0)
[02:22:00.670] Build status: STARTED
[02:22:00.670] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-rust_test-x64-linux-49def413:8877740656241411792:21:0) after 7m7s
[02:24:43.875] Received PubSub notification, asking Buildbucket for the build status
[02:24:43.894] Build:
{
"id": "8712310594234964273",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2025-06-12T01:02:51.932877422Z",
"startTime": "2025-06-12T01:02:54.754308758Z",
"endTime": "2025-06-12T02:24:38.315473186Z",
"updateTime": "2025-06-12T02:24:38.315473186Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "31d0d2123d36de10c2611b842299cce5f447ddf7",
"ref": "refs/heads/main"
}
}
}
[02:24:43.894] Invocation finished in 1h21m53.259415584s with status SUCCEEDED