[INFO] fetching crate sql-audit 0.1.0...
[INFO] testing sql-audit-0.1.0 against beta-2023-04-20 for beta-1.70-1
[INFO] extracting crate sql-audit 0.1.0 into /workspace/builds/worker-6-tc2/source
[INFO] validating manifest of crates.io crate sql-audit 0.1.0 on toolchain beta-2023-04-20
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2023-04-20" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate sql-audit 0.1.0
[INFO] finished tweaking crates.io crate sql-audit 0.1.0
[INFO] tweaked toml for crates.io crate sql-audit 0.1.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" __CARGO_TEST_CHANNEL_OVERRIDE_DO_NOT_USE_THIS="nightly" "/workspace/cargo-home/bin/cargo" "+beta-2023-04-20" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2023-04-20" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded owo-colors v1.3.0
[INFO] [stderr]   Downloaded whoami v1.4.0
[INFO] [stderr]   Downloaded tracing-error v0.1.2
[INFO] [stderr]   Downloaded cargo_metadata v0.12.3
[INFO] [stderr]   Downloaded ahash v0.6.3
[INFO] [stderr]   Downloaded color-spantrace v0.1.6
[INFO] [stderr]   Downloaded color-eyre v0.5.11
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-04-20" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 11133ac0343ee1fe84e663231380ec6a6afc74af0049973d1fc7b61c55ae6271
[INFO] running `Command { std: "docker" "start" "-a" "11133ac0343ee1fe84e663231380ec6a6afc74af0049973d1fc7b61c55ae6271", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "11133ac0343ee1fe84e663231380ec6a6afc74af0049973d1fc7b61c55ae6271", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "11133ac0343ee1fe84e663231380ec6a6afc74af0049973d1fc7b61c55ae6271", kill_on_drop: false }`
[INFO] [stdout] 11133ac0343ee1fe84e663231380ec6a6afc74af0049973d1fc7b61c55ae6271
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-04-20" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8608a15a20976ee4716e66e6045da489485fb42cb4265888112480bc069c575d
[INFO] running `Command { std: "docker" "start" "-a" "8608a15a20976ee4716e66e6045da489485fb42cb4265888112480bc069c575d", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.56
[INFO] [stderr]    Compiling libc v0.2.142
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling once_cell v1.17.1
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling log v0.4.17
[INFO] [stderr]    Compiling futures-io v0.3.28
[INFO] [stderr]    Compiling value-bag v1.0.0-alpha.9
[INFO] [stderr]    Compiling parking v2.1.0
[INFO] [stderr]    Compiling waker-fn v1.1.0
[INFO] [stderr]    Compiling fastrand v1.9.0
[INFO] [stderr]    Compiling concurrent-queue v2.2.0
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling io-lifetimes v1.0.10
[INFO] [stderr]    Compiling async-lock v2.7.0
[INFO] [stderr]    Compiling polling v2.8.0
[INFO] [stderr]    Compiling rustix v0.37.18
[INFO] [stderr]    Compiling async-io v1.13.0
[INFO] [stderr]    Compiling linux-raw-sys v0.3.6
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling signal-hook v0.3.15
[INFO] [stderr]    Compiling async-task v4.4.0
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling futures-channel v0.3.28
[INFO] [stderr]    Compiling futures-task v0.3.28
[INFO] [stderr]    Compiling async-channel v1.8.0
[INFO] [stderr]    Compiling digest v0.9.0
[INFO] [stderr]    Compiling async-process v1.7.0
[INFO] [stderr]    Compiling futures-util v0.3.28
[INFO] [stderr]    Compiling futures-sink v0.3.28
[INFO] [stderr]    Compiling atomic-waker v1.1.1
[INFO] [stderr]    Compiling block-buffer v0.9.0
[INFO] [stderr]    Compiling num-integer v0.1.45
[INFO] [stderr]    Compiling build_const v0.2.2
[INFO] [stderr]    Compiling hashbrown v0.12.3
[INFO] [stderr]    Compiling ucd-trie v0.1.5
[INFO] [stderr]    Compiling base64 v0.12.3
[INFO] [stderr]    Compiling futures-lite v1.13.0
[INFO] [stderr]    Compiling serde_json v1.0.96
[INFO] [stderr]    Compiling tracing-core v0.1.30
[INFO] [stderr]    Compiling quote v1.0.26
[INFO] [stderr]    Compiling crc v1.8.1
[INFO] [stderr]    Compiling ahash v0.6.3
[INFO] [stderr]    Compiling subtle v2.4.1
[INFO] [stderr]    Compiling ahash v0.4.7
[INFO] [stderr]    Compiling syn v2.0.15
[INFO] [stderr]    Compiling indexmap v1.9.3
[INFO] [stderr]    Compiling crypto-mac v0.10.1
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling sharded-slab v0.1.4
[INFO] [stderr]    Compiling hashbrown v0.9.1
[INFO] [stderr]    Compiling thread_local v1.1.7
[INFO] [stderr]    Compiling crossbeam-queue v0.3.8
[INFO] [stderr]    Compiling hmac v0.10.1
[INFO] [stderr]    Compiling sha2 v0.9.9
[INFO] [stderr]    Compiling sha-1 v0.9.8
[INFO] [stderr]    Compiling md-5 v0.9.1
[INFO] [stderr]    Compiling crossbeam-channel v0.5.8
[INFO] [stderr]    Compiling async-executor v1.5.1
[INFO] [stderr]    Compiling hashlink v0.6.0
[INFO] [stderr]    Compiling ring v0.16.20
[INFO] [stderr]    Compiling socket2 v0.4.9
[INFO] [stderr]    Compiling signal-hook-registry v1.4.1
[INFO] [stderr]    Compiling parking_lot_core v0.8.6
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling getrandom v0.2.9
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling time v0.1.45
[INFO] [stderr]    Compiling parking_lot v0.11.2
[INFO] [stderr]    Compiling tracing-subscriber v0.2.25
[INFO] [stderr]    Compiling atoi v0.4.0
[INFO] [stderr]    Compiling backtrace v0.3.67
[INFO] [stderr]    Compiling eyre v0.6.8
[INFO] [stderr]    Compiling chrono v0.4.24
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling itoa v0.4.8
[INFO] [stderr]    Compiling gimli v0.27.2
[INFO] [stderr]    Compiling whoami v1.4.0
[INFO] [stderr]    Compiling webpki v0.21.4
[INFO] [stderr]    Compiling sct v0.6.1
[INFO] [stderr]    Compiling bytes v0.5.6
[INFO] [stderr]    Compiling base64 v0.13.1
[INFO] [stderr]    Compiling miniz_oxide v0.6.2
[INFO] [stderr]    Compiling heck v0.3.3
[INFO] [stderr]    Compiling webpki-roots v0.21.1
[INFO] [stderr]    Compiling sqlformat v0.1.8
[INFO] [stderr]    Compiling object v0.30.3
[INFO] [stderr]    Compiling owo-colors v1.3.0
[INFO] [stderr]    Compiling indenter v0.3.3
[INFO] [stderr]    Compiling rustc-demangle v0.1.23
[INFO] [stderr]    Compiling dotenv v0.15.0
[INFO] [stderr]    Compiling ctor v0.1.26
[INFO] [stderr]    Compiling async-attributes v1.1.2
[INFO] [stderr]    Compiling addr2line v0.19.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling serde_derive v1.0.160
[INFO] [stderr]    Compiling futures-macro v0.3.28
[INFO] [stderr]    Compiling tracing-attributes v0.1.24
[INFO] [stderr]    Compiling blocking v1.3.1
[INFO] [stderr]    Compiling rustls v0.18.1
[INFO] [stderr]    Compiling kv-log-macro v1.0.7
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling tracing v0.1.37
[INFO] [stderr]    Compiling async-global-executor v2.3.1
[INFO] [stderr]    Compiling pest v2.6.0
[INFO] [stderr]    Compiling tracing-error v0.1.2
[INFO] [stderr]    Compiling async-std v1.12.0
[INFO] [stderr]    Compiling color-spantrace v0.1.6
[INFO] [stderr]    Compiling color-eyre v0.5.11
[INFO] [stderr]    Compiling semver-parser v0.10.2
[INFO] [stderr]    Compiling async-rustls v0.1.2
[INFO] [stderr]    Compiling serde v1.0.160
[INFO] [stderr]    Compiling futures-executor v0.3.28
[INFO] [stderr]    Compiling futures v0.3.28
[INFO] [stderr]    Compiling sqlx-rt v0.2.0
[INFO] [stderr]    Compiling semver v0.11.0
[INFO] [stderr]    Compiling cargo-platform v0.1.2
[INFO] [stderr]    Compiling sqlx-core v0.4.2
[INFO] [stderr]    Compiling cargo_metadata v0.12.3
[INFO] [stderr]    Compiling sqlx-macros v0.4.2
[INFO] [stderr]    Compiling sqlx v0.4.2
[INFO] [stderr]    Compiling sql-audit v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 28.46s
[INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: sqlx-macros v0.4.2
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 2`
[INFO] running `Command { std: "docker" "inspect" "8608a15a20976ee4716e66e6045da489485fb42cb4265888112480bc069c575d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8608a15a20976ee4716e66e6045da489485fb42cb4265888112480bc069c575d", kill_on_drop: false }`
[INFO] [stdout] 8608a15a20976ee4716e66e6045da489485fb42cb4265888112480bc069c575d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-04-20" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a53e5d9f3b445af9c0d9d73de0e3ddf7424a8f14b186953689bb197b6cf69c75
[INFO] running `Command { std: "docker" "start" "-a" "a53e5d9f3b445af9c0d9d73de0e3ddf7424a8f14b186953689bb197b6cf69c75", kill_on_drop: false }`
[INFO] [stderr]    Compiling sql-audit v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 4.50s
[INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: sqlx-macros v0.4.2
[INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 2`
[INFO] running `Command { std: "docker" "inspect" "a53e5d9f3b445af9c0d9d73de0e3ddf7424a8f14b186953689bb197b6cf69c75", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a53e5d9f3b445af9c0d9d73de0e3ddf7424a8f14b186953689bb197b6cf69c75", kill_on_drop: false }`
[INFO] [stdout] a53e5d9f3b445af9c0d9d73de0e3ddf7424a8f14b186953689bb197b6cf69c75
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-04-20" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 5bca171f45cf0b65b1338bed0b7ace7831d3f0504299cd260fee74987453fbeb
[INFO] running `Command { std: "docker" "start" "-a" "5bca171f45cf0b65b1338bed0b7ace7831d3f0504299cd260fee74987453fbeb", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr] warning: the following packages contain code that will be rejected by a future version of Rust: sqlx-macros v0.4.2
[INFO] [stderr] note: to see what the problems were, use the option `--future-incompat-report`, or run `cargo report future-incompatibilities --id 2`
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sql_audit-5a44e14a286f9a1c)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::it_works ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-6f4cd26331db6de3)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_e2e ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_e2e stdout ----
[INFO] [stdout] [31mThe application panicked (crashed).[0m
[INFO] [stdout] Message:  [36mcalled `Result::unwrap()` on an `Err` value: PoolTimedOut[0m
[INFO] [stdout] Location: [35mtests/integration_test.rs[0m:[35m13[0m
[INFO] [stdout] 
[INFO] [stdout]   ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ BACKTRACE ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━
[INFO] [stdout]   [96m                              ⋮ 9 frames hidden ⋮                               [0m
[INFO] [stdout]   10: [32mcore::result::Result<T,E>::unwrap[0m[90m::h89075571c9d0741f[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/core/src/result.rs[0m:[35m1089[0m
[INFO] [stdout]   11: [91mintegration_test::test_e2e::{{closure}}[0m[90m::hcdeecdfc1bdad8e9[0m
[INFO] [stdout]       at [35m/opt/rustwide/workdir/tests/integration_test.rs[0m:[35m10[0m
[INFO] [stdout]          8 │     let database_uri = "postgres://postgres:rootpw@localhost/testing";
[INFO] [stdout]          9 │     let pool = sqlx::PgPool::connect(database_uri).await.unwrap();
[INFO] [stdout]   [37m[1m      10[0m [37m[1m>[0m [37m[1m    sqlx::query("CREATE TABLE should_be_audited(pk serial primary key, data text)")[0m
[INFO] [stdout]         11 │         .execute(&pool)
[INFO] [stdout]         12 │         .await
[INFO] [stdout]   12: [91m<async_std::task::builder::SupportTaskLocals<F> as core::future::future::Future>::poll::{{closure}}[0m[90m::hdf3042ee758539e3[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/builder.rs[0m:[35m199[0m
[INFO] [stdout]        197 │             TaskLocalsWrapper::set_current(&self.tag, || {
[INFO] [stdout]        198 │                 let this = self.project();
[INFO] [stdout]   [37m[1m     199[0m [37m[1m>[0m [37m[1m                this.future.poll(cx)[0m
[INFO] [stdout]        200 │             })
[INFO] [stdout]        201 │         }
[INFO] [stdout]   13: [91masync_std::task::task_locals_wrapper::TaskLocalsWrapper::set_current::{{closure}}[0m[90m::h3cc0eb98638f3900[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/task_locals_wrapper.rs[0m:[35m60[0m
[INFO] [stdout]         58 │                 current.set(old_task);
[INFO] [stdout]         59 │             }
[INFO] [stdout]   [37m[1m      60[0m [37m[1m>[0m [37m[1m            f()[0m
[INFO] [stdout]         61 │         })
[INFO] [stdout]         62 │     }
[INFO] [stdout]   14: [32mstd::thread::local::LocalKey<T>::try_with[0m[90m::he72e36b246b57399[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/thread/local.rs[0m:[35m252[0m
[INFO] [stdout]   15: [32mstd::thread::local::LocalKey<T>::with[0m[90m::h176479c910140e66[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/thread/local.rs[0m:[35m228[0m
[INFO] [stdout]   16: [91masync_std::task::task_locals_wrapper::TaskLocalsWrapper::set_current[0m[90m::h38ad763b416cbc26[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/task_locals_wrapper.rs[0m:[35m55[0m
[INFO] [stdout]         53 │         F: FnOnce() -> R,
[INFO] [stdout]         54 │     {
[INFO] [stdout]   [37m[1m      55[0m [37m[1m>[0m [37m[1m        CURRENT.with(|current| {[0m
[INFO] [stdout]         56 │             let old_task = current.replace(task);
[INFO] [stdout]         57 │             defer! {
[INFO] [stdout]   17: [91m<async_std::task::builder::SupportTaskLocals<F> as core::future::future::Future>::poll[0m[90m::he5379fa86905cd3c[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/builder.rs[0m:[35m197[0m
[INFO] [stdout]        195 │     fn poll(self: Pin<&mut Self>, cx: &mut Context<'_>) -> Poll<Self::Output> {
[INFO] [stdout]        196 │         unsafe {
[INFO] [stdout]   [37m[1m     197[0m [37m[1m>[0m [37m[1m            TaskLocalsWrapper::set_current(&self.tag, || {[0m
[INFO] [stdout]        198 │                 let this = self.project();
[INFO] [stdout]        199 │                 this.future.poll(cx)
[INFO] [stdout]   18: [91m<futures_lite::future::Or<F1,F2> as core::future::future::Future>::poll[0m[90m::h4fddc4a3fda19a91[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/futures-lite-1.13.0/src/future.rs[0m:[35m526[0m
[INFO] [stdout]        524 │         let this = self.project();
[INFO] [stdout]        525 │ 
[INFO] [stdout]   [37m[1m     526[0m [37m[1m>[0m [37m[1m        if let Poll::Ready(t) = this.future1.poll(cx) {[0m
[INFO] [stdout]        527 │             return Poll::Ready(t);
[INFO] [stdout]        528 │         }
[INFO] [stdout]   19: [91masync_executor::Executor::run::{{closure}}[0m[90m::ha165c1bef72d88d5[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-executor-1.5.1/src/lib.rs[0m:[35m243[0m
[INFO] [stdout]        241 │ 
[INFO] [stdout]        242 │         // Run `future` and `run_forever` concurrently until `future` completes.
[INFO] [stdout]   [37m[1m     243[0m [37m[1m>[0m [37m[1m        future.or(run_forever).await[0m
[INFO] [stdout]        244 │     }
[INFO] [stdout]        245 │ 
[INFO] [stdout]   20: [91masync_executor::LocalExecutor::run::{{closure}}[0m[90m::h129d5c8af655d731[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-executor-1.5.1/src/lib.rs[0m:[35m447[0m
[INFO] [stdout]        445 │     /// ```
[INFO] [stdout]        446 │     pub async fn run<T>(&self, future: impl Future<Output = T>) -> T {
[INFO] [stdout]   [37m[1m     447[0m [37m[1m>[0m [37m[1m        self.inner().run(future).await[0m
[INFO] [stdout]        448 │     }
[INFO] [stdout]        449 │ 
[INFO] [stdout]   21: [91masync_io::driver::block_on[0m[90m::hd1ffdb37104a24aa[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-io-1.13.0/src/driver.rs[0m:[35m146[0m
[INFO] [stdout]        144 │     loop {
[INFO] [stdout]        145 │         // Poll the future.
[INFO] [stdout]   [37m[1m     146[0m [37m[1m>[0m [37m[1m        if let Poll::Ready(t) = future.as_mut().poll(cx) {[0m
[INFO] [stdout]        147 │             log::trace!("block_on: completed");
[INFO] [stdout]        148 │             return t;
[INFO] [stdout]   22: [91masync_global_executor::reactor::block_on::{{closure}}[0m[90m::h0d3392247d0cc6ac[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-global-executor-2.3.1/src/reactor.rs[0m:[35m3[0m
[INFO] [stdout]          1 │ pub(crate) fn block_on<F: std::future::Future<Output = T>, T>(future: F) -> T {
[INFO] [stdout]          2 │     #[cfg(feature = "async-io")]
[INFO] [stdout]   [37m[1m       3[0m [37m[1m>[0m [37m[1m    let run = || async_io::block_on(future);[0m
[INFO] [stdout]          4 │     #[cfg(not(feature = "async-io"))]
[INFO] [stdout]          5 │     let run = || futures_lite::future::block_on(future);
[INFO] [stdout]   23: [91masync_global_executor::reactor::block_on[0m[90m::hc847e7abb9c6ee25[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-global-executor-2.3.1/src/reactor.rs[0m:[35m12[0m
[INFO] [stdout]         10 │     #[cfg(feature = "tokio03")]
[INFO] [stdout]         11 │     let _tokio03_enter = crate::tokio03::enter();
[INFO] [stdout]   [37m[1m      12[0m [37m[1m>[0m [37m[1m    run()[0m
[INFO] [stdout]         13 │ }
[INFO] [stdout]   24: [91masync_global_executor::executor::block_on::{{closure}}[0m[90m::h5f239f6b55407c30[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-global-executor-2.3.1/src/executor.rs[0m:[35m26[0m
[INFO] [stdout]         24 │ /// ```
[INFO] [stdout]         25 │ pub fn block_on<F: Future<Output = T>, T>(future: F) -> T {
[INFO] [stdout]   [37m[1m      26[0m [37m[1m>[0m [37m[1m    LOCAL_EXECUTOR.with(|executor| crate::reactor::block_on(executor.run(future)))[0m
[INFO] [stdout]         27 │ }
[INFO] [stdout]         28 │ 
[INFO] [stdout]   25: [32mstd::thread::local::LocalKey<T>::try_with[0m[90m::habdaceb3cc5a58d9[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/thread/local.rs[0m:[35m252[0m
[INFO] [stdout]   26: [32mstd::thread::local::LocalKey<T>::with[0m[90m::hb2e8fff4d94493c9[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/thread/local.rs[0m:[35m228[0m
[INFO] [stdout]   27: [91masync_global_executor::executor::block_on[0m[90m::hea7d89eb963d9415[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-global-executor-2.3.1/src/executor.rs[0m:[35m26[0m
[INFO] [stdout]         24 │ /// ```
[INFO] [stdout]         25 │ pub fn block_on<F: Future<Output = T>, T>(future: F) -> T {
[INFO] [stdout]   [37m[1m      26[0m [37m[1m>[0m [37m[1m    LOCAL_EXECUTOR.with(|executor| crate::reactor::block_on(executor.run(future)))[0m
[INFO] [stdout]         27 │ }
[INFO] [stdout]         28 │ 
[INFO] [stdout]   28: [91masync_std::task::builder::Builder::blocking::{{closure}}::{{closure}}[0m[90m::h5ca85be42c13b2a2[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/builder.rs[0m:[35m171[0m
[INFO] [stdout]        169 │                     let res = if should_run {
[INFO] [stdout]        170 │                         // The first call should run the executor
[INFO] [stdout]   [37m[1m     171[0m [37m[1m>[0m [37m[1m                        async_global_executor::block_on(wrapped)[0m
[INFO] [stdout]        172 │                     } else {
[INFO] [stdout]        173 │                         futures_lite::future::block_on(wrapped)
[INFO] [stdout]   29: [91masync_std::task::task_locals_wrapper::TaskLocalsWrapper::set_current::{{closure}}[0m[90m::h59a3b491470884fb[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/task_locals_wrapper.rs[0m:[35m60[0m
[INFO] [stdout]         58 │                 current.set(old_task);
[INFO] [stdout]         59 │             }
[INFO] [stdout]   [37m[1m      60[0m [37m[1m>[0m [37m[1m            f()[0m
[INFO] [stdout]         61 │         })
[INFO] [stdout]         62 │     }
[INFO] [stdout]   30: [32mstd::thread::local::LocalKey<T>::try_with[0m[90m::h114cdb8efa04a66a[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/thread/local.rs[0m:[35m252[0m
[INFO] [stdout]   31: [32mstd::thread::local::LocalKey<T>::with[0m[90m::hbb016f5c2b8973cc[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/thread/local.rs[0m:[35m228[0m
[INFO] [stdout]   32: [91masync_std::task::task_locals_wrapper::TaskLocalsWrapper::set_current[0m[90m::he1382e7e8b7ae84d[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/task_locals_wrapper.rs[0m:[35m55[0m
[INFO] [stdout]         53 │         F: FnOnce() -> R,
[INFO] [stdout]         54 │     {
[INFO] [stdout]   [37m[1m      55[0m [37m[1m>[0m [37m[1m        CURRENT.with(|current| {[0m
[INFO] [stdout]         56 │             let old_task = current.replace(task);
[INFO] [stdout]         57 │             defer! {
[INFO] [stdout]   33: [91masync_std::task::builder::Builder::blocking::{{closure}}[0m[90m::hd0397cf371654e0a[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/builder.rs[0m:[35m168[0m
[INFO] [stdout]        166 │ 
[INFO] [stdout]        167 │             unsafe {
[INFO] [stdout]   [37m[1m     168[0m [37m[1m>[0m [37m[1m                TaskLocalsWrapper::set_current(&wrapped.tag, || {[0m
[INFO] [stdout]        169 │                     let res = if should_run {
[INFO] [stdout]        170 │                         // The first call should run the executor
[INFO] [stdout]   34: [32mstd::thread::local::LocalKey<T>::try_with[0m[90m::h8ecfe10dff0da344[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/thread/local.rs[0m:[35m252[0m
[INFO] [stdout]   35: [32mstd::thread::local::LocalKey<T>::with[0m[90m::hb780d52377b38a28[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/thread/local.rs[0m:[35m228[0m
[INFO] [stdout]   36: [91masync_std::task::builder::Builder::blocking[0m[90m::hea3d31697286ce68[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/builder.rs[0m:[35m161[0m
[INFO] [stdout]        159 │ 
[INFO] [stdout]        160 │         // Run the future as a task.
[INFO] [stdout]   [37m[1m     161[0m [37m[1m>[0m [37m[1m        NUM_NESTED_BLOCKING.with(|num_nested_blocking| {[0m
[INFO] [stdout]        162 │             let count = num_nested_blocking.get();
[INFO] [stdout]        163 │             let should_run = count == 0;
[INFO] [stdout]   37: [91masync_std::task::block_on::block_on[0m[90m::hbcd0c4b5ee40ef6a[0m
[INFO] [stdout]       at [35m/opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/async-std-1.12.0/src/task/block_on.rs[0m:[35m33[0m
[INFO] [stdout]         31 │     F: Future<Output = T>,
[INFO] [stdout]         32 │ {
[INFO] [stdout]   [37m[1m      33[0m [37m[1m>[0m [37m[1m    Builder::new().blocking(future)[0m
[INFO] [stdout]         34 │ }
[INFO] [stdout]         35 │ 
[INFO] [stdout]   38: [91mintegration_test::test_e2e[0m[90m::hdee1b64fda34b09f[0m
[INFO] [stdout]       at [35m/opt/rustwide/workdir/tests/integration_test.rs[0m:[35m5[0m
[INFO] [stdout]          3 │ };
[INFO] [stdout]          4 │ 
[INFO] [stdout]   [37m[1m       5[0m [37m[1m>[0m [37m[1m#[async_std::test][0m
[INFO] [stdout]          6 │ async fn test_e2e() {
[INFO] [stdout]          7 │     color_eyre::install().unwrap();
[INFO] [stdout]   39: [91mintegration_test::test_e2e::{{closure}}[0m[90m::hdace6145098c93db[0m
[INFO] [stdout]       at [35m/opt/rustwide/workdir/tests/integration_test.rs[0m:[35m5[0m
[INFO] [stdout]          3 │ };
[INFO] [stdout]          4 │ 
[INFO] [stdout]   [37m[1m       5[0m [37m[1m>[0m [37m[1m#[async_std::test][0m
[INFO] [stdout]          6 │ async fn test_e2e() {
[INFO] [stdout]          7 │     color_eyre::install().unwrap();
[INFO] [stdout]   40: [32mcore::ops::function::FnOnce::call_once[0m[90m::h3f1c201dddf5db23[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/core/src/ops/function.rs[0m:[35m250[0m
[INFO] [stdout]   41: [32mcore::ops::function::FnOnce::call_once[0m[90m::ha6a70e79f7481a7e[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/core/src/ops/function.rs[0m:[35m250[0m
[INFO] [stdout]   42: [32mtest::__rust_begin_short_backtrace[0m[90m::hce33033019b61e69[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/test/src/lib.rs[0m:[35m655[0m
[INFO] [stdout]   43: [32mtest::run_test::{{closure}}[0m[90m::h858d3528838ae3e5[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/test/src/lib.rs[0m:[35m646[0m
[INFO] [stdout]   44: [32mcore::ops::function::FnOnce::call_once{{vtable.shim}}[0m[90m::he8ac2b00f01ae79e[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/core/src/ops/function.rs[0m:[35m250[0m
[INFO] [stdout]   45: [32m<alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once[0m[90m::h8093d25b522725ef[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/alloc/src/boxed.rs[0m:[35m1973[0m
[INFO] [stdout]   46: [32m<core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once[0m[90m::h5c334c204e4a3913[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/core/src/panic/unwind_safe.rs[0m:[35m271[0m
[INFO] [stdout]   47: [32mstd::panicking::try::do_call[0m[90m::ha8b740c7b9478074[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/panicking.rs[0m:[35m485[0m
[INFO] [stdout]   48: [32mstd::panicking::try[0m[90m::h5d34f63d0e41b64e[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/panicking.rs[0m:[35m449[0m
[INFO] [stdout]   49: [32mstd::panic::catch_unwind[0m[90m::hcfbb511e1aa7fc67[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/std/src/panic.rs[0m:[35m140[0m
[INFO] [stdout]   50: [32mtest::run_test_in_process[0m[90m::h9abda90f802eaf21[0m
[INFO] [stdout]       at [35m/rustc/1b7dd2252b99671ce5d1cb9664c5f8636329436d/library/test/src/lib.rs[0m:[35m678[0m
[INFO] [stdout]   [96m                              ⋮ 14 frames hidden ⋮                              [0m
[INFO] [stdout] 
[INFO] [stdout] Run with COLORBT_SHOW_HIDDEN=1 environment variable to disable frame filtering.
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_e2e
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 30.43s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test integration_test`
[INFO] running `Command { std: "docker" "inspect" "5bca171f45cf0b65b1338bed0b7ace7831d3f0504299cd260fee74987453fbeb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5bca171f45cf0b65b1338bed0b7ace7831d3f0504299cd260fee74987453fbeb", kill_on_drop: false }`
[INFO] [stdout] 5bca171f45cf0b65b1338bed0b7ace7831d3f0504299cd260fee74987453fbeb
