[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#17092ad00ed8fe1e7f81a7e38238ff70779034b1 for pr-140985 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fesmevane%2Fvacuum-reproduction" "/workspace/builds/worker-2-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc2/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/esmevane/vacuum-reproduction on toolchain 17092ad00ed8fe1e7f81a7e38238ff70779034b1 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "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-2-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" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 1989c84147d3e5c53ad7914f0df18cd97a8c1cb837c48c2a4a0d345f952934aa [INFO] running `Command { std: "docker" "start" "-a" "1989c84147d3e5c53ad7914f0df18cd97a8c1cb837c48c2a4a0d345f952934aa", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "1989c84147d3e5c53ad7914f0df18cd97a8c1cb837c48c2a4a0d345f952934aa", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "1989c84147d3e5c53ad7914f0df18cd97a8c1cb837c48c2a4a0d345f952934aa", kill_on_drop: false }` [INFO] [stdout] 1989c84147d3e5c53ad7914f0df18cd97a8c1cb837c48c2a4a0d345f952934aa [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f744b074389e4c2a1b42c6d95d5fdc83651eafca14d51a85882f6b8523c21c44 [INFO] running `Command { std: "docker" "start" "-a" "f744b074389e4c2a1b42c6d95d5fdc83651eafca14d51a85882f6b8523c21c44", kill_on_drop: false }` [INFO] [stderr] Compiling autocfg v1.3.0 [INFO] [stderr] Compiling proc-macro2 v1.0.85 [INFO] [stderr] Compiling libc v0.2.155 [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 cc v1.0.98 [INFO] [stderr] Compiling once_cell v1.19.0 [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 generic-array v0.14.7 [INFO] [stderr] Compiling futures-core v0.3.30 [INFO] [stderr] Compiling ahash v0.8.11 [INFO] [stderr] Compiling parking_lot_core v0.9.10 [INFO] [stderr] Compiling lock_api v0.4.12 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling vcpkg v0.2.15 [INFO] [stderr] Compiling zerocopy v0.7.34 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling pkg-config v0.3.30 [INFO] [stderr] Compiling slab v0.4.9 [INFO] [stderr] Compiling quote v1.0.36 [INFO] [stderr] Compiling getrandom v0.2.15 [INFO] [stderr] Compiling syn v2.0.66 [INFO] [stderr] Compiling mio v0.8.11 [INFO] [stderr] Compiling socket2 v0.5.7 [INFO] [stderr] Compiling serde_json v1.0.117 [INFO] [stderr] Compiling ring v0.17.8 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling untrusted v0.9.0 [INFO] [stderr] Compiling futures-sink v0.3.30 [INFO] [stderr] Compiling memchr v2.7.2 [INFO] [stderr] Compiling allocator-api2 v0.2.18 [INFO] [stderr] Compiling bytes v1.6.0 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling parking_lot v0.12.3 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling crossbeam-utils v0.8.20 [INFO] [stderr] Compiling iana-time-zone v0.1.60 [INFO] [stderr] Compiling itoa v1.0.11 [INFO] [stderr] Compiling ryu v1.0.18 [INFO] [stderr] Compiling chrono v0.4.38 [INFO] [stderr] Compiling futures-io v0.3.30 [INFO] [stderr] Compiling futures-task v0.3.30 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling unicode-bidi v0.3.15 [INFO] [stderr] Compiling minimal-lexical v0.2.1 [INFO] [stderr] Compiling thiserror v1.0.61 [INFO] [stderr] Compiling rustls v0.21.12 [INFO] [stderr] Compiling paste v1.0.15 [INFO] [stderr] Compiling percent-encoding v2.3.1 [INFO] [stderr] Compiling cpufeatures v0.2.12 [INFO] [stderr] Compiling unicode-normalization v0.1.23 [INFO] [stderr] Compiling nom v7.1.3 [INFO] [stderr] Compiling hashlink v0.8.4 [INFO] [stderr] Compiling form_urlencoded v1.2.1 [INFO] [stderr] Compiling futures-util v0.3.30 [INFO] [stderr] Compiling tracing-core v0.1.32 [INFO] [stderr] Compiling idna v0.5.0 [INFO] [stderr] Compiling equivalent v1.0.1 [INFO] [stderr] Compiling crc-catalog v2.4.0 [INFO] [stderr] Compiling unicode_categories v0.1.1 [INFO] [stderr] Compiling base64 v0.21.7 [INFO] [stderr] Compiling url v2.5.0 [INFO] [stderr] Compiling crc v3.2.1 [INFO] [stderr] Compiling rustls-pemfile v1.0.4 [INFO] [stderr] Compiling indexmap v2.2.6 [INFO] [stderr] Compiling crossbeam-queue v0.3.11 [INFO] [stderr] Compiling futures-intrusive v0.5.0 [INFO] [stderr] Compiling crypto-common v0.1.6 [INFO] [stderr] Compiling atoi v2.0.0 [INFO] [stderr] Compiling futures-channel v0.3.30 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling uuid v1.8.0 [INFO] [stderr] Compiling event-listener v2.5.3 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling log v0.4.21 [INFO] [stderr] Compiling sct v0.7.1 [INFO] [stderr] Compiling rustls-webpki v0.101.7 [INFO] [stderr] Compiling webpki-roots v0.25.4 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling tokio v1.38.0 [INFO] [stderr] Compiling libsqlite3-sys v0.27.0 [INFO] [stderr] Compiling bitflags v2.5.0 [INFO] [stderr] Compiling rustix v0.38.34 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling flume v0.11.0 [INFO] [stderr] Compiling futures-executor v0.3.30 [INFO] [stderr] Compiling signal-hook-registry v1.4.2 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling linux-raw-sys v0.4.14 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling urlencoding v2.1.3 [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 tracing v0.1.40 [INFO] [stderr] Compiling regex-syntax v0.6.29 [INFO] [stderr] Compiling fastrand v2.1.0 [INFO] [stderr] Compiling tokio-stream v0.1.15 [INFO] [stderr] Compiling unicode-segmentation v1.11.0 [INFO] [stderr] Compiling regex-syntax v0.8.3 [INFO] [stderr] Compiling heck v0.4.1 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling tempfile v3.10.1 [INFO] [stderr] Compiling dotenvy v0.15.7 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling regex-automata v0.4.6 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling nu-ansi-term v0.46.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 regex v1.10.4 [INFO] [stderr] Compiling matchers v0.1.0 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling thread_local v1.1.8 [INFO] [stderr] Compiling anyhow v1.0.86 [INFO] [stderr] Compiling tracing-test-macro v0.2.5 [INFO] [stderr] Compiling fallible-iterator v0.3.0 [INFO] [stderr] Compiling tracing-subscriber v0.3.18 [INFO] [stderr] Compiling fallible-streaming-iterator v0.1.9 [INFO] [stderr] Compiling sqlformat v0.2.3 [INFO] [stderr] Compiling tracing-test v0.2.5 [INFO] [stderr] Compiling rusqlite v0.30.0 [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 2m 26s [INFO] running `Command { std: "docker" "inspect" "f744b074389e4c2a1b42c6d95d5fdc83651eafca14d51a85882f6b8523c21c44", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f744b074389e4c2a1b42c6d95d5fdc83651eafca14d51a85882f6b8523c21c44", kill_on_drop: false }` [INFO] [stdout] f744b074389e4c2a1b42c6d95d5fdc83651eafca14d51a85882f6b8523c21c44 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 07444821e62deecdd83a76d6cb17601cd3cd113d0a32a749319343d34cec9dca [INFO] running `Command { std: "docker" "start" "-a" "07444821e62deecdd83a76d6cb17601cd3cd113d0a32a749319343d34cec9dca", 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 3.15s [INFO] running `Command { std: "docker" "inspect" "07444821e62deecdd83a76d6cb17601cd3cd113d0a32a749319343d34cec9dca", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "07444821e62deecdd83a76d6cb17601cd3cd113d0a32a749319343d34cec9dca", kill_on_drop: false }` [INFO] [stdout] 07444821e62deecdd83a76d6cb17601cd3cd113d0a32a749319343d34cec9dca [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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:eea15d5475069c3ef791f10c2c6b5af2ee421ef2da1e680ecce1cba46243983b" "/opt/rustwide/cargo-home/bin/cargo" "+17092ad00ed8fe1e7f81a7e38238ff70779034b1" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 23e92342df5b61607296ae74db44952d6216c612ba9daefa77a5f108f637517e [INFO] running `Command { std: "docker" "start" "-a" "23e92342df5b61607296ae74db44952d6216c612ba9daefa77a5f108f637517e", 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.24s [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-05-16T09:40:34.005960Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Creating pool with shared cache" [INFO] [stdout] 2025-05-16T09:40:34.014476Z 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=77.7µs elapsed_secs=7.77e-5 [INFO] [stdout] 2025-05-16T09:40:34.014592Z 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-05-16T09:40:34.017637Z 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=768.46µs elapsed_secs=0.00076846 [INFO] [stdout] 2025-05-16T09:40:34.017758Z 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-05-16T09:40:34.018313Z 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=260.81µs elapsed_secs=0.00026081 [INFO] [stdout] [src/main.rs:28:5] format!("vacuum into '{db_str}'") = "vacuum into '/tmp/.tmps9fHsZ'" [INFO] [stdout] 2025-05-16T09:40:34.018464Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Vacuuming into new db" path="/tmp/.tmps9fHsZ" [INFO] [stdout] 2025-05-16T09:40:34.019161Z DEBUG test_sqlx_with_pools:Running sqlx with pooled connection: sqlx::query: summary="vacuum into '/tmp/.tmps9fHsZ'" db.statement="" rows_affected=1 rows_returned=0 elapsed=440.08µs elapsed_secs=0.00044008 [INFO] [stdout] 2025-05-16T09:40:34.019251Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Dropping pool" [INFO] [stdout] 2025-05-16T09:40:34.019272Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Checking if new db exists" [INFO] [stdout] 2025-05-16T09:40:34.019298Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Opening new db connection to temp db path" [INFO] [stdout] 2025-05-16T09:40:34.021482Z 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=94.98µs elapsed_secs=9.498e-5 [INFO] [stdout] 2025-05-16T09:40:34.021585Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Checking if tables exist" [INFO] [stdout] 2025-05-16T09:40:34.022805Z 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=280.45µs elapsed_secs=0.00028045 [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-05-16T09:40:34.024551Z 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: 0x59c2ce4ee1f2 - std::backtrace_rs::backtrace::libunwind::trace::h2bdbdb423cc746ad [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x59c2ce4ee1f2 - std::backtrace_rs::backtrace::trace_unsynchronized::h876081fa48c0856a [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x59c2ce4ee1f2 - std::sys::backtrace::_print_fmt::h744638bebbff2806 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x59c2ce4ee1f2 - ::fmt::he6e74fa9d0076b5d [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x59c2ce515f43 - core::fmt::rt::Argument::fmt::hf88a3177e76af877 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/fmt/rt.rs:173:76 [INFO] [stdout] 5: 0x59c2ce515f43 - core::fmt::write::h6442196e41589522 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/fmt/mod.rs:1446:25 [INFO] [stdout] 6: 0x59c2ce4eabe3 - std::io::default_write_fmt::h19b804dc75596022 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x59c2ce4eabe3 - std::io::Write::write_fmt::h561df7c669043671 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/io/mod.rs:1914:13 [INFO] [stdout] 8: 0x59c2ce4ee042 - std::sys::backtrace::BacktraceLock::print::h25e1ce4c29150054 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 9: 0x59c2ce4ef82c - std::panicking::default_hook::{{closure}}::h36663bdaae83f2bb [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:300:22 [INFO] [stdout] 10: 0x59c2ce4ef682 - std::panicking::default_hook::hb9d7c40580cf1835 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:324:9 [INFO] [stdout] 11: 0x59c2cdf1a014 - as core::ops::function::Fn>::call::h53bdf3f1ac68020f [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 12: 0x59c2cdf1a014 - test::test_main_with_exit_callback::{{closure}}::h3ae9af1665ff5b7d [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x59c2ce4f0323 - as core::ops::function::Fn>::call::ha3a705c6ebc0f8fb [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 14: 0x59c2ce4f0323 - std::panicking::rust_panic_with_hook::h2d703857e4ba629f [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:841:13 [INFO] [stdout] 15: 0x59c2ce4effa6 - std::panicking::begin_panic_handler::{{closure}}::h53dd12a17ad784b1 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:699:13 [INFO] [stdout] 16: 0x59c2ce4ee6f9 - std::sys::backtrace::__rust_end_short_backtrace::hf54a874920d38937 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 17: 0x59c2ce4efc6d - __rustc[22d03d94d4da23d0]::rust_begin_unwind [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:697:5 [INFO] [stdout] 18: 0x59c2ce513cd0 - core::panicking::panic_fmt::hb74c170c8276d1d6 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/panicking.rs:75:14 [INFO] [stdout] 19: 0x59c2cde82a11 - vacuum_reproduction::sqlx_with_pooled_connection::{{closure}}::{{closure}}::hce4f81a044814d1d [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:134:5 [INFO] [stdout] 20: 0x59c2cdeab9ba - as core::future::future::Future>::poll::haf7af33e03474f7f [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-0.1.40/src/instrument.rs:321:9 [INFO] [stdout] 21: 0x59c2cde7b661 - vacuum_reproduction::sqlx_with_pooled_connection::{{closure}}::h4a271bca59c87346 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:89:1 [INFO] [stdout] 22: 0x59c2cde8e9b1 - vacuum_reproduction::test_sqlx_with_pools::{{closure}}::he3f426bbde819225 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:215:35 [INFO] [stdout] 23: 0x59c2cdea3c05 - as core::future::future::Future>::poll::hc23922a0f8b2c3e3 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/future/future.rs:124:9 [INFO] [stdout] 24: 0x59c2cdea3bbd - as core::future::future::Future>::poll::h337e639d77b8d430 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/future/future.rs:124:9 [INFO] [stdout] 25: 0x59c2cdeb4a3f - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h06dbb8db82f72017 [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] 26: 0x59c2cdeb4966 - tokio::runtime::coop::with_budget::h7b5b6c51dd97e39f [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] 27: 0x59c2cdeb4966 - tokio::runtime::coop::budget::h22295f327608b829 [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] 28: 0x59c2cdeb4966 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h12795b8ee5b73679 [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] 29: 0x59c2cdeb330a - tokio::runtime::scheduler::current_thread::Context::enter::h6ddb54d46004aac6 [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] 30: 0x59c2cdeb3f38 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::hdced4ab5075766ff [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] 31: 0x59c2cdeb3c3b - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::hc58b56918c4f27a5 [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] 32: 0x59c2cde902da - tokio::runtime::context::scoped::Scoped::set::heeb667eaea6362cc [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] 33: 0x59c2cdeaa2ba - tokio::runtime::context::set_scheduler::{{closure}}::ha6de0f6850e36da2 [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] 34: 0x59c2cdec8d16 - std::thread::local::LocalKey::try_with::h8de78fb7d1ec52f6 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/thread/local.rs:315:12 [INFO] [stdout] 35: 0x59c2cdec8acc - std::thread::local::LocalKey::with::hc28dfd20d37abf10 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/thread/local.rs:279:15 [INFO] [stdout] 36: 0x59c2cdeaa261 - tokio::runtime::context::set_scheduler::h3219fd88a0c16ac1 [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] 37: 0x59c2cdeb39a9 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::h7c5e883e1c8d1fc7 [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] 38: 0x59c2cdeb3c62 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h6fb0949ef301e5f2 [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] 39: 0x59c2cdeb2525 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::hbc5663e944120f60 [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] 40: 0x59c2cdec65c8 - tokio::runtime::context::runtime::enter_runtime::hd0cb4525673927c3 [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] 41: 0x59c2cdeb2421 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::hcbf111ddfb4dd542 [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] 42: 0x59c2cdecb59f - tokio::runtime::runtime::Runtime::block_on::hb540083cc8cd28a9 [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] 43: 0x59c2cde8df72 - vacuum_reproduction::test_sqlx_with_pools::h65824277d2ccac3e [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:217:5 [INFO] [stdout] 44: 0x59c2cde8de07 - vacuum_reproduction::test_sqlx_with_pools::{{closure}}::ha2eb120c3e5f4979 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:214:36 [INFO] [stdout] 45: 0x59c2cde9add6 - core::ops::function::FnOnce::call_once::hbbe29249301634a5 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x59c2cdf1f80b - core::ops::function::FnOnce::call_once::h0c81d2c7e362685a [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 47: 0x59c2cdf1f80b - test::__rust_begin_short_backtrace::hc62049913de4b9c6 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:648:18 [INFO] [stdout] 48: 0x59c2cdf1ea22 - test::run_test_in_process::{{closure}}::h906d61461feea06d [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:671:60 [INFO] [stdout] 49: 0x59c2cdf1ea22 - as core::ops::function::FnOnce<()>>::call_once::h962d8c24a3ec06f1 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 50: 0x59c2cdf1ea22 - std::panicking::try::do_call::h88e304055018b07f [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:589:40 [INFO] [stdout] 51: 0x59c2cdf1ea22 - std::panicking::try::h34046f0780b49f58 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:552:19 [INFO] [stdout] 52: 0x59c2cdf1ea22 - std::panic::catch_unwind::h7d7ad4d133a51a76 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panic.rs:359:14 [INFO] [stdout] 53: 0x59c2cdf1ea22 - test::run_test_in_process::h0871d7f888d1f41c [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:671:27 [INFO] [stdout] 54: 0x59c2cdf1ea22 - test::run_test::{{closure}}::h696f8114d8bae20e [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:592:43 [INFO] [stdout] 55: 0x59c2cdee1e14 - test::run_test::{{closure}}::h632082d0bd36bde1 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:622:41 [INFO] [stdout] 56: 0x59c2cdee1e14 - std::sys::backtrace::__rust_begin_short_backtrace::hf4db03c672d46ea2 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 57: 0x59c2cdee58ea - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h571ce7b4ea6fba0e [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 58: 0x59c2cdee58ea - as core::ops::function::FnOnce<()>>::call_once::h79478c2f2b0b4ed6 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 59: 0x59c2cdee58ea - std::panicking::try::do_call::hdfb524d8b1c5ea5d [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:589:40 [INFO] [stdout] 60: 0x59c2cdee58ea - std::panicking::try::hb57ee69084fa6c6a [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:552:19 [INFO] [stdout] 61: 0x59c2cdee58ea - std::panic::catch_unwind::h1fcc7dadd90dd47c [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panic.rs:359:14 [INFO] [stdout] 62: 0x59c2cdee58ea - std::thread::Builder::spawn_unchecked_::{{closure}}::h7201710e36d47c29 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 63: 0x59c2cdee58ea - core::ops::function::FnOnce::call_once{{vtable.shim}}::ha75b12b48ae5b3d2 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 64: 0x59c2ce4f20db - as core::ops::function::FnOnce>::call_once::h02517bb8c2b8e279 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 65: 0x59c2ce4f20db - as core::ops::function::FnOnce>::call_once::h760bb73d54d4c118 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 66: 0x59c2ce4f20db - std::sys::pal::unix::thread::Thread::new::thread_start::h91ff250566269b77 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/pal/unix/thread.rs:97:17 [INFO] [stdout] 67: 0x7afd2e869aa4 - [INFO] [stdout] 68: 0x7afd2e8f6a34 - clone [INFO] [stdout] 69: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- test_sqlx_with_shared_cache_connection stdout ---- [INFO] [stdout] 2025-05-16T09:40:34.005544Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Creating connection with shared cache" [INFO] [stdout] 2025-05-16T09:40:34.008385Z 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=109.56µs elapsed_secs=0.00010956 [INFO] [stdout] 2025-05-16T09:40:34.008511Z 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-05-16T09:40:34.011052Z 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=421.36µs elapsed_secs=0.00042136 [INFO] [stdout] 2025-05-16T09:40:34.014476Z 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-05-16T09:40:34.014874Z 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=282.36µs elapsed_secs=0.00028236 [INFO] [stdout] [src/main.rs:28:5] format!("vacuum into '{db_str}'") = "vacuum into '/tmp/.tmp2MsK59'" [INFO] [stdout] 2025-05-16T09:40:34.015000Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Vacuuming into new db" path="/tmp/.tmp2MsK59" [INFO] [stdout] 2025-05-16T09:40:34.029545Z DEBUG test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: sqlx::query: summary="vacuum into '/tmp/.tmp2MsK59'" db.statement="" rows_affected=1 rows_returned=0 elapsed=14.43691ms elapsed_secs=0.01443691 [INFO] [stdout] 2025-05-16T09:40:34.029646Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Dropping connection" [INFO] [stdout] 2025-05-16T09:40:34.029676Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Checking if new db exists" [INFO] [stdout] 2025-05-16T09:40:34.035816Z 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=52.19µs elapsed_secs=5.219e-5 [INFO] [stdout] 2025-05-16T09:40:34.035971Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Checking if tables exist" [INFO] [stdout] 2025-05-16T09:40:34.037133Z 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=301.63µs elapsed_secs=0.00030163 [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-05-16T09:40:34.037244Z 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: 0x59c2ce4ee1f2 - std::backtrace_rs::backtrace::libunwind::trace::h2bdbdb423cc746ad [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x59c2ce4ee1f2 - std::backtrace_rs::backtrace::trace_unsynchronized::h876081fa48c0856a [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x59c2ce4ee1f2 - std::sys::backtrace::_print_fmt::h744638bebbff2806 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x59c2ce4ee1f2 - ::fmt::he6e74fa9d0076b5d [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x59c2ce515f43 - core::fmt::rt::Argument::fmt::hf88a3177e76af877 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/fmt/rt.rs:173:76 [INFO] [stdout] 5: 0x59c2ce515f43 - core::fmt::write::h6442196e41589522 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/fmt/mod.rs:1446:25 [INFO] [stdout] 6: 0x59c2ce4eabe3 - std::io::default_write_fmt::h19b804dc75596022 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x59c2ce4eabe3 - std::io::Write::write_fmt::h561df7c669043671 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/io/mod.rs:1914:13 [INFO] [stdout] 8: 0x59c2ce4ee042 - std::sys::backtrace::BacktraceLock::print::h25e1ce4c29150054 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 9: 0x59c2ce4ef82c - std::panicking::default_hook::{{closure}}::h36663bdaae83f2bb [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:300:22 [INFO] [stdout] 10: 0x59c2ce4ef682 - std::panicking::default_hook::hb9d7c40580cf1835 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:324:9 [INFO] [stdout] 11: 0x59c2cdf1a014 - as core::ops::function::Fn>::call::h53bdf3f1ac68020f [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 12: 0x59c2cdf1a014 - test::test_main_with_exit_callback::{{closure}}::h3ae9af1665ff5b7d [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x59c2ce4f0323 - as core::ops::function::Fn>::call::ha3a705c6ebc0f8fb [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/alloc/src/boxed.rs:1980:9 [INFO] [stdout] 14: 0x59c2ce4f0323 - std::panicking::rust_panic_with_hook::h2d703857e4ba629f [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:841:13 [INFO] [stdout] 15: 0x59c2ce4effa6 - std::panicking::begin_panic_handler::{{closure}}::h53dd12a17ad784b1 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:699:13 [INFO] [stdout] 16: 0x59c2ce4ee6f9 - std::sys::backtrace::__rust_end_short_backtrace::hf54a874920d38937 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 17: 0x59c2ce4efc6d - __rustc[22d03d94d4da23d0]::rust_begin_unwind [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:697:5 [INFO] [stdout] 18: 0x59c2ce513cd0 - core::panicking::panic_fmt::hb74c170c8276d1d6 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/panicking.rs:75:14 [INFO] [stdout] 19: 0x59c2cde78066 - vacuum_reproduction::sqlx_with_shared_cache_connection::{{closure}}::{{closure}}::hc6959e8afd385898 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:74:5 [INFO] [stdout] 20: 0x59c2cdeabc4a - as core::future::future::Future>::poll::hf6f6f6a1a20b4f10 [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/index.crates.io-1949cf8c6b5b557f/tracing-0.1.40/src/instrument.rs:321:9 [INFO] [stdout] 21: 0x59c2cde71531 - vacuum_reproduction::sqlx_with_shared_cache_connection::{{closure}}::hf55e8e08af95aeeb [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:31:1 [INFO] [stdout] 22: 0x59c2cde8f821 - vacuum_reproduction::test_sqlx_with_shared_cache_connection::{{closure}}::h51f1ee1a5ee2a660 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:223:41 [INFO] [stdout] 23: 0x59c2cdea3c05 - as core::future::future::Future>::poll::hc23922a0f8b2c3e3 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/future/future.rs:124:9 [INFO] [stdout] 24: 0x59c2cdea3bbd - as core::future::future::Future>::poll::h337e639d77b8d430 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/future/future.rs:124:9 [INFO] [stdout] 25: 0x59c2cdeb4a3f - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h06dbb8db82f72017 [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] 26: 0x59c2cdeb4966 - tokio::runtime::coop::with_budget::h7b5b6c51dd97e39f [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] 27: 0x59c2cdeb4966 - tokio::runtime::coop::budget::h22295f327608b829 [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] 28: 0x59c2cdeb4966 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h12795b8ee5b73679 [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] 29: 0x59c2cdeb330a - tokio::runtime::scheduler::current_thread::Context::enter::h6ddb54d46004aac6 [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] 30: 0x59c2cdeb3f38 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::hdced4ab5075766ff [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] 31: 0x59c2cdeb3c3b - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::hc58b56918c4f27a5 [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] 32: 0x59c2cde902da - tokio::runtime::context::scoped::Scoped::set::heeb667eaea6362cc [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] 33: 0x59c2cdeaa2ba - tokio::runtime::context::set_scheduler::{{closure}}::ha6de0f6850e36da2 [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] 34: 0x59c2cdec8d16 - std::thread::local::LocalKey::try_with::h8de78fb7d1ec52f6 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/thread/local.rs:315:12 [INFO] [stdout] 35: 0x59c2cdec8acc - std::thread::local::LocalKey::with::hc28dfd20d37abf10 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/thread/local.rs:279:15 [INFO] [stdout] 36: 0x59c2cdeaa261 - tokio::runtime::context::set_scheduler::h3219fd88a0c16ac1 [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] 37: 0x59c2cdeb39a9 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::h7c5e883e1c8d1fc7 [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] 38: 0x59c2cdeb3c62 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h6fb0949ef301e5f2 [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] 39: 0x59c2cdeb2525 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::hbc5663e944120f60 [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] 40: 0x59c2cdec65c8 - tokio::runtime::context::runtime::enter_runtime::hd0cb4525673927c3 [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] 41: 0x59c2cdeb2421 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::hcbf111ddfb4dd542 [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] 42: 0x59c2cdecb59f - tokio::runtime::runtime::Runtime::block_on::hb540083cc8cd28a9 [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] 43: 0x59c2cde8ede2 - vacuum_reproduction::test_sqlx_with_shared_cache_connection::h47656c0256606e20 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:225:5 [INFO] [stdout] 44: 0x59c2cde8ec77 - vacuum_reproduction::test_sqlx_with_shared_cache_connection::{{closure}}::hf91805858bf3ea24 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:222:54 [INFO] [stdout] 45: 0x59c2cde9ab96 - core::ops::function::FnOnce::call_once::h84a8dc1d2439463e [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x59c2cdf1f80b - core::ops::function::FnOnce::call_once::h0c81d2c7e362685a [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 47: 0x59c2cdf1f80b - test::__rust_begin_short_backtrace::hc62049913de4b9c6 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:648:18 [INFO] [stdout] 48: 0x59c2cdf1ea22 - test::run_test_in_process::{{closure}}::h906d61461feea06d [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:671:60 [INFO] [stdout] 49: 0x59c2cdf1ea22 - as core::ops::function::FnOnce<()>>::call_once::h962d8c24a3ec06f1 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 50: 0x59c2cdf1ea22 - std::panicking::try::do_call::h88e304055018b07f [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:589:40 [INFO] [stdout] 51: 0x59c2cdf1ea22 - std::panicking::try::h34046f0780b49f58 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:552:19 [INFO] [stdout] 52: 0x59c2cdf1ea22 - std::panic::catch_unwind::h7d7ad4d133a51a76 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panic.rs:359:14 [INFO] [stdout] 53: 0x59c2cdf1ea22 - test::run_test_in_process::h0871d7f888d1f41c [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:671:27 [INFO] [stdout] 54: 0x59c2cdf1ea22 - test::run_test::{{closure}}::h696f8114d8bae20e [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:592:43 [INFO] [stdout] 55: 0x59c2cdee1e14 - test::run_test::{{closure}}::h632082d0bd36bde1 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/test/src/lib.rs:622:41 [INFO] [stdout] 56: 0x59c2cdee1e14 - std::sys::backtrace::__rust_begin_short_backtrace::hf4db03c672d46ea2 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 57: 0x59c2cdee58ea - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h571ce7b4ea6fba0e [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/thread/mod.rs:559:17 [INFO] [stdout] 58: 0x59c2cdee58ea - as core::ops::function::FnOnce<()>>::call_once::h79478c2f2b0b4ed6 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 59: 0x59c2cdee58ea - std::panicking::try::do_call::hdfb524d8b1c5ea5d [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:589:40 [INFO] [stdout] 60: 0x59c2cdee58ea - std::panicking::try::hb57ee69084fa6c6a [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panicking.rs:552:19 [INFO] [stdout] 61: 0x59c2cdee58ea - std::panic::catch_unwind::h1fcc7dadd90dd47c [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/panic.rs:359:14 [INFO] [stdout] 62: 0x59c2cdee58ea - std::thread::Builder::spawn_unchecked_::{{closure}}::h7201710e36d47c29 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/thread/mod.rs:557:30 [INFO] [stdout] 63: 0x59c2cdee58ea - core::ops::function::FnOnce::call_once{{vtable.shim}}::ha75b12b48ae5b3d2 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 64: 0x59c2ce4f20db - as core::ops::function::FnOnce>::call_once::h02517bb8c2b8e279 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 65: 0x59c2ce4f20db - as core::ops::function::FnOnce>::call_once::h760bb73d54d4c118 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/alloc/src/boxed.rs:1966:9 [INFO] [stdout] 66: 0x59c2ce4f20db - std::sys::pal::unix::thread::Thread::new::thread_start::h91ff250566269b77 [INFO] [stdout] at /rustc/17092ad00ed8fe1e7f81a7e38238ff70779034b1/library/std/src/sys/pal/unix/thread.rs:97:17 [INFO] [stdout] 67: 0x7afd2e869aa4 - [INFO] [stdout] 68: 0x7afd2e8f6a34 - clone [INFO] [stdout] 69: 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.15s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--bin vacuum-reproduction` [INFO] running `Command { std: "docker" "inspect" "23e92342df5b61607296ae74db44952d6216c612ba9daefa77a5f108f637517e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "23e92342df5b61607296ae74db44952d6216c612ba9daefa77a5f108f637517e", kill_on_drop: false }` [INFO] [stdout] 23e92342df5b61607296ae74db44952d6216c612ba9daefa77a5f108f637517e