[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 beta-2025-01-12 for beta-1.85-1 [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 beta-2025-01-12 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2025-01-12" "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" "+beta-2025-01-12" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-01-12" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 11f68f987e6c984fa59c1bfbdc2152a8d885ccd00825d8a676ecb88d2499f6bf [INFO] running `Command { std: "docker" "start" "-a" "11f68f987e6c984fa59c1bfbdc2152a8d885ccd00825d8a676ecb88d2499f6bf", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "11f68f987e6c984fa59c1bfbdc2152a8d885ccd00825d8a676ecb88d2499f6bf", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "11f68f987e6c984fa59c1bfbdc2152a8d885ccd00825d8a676ecb88d2499f6bf", kill_on_drop: false }` [INFO] [stdout] 11f68f987e6c984fa59c1bfbdc2152a8d885ccd00825d8a676ecb88d2499f6bf [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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-01-12" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f522bc040d70bac502969f70375981604641b64724077433e0aae2f77e5d13ff [INFO] running `Command { std: "docker" "start" "-a" "f522bc040d70bac502969f70375981604641b64724077433e0aae2f77e5d13ff", 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 cc v1.0.98 [INFO] [stderr] Compiling once_cell v1.19.0 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling pin-project-lite v0.2.14 [INFO] [stderr] Compiling typenum v1.17.0 [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 zerocopy v0.7.34 [INFO] [stderr] Compiling vcpkg v0.2.15 [INFO] [stderr] Compiling pkg-config v0.3.30 [INFO] [stderr] Compiling untrusted v0.9.0 [INFO] [stderr] Compiling futures-sink v0.3.30 [INFO] [stderr] Compiling serde_json v1.0.117 [INFO] [stderr] Compiling bytes v1.6.0 [INFO] [stderr] Compiling allocator-api2 v0.2.18 [INFO] [stderr] Compiling memchr v2.7.2 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling ahash v0.8.11 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling iana-time-zone v0.1.60 [INFO] [stderr] Compiling tinyvec v1.6.0 [INFO] [stderr] Compiling lock_api v0.4.12 [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 crossbeam-utils v0.8.20 [INFO] [stderr] Compiling ryu v1.0.18 [INFO] [stderr] Compiling cpufeatures v0.2.12 [INFO] [stderr] Compiling percent-encoding v2.3.1 [INFO] [stderr] Compiling unicode-bidi v0.3.15 [INFO] [stderr] Compiling thiserror v1.0.61 [INFO] [stderr] Compiling futures-task v0.3.30 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling paste v1.0.15 [INFO] [stderr] Compiling spin v0.9.8 [INFO] [stderr] Compiling futures-io v0.3.30 [INFO] [stderr] Compiling rustls v0.21.12 [INFO] [stderr] Compiling minimal-lexical v0.2.1 [INFO] [stderr] Compiling form_urlencoded v1.2.1 [INFO] [stderr] Compiling tracing-core v0.1.32 [INFO] [stderr] Compiling crc-catalog v2.4.0 [INFO] [stderr] Compiling equivalent v1.0.1 [INFO] [stderr] Compiling unicode_categories v0.1.1 [INFO] [stderr] Compiling base64 v0.21.7 [INFO] [stderr] Compiling crc v3.2.1 [INFO] [stderr] Compiling quote v1.0.36 [INFO] [stderr] Compiling futures-util v0.3.30 [INFO] [stderr] Compiling nom v7.1.3 [INFO] [stderr] Compiling unicode-normalization v0.1.23 [INFO] [stderr] Compiling getrandom v0.2.15 [INFO] [stderr] Compiling mio v0.8.11 [INFO] [stderr] Compiling syn v2.0.66 [INFO] [stderr] Compiling socket2 v0.5.7 [INFO] [stderr] Compiling parking_lot v0.12.3 [INFO] [stderr] Compiling ring v0.17.8 [INFO] [stderr] Compiling rustls-pemfile v1.0.4 [INFO] [stderr] Compiling futures-channel v0.3.30 [INFO] [stderr] Compiling chrono v0.4.38 [INFO] [stderr] Compiling futures-intrusive v0.5.0 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling atoi v2.0.0 [INFO] [stderr] Compiling crossbeam-queue v0.3.11 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling idna v0.5.0 [INFO] [stderr] Compiling hex v0.4.3 [INFO] [stderr] Compiling webpki-roots v0.25.4 [INFO] [stderr] Compiling event-listener v2.5.3 [INFO] [stderr] Compiling log v0.4.21 [INFO] [stderr] Compiling uuid v1.8.0 [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 bitflags v2.5.0 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling rustix v0.38.34 [INFO] [stderr] Compiling num_cpus v1.16.0 [INFO] [stderr] Compiling url v2.5.0 [INFO] [stderr] Compiling sha2 v0.10.8 [INFO] [stderr] Compiling signal-hook-registry v1.4.2 [INFO] [stderr] Compiling flume v0.11.0 [INFO] [stderr] Compiling hashlink v0.8.4 [INFO] [stderr] Compiling indexmap v2.2.6 [INFO] [stderr] Compiling urlencoding v2.1.3 [INFO] [stderr] Compiling syn v1.0.109 [INFO] [stderr] Compiling linux-raw-sys v0.4.14 [INFO] [stderr] Compiling regex-syntax v0.8.3 [INFO] [stderr] Compiling fastrand v2.1.0 [INFO] [stderr] Compiling unicode-segmentation v1.11.0 [INFO] [stderr] Compiling regex-syntax v0.6.29 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling overload v0.1.1 [INFO] [stderr] Compiling dotenvy v0.15.7 [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 thread_local v1.1.8 [INFO] [stderr] Compiling heck v0.4.1 [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 futures-executor v0.3.30 [INFO] [stderr] Compiling regex-automata v0.4.6 [INFO] [stderr] Compiling tempfile v3.10.1 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling rustls-webpki v0.101.7 [INFO] [stderr] Compiling sct v0.7.1 [INFO] [stderr] Compiling matchers v0.1.0 [INFO] [stderr] Compiling tokio-stream v0.1.15 [INFO] [stderr] Compiling regex v1.10.4 [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-test-macro v0.2.5 [INFO] [stderr] Compiling tracing v0.1.40 [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 34s [INFO] running `Command { std: "docker" "inspect" "f522bc040d70bac502969f70375981604641b64724077433e0aae2f77e5d13ff", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f522bc040d70bac502969f70375981604641b64724077433e0aae2f77e5d13ff", kill_on_drop: false }` [INFO] [stdout] f522bc040d70bac502969f70375981604641b64724077433e0aae2f77e5d13ff [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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-01-12" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] e627b11321e11e29f17106ff704459237b904ee53c5bcdc5f84af347181911b2 [INFO] running `Command { std: "docker" "start" "-a" "e627b11321e11e29f17106ff704459237b904ee53c5bcdc5f84af347181911b2", 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 5.46s [INFO] running `Command { std: "docker" "inspect" "e627b11321e11e29f17106ff704459237b904ee53c5bcdc5f84af347181911b2", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "e627b11321e11e29f17106ff704459237b904ee53c5bcdc5f84af347181911b2", kill_on_drop: false }` [INFO] [stdout] e627b11321e11e29f17106ff704459237b904ee53c5bcdc5f84af347181911b2 [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=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-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:86ea7c7af713d31e8cfdb68a6d0db50b5cf7cbeecde3d112f9f257f747318d36" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2025-01-12" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 15f7a38c8b00364f7d1b2f96224480be943902320506e47f69e442b449f73279 [INFO] running `Command { std: "docker" "start" "-a" "15f7a38c8b00364f7d1b2f96224480be943902320506e47f69e442b449f73279", 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-35eecb0b85ed4805) [INFO] [stdout] [INFO] [stdout] running 3 tests [INFO] [stdout] test test_rusqlite ... ok [INFO] [stdout] test test_sqlx_with_shared_cache_connection ... FAILED [INFO] [stdout] test test_sqlx_with_pools ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- test_sqlx_with_shared_cache_connection stdout ---- [INFO] [stdout] 2025-01-15T14:23:05.864536Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Creating connection with shared cache" [INFO] [stdout] 2025-01-15T14:23:05.868128Z 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=59.8µs elapsed_secs=5.98e-5 [INFO] [stdout] 2025-01-15T14:23:05.868398Z 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-01-15T14:23:05.871901Z 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=1.0076ms elapsed_secs=0.0010076 [INFO] [stdout] 2025-01-15T14:23:05.872034Z 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-01-15T14:23:05.874604Z 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=217.93µs elapsed_secs=0.00021793 [INFO] [stdout] [src/main.rs:28:5] format!("vacuum into '{db_str}'") = "vacuum into '/tmp/.tmpYvTAvA'" [INFO] [stdout] 2025-01-15T14:23:05.874721Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Vacuuming into new db" path="/tmp/.tmpYvTAvA" [INFO] [stdout] 2025-01-15T14:23:05.875330Z DEBUG test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: sqlx::query: summary="vacuum into '/tmp/.tmpYvTAvA'" db.statement="" rows_affected=1 rows_returned=0 elapsed=524.68µs elapsed_secs=0.00052468 [INFO] [stdout] 2025-01-15T14:23:05.875404Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Dropping connection" [INFO] [stdout] 2025-01-15T14:23:05.875425Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Checking if new db exists" [INFO] [stdout] 2025-01-15T14:23:05.883541Z 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=85.02µs elapsed_secs=8.502e-5 [INFO] [stdout] 2025-01-15T14:23:05.888996Z INFO test_sqlx_with_shared_cache_connection:Running sqlx with shared cache connection: vacuum_reproduction: name="Checking if tables exist" [INFO] [stdout] 2025-01-15T14:23:05.894071Z 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=288.23µs elapsed_secs=0.00028823 [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-01-15T14:23:05.897515Z 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: 0x55acbd4701ea - std::backtrace_rs::backtrace::libunwind::trace::ha13ab8a94fd3bb92 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x55acbd4701ea - std::backtrace_rs::backtrace::trace_unsynchronized::h2a4c556e569d314b [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55acbd4701ea - std::sys::backtrace::_print_fmt::hf52186dec7bdf1bb [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x55acbd4701ea - ::fmt::hb5c3379828c15690 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x55acbd499563 - core::fmt::rt::Argument::fmt::h8220db795cd6f76c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/fmt/rt.rs:177:76 [INFO] [stdout] 5: 0x55acbd499563 - core::fmt::write::hd20c41beeec2e8c0 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/fmt/mod.rs:1440:21 [INFO] [stdout] 6: 0x55acbd46cd73 - std::io::Write::write_fmt::hf276ec928345bea3 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/io/mod.rs:1887:15 [INFO] [stdout] 7: 0x55acbd470032 - std::sys::backtrace::BacktraceLock::print::h4fa77b65bb5ed2ec [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x55acbd471720 - std::panicking::default_hook::{{closure}}::hd3560f93167cf51e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x55acbd4714bd - std::panicking::default_hook::h361b8e3c5cbb2501 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:319:9 [INFO] [stdout] 10: 0x55acbce9f8f3 - as core::ops::function::Fn>::call::h52b4c42c9dce8b0e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 11: 0x55acbce9f8f3 - test::test_main::{{closure}}::h1a9dc25180417899 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:134:21 [INFO] [stdout] 12: 0x55acbd471f53 - as core::ops::function::Fn>::call::h080867abcafb687f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 13: 0x55acbd471f53 - std::panicking::rust_panic_with_hook::h7e187ba6ef3a8505 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:836:13 [INFO] [stdout] 14: 0x55acbd471bf6 - std::panicking::begin_panic_handler::{{closure}}::h2160aaedd30b4698 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:694:13 [INFO] [stdout] 15: 0x55acbd4706e9 - std::sys::backtrace::__rust_end_short_backtrace::h2544fe16c7a2009f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x55acbd4718bd - rust_begin_unwind [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:692:5 [INFO] [stdout] 17: 0x55acbcdf40d0 - core::panicking::panic_fmt::h55d7693adb8e1cee [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panicking.rs:75:14 [INFO] [stdout] 18: 0x55acbcdfde3a - vacuum_reproduction::sqlx_with_shared_cache_connection::{{closure}}::{{closure}}::h1f92642455f518e8 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:74:5 [INFO] [stdout] 19: 0x55acbce4a6e6 - as core::future::future::Future>::poll::hdadcb44cf0ff37e7 [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: 0x55acbcdf7046 - vacuum_reproduction::sqlx_with_shared_cache_connection::{{closure}}::h30db168af1fcd018 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:31:1 [INFO] [stdout] 21: 0x55acbce15cb2 - vacuum_reproduction::test_sqlx_with_shared_cache_connection::{{closure}}::h26b462137fb484fa [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:223:41 [INFO] [stdout] 22: 0x55acbce3bf45 - as core::future::future::Future>::poll::h477c75b92c5d0483 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/future/future.rs:124:9 [INFO] [stdout] 23: 0x55acbce3bf7d - as core::future::future::Future>::poll::he0a8b7111d339130 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/future/future.rs:124:9 [INFO] [stdout] 24: 0x55acbce1a14f - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h8a61fbcd24144fd8 [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: 0x55acbce1a076 - tokio::runtime::coop::with_budget::ha4f969844528b4df [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: 0x55acbce1a076 - tokio::runtime::coop::budget::hc72f46dd551fefbc [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: 0x55acbce1a076 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h9eff3e233e900f11 [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: 0x55acbce18a0a - tokio::runtime::scheduler::current_thread::Context::enter::h18e5fe71af88a982 [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: 0x55acbce1985e - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h7f8a781f62c2214e [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: 0x55acbce195ab - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::h1308ff33ae95eb86 [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: 0x55acbce4173a - tokio::runtime::context::scoped::Scoped::set::h156f9be00609162a [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: 0x55acbce3b4da - tokio::runtime::context::set_scheduler::{{closure}}::h23d80bd2c07d95f1 [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: 0x55acbce4df56 - std::thread::local::LocalKey::try_with::ha955fc9f033e1d69 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/local.rs:308:12 [INFO] [stdout] 34: 0x55acbce4d8ed - std::thread::local::LocalKey::with::h2289ae2464168968 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/local.rs:272:9 [INFO] [stdout] 35: 0x55acbce3b481 - tokio::runtime::context::set_scheduler::h94bbe80910b37ce2 [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: 0x55acbce19319 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::h5d504f6d5c9a0197 [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: 0x55acbce195d3 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h2db06a205e9d03e2 [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: 0x55acbce17f23 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::h1fe85a60552f77af [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: 0x55acbce475a6 - tokio::runtime::context::runtime::enter_runtime::he73e0c8001f82987 [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: 0x55acbce17e21 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::h36a79d10305ef980 [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: 0x55acbce2ea49 - tokio::runtime::runtime::Runtime::block_on::h8404498d8cbf1ec6 [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: 0x55acbce15232 - vacuum_reproduction::test_sqlx_with_shared_cache_connection::hf7222bd6d47c5a18 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:225:5 [INFO] [stdout] 43: 0x55acbce150c7 - vacuum_reproduction::test_sqlx_with_shared_cache_connection::{{closure}}::ha9929beb8d81b90f [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:222:54 [INFO] [stdout] 44: 0x55acbce23426 - core::ops::function::FnOnce::call_once::he752830bbb4924e6 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 45: 0x55acbcea514b - core::ops::function::FnOnce::call_once::h42df3dc9a56fb705 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x55acbcea514b - test::__rust_begin_short_backtrace::hf2ff4d4d12dd75b0 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:632:18 [INFO] [stdout] 47: 0x55acbcea3fd3 - test::run_test_in_process::{{closure}}::h8461a23c6c0ac10c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:655:60 [INFO] [stdout] 48: 0x55acbcea3fd3 - as core::ops::function::FnOnce<()>>::call_once::hefab1bfcb42baf2e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 49: 0x55acbcea3fd3 - std::panicking::try::do_call::h75c82cb1133d19f1 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:584:40 [INFO] [stdout] 50: 0x55acbcea3fd3 - std::panicking::try::h41d68fc63841231a [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:547:19 [INFO] [stdout] 51: 0x55acbcea3fd3 - std::panic::catch_unwind::h7a7ff6adf9e0c698 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panic.rs:358:14 [INFO] [stdout] 52: 0x55acbcea3fd3 - test::run_test_in_process::hcd527530689ec177 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:655:27 [INFO] [stdout] 53: 0x55acbcea3fd3 - test::run_test::{{closure}}::h51ba581aac56ca21 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:576:43 [INFO] [stdout] 54: 0x55acbce67cd5 - test::run_test::{{closure}}::h9d0d2581742c4e6c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:606:41 [INFO] [stdout] 55: 0x55acbce67cd5 - std::sys::backtrace::__rust_begin_short_backtrace::h94b953e0285eca69 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 56: 0x55acbce6b766 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hac891bfe52f0501a [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/mod.rs:564:17 [INFO] [stdout] 57: 0x55acbce6b766 - as core::ops::function::FnOnce<()>>::call_once::hd4f76b3ef0615394 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 58: 0x55acbce6b766 - std::panicking::try::do_call::h31b1a419f4fa670c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:584:40 [INFO] [stdout] 59: 0x55acbce6b766 - std::panicking::try::h277e348adef7f0af [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:547:19 [INFO] [stdout] 60: 0x55acbce6b766 - std::panic::catch_unwind::h06db5059e51a109d [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panic.rs:358:14 [INFO] [stdout] 61: 0x55acbce6b766 - std::thread::Builder::spawn_unchecked_::{{closure}}::h048aed1b5c822396 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/mod.rs:562:30 [INFO] [stdout] 62: 0x55acbce6b766 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9f03098da71d0b51 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 63: 0x55acbd4761bb - as core::ops::function::FnOnce>::call_once::hcc221cc1d8cbbdc7 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 64: 0x55acbd4761bb - as core::ops::function::FnOnce>::call_once::he5e5264a0dcd6e5f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 65: 0x55acbd4761bb - std::sys::pal::unix::thread::Thread::new::thread_start::h307a072356a0dfca [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/pal/unix/thread.rs:106:17 [INFO] [stdout] 66: 0x7cfbb8d7aac3 - [INFO] [stdout] 67: 0x7cfbb8e0ba04 - clone [INFO] [stdout] 68: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- test_sqlx_with_pools stdout ---- [INFO] [stdout] 2025-01-15T14:23:05.865140Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Creating pool with shared cache" [INFO] [stdout] 2025-01-15T14:23:05.867478Z 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=67.33µs elapsed_secs=6.733e-5 [INFO] [stdout] 2025-01-15T14:23:05.867623Z 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-01-15T14:23:05.871597Z 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=474.9µs elapsed_secs=0.0004749 [INFO] [stdout] 2025-01-15T14:23:05.871873Z 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-01-15T14:23:05.872663Z 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=309.48µs elapsed_secs=0.00030948 [INFO] [stdout] [src/main.rs:28:5] format!("vacuum into '{db_str}'") = "vacuum into '/tmp/.tmpwrlX7N'" [INFO] [stdout] 2025-01-15T14:23:05.872820Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Vacuuming into new db" path="/tmp/.tmpwrlX7N" [INFO] [stdout] 2025-01-15T14:23:05.873523Z DEBUG test_sqlx_with_pools:Running sqlx with pooled connection: sqlx::query: summary="vacuum into '/tmp/.tmpwrlX7N'" db.statement="" rows_affected=1 rows_returned=0 elapsed=393.029µs elapsed_secs=0.000393029 [INFO] [stdout] 2025-01-15T14:23:05.873731Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Dropping pool" [INFO] [stdout] 2025-01-15T14:23:05.873754Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Checking if new db exists" [INFO] [stdout] 2025-01-15T14:23:05.873779Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Opening new db connection to temp db path" [INFO] [stdout] 2025-01-15T14:23:05.875450Z 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=105.99µs elapsed_secs=0.00010599 [INFO] [stdout] 2025-01-15T14:23:05.878918Z INFO test_sqlx_with_pools:Running sqlx with pooled connection: vacuum_reproduction: name="Checking if tables exist" [INFO] [stdout] 2025-01-15T14:23:05.880367Z 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=253.17µs elapsed_secs=0.00025317 [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-01-15T14:23:05.880505Z 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: 0x55acbd4701ea - std::backtrace_rs::backtrace::libunwind::trace::ha13ab8a94fd3bb92 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5 [INFO] [stdout] 1: 0x55acbd4701ea - std::backtrace_rs::backtrace::trace_unsynchronized::h2a4c556e569d314b [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5 [INFO] [stdout] 2: 0x55acbd4701ea - std::sys::backtrace::_print_fmt::hf52186dec7bdf1bb [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:66:9 [INFO] [stdout] 3: 0x55acbd4701ea - ::fmt::hb5c3379828c15690 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:39:26 [INFO] [stdout] 4: 0x55acbd499563 - core::fmt::rt::Argument::fmt::h8220db795cd6f76c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/fmt/rt.rs:177:76 [INFO] [stdout] 5: 0x55acbd499563 - core::fmt::write::hd20c41beeec2e8c0 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/fmt/mod.rs:1440:21 [INFO] [stdout] 6: 0x55acbd46cd73 - std::io::Write::write_fmt::hf276ec928345bea3 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/io/mod.rs:1887:15 [INFO] [stdout] 7: 0x55acbd470032 - std::sys::backtrace::BacktraceLock::print::h4fa77b65bb5ed2ec [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:42:9 [INFO] [stdout] 8: 0x55acbd471720 - std::panicking::default_hook::{{closure}}::hd3560f93167cf51e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:295:22 [INFO] [stdout] 9: 0x55acbd4714bd - std::panicking::default_hook::h361b8e3c5cbb2501 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:319:9 [INFO] [stdout] 10: 0x55acbce9f8f3 - as core::ops::function::Fn>::call::h52b4c42c9dce8b0e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 11: 0x55acbce9f8f3 - test::test_main::{{closure}}::h1a9dc25180417899 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:134:21 [INFO] [stdout] 12: 0x55acbd471f53 - as core::ops::function::Fn>::call::h080867abcafb687f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:2007:9 [INFO] [stdout] 13: 0x55acbd471f53 - std::panicking::rust_panic_with_hook::h7e187ba6ef3a8505 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:836:13 [INFO] [stdout] 14: 0x55acbd471bf6 - std::panicking::begin_panic_handler::{{closure}}::h2160aaedd30b4698 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:694:13 [INFO] [stdout] 15: 0x55acbd4706e9 - std::sys::backtrace::__rust_end_short_backtrace::h2544fe16c7a2009f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:168:18 [INFO] [stdout] 16: 0x55acbd4718bd - rust_begin_unwind [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:692:5 [INFO] [stdout] 17: 0x55acbcdf40d0 - core::panicking::panic_fmt::h55d7693adb8e1cee [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panicking.rs:75:14 [INFO] [stdout] 18: 0x55acbce08b8e - vacuum_reproduction::sqlx_with_pooled_connection::{{closure}}::{{closure}}::h9b684843ac81fc44 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:134:5 [INFO] [stdout] 19: 0x55acbce4a1c6 - as core::future::future::Future>::poll::hbcaa55f9a5824f5d [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: 0x55acbce014d6 - vacuum_reproduction::sqlx_with_pooled_connection::{{closure}}::hbdb45518d62b5590 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:89:1 [INFO] [stdout] 21: 0x55acbce14df2 - vacuum_reproduction::test_sqlx_with_pools::{{closure}}::hc4c3ffbd64612387 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:215:35 [INFO] [stdout] 22: 0x55acbce3bf45 - as core::future::future::Future>::poll::h477c75b92c5d0483 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/future/future.rs:124:9 [INFO] [stdout] 23: 0x55acbce3bf7d - as core::future::future::Future>::poll::he0a8b7111d339130 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/future/future.rs:124:9 [INFO] [stdout] 24: 0x55acbce1a14f - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::{{closure}}::h8a61fbcd24144fd8 [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: 0x55acbce1a076 - tokio::runtime::coop::with_budget::ha4f969844528b4df [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: 0x55acbce1a076 - tokio::runtime::coop::budget::hc72f46dd551fefbc [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: 0x55acbce1a076 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::{{closure}}::h9eff3e233e900f11 [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: 0x55acbce18a0a - tokio::runtime::scheduler::current_thread::Context::enter::h18e5fe71af88a982 [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: 0x55acbce1985e - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::{{closure}}::h7f8a781f62c2214e [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: 0x55acbce195ab - tokio::runtime::scheduler::current_thread::CoreGuard::enter::{{closure}}::h1308ff33ae95eb86 [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: 0x55acbce4173a - tokio::runtime::context::scoped::Scoped::set::h156f9be00609162a [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: 0x55acbce3b4da - tokio::runtime::context::set_scheduler::{{closure}}::h23d80bd2c07d95f1 [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: 0x55acbce4df56 - std::thread::local::LocalKey::try_with::ha955fc9f033e1d69 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/local.rs:308:12 [INFO] [stdout] 34: 0x55acbce4d8ed - std::thread::local::LocalKey::with::h2289ae2464168968 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/local.rs:272:9 [INFO] [stdout] 35: 0x55acbce3b481 - tokio::runtime::context::set_scheduler::h94bbe80910b37ce2 [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: 0x55acbce19319 - tokio::runtime::scheduler::current_thread::CoreGuard::enter::h5d504f6d5c9a0197 [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: 0x55acbce195d3 - tokio::runtime::scheduler::current_thread::CoreGuard::block_on::h2db06a205e9d03e2 [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: 0x55acbce17f23 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::{{closure}}::h1fe85a60552f77af [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: 0x55acbce475a6 - tokio::runtime::context::runtime::enter_runtime::he73e0c8001f82987 [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: 0x55acbce17e21 - tokio::runtime::scheduler::current_thread::CurrentThread::block_on::h36a79d10305ef980 [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: 0x55acbce2ea49 - tokio::runtime::runtime::Runtime::block_on::h8404498d8cbf1ec6 [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: 0x55acbce14372 - vacuum_reproduction::test_sqlx_with_pools::h276be36942743d23 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:217:5 [INFO] [stdout] 43: 0x55acbce14207 - vacuum_reproduction::test_sqlx_with_pools::{{closure}}::h233f885855a0bae6 [INFO] [stdout] at /opt/rustwide/workdir/src/main.rs:214:36 [INFO] [stdout] 44: 0x55acbce23466 - core::ops::function::FnOnce::call_once::hedc10ef340953267 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 45: 0x55acbcea514b - core::ops::function::FnOnce::call_once::h42df3dc9a56fb705 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 46: 0x55acbcea514b - test::__rust_begin_short_backtrace::hf2ff4d4d12dd75b0 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:632:18 [INFO] [stdout] 47: 0x55acbcea3fd3 - test::run_test_in_process::{{closure}}::h8461a23c6c0ac10c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:655:60 [INFO] [stdout] 48: 0x55acbcea3fd3 - as core::ops::function::FnOnce<()>>::call_once::hefab1bfcb42baf2e [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 49: 0x55acbcea3fd3 - std::panicking::try::do_call::h75c82cb1133d19f1 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:584:40 [INFO] [stdout] 50: 0x55acbcea3fd3 - std::panicking::try::h41d68fc63841231a [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:547:19 [INFO] [stdout] 51: 0x55acbcea3fd3 - std::panic::catch_unwind::h7a7ff6adf9e0c698 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panic.rs:358:14 [INFO] [stdout] 52: 0x55acbcea3fd3 - test::run_test_in_process::hcd527530689ec177 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:655:27 [INFO] [stdout] 53: 0x55acbcea3fd3 - test::run_test::{{closure}}::h51ba581aac56ca21 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:576:43 [INFO] [stdout] 54: 0x55acbce67cd5 - test::run_test::{{closure}}::h9d0d2581742c4e6c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/test/src/lib.rs:606:41 [INFO] [stdout] 55: 0x55acbce67cd5 - std::sys::backtrace::__rust_begin_short_backtrace::h94b953e0285eca69 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/backtrace.rs:152:18 [INFO] [stdout] 56: 0x55acbce6b766 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hac891bfe52f0501a [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/mod.rs:564:17 [INFO] [stdout] 57: 0x55acbce6b766 - as core::ops::function::FnOnce<()>>::call_once::hd4f76b3ef0615394 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/panic/unwind_safe.rs:272:9 [INFO] [stdout] 58: 0x55acbce6b766 - std::panicking::try::do_call::h31b1a419f4fa670c [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:584:40 [INFO] [stdout] 59: 0x55acbce6b766 - std::panicking::try::h277e348adef7f0af [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panicking.rs:547:19 [INFO] [stdout] 60: 0x55acbce6b766 - std::panic::catch_unwind::h06db5059e51a109d [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/panic.rs:358:14 [INFO] [stdout] 61: 0x55acbce6b766 - std::thread::Builder::spawn_unchecked_::{{closure}}::h048aed1b5c822396 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/thread/mod.rs:562:30 [INFO] [stdout] 62: 0x55acbce6b766 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h9f03098da71d0b51 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 63: 0x55acbd4761bb - as core::ops::function::FnOnce>::call_once::hcc221cc1d8cbbdc7 [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 64: 0x55acbd4761bb - as core::ops::function::FnOnce>::call_once::he5e5264a0dcd6e5f [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/alloc/src/boxed.rs:1993:9 [INFO] [stdout] 65: 0x55acbd4761bb - std::sys::pal::unix::thread::Thread::new::thread_start::h307a072356a0dfca [INFO] [stdout] at /rustc/fe9b9751fa54a5871b87cd36a582f9b7b06123fd/library/std/src/sys/pal/unix/thread.rs:106:17 [INFO] [stdout] 66: 0x7cfbb8d7aac3 - [INFO] [stdout] 67: 0x7cfbb8e0ba04 - 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.09s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--bin vacuum-reproduction` [INFO] running `Command { std: "docker" "inspect" "15f7a38c8b00364f7d1b2f96224480be943902320506e47f69e442b449f73279", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "15f7a38c8b00364f7d1b2f96224480be943902320506e47f69e442b449f73279", kill_on_drop: false }` [INFO] [stdout] 15f7a38c8b00364f7d1b2f96224480be943902320506e47f69e442b449f73279