[20:02:31.150] New invocation is queued and will start shortly
[20:02:32.563] Starting the invocation (attempt 1)
[20:02:32.599] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/third_party/rust/+/759e07f063fb8e6306ff1bdaeb70af56a878b415"
[20:02:32.599] Popped gitiles commit info from properties and tags
[20:02:32.599] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:02:32.599] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:02:32.600] Buildbucket request:
{
"requestId": "8898053271525365408",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8898053271525365408",
"job": "fuchsia/rust_test-x64-linux-49def413",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "cdbe8e5d281dfecaa3621dc32b1507b4901aef58"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@cdbe8e5d281dfecaa3621dc32b1507b4901aef58",
"title": "cdbe8e5d281dfecaa3621dc32b1507b4901aef58",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/cdbe8e5d281dfecaa3621dc32b1507b4901aef58"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "b073ddcce51aafde86e888d27c640f6d506e0d9d"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@b073ddcce51aafde86e888d27c640f6d506e0d9d",
"title": "b073ddcce51aafde86e888d27c640f6d506e0d9d",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/b073ddcce51aafde86e888d27c640f6d506e0d9d"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "744eb2f9372dfe9c4de9faeac27c986fb5c5fb10"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@744eb2f9372dfe9c4de9faeac27c986fb5c5fb10",
"title": "744eb2f9372dfe9c4de9faeac27c986fb5c5fb10",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/744eb2f9372dfe9c4de9faeac27c986fb5c5fb10"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a8ce44f7d9921f4ae1e620016c22f2a0ac6d8753"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a8ce44f7d9921f4ae1e620016c22f2a0ac6d8753",
"title": "a8ce44f7d9921f4ae1e620016c22f2a0ac6d8753",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a8ce44f7d9921f4ae1e620016c22f2a0ac6d8753"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "d921be92a459b41f0ba2d5b97e32397902f37294"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@d921be92a459b41f0ba2d5b97e32397902f37294",
"title": "d921be92a459b41f0ba2d5b97e32397902f37294",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/d921be92a459b41f0ba2d5b97e32397902f37294"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "e419b3d1ec234d428a00c9d6a8527ec4f6dc7e1a"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@e419b3d1ec234d428a00c9d6a8527ec4f6dc7e1a",
"title": "e419b3d1ec234d428a00c9d6a8527ec4f6dc7e1a",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/e419b3d1ec234d428a00c9d6a8527ec4f6dc7e1a"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "6d8d79595e93c74a545d60b181febc0e351851db"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@6d8d79595e93c74a545d60b181febc0e351851db",
"title": "6d8d79595e93c74a545d60b181febc0e351851db",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/6d8d79595e93c74a545d60b181febc0e351851db"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "86af0f9b7eccf3f8807cc0205a46d67ce31d9cf7"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@86af0f9b7eccf3f8807cc0205a46d67ce31d9cf7",
"title": "86af0f9b7eccf3f8807cc0205a46d67ce31d9cf7",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/86af0f9b7eccf3f8807cc0205a46d67ce31d9cf7"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a43a37c706890aa6d7e1a01a021e8e5b3d6341b8"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a43a37c706890aa6d7e1a01a021e8e5b3d6341b8",
"title": "a43a37c706890aa6d7e1a01a021e8e5b3d6341b8",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a43a37c706890aa6d7e1a01a021e8e5b3d6341b8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "0900a1bd8037bc2042eb926b129123e942f00d33"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@0900a1bd8037bc2042eb926b129123e942f00d33",
"title": "0900a1bd8037bc2042eb926b129123e942f00d33",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/0900a1bd8037bc2042eb926b129123e942f00d33"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "8d9686efc2ef9b809d95a82f678055a7fd833ae3"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@8d9686efc2ef9b809d95a82f678055a7fd833ae3",
"title": "8d9686efc2ef9b809d95a82f678055a7fd833ae3",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/8d9686efc2ef9b809d95a82f678055a7fd833ae3"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "a864e30269091791af5d45f0895dab2e2493e95c"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@a864e30269091791af5d45f0895dab2e2493e95c",
"title": "a864e30269091791af5d45f0895dab2e2493e95c",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/a864e30269091791af5d45f0895dab2e2493e95c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "c22832fdbef4c7aa16440476dec00d159d0567ce"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@c22832fdbef4c7aa16440476dec00d159d0567ce",
"title": "c22832fdbef4c7aa16440476dec00d159d0567ce",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/c22832fdbef4c7aa16440476dec00d159d0567ce"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "18e44f89bf97dfd5e7bf42bb3c6965650b565c16"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@18e44f89bf97dfd5e7bf42bb3c6965650b565c16",
"title": "18e44f89bf97dfd5e7bf42bb3c6965650b565c16",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/18e44f89bf97dfd5e7bf42bb3c6965650b565c16"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "426f2fbbe2b9a300b2afa9bc68ed30d95ad96ce8"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@426f2fbbe2b9a300b2afa9bc68ed30d95ad96ce8",
"title": "426f2fbbe2b9a300b2afa9bc68ed30d95ad96ce8",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/426f2fbbe2b9a300b2afa9bc68ed30d95ad96ce8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "5209757e296c5a9f6531e243d0ec2de163083067"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@5209757e296c5a9f6531e243d0ec2de163083067",
"title": "5209757e296c5a9f6531e243d0ec2de163083067",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/5209757e296c5a9f6531e243d0ec2de163083067"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/third_party/rust",
"revision": "759e07f063fb8e6306ff1bdaeb70af56a878b415"
},
"id": "https://fuchsia.googlesource.com/third_party/rust/+/refs/heads/main@759e07f063fb8e6306ff1bdaeb70af56a878b415",
"title": "759e07f063fb8e6306ff1bdaeb70af56a878b415",
"url": "https://fuchsia.googlesource.com/third_party/rust/+/759e07f063fb8e6306ff1bdaeb70af56a878b415"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "759e07f063fb8e6306ff1bdaeb70af56a878b415",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8898053271525365408"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/rust_test-x64-linux-49def413"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:02:33.080] Scheduled build:
{
"id": "8732623209267042977",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-30T20:02:32.676122129Z",
"updateTime": "2024-10-30T20:02:32.676122129Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "759e07f063fb8e6306ff1bdaeb70af56a878b415",
"ref": "refs/heads/main"
}
}
}
[20:02:33.080] Task URL: https://cr-buildbucket.appspot.com/build/8732623209267042977
[20:02:33.080] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:2:0) after 9m34s
[20:02:34.045] Received PubSub notification, asking Buildbucket for the build status
[20:02:34.169] Build status: SCHEDULED
[20:02:41.217] Received PubSub notification, asking Buildbucket for the build status
[20:02:41.907] Build status: STARTED
[20:12:07.117] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:2:0)
[20:12:07.166] Build status: STARTED
[20:12:07.166] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:5:0) after 4m15s
[20:16:22.181] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:5:0)
[20:16:22.206] Build status: STARTED
[20:16:22.206] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:6:0) after 3m55s
[20:20:17.228] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:6:0)
[20:20:17.277] Build status: STARTED
[20:20:17.277] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:7:0) after 7m16s
[20:27:33.294] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:7:0)
[20:27:33.315] Build status: STARTED
[20:27:33.315] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:8:0) after 9m8s
[20:36:41.382] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:8:0)
[20:36:41.403] Build status: STARTED
[20:36:41.403] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:9:0) after 1m51s
[20:38:32.487] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:9:0)
[20:38:32.505] Build status: STARTED
[20:38:32.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:10:0) after 1m5s
[20:39:37.555] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:10:0)
[20:39:37.584] Build status: STARTED
[20:39:37.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:11:0) after 5m50s
[20:45:27.602] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:11:0)
[20:45:27.623] Build status: STARTED
[20:45:27.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:12:0) after 1m39s
[20:47:06.675] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:12:0)
[20:47:06.702] Build status: STARTED
[20:47:06.702] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:13:0) after 9m10s
[20:56:16.696] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:13:0)
[20:56:16.720] Build status: STARTED
[20:56:16.720] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:14:0) after 7m18s
[21:03:34.779] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:14:0)
[21:03:34.814] Build status: STARTED
[21:03:34.815] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:15:0) after 7m51s
[21:11:25.834] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:15:0)
[21:11:25.850] Build status: STARTED
[21:11:25.851] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:16:0) after 1m1s
[21:12:26.917] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:16:0)
[21:12:26.931] Build status: STARTED
[21:12:26.932] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:17:0) after 1m42s
[21:14:08.906] Handling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:17:0)
[21:14:08.959] Build status: STARTED
[21:14:08.959] Scheduling timer "check-buildbucket-build-status" (fuchsia/rust_test-x64-linux-49def413:8898053271525365408:18:0) after 7m19s
[21:16:06.765] Received PubSub notification, asking Buildbucket for the build status
[21:16:06.797] Build:
{
"id": "8732623209267042977",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "rust_test-x64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2024-10-30T20:02:32.676122129Z",
"startTime": "2024-10-30T20:02:40.984770100Z",
"endTime": "2024-10-30T21:16:06.475402184Z",
"updateTime": "2024-10-30T21:16:06.475402184Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "third_party/rust",
"id": "759e07f063fb8e6306ff1bdaeb70af56a878b415",
"ref": "refs/heads/main"
}
}
}
[21:16:06.797] Invocation finished in 1h13m35.65834627s with status SUCCEEDED