[INFO] cloning repository https://github.com/esmevane/vacuum-reproduction [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/esmevane/vacuum-reproduction" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fesmevane%2Fvacuum-reproduction", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fesmevane%2Fvacuum-reproduction'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] 72aa36116808ecef21a48e3fb57152f440d56b3b [INFO] testing esmevane/vacuum-reproduction against try#7af779037716ae4125ceabb429791b4cf5dd0a43 for pr-136932 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fesmevane%2Fvacuum-reproduction" "/workspace/builds/worker-7-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-7-tc2/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/esmevane/vacuum-reproduction on toolchain 7af779037716ae4125ceabb429791b4cf5dd0a43 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+7af779037716ae4125ceabb429791b4cf5dd0a43" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking git repo https://github.com/esmevane/vacuum-reproduction [INFO] finished tweaking git repo https://github.com/esmevane/vacuum-reproduction [INFO] tweaked toml for git repo https://github.com/esmevane/vacuum-reproduction written to /workspace/builds/worker-7-tc2/source/Cargo.toml [INFO] crate git repo https://github.com/esmevane/vacuum-reproduction already has a lockfile, it will not be regenerated [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+7af779037716ae4125ceabb429791b4cf5dd0a43" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3959728d45483eb673ba100a951a6b9f5012970368db2a9e08e0ac9b67c8a5ad" "/opt/rustwide/cargo-home/bin/cargo" "+7af779037716ae4125ceabb429791b4cf5dd0a43" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 70cdf818dd006c0160ae75b7c6295275ebfdf07719cae17a1d3a7564a51cd6e9 [INFO] running `Command { std: "docker" "start" "-a" "70cdf818dd006c0160ae75b7c6295275ebfdf07719cae17a1d3a7564a51cd6e9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "70cdf818dd006c0160ae75b7c6295275ebfdf07719cae17a1d3a7564a51cd6e9", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "70cdf818dd006c0160ae75b7c6295275ebfdf07719cae17a1d3a7564a51cd6e9", kill_on_drop: false }` [INFO] [stdout] 70cdf818dd006c0160ae75b7c6295275ebfdf07719cae17a1d3a7564a51cd6e9 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3959728d45483eb673ba100a951a6b9f5012970368db2a9e08e0ac9b67c8a5ad" "/opt/rustwide/cargo-home/bin/cargo" "+7af779037716ae4125ceabb429791b4cf5dd0a43" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 7f2a6966c8ed53d46b03120dbd5b343ef4faa34c091a9a8f4ab503e8d124b81f [INFO] running `Command { std: "docker" "start" "-a" "7f2a6966c8ed53d46b03120dbd5b343ef4faa34c091a9a8f4ab503e8d124b81f", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.3.0 [INFO] [stderr] Compiling libc v0.2.155 [INFO] [stderr] Compiling proc-macro2 v1.0.85 [INFO] [stderr] Compiling unicode-ident v1.0.12 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling version_check v0.9.4 [INFO] [stderr] Compiling once_cell v1.19.0 [INFO] [stderr] Compiling cc v1.0.98 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling typenum v1.17.0 [INFO] [stderr] Compiling pin-project-lite v0.2.14 [INFO] [stderr] Compiling serde v1.0.203 [INFO] [stderr] Compiling smallvec v1.13.2 [INFO] [stderr] Compiling futures-core v0.3.30 [INFO] [stderr] Compiling parking_lot_core v0.9.10 [INFO] [stderr] Compiling vcpkg v0.2.15 [INFO] [stderr] Compiling pkg-config v0.3.30 [INFO] [stderr] Compiling zerocopy v0.7.34 [INFO] [stderr] Compiling serde_json v1.0.117 [INFO] [stderr] Compiling futures-sink v0.3.30 [INFO] [stderr] Compiling bytes v1.6.0 [INFO] [stderr] Compiling memchr v2.7.2 [INFO] [stderr] Compiling untrusted v0.9.0 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling allocator-api2 v0.2.18 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling crossbeam-utils v0.8.20 [INFO] [stderr] Compiling ryu v1.0.18 [INFO] [stderr] Compiling iana-time-zone v0.1.60 [INFO] [stderr] Compiling lock_api v0.4.12 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling ahash v0.8.11 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling itoa v1.0.11 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling thiserror v1.0.61 [INFO] [stderr] Compiling paste v1.0.15 [INFO] [stderr] Compiling cpufeatures v0.2.12 [INFO] [stderr] Compiling quote v1.0.36 [INFO] [stderr] Compiling unicode-bidi v0.3.15 [INFO] [stderr] Compiling minimal-lexical v0.2.1 [INFO] [stderr] Compiling syn v2.0.66 [INFO] [stderr] Compiling futures-task v0.3.30 [INFO] [stderr] Compiling percent-encoding v2.3.1 [INFO] [stderr] Compiling futures-io v0.3.30 [INFO] [stderr] Compiling rustls v0.21.12 [INFO] [stderr] Compiling form_urlencoded v1.2.1 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling futures-util v0.3.30 [INFO] [stderr] Compiling nom v7.1.3 [INFO] [stderr] Compiling tracing-core v0.1.32 [INFO] [stderr] Compiling equivalent v1.0.1 [INFO] [stderr] Compiling base64 v0.21.7 [INFO] [stderr] Compiling crc-catalog v2.4.0 [INFO] [stderr] Compiling unicode_categories v0.1.1 [INFO] [stderr] Compiling crc v3.2.1 [INFO] [stderr] Compiling unicode-normalization v0.1.23 [INFO] [stderr] Compiling futures-channel v0.3.30 [INFO] [stderr] Compiling getrandom v0.2.15 [INFO] [stderr] Compiling socket2 v0.5.7 [INFO] [stderr] Compiling mio v0.8.11 [INFO] [stderr] Compiling parking_lot v0.12.3 [INFO] [stderr] Compiling ring v0.17.8 [INFO] [stderr] Compiling chrono v0.4.38 [INFO] [stderr] Compiling rustls-pemfile v1.0.4 [INFO] [stderr] Compiling atoi v2.0.0 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling event-listener v2.5.3 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling futures-intrusive v0.5.0 [INFO] [stderr] Compiling crossbeam-queue v0.3.11 [INFO] [stderr] Compiling idna v0.5.0 [INFO] [stderr] Compiling log v0.4.21 [INFO] [stderr] Compiling uuid v1.8.0 [INFO] [stderr] Compiling webpki-roots v0.25.4 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling tokio v1.38.0 [INFO] [stderr] Compiling libsqlite3-sys v0.27.0 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling rustix v0.38.34 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling bitflags v2.5.0 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling signal-hook-registry v1.4.2 [INFO] [stderr] Compiling url v2.5.0 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling flume v0.11.0 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling urlencoding v2.1.3 [INFO] [stderr] Compiling linux-raw-sys v0.4.14 [INFO] [stderr] Compiling hashlink v0.8.4 [INFO] [stderr] Compiling indexmap v2.2.6 [INFO] [stderr] Compiling unicode-segmentation v1.11.0 [INFO] [stderr] Compiling fastrand v2.1.0 [INFO] [stderr] Compiling regex-syntax v0.6.29 [INFO] [stderr] Compiling regex-syntax v0.8.3 [INFO] [stderr] Compiling heck v0.4.1 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling dotenvy v0.15.7 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling nu-ansi-term v0.46.0 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling futures-executor v0.3.30 [INFO] [stderr] Compiling thread_local v1.1.8 [INFO] [stderr] Compiling anyhow v1.0.86 [INFO] [stderr] Compiling fallible-iterator v0.3.0 [INFO] [stderr] Compiling fallible-streaming-iterator v0.1.9 [INFO] [stderr] Compiling tempfile v3.10.1 [INFO] [stderr] Compiling regex-automata v0.4.6 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling serde_derive v1.0.203 [INFO] [stderr] Compiling tracing-attributes v0.1.27 [INFO] [stderr] Compiling thiserror-impl v1.0.61 [INFO] [stderr] Compiling tokio-macros v2.3.0 [INFO] [stderr] Compiling matchers v0.1.0 [INFO] [stderr] Compiling tracing-test-macro v0.2.5 [INFO] [stderr] Compiling tracing v0.1.40 [INFO] [stderr] Compiling regex v1.10.4 [INFO] [stderr] Compiling rustls-webpki v0.101.7 [INFO] [stderr] Compiling sct v0.7.1 [INFO] [stderr] Compiling tokio-stream v0.1.15 [INFO] [stderr] Compiling rusqlite v0.30.0 [INFO] [stderr] Compiling either v1.12.0 [INFO] [stderr] Compiling tracing-serde v0.1.3 [INFO] [stderr] Compiling itertools v0.12.1 [INFO] [stderr] Compiling tracing-subscriber v0.3.18 [INFO] [stderr] Compiling sqlformat v0.2.3 [INFO] [stderr] Compiling tracing-test v0.2.5 [INFO] [stderr] Compiling sqlx-core v0.7.4 [INFO] [stderr] Compiling sqlx-sqlite v0.7.4 [INFO] [stderr] Compiling sqlx-macros-core v0.7.4 [INFO] [stderr] Compiling sqlx-macros v0.7.4 [INFO] [stderr] Compiling sqlx v0.7.4 [INFO] [stderr] Compiling vacuum-reproduction v0.1.0 (/opt/rustwide/workdir) [INFO] [stdout] warning: field `name` is never read [INFO] [stdout] --> src/main.rs:23:5 [INFO] [stdout] | [INFO] [stdout] 22 | struct Table { [INFO] [stdout] | ----- field in this struct [INFO] [stdout] 23 | name: String, [INFO] [stdout] | ^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `Table` has a derived impl for the trait `Debug`, but this is intentionally ignored during dead code analysis [INFO] [stdout] = note: `#[warn(dead_code)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 10s [INFO] running `Command { std: "docker" "inspect" "7f2a6966c8ed53d46b03120dbd5b343ef4faa34c091a9a8f4ab503e8d124b81f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7f2a6966c8ed53d46b03120dbd5b343ef4faa34c091a9a8f4ab503e8d124b81f", kill_on_drop: false }` [INFO] [stdout] 7f2a6966c8ed53d46b03120dbd5b343ef4faa34c091a9a8f4ab503e8d124b81f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3959728d45483eb673ba100a951a6b9f5012970368db2a9e08e0ac9b67c8a5ad" "/opt/rustwide/cargo-home/bin/cargo" "+7af779037716ae4125ceabb429791b4cf5dd0a43" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f3ab52e6b0e1e0d7248ce7b8605a8ef665c5c16377d227af885632db4c04d78d [INFO] running `Command { std: "docker" "start" "-a" "f3ab52e6b0e1e0d7248ce7b8605a8ef665c5c16377d227af885632db4c04d78d", kill_on_drop: false }` [INFO] [stderr] Compiling vacuum-reproduction v0.1.0 (/opt/rustwide/workdir) [INFO] [stdout] warning: field `name` is never read [INFO] [stdout] --> src/main.rs:23:5 [INFO] [stdout] | [INFO] [stdout] 22 | struct Table { [INFO] [stdout] | ----- field in this struct [INFO] [stdout] 23 | name: String, [INFO] [stdout] | ^^^^ [INFO] [stdout] | [INFO] [stdout] = note: `Table` has a derived impl for the trait `Debug`, but this is intentionally ignored during dead code analysis [INFO] [stdout] = note: `#[warn(dead_code)]` on by default [INFO] [stdout] [INFO] [stdout] [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 2.87s [INFO] running `Command { std: "docker" "inspect" "f3ab52e6b0e1e0d7248ce7b8605a8ef665c5c16377d227af885632db4c04d78d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f3ab52e6b0e1e0d7248ce7b8605a8ef665c5c16377d227af885632db4c04d78d", kill_on_drop: false }` [INFO] [stdout] f3ab52e6b0e1e0d7248ce7b8605a8ef665c5c16377d227af885632db4c04d78d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3959728d45483eb673ba100a951a6b9f5012970368db2a9e08e0ac9b67c8a5ad" "/opt/rustwide/cargo-home/bin/cargo" "+7af779037716ae4125ceabb429791b4cf5dd0a43" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 26eaa898fa2da1f3eec85a15f6b47ff66e4b6bcde16619a99b3703c8e7ddf96f [INFO] running `Command { std: "docker" "start" "-a" "26eaa898fa2da1f3eec85a15f6b47ff66e4b6bcde16619a99b3703c8e7ddf96f", kill_on_drop: false }` [INFO] [stderr] warning: field `name` is never read [INFO] [stderr] --> src/main.rs:23:5 [INFO] [stderr] | [INFO] [stderr] 22 | struct Table { [INFO] [stderr] | ----- field in this struct [INFO] [stderr] 23 | name: String, [INFO] [stderr] | ^^^^ [INFO] [stderr] | [INFO] [stderr] = note: `Table` has a derived impl for the trait `Debug`, but this is intentionally ignored during dead code analysis [INFO] [stderr] = note: `#[warn(dead_code)]` on by default [INFO] [stderr] [INFO] [stderr] warning: `vacuum-reproduction` (bin "vacuum-reproduction" test) generated 1 warning [INFO] [stderr] Finished `test` profile [unoptimized + debuginfo] target(s) in 0.20s [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/vacuum_reproduction-31139130121ffa9a) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test test_rusqlite ... ok [INFO] [stdout] test test_sqlx_with_pools ... FAILED [INFO] [stdout] test test_sqlx_with_shared_cache_connection ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test_sqlx_with_pools stdout ---- [INFO] [stdout] 2025-02-13T05:24:59.105349Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Creating pool with shared cache" [INFO] [stdout] 2025-02-13T05:24:59.107255Z DEBUG test_sqlx_with_pools:Running sqlx with pooled connection: sqlx::query: summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=60.17µs elapsed_secs=6.017e-5 [INFO] [stdout] 2025-02-13T05:24:59.107379Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Creating table and inserting data" CREATE_TABLE="\n create table test (id integer primary key, name text);\n insert into test (name) values ('hello');\n insert into test (name) values ('world');\n" [INFO] [stdout] 2025-02-13T05:24:59.110531Z DEBUG test_sqlx_with_pools:Running sqlx with pooled connection: sqlx::query: summary="create table test (id …" db.statement="\n\ncreate table test (id integer primary key, name text);\ninsert into\n test (name)\nvalues\n ('hello');\ninsert into\n test (name)\nvalues\n ('world');\n" rows_affected=2 rows_returned=0 elapsed=631.54µs elapsed_secs=0.00063154 [INFO] [stdout] 2025-02-13T05:24:59.110686Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Selecting all data from memory table" SELECT_ALL="select * from test" [INFO] [stdout] 2025-02-13T05:24:59.111176Z DEBUG test_sqlx_with_pools:Running sqlx with pooled connection: sqlx::query: summary="select * from test" db.statement="" rows_affected=1 rows_returned=2 elapsed=178.509µs elapsed_secs=0.000178509 [INFO] [stdout] [src/main.rs:28:5] format!("vacuum into '{db_str}'") = "vacuum into '/tmp/.tmppJlNM0'" [INFO] [stdout] 2025-02-13T05:24:59.111324Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Vacuuming into new db" path="/tmp/.tmppJlNM0" [INFO] [stdout] 2025-02-13T05:24:59.115095Z DEBUG test_sqlx_with_pools:Running sqlx with pooled connection: sqlx::query: summary="vacuum into '/tmp/.tmppJlNM0'" db.statement="" rows_affected=1 rows_returned=0 elapsed=381.27µs elapsed_secs=0.00038127 [INFO] [stdout] 2025-02-13T05:24:59.115195Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Dropping pool" [INFO] [stdout] 2025-02-13T05:24:59.115216Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Checking if new db exists" [INFO] [stdout] 2025-02-13T05:24:59.115240Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Opening new db connection to temp db path" [INFO] [stdout] 2025-02-13T05:24:59.118149Z DEBUG test_sqlx_with_pools:Running sqlx with pooled connection: sqlx::query: summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=44.42µs elapsed_secs=4.442e-5 [INFO] [stdout] 2025-02-13T05:24:59.118269Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Checking if tables exist" [INFO] [stdout] 2025-02-13T05:24:59.119545Z DEBUG test_sqlx_with_pools:Running sqlx with pooled connection: sqlx::query: summary="SELECT name FROM sqlite_master …" db.statement="\n\nSELECT\n name\nFROM\n sqlite_master\nWHERE\n type = 'table'\n" rows_affected=0 rows_returned=0 elapsed=359.8µs elapsed_secs=0.0003598 [INFO] [stdout] [src/main.rs:126:18] sqlx::query_as::<_, [INFO] [stdout] Table>("SELECT name FROM sqlite_master WHERE type='table'").fetch_all(&pool).await? = [] [INFO] [stdout] 2025-02-13T05:24:59.119679Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Current tables" tables=[] [INFO] [stdout] [INFO] [stdout] thread 'test_sqlx_with_pools' panicked at src/main.rs:134:5: [INFO] [stdout] No tables found in new db [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5e5409e3e99f - std::backtrace_rs::backtrace::libunwind::trace::h273cca4b4ff52a75 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x5e5409e3e99f - std::backtrace_rs::backtrace::trace_unsynchronized::h0dcaf4eaddc63f4d [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5e5409e3e99f - std::sys::backtrace::_print_fmt::h99227612ab693c91 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x5e5409e3e99f - ::fmt::hd0fb9a24f673249b [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x5e5409e69e43 - core::fmt::rt::Argument::fmt::h3790bd73ff49839a [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/fmt/rt.rs:184:76 [INFO] [stdout] 5: 0x5e5409e69e43 - core::fmt::write::hf7b505e27c2f59c0 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/fmt/mod.rs:1449:21 [INFO] [stdout] 6: 0x5e5409e3aec3 - std::io::Write::write_fmt::hb002ef36900cedb4 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/io/mod.rs:1890:15 [INFO] [stdout] 7: 0x5e5409e3e7f2 - std::sys::backtrace::BacktraceLock::print::h5fa244ae2c1a02f2 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x5e5409e3fdcf - std::panicking::default_hook::{{closure}}::hd977fe155ed94062 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:298:22 [INFO] [stdout] 9: 0x5e5409e3fbe8 - std::panicking::default_hook::hf1aee4d1a1a53629 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:322:9 [INFO] [stdout] 10: 0x5e540986e975 - as core::ops::function::Fn>::call::h863d5366fd8956b9 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/alloc/src/boxed.rs:2030:9 [INFO] [stdout] 11: 0x5e540986e975 - test::test_main::{{closure}}::h069467131d9eccce [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:135:21 [INFO] [stdout] 12: 0x5e5409e408c3 - as core::ops::function::Fn>::call::h4d850f4eb7d2da54 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/alloc/src/boxed.rs:2030:9 [INFO] [stdout] 13: 0x5e5409e408c3 - std::panicking::rust_panic_with_hook::h8442779a6bb2c045 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:839:13 [INFO] [stdout] 14: 0x5e5409e40546 - std::panicking::begin_panic_handler::{{closure}}::h5fc7eacd91180541 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:697:13 [INFO] [stdout] 15: 0x5e5409e3eeb9 - std::sys::backtrace::__rust_end_short_backtrace::h83d61fb88e4c1551 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x5e5409e4020d - rust_begin_unwind [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:695:5 [INFO] [stdout] 17: 0x5e5409e67b50 - core::panicking::panic_fmt::hcb1ec5c71ed9d2aa [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/panicking.rs:75:14 [INFO] [stdout] 18: 0x5e54097d5f32 - vacuum_reproduction::sqlx_with_pooled_connection::{{closure}}::{{closure}}::hac513d8c44b0948b [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:134:5 [INFO] [stdout] 19: 0x5e540981e206 - as core::future::future::Future>::poll::h2e53ecff3210bf90 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-0.1.40/src/instrument.rs:321:9 [INFO] [stdout] 20: 0x5e54097ce896 - vacuum_reproduction::sqlx_with_pooled_connection::{{closure}}::habf463e02e1027ae [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:89:1 [INFO] [stdout] 21: 0x5e54097e2182 - vacuum_reproduction::test_sqlx_with_pools::{{closure}}::hb2e8fc35d518867d [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:215:35 [INFO] [stdout] 22: 0x5e54098173b5 - as core::future::future::Future>::poll::h59048f336d1bf31b [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/future/future.rs:124:9 [INFO] [stdout] 23: 0x5e540981736d - as core::future::future::Future>::poll::h518d1334de62cf41 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/future/future.rs:124:9 [INFO] [stdout] 24: 0x5e5409816fdf - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h65c6638c1f1cf88d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:659:57 [INFO] [stdout] 25: 0x5e5409816f06 - tokio::runtime::coop::with_budget::h0dda718363288756 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/coop.rs:107:5 [INFO] [stdout] 26: 0x5e5409816f06 - tokio::runtime::coop::budget::h1197911f9770858f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/coop.rs:73:5 [INFO] [stdout] 27: 0x5e5409816f06 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h25216484756914cf [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:659:25 [INFO] [stdout] 28: 0x5e54098156ca - tokio::runtime::scheduler::current_thread::Context::enter::h30739d9a9c6eef08 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:404:19 [INFO] [stdout] 29: 0x5e540981659f - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h01facdd382503065 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:658:36 [INFO] [stdout] 30: 0x5e54098162bb - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::hb494441cf0933db2 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:737:68 [INFO] [stdout] 31: 0x5e54097fde6a - tokio::runtime::context::scoped::Scoped::set::ha18ca69056987bf1 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 32: 0x5e54098148fa - tokio::runtime::context::set_scheduler::{{closure}}::ha35228ad1276d45b [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/context.rs:180:26 [INFO] [stdout] 33: 0x5e54097fbba6 - std::thread::local::LocalKey::try_with::hb5bccf5dfb42d0c1 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/thread/local.rs:310:12 [INFO] [stdout] 34: 0x5e54097fb4dc - std::thread::local::LocalKey::with::he661c85369b34e26 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/thread/local.rs:274:15 [INFO] [stdout] 35: 0x5e54098148a1 - tokio::runtime::context::set_scheduler::h45e9c51291e5e7e6 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/context.rs:180:9 [INFO] [stdout] 36: 0x5e5409816029 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::h7e8a2590db1c5358 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:737:27 [INFO] [stdout] 37: 0x5e54098162e3 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h38ae890daacd6ca8 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:646:19 [INFO] [stdout] 38: 0x5e5409814be3 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::h819d7064e5921553 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:175:28 [INFO] [stdout] 39: 0x5e54097e5c36 - tokio::runtime::context::runtime::enter_runtime::h8a48ede0583315fd [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 40: 0x5e5409814ae1 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::hd7e525e25cf629f6 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:167:9 [INFO] [stdout] 41: 0x5e54097e6339 - tokio::runtime::runtime::Runtime::block_on::h2b9065080c385ec9 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/runtime.rs:347:47 [INFO] [stdout] 42: 0x5e54097e1702 - vacuum_reproduction::test_sqlx_with_pools::hc79342c974045c6e [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:217:5 [INFO] [stdout] 43: 0x5e54097e1597 - vacuum_reproduction::test_sqlx_with_pools::{{closure}}::h80e40039701ab5ee [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:214:36 [INFO] [stdout] 44: 0x5e54097ef0c6 - core::ops::function::FnOnce::call_once::heacecad5f638c303 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 45: 0x5e540987418b - core::ops::function::FnOnce::call_once::h4f53344eaef367a7 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x5e540987418b - test::__rust_begin_short_backtrace::hd74e5b45349ae0eb [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:637:18 [INFO] [stdout] 47: 0x5e5409872fe8 - test::run_test_in_process::{{closure}}::h464496cd0c1c7008 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:660:60 [INFO] [stdout] 48: 0x5e5409872fe8 - as core::ops::function::FnOnce<()>>::call_once::h783dbf339886dbb5 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 49: 0x5e5409872fe8 - std::panicking::try::do_call::h939d38eaf9984278 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:587:40 [INFO] [stdout] 50: 0x5e5409872fe8 - std::panicking::try::h7462749e6e425b58 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:550:19 [INFO] [stdout] 51: 0x5e5409872fe8 - std::panic::catch_unwind::hd7e0994ef35a8a51 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panic.rs:358:14 [INFO] [stdout] 52: 0x5e5409872fe8 - test::run_test_in_process::hf0a6730e4eaf615d [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:660:27 [INFO] [stdout] 53: 0x5e5409872fe8 - test::run_test::{{closure}}::h6563d57083dce3d5 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:581:43 [INFO] [stdout] 54: 0x5e5409835f65 - test::run_test::{{closure}}::hd77e8481970892f0 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:611:41 [INFO] [stdout] 55: 0x5e5409835f65 - std::sys::backtrace::__rust_begin_short_backtrace::h3affc308abe149f2 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 56: 0x5e540983990a - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h0bcb7f1fc989ad90 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 57: 0x5e540983990a - as core::ops::function::FnOnce<()>>::call_once::h7f1d3c81251e8f39 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 58: 0x5e540983990a - std::panicking::try::do_call::ha04f8c9df155cd96 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:587:40 [INFO] [stdout] 59: 0x5e540983990a - std::panicking::try::hbac6309ffcaaa153 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:550:19 [INFO] [stdout] 60: 0x5e540983990a - std::panic::catch_unwind::h05df0eec2faa6d0d [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panic.rs:358:14 [INFO] [stdout] 61: 0x5e540983990a - std::thread::Builder::spawn_unchecked_::{{closure}}::h0931fb094701c63d [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 62: 0x5e540983990a - core::ops::function::FnOnce::call_once{{vtable.shim}}::h58033be664b55387 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 63: 0x5e5409e44adb - as core::ops::function::FnOnce>::call_once::hc2b66a72ea953e16 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/alloc/src/boxed.rs:2016:9 [INFO] [stdout] 64: 0x5e5409e44adb - as core::ops::function::FnOnce>::call_once::h64ac890f18adb1a4 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/alloc/src/boxed.rs:2016:9 [INFO] [stdout] 65: 0x5e5409e44adb - std::sys::pal::unix::thread::Thread::new::thread_start::h8744afc3d48ab12e [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/pal/unix/thread.rs:106:17 [INFO] [stdout] 66: 0x7cee4f847ac3 - [INFO] [stdout] 67: 0x7cee4f8d8a04 - clone [INFO] [stdout] 68: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- test_sqlx_with_shared_cache_connection stdout ---- [INFO] [stdout] 2025-02-13T05:24:59.105776Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Creating connection with shared cache" [INFO] [stdout] 2025-02-13T05:24:59.107245Z DEBUG test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: sqlx::query: summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=53.27µs elapsed_secs=5.327e-5 [INFO] [stdout] 2025-02-13T05:24:59.107368Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Creating table and inserting data" CREATE_TABLE="\n create table test (id integer primary key, name text);\n insert into test (name) values ('hello');\n insert into test (name) values ('world');\n" [INFO] [stdout] 2025-02-13T05:24:59.110480Z DEBUG test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: sqlx::query: summary="create table test (id …" db.statement="\n\ncreate table test (id integer primary key, name text);\ninsert into\n test (name)\nvalues\n ('hello');\ninsert into\n test (name)\nvalues\n ('world');\n" rows_affected=2 rows_returned=0 elapsed=670.44µs elapsed_secs=0.00067044 [INFO] [stdout] 2025-02-13T05:24:59.113695Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Selecting all data from memory table" SELECT_ALL="select * from test" [INFO] [stdout] 2025-02-13T05:24:59.114130Z DEBUG test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: sqlx::query: summary="select * from test" db.statement="" rows_affected=1 rows_returned=2 elapsed=268.72µs elapsed_secs=0.00026872 [INFO] [stdout] [src/main.rs:28:5] format!("vacuum into '{db_str}'") = "vacuum into '/tmp/.tmphxmuPN'" [INFO] [stdout] 2025-02-13T05:24:59.114278Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Vacuuming into new db" path="/tmp/.tmphxmuPN" [INFO] [stdout] 2025-02-13T05:24:59.115020Z DEBUG test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: sqlx::query: summary="vacuum into '/tmp/.tmphxmuPN'" db.statement="" rows_affected=1 rows_returned=0 elapsed=635.039µs elapsed_secs=0.000635039 [INFO] [stdout] 2025-02-13T05:24:59.115111Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Dropping connection" [INFO] [stdout] 2025-02-13T05:24:59.115142Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Checking if new db exists" [INFO] [stdout] 2025-02-13T05:24:59.118138Z DEBUG test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: sqlx::query: summary="PRAGMA foreign_keys = ON; …" db.statement="\n\nPRAGMA foreign_keys = ON;\n" rows_affected=0 rows_returned=0 elapsed=44.34µs elapsed_secs=4.434e-5 [INFO] [stdout] 2025-02-13T05:24:59.120673Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Checking if tables exist" [INFO] [stdout] 2025-02-13T05:24:59.121917Z DEBUG test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: sqlx::query: summary="SELECT name FROM sqlite_master …" db.statement="\n\nSELECT\n name\nFROM\n sqlite_master\nWHERE\n type = 'table'\n" rows_affected=0 rows_returned=0 elapsed=279.2µs elapsed_secs=0.0002792 [INFO] [stdout] [src/main.rs:66:18] sqlx::query_as::<_, [INFO] [stdout] Table>("SELECT name FROM sqlite_master WHERE type='table'").fetch_all(&pool).await? = [] [INFO] [stdout] 2025-02-13T05:24:59.122033Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Current tables" tables=[] [INFO] [stdout] [INFO] [stdout] thread 'test_sqlx_with_shared_cache_connection' panicked at src/main.rs:74:5: [INFO] [stdout] No tables found in new db [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x5e5409e3e99f - std::backtrace_rs::backtrace::libunwind::trace::h273cca4b4ff52a75 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x5e5409e3e99f - std::backtrace_rs::backtrace::trace_unsynchronized::h0dcaf4eaddc63f4d [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x5e5409e3e99f - std::sys::backtrace::_print_fmt::h99227612ab693c91 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x5e5409e3e99f - ::fmt::hd0fb9a24f673249b [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x5e5409e69e43 - core::fmt::rt::Argument::fmt::h3790bd73ff49839a [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/fmt/rt.rs:184:76 [INFO] [stdout] 5: 0x5e5409e69e43 - core::fmt::write::hf7b505e27c2f59c0 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/fmt/mod.rs:1449:21 [INFO] [stdout] 6: 0x5e5409e3aec3 - std::io::Write::write_fmt::hb002ef36900cedb4 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/io/mod.rs:1890:15 [INFO] [stdout] 7: 0x5e5409e3e7f2 - std::sys::backtrace::BacktraceLock::print::h5fa244ae2c1a02f2 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x5e5409e3fdcf - std::panicking::default_hook::{{closure}}::hd977fe155ed94062 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:298:22 [INFO] [stdout] 9: 0x5e5409e3fbe8 - std::panicking::default_hook::hf1aee4d1a1a53629 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:322:9 [INFO] [stdout] 10: 0x5e540986e975 - as core::ops::function::Fn>::call::h863d5366fd8956b9 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/alloc/src/boxed.rs:2030:9 [INFO] [stdout] 11: 0x5e540986e975 - test::test_main::{{closure}}::h069467131d9eccce [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:135:21 [INFO] [stdout] 12: 0x5e5409e408c3 - as core::ops::function::Fn>::call::h4d850f4eb7d2da54 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/alloc/src/boxed.rs:2030:9 [INFO] [stdout] 13: 0x5e5409e408c3 - std::panicking::rust_panic_with_hook::h8442779a6bb2c045 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:839:13 [INFO] [stdout] 14: 0x5e5409e40546 - std::panicking::begin_panic_handler::{{closure}}::h5fc7eacd91180541 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:697:13 [INFO] [stdout] 15: 0x5e5409e3eeb9 - std::sys::backtrace::__rust_end_short_backtrace::h83d61fb88e4c1551 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x5e5409e4020d - rust_begin_unwind [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:695:5 [INFO] [stdout] 17: 0x5e5409e67b50 - core::panicking::panic_fmt::hcb1ec5c71ed9d2aa [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/panicking.rs:75:14 [INFO] [stdout] 18: 0x5e54097cb20e - vacuum_reproduction::sqlx_with_shared_cache_connection::{{closure}}::{{closure}}::hb2d384645ed9c91d [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:74:5 [INFO] [stdout] 19: 0x5e540981e496 - as core::future::future::Future>::poll::h55dde598ef92d231 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-0.1.40/src/instrument.rs:321:9 [INFO] [stdout] 20: 0x5e54097c4436 - vacuum_reproduction::sqlx_with_shared_cache_connection::{{closure}}::ha17e99ff46167e59 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:31:1 [INFO] [stdout] 21: 0x5e54097e3042 - vacuum_reproduction::test_sqlx_with_shared_cache_connection::{{closure}}::hda260147b83baf74 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:223:41 [INFO] [stdout] 22: 0x5e54098173b5 - as core::future::future::Future>::poll::h59048f336d1bf31b [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/future/future.rs:124:9 [INFO] [stdout] 23: 0x5e540981736d - as core::future::future::Future>::poll::h518d1334de62cf41 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/future/future.rs:124:9 [INFO] [stdout] 24: 0x5e5409816fdf - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h65c6638c1f1cf88d [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:659:57 [INFO] [stdout] 25: 0x5e5409816f06 - tokio::runtime::coop::with_budget::h0dda718363288756 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/coop.rs:107:5 [INFO] [stdout] 26: 0x5e5409816f06 - tokio::runtime::coop::budget::h1197911f9770858f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/coop.rs:73:5 [INFO] [stdout] 27: 0x5e5409816f06 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h25216484756914cf [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:659:25 [INFO] [stdout] 28: 0x5e54098156ca - tokio::runtime::scheduler::current_thread::Context::enter::h30739d9a9c6eef08 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:404:19 [INFO] [stdout] 29: 0x5e540981659f - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h01facdd382503065 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:658:36 [INFO] [stdout] 30: 0x5e54098162bb - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::hb494441cf0933db2 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:737:68 [INFO] [stdout] 31: 0x5e54097fde6a - tokio::runtime::context::scoped::Scoped::set::ha18ca69056987bf1 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/context/scoped.rs:40:9 [INFO] [stdout] 32: 0x5e54098148fa - tokio::runtime::context::set_scheduler::{{closure}}::ha35228ad1276d45b [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/context.rs:180:26 [INFO] [stdout] 33: 0x5e54097fbba6 - std::thread::local::LocalKey::try_with::hb5bccf5dfb42d0c1 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/thread/local.rs:310:12 [INFO] [stdout] 34: 0x5e54097fb4dc - std::thread::local::LocalKey::with::he661c85369b34e26 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/thread/local.rs:274:15 [INFO] [stdout] 35: 0x5e54098148a1 - tokio::runtime::context::set_scheduler::h45e9c51291e5e7e6 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/context.rs:180:9 [INFO] [stdout] 36: 0x5e5409816029 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::h7e8a2590db1c5358 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:737:27 [INFO] [stdout] 37: 0x5e54098162e3 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h38ae890daacd6ca8 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:646:19 [INFO] [stdout] 38: 0x5e5409814be3 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::h819d7064e5921553 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:175:28 [INFO] [stdout] 39: 0x5e54097e5c36 - tokio::runtime::context::runtime::enter_runtime::h8a48ede0583315fd [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/context/runtime.rs:65:16 [INFO] [stdout] 40: 0x5e5409814ae1 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::hd7e525e25cf629f6 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/scheduler/current_thread/mod.rs:167:9 [INFO] [stdout] 41: 0x5e54097e6339 - tokio::runtime::runtime::Runtime::block_on::h2b9065080c385ec9 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tokio-1.38.0/src/runtime/runtime.rs:347:47 [INFO] [stdout] 42: 0x5e54097e25c2 - vacuum_reproduction::test_sqlx_with_shared_cache_connection::h09e9db5a4efc80f4 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:225:5 [INFO] [stdout] 43: 0x5e54097e2457 - vacuum_reproduction::test_sqlx_with_shared_cache_connection::{{closure}}::hc4406b56f02777e3 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:222:54 [INFO] [stdout] 44: 0x5e54097ef016 - core::ops::function::FnOnce::call_once::hc56acc8a1514eb93 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 45: 0x5e540987418b - core::ops::function::FnOnce::call_once::h4f53344eaef367a7 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x5e540987418b - test::__rust_begin_short_backtrace::hd74e5b45349ae0eb [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:637:18 [INFO] [stdout] 47: 0x5e5409872fe8 - test::run_test_in_process::{{closure}}::h464496cd0c1c7008 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:660:60 [INFO] [stdout] 48: 0x5e5409872fe8 - as core::ops::function::FnOnce<()>>::call_once::h783dbf339886dbb5 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 49: 0x5e5409872fe8 - std::panicking::try::do_call::h939d38eaf9984278 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:587:40 [INFO] [stdout] 50: 0x5e5409872fe8 - std::panicking::try::h7462749e6e425b58 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:550:19 [INFO] [stdout] 51: 0x5e5409872fe8 - std::panic::catch_unwind::hd7e0994ef35a8a51 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panic.rs:358:14 [INFO] [stdout] 52: 0x5e5409872fe8 - test::run_test_in_process::hf0a6730e4eaf615d [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:660:27 [INFO] [stdout] 53: 0x5e5409872fe8 - test::run_test::{{closure}}::h6563d57083dce3d5 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:581:43 [INFO] [stdout] 54: 0x5e5409835f65 - test::run_test::{{closure}}::hd77e8481970892f0 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/test/src/lib.rs:611:41 [INFO] [stdout] 55: 0x5e5409835f65 - std::sys::backtrace::__rust_begin_short_backtrace::h3affc308abe149f2 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 56: 0x5e540983990a - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h0bcb7f1fc989ad90 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 57: 0x5e540983990a - as core::ops::function::FnOnce<()>>::call_once::h7f1d3c81251e8f39 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 58: 0x5e540983990a - std::panicking::try::do_call::ha04f8c9df155cd96 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:587:40 [INFO] [stdout] 59: 0x5e540983990a - std::panicking::try::hbac6309ffcaaa153 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panicking.rs:550:19 [INFO] [stdout] 60: 0x5e540983990a - std::panic::catch_unwind::h05df0eec2faa6d0d [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/panic.rs:358:14 [INFO] [stdout] 61: 0x5e540983990a - std::thread::Builder::spawn_unchecked_::{{closure}}::h0931fb094701c63d [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 62: 0x5e540983990a - core::ops::function::FnOnce::call_once{{vtable.shim}}::h58033be664b55387 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 63: 0x5e5409e44adb - as core::ops::function::FnOnce>::call_once::hc2b66a72ea953e16 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/alloc/src/boxed.rs:2016:9 [INFO] [stdout] 64: 0x5e5409e44adb - as core::ops::function::FnOnce>::call_once::h64ac890f18adb1a4 [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/alloc/src/boxed.rs:2016:9 [INFO] [stdout] 65: 0x5e5409e44adb - std::sys::pal::unix::thread::Thread::new::thread_start::h8744afc3d48ab12e [INFO] [stdout] at /rustc/7af779037716ae4125ceabb429791b4cf5dd0a43/library/std/src/sys/pal/unix/thread.rs:106:17 [INFO] [stdout] 66: 0x7cee4f847ac3 - [INFO] [stdout] 67: 0x7cee4f8d8a04 - clone [INFO] [stdout] 68: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] test_sqlx_with_pools [INFO] [stdout] test_sqlx_with_shared_cache_connection [INFO] [stdout] [INFO] [stdout] test result: FAILED. 1 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--bin vacuum-reproduction` [INFO] running `Command { std: "docker" "inspect" "26eaa898fa2da1f3eec85a15f6b47ff66e4b6bcde16619a99b3703c8e7ddf96f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "26eaa898fa2da1f3eec85a15f6b47ff66e4b6bcde16619a99b3703c8e7ddf96f", kill_on_drop: false }` [INFO] [stdout] 26eaa898fa2da1f3eec85a15f6b47ff66e4b6bcde16619a99b3703c8e7ddf96f