[INFO] fetching crate sql-audit 0.1.0... [INFO] testing sql-audit-0.1.0 against try#ce59db7a1b1b012fb2793c4641c1bdecad7a128b for pr-85530 [INFO] extracting crate sql-audit 0.1.0 into /workspace/builds/worker-5/source [INFO] validating manifest of crates.io crate sql-audit 0.1.0 on toolchain ce59db7a1b1b012fb2793c4641c1bdecad7a128b [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "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-5/source/Cargo.toml [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded owo-colors v1.3.0 [INFO] [stderr] Downloaded color-eyre v0.5.11 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] c1920d6c88263f5a21578fdcfcfd51df1252be8eb734a988975fa74df52a6137 [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "c1920d6c88263f5a21578fdcfcfd51df1252be8eb734a988975fa74df52a6137", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "c1920d6c88263f5a21578fdcfcfd51df1252be8eb734a988975fa74df52a6137", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "c1920d6c88263f5a21578fdcfcfd51df1252be8eb734a988975fa74df52a6137", kill_on_drop: false }` [INFO] [stdout] c1920d6c88263f5a21578fdcfcfd51df1252be8eb734a988975fa74df52a6137 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 9fb951b425fa1176e4de5b75ddf70278e52aa0d642c2276da847baeb2c2817dd [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "9fb951b425fa1176e4de5b75ddf70278e52aa0d642c2276da847baeb2c2817dd", kill_on_drop: false }` [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling syn v1.0.72 [INFO] [stderr] Compiling libc v0.2.95 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling autocfg v1.0.1 [INFO] [stderr] Compiling memchr v2.4.0 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling parking v2.0.0 [INFO] [stderr] Compiling waker-fn v1.1.0 [INFO] [stderr] Compiling cache-padded v1.1.1 [INFO] [stderr] Compiling fastrand v1.4.1 [INFO] [stderr] Compiling event-listener v2.5.1 [INFO] [stderr] Compiling ryu v1.0.5 [INFO] [stderr] Compiling serde_derive v1.0.126 [INFO] [stderr] Compiling spin v0.5.2 [INFO] [stderr] Compiling untrusted v0.7.1 [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling serde v1.0.126 [INFO] [stderr] Compiling proc-macro-hack v0.5.19 [INFO] [stderr] Compiling ahash v0.4.7 [INFO] [stderr] Compiling bitflags v1.2.1 [INFO] [stderr] Compiling async-task v4.0.3 [INFO] [stderr] Compiling radium v0.5.3 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling signal-hook v0.3.9 [INFO] [stderr] Compiling atomic-waker v1.0.0 [INFO] [stderr] Compiling lexical-core v0.7.6 [INFO] [stderr] Compiling static_assertions v1.1.0 [INFO] [stderr] Compiling funty v1.1.0 [INFO] [stderr] Compiling tap v1.0.1 [INFO] [stderr] Compiling base64 v0.12.3 [INFO] [stderr] Compiling ucd-trie v0.1.3 [INFO] [stderr] Compiling wyz v0.2.0 [INFO] [stderr] Compiling serde_json v1.0.64 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling smallvec v1.6.1 [INFO] [stderr] Compiling itoa v0.4.7 [INFO] [stderr] Compiling subtle v2.4.0 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling regex-syntax v0.6.25 [INFO] [stderr] Compiling unicode_categories v0.1.1 [INFO] [stderr] Compiling maplit v1.0.2 [INFO] [stderr] Compiling gimli v0.24.0 [INFO] [stderr] Compiling eyre v0.6.5 [INFO] [stderr] Compiling bytes v0.5.6 [INFO] [stderr] Compiling base64 v0.13.0 [INFO] [stderr] Compiling rustc-demangle v0.1.19 [INFO] [stderr] Compiling owo-colors v1.3.0 [INFO] [stderr] Compiling indenter v0.3.3 [INFO] [stderr] Compiling futures-core v0.3.15 [INFO] [stderr] Compiling typenum v1.13.0 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling thread_local v1.1.3 [INFO] [stderr] Compiling backtrace v0.3.60 [INFO] [stderr] Compiling instant v0.1.9 [INFO] [stderr] Compiling tracing-core v0.1.18 [INFO] [stderr] Compiling sharded-slab v0.1.1 [INFO] [stderr] Compiling concurrent-queue v1.2.2 [INFO] [stderr] Compiling async-mutex v1.4.0 [INFO] [stderr] Compiling async-lock v2.4.0 [INFO] [stderr] Compiling tinyvec v1.2.0 [INFO] [stderr] Compiling unicode-bidi v0.3.5 [INFO] [stderr] Compiling futures-channel v0.3.15 [INFO] [stderr] Compiling proc-macro-nested v0.1.7 [INFO] [stderr] Compiling futures-task v0.3.15 [INFO] [stderr] Compiling hashbrown v0.9.1 [INFO] [stderr] Compiling crc v1.8.1 [INFO] [stderr] Compiling crossbeam-queue v0.3.2 [INFO] [stderr] Compiling whoami v1.1.2 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling value-bag v1.0.0-alpha.7 [INFO] [stderr] Compiling generic-array v0.14.4 [INFO] [stderr] Compiling nom v6.1.2 [INFO] [stderr] Compiling ahash v0.6.3 [INFO] [stderr] Compiling lock_api v0.4.4 [INFO] [stderr] Compiling pest v2.1.3 [INFO] [stderr] Compiling futures-macro v0.3.15 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling futures-util v0.3.15 [INFO] [stderr] Compiling indexmap v1.6.2 [INFO] [stderr] Compiling num-integer v0.1.44 [INFO] [stderr] Compiling miniz_oxide v0.4.4 [INFO] [stderr] Compiling heck v0.3.3 [INFO] [stderr] Compiling hashlink v0.6.0 [INFO] [stderr] Compiling tracing-subscriber v0.2.18 [INFO] [stderr] Compiling async-channel v1.6.1 [INFO] [stderr] Compiling unicode-normalization v0.1.19 [INFO] [stderr] Compiling bitvec v0.19.5 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling futures-lite v1.12.0 [INFO] [stderr] Compiling aho-corasick v0.7.18 [INFO] [stderr] Compiling object v0.25.2 [INFO] [stderr] Compiling socket2 v0.4.0 [INFO] [stderr] Compiling signal-hook-registry v1.4.0 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling parking_lot_core v0.8.3 [INFO] [stderr] Compiling time v0.1.44 [INFO] [stderr] Compiling semver-parser v0.10.2 [INFO] [stderr] Compiling atoi v0.4.0 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling stringprep v0.1.2 [INFO] [stderr] Compiling addr2line v0.15.2 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling async-executor v1.4.1 [INFO] [stderr] Compiling blocking v1.0.2 [INFO] [stderr] Compiling parking_lot v0.11.1 [INFO] [stderr] Compiling webpki v0.21.4 [INFO] [stderr] Compiling sct v0.6.1 [INFO] [stderr] Compiling regex v1.5.4 [INFO] [stderr] Compiling digest v0.9.0 [INFO] [stderr] Compiling block-buffer v0.9.0 [INFO] [stderr] Compiling crypto-mac v0.10.0 [INFO] [stderr] Compiling rand_chacha v0.2.2 [INFO] [stderr] Compiling chrono v0.4.19 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling webpki-roots v0.21.1 [INFO] [stderr] Compiling sha2 v0.9.5 [INFO] [stderr] Compiling md-5 v0.9.1 [INFO] [stderr] Compiling sha-1 v0.9.6 [INFO] [stderr] Compiling hmac v0.10.1 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling sqlformat v0.1.6 [INFO] [stderr] Compiling ctor v0.1.20 [INFO] [stderr] Compiling async-attributes v1.1.2 [INFO] [stderr] Compiling thiserror-impl v1.0.25 [INFO] [stderr] Compiling tracing-attributes v0.1.15 [INFO] [stderr] Compiling polling v2.0.3 [INFO] [stderr] Compiling rustls v0.18.1 [INFO] [stderr] Compiling kv-log-macro v1.0.7 [INFO] [stderr] Compiling thiserror v1.0.25 [INFO] [stderr] Compiling async-io v1.4.1 [INFO] [stderr] Compiling tracing v0.1.26 [INFO] [stderr] Compiling async-process v1.1.0 [INFO] [stderr] Compiling async-global-executor v2.0.2 [INFO] [stderr] Compiling tracing-error v0.1.2 [INFO] [stderr] Compiling color-spantrace v0.1.6 [INFO] [stderr] Compiling async-std v1.9.0 [INFO] [stderr] Compiling color-eyre v0.5.11 [INFO] [stderr] Compiling async-rustls v0.1.2 [INFO] [stderr] Compiling futures-executor v0.3.15 [INFO] [stderr] Compiling futures v0.3.15 [INFO] [stderr] Compiling semver v0.11.0 [INFO] [stderr] Compiling cargo-platform v0.1.1 [INFO] [stderr] Compiling sqlx-rt v0.2.0 [INFO] [stderr] Compiling cargo_metadata v0.12.3 [INFO] [stderr] Compiling sqlx-core v0.4.2 [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 1m 21s [INFO] running `Command { std: "docker" "inspect" "9fb951b425fa1176e4de5b75ddf70278e52aa0d642c2276da847baeb2c2817dd", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "9fb951b425fa1176e4de5b75ddf70278e52aa0d642c2276da847baeb2c2817dd", kill_on_drop: false }` [INFO] [stdout] 9fb951b425fa1176e4de5b75ddf70278e52aa0d642c2276da847baeb2c2817dd [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] 6220df87dfc34bbd8cd163ad25ee8ab19b87dd5b7253b6584f260cd74f709188 [INFO] running `Command { std: "docker" "start" "-a" "6220df87dfc34bbd8cd163ad25ee8ab19b87dd5b7253b6584f260cd74f709188", kill_on_drop: false }` [INFO] [stderr] Compiling sql-audit v0.1.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 7.42s [INFO] running `Command { std: "docker" "inspect" "6220df87dfc34bbd8cd163ad25ee8ab19b87dd5b7253b6584f260cd74f709188", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "6220df87dfc34bbd8cd163ad25ee8ab19b87dd5b7253b6584f260cd74f709188", kill_on_drop: false }` [INFO] [stdout] 6220df87dfc34bbd8cd163ad25ee8ab19b87dd5b7253b6584f260cd74f709188 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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" "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:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+ce59db7a1b1b012fb2793c4641c1bdecad7a128b" "test" "--frozen", kill_on_drop: false }` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] d6d1e4385a04ae2df46b8bbec194cd429ef45a4a04d6f4453af4ebf6eac4529e [INFO] running `Command { std: "docker" "start" "-a" "d6d1e4385a04ae2df46b8bbec194cd429ef45a4a04d6f4453af4ebf6eac4529e", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.21s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/sql_audit-35d68123901f837e) [INFO] [stdout] [INFO] [stdout] running 1 test [INFO] [stderr] Running tests/integration_test.rs (/opt/rustwide/target/debug/deps/integration_test-012e5257f2ad5a4f) [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.01s [INFO] [stdout] [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] The application panicked (crashed). [INFO] [stdout] Message: called `Result::unwrap()` on an `Err` value: PoolTimedOut [INFO] [stdout] Location: tests/integration_test.rs:13 [INFO] [stdout] [INFO] [stdout] ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ BACKTRACE ━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━━ [INFO] [stdout]  ⋮ 6 frames hidden ⋮  [INFO] [stdout] 7: core[ee1ca6415511a9c4]::panicking::panic_fmt [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/panicking.rs:92 [INFO] [stdout] 8: core[ee1ca6415511a9c4]::result::unwrap_failed [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/result.rs:1355 [INFO] [stdout] 9: >::unwrap [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/result.rs:1037 [INFO] [stdout] 10: integration_test[f19c675723c90b7f]::test_e2e::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/integration_test.rs:10 [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]  10 >  sqlx::query("CREATE TABLE should_be_audited(pk serial primary key, data text)") [INFO] [stdout] 11 │ .execute(&pool) [INFO] [stdout] 12 │ .await [INFO] [stdout] 11:  as core[ee1ca6415511a9c4]::future::future::Future>::poll [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/future/mod.rs:80 [INFO] [stdout] 12: > as core[ee1ca6415511a9c4]::future::future::Future>::poll::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/builder.rs:199 [INFO] [stdout] 197 │ TaskLocalsWrapper::set_current(&self.tag, || { [INFO] [stdout] 198 │ let this = self.project(); [INFO] [stdout]  199 >  this.future.poll(cx) [INFO] [stdout] 200 │ }) [INFO] [stdout] 201 │ } [INFO] [stdout] 13: ::set_current::<> as core[ee1ca6415511a9c4]::future::future::Future>::poll::{closure#0}, core[ee1ca6415511a9c4]::task::poll::Poll<()>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/task_locals_wrapper.rs:60 [INFO] [stdout] 58 │ current.set(old_task); [INFO] [stdout] 59 │ } [INFO] [stdout]  60 >  f() [INFO] [stdout] 61 │ }) [INFO] [stdout] 62 │ } [INFO] [stdout] 14: >>::try_with::<::set_current<> as core[ee1ca6415511a9c4]::future::future::Future>::poll::{closure#0}, core[ee1ca6415511a9c4]::task::poll::Poll<()>>::{closure#0}, core[ee1ca6415511a9c4]::task::poll::Poll<()>> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/local.rs:400 [INFO] [stdout] 15: >>::with::<::set_current<> as core[ee1ca6415511a9c4]::future::future::Future>::poll::{closure#0}, core[ee1ca6415511a9c4]::task::poll::Poll<()>>::{closure#0}, core[ee1ca6415511a9c4]::task::poll::Poll<()>> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/local.rs:376 [INFO] [stdout] 16: ::set_current::<> as core[ee1ca6415511a9c4]::future::future::Future>::poll::{closure#0}, core[ee1ca6415511a9c4]::task::poll::Poll<()>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/task_locals_wrapper.rs:55 [INFO] [stdout] 53 │ F: FnOnce() -> R, [INFO] [stdout] 54 │ { [INFO] [stdout]  55 >  CURRENT.with(|current| { [INFO] [stdout] 56 │ let old_task = current.replace(task); [INFO] [stdout] 57 │ defer! { [INFO] [stdout] 17: > as core[ee1ca6415511a9c4]::future::future::Future>::poll [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/builder.rs:197 [INFO] [stdout] 195 │ fn poll(self: Pin<&mut Self>, cx: &mut Context<'_>) -> Poll { [INFO] [stdout] 196 │ unsafe { [INFO] [stdout]  197 >  TaskLocalsWrapper::set_current(&self.tag, || { [INFO] [stdout] 198 │ let this = self.project(); [INFO] [stdout] 199 │ this.future.poll(cx) [INFO] [stdout] 18: >, core[ee1ca6415511a9c4]::future::from_generator::GenFuture<::run<(), async_std[934e55d0994a9702]::task::builder::SupportTaskLocals>>::{closure#0}::{closure#0}>> as core[ee1ca6415511a9c4]::future::future::Future>::poll [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/futures-lite-1.12.0/src/future.rs:526 [INFO] [stdout] 524 │ let this = self.project(); [INFO] [stdout] 525 │ [INFO] [stdout]  526 >  if let Poll::Ready(t) = this.future1.poll(cx) { [INFO] [stdout] 527 │ return Poll::Ready(t); [INFO] [stdout] 528 │ } [INFO] [stdout] 19: ::run::<(), async_std[934e55d0994a9702]::task::builder::SupportTaskLocals>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-executor-1.4.1/src/lib.rs:242 [INFO] [stdout] 240 │ [INFO] [stdout] 241 │ // Run `future` and `run_forever` concurrently until `future` completes. [INFO] [stdout]  242 >  future.or(run_forever).await [INFO] [stdout] 243 │ } [INFO] [stdout] 244 │ [INFO] [stdout] 20: ::run<(), async_std[934e55d0994a9702]::task::builder::SupportTaskLocals>>::{closure#0}> as core[ee1ca6415511a9c4]::future::future::Future>::poll [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/future/mod.rs:80 [INFO] [stdout] 21: ::run::<(), async_std[934e55d0994a9702]::task::builder::SupportTaskLocals>>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-executor-1.4.1/src/lib.rs:447 [INFO] [stdout] 445 │ /// ``` [INFO] [stdout] 446 │ pub async fn run(&self, future: impl Future) -> T { [INFO] [stdout]  447 >  self.inner().run(future).await [INFO] [stdout] 448 │ } [INFO] [stdout] 449 │ [INFO] [stdout] 22: ::run<(), async_std[934e55d0994a9702]::task::builder::SupportTaskLocals>>::{closure#0}> as core[ee1ca6415511a9c4]::future::future::Future>::poll [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/future/mod.rs:80 [INFO] [stdout] 23: async_io[48f9420844374350]::driver::block_on::<(), core[ee1ca6415511a9c4]::future::from_generator::GenFuture<::run<(), async_std[934e55d0994a9702]::task::builder::SupportTaskLocals>>::{closure#0}>> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-io-1.4.1/src/driver.rs:142 [INFO] [stdout] 140 │ loop { [INFO] [stdout] 141 │ // Poll the future. [INFO] [stdout]  142 >  if let Poll::Ready(t) = future.as_mut().poll(cx) { [INFO] [stdout] 143 │ log::trace!("block_on: completed"); [INFO] [stdout] 144 │ return t; [INFO] [stdout] 24: async_global_executor[54c5d96089ab3e6d]::reactor::block_on::::run<(), async_std[934e55d0994a9702]::task::builder::SupportTaskLocals>>::{closure#0}>, ()>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-global-executor-2.0.2/src/reactor.rs:3 [INFO] [stdout] 1 │ pub(crate) fn block_on, T>(future: F) -> T { [INFO] [stdout] 2 │ #[cfg(feature = "async-io")] [INFO] [stdout]  3 >  let run = || async_io::block_on(future); [INFO] [stdout] 4 │ #[cfg(not(feature = "async-io"))] [INFO] [stdout] 5 │ let run = || futures_lite::future::block_on(future); [INFO] [stdout] 25: async_global_executor[54c5d96089ab3e6d]::reactor::block_on::::run<(), async_std[934e55d0994a9702]::task::builder::SupportTaskLocals>>::{closure#0}>, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-global-executor-2.0.2/src/reactor.rs:12 [INFO] [stdout] 10 │ #[cfg(feature = "tokio03")] [INFO] [stdout] 11 │ let _tokio03_enter = crate::tokio03::enter(); [INFO] [stdout]  12 >  run() [INFO] [stdout] 13 │ } [INFO] [stdout] 26: async_global_executor[54c5d96089ab3e6d]::executor::block_on::>, ()>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-global-executor-2.0.2/src/executor.rs:26 [INFO] [stdout] 24 │ /// ``` [INFO] [stdout] 25 │ pub fn block_on, T>(future: F) -> T { [INFO] [stdout]  26 >  LOCAL_EXECUTOR.with(|executor| crate::reactor::block_on(executor.run(future))) [INFO] [stdout] 27 │ } [INFO] [stdout] 28 │ [INFO] [stdout] 27: >::try_with::>, ()>::{closure#0}, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/local.rs:400 [INFO] [stdout] 28: >::with::>, ()>::{closure#0}, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/local.rs:376 [INFO] [stdout] 29: async_global_executor[54c5d96089ab3e6d]::executor::block_on::>, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-global-executor-2.0.2/src/executor.rs:26 [INFO] [stdout] 24 │ /// ``` [INFO] [stdout] 25 │ pub fn block_on, T>(future: F) -> T { [INFO] [stdout]  26 >  LOCAL_EXECUTOR.with(|executor| crate::reactor::block_on(executor.run(future))) [INFO] [stdout] 27 │ } [INFO] [stdout] 28 │ [INFO] [stdout] 30: ::blocking::, ()>::{closure#0}::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/builder.rs:171 [INFO] [stdout] 169 │ let res = if should_run { [INFO] [stdout] 170 │ // The first call should run the executor [INFO] [stdout]  171 >  async_global_executor::block_on(wrapped) [INFO] [stdout] 172 │ } else { [INFO] [stdout] 173 │ futures_lite::future::block_on(wrapped) [INFO] [stdout] 31: ::set_current::<::blocking, ()>::{closure#0}::{closure#0}, ()>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/task_locals_wrapper.rs:60 [INFO] [stdout] 58 │ current.set(old_task); [INFO] [stdout] 59 │ } [INFO] [stdout]  60 >  f() [INFO] [stdout] 61 │ }) [INFO] [stdout] 62 │ } [INFO] [stdout] 32: >>::try_with::<::set_current<::blocking, ()>::{closure#0}::{closure#0}, ()>::{closure#0}, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/local.rs:400 [INFO] [stdout] 33: >>::with::<::set_current<::blocking, ()>::{closure#0}::{closure#0}, ()>::{closure#0}, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/local.rs:376 [INFO] [stdout] 34: ::set_current::<::blocking, ()>::{closure#0}::{closure#0}, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/task_locals_wrapper.rs:55 [INFO] [stdout] 53 │ F: FnOnce() -> R, [INFO] [stdout] 54 │ { [INFO] [stdout]  55 >  CURRENT.with(|current| { [INFO] [stdout] 56 │ let old_task = current.replace(task); [INFO] [stdout] 57 │ defer! { [INFO] [stdout] 35: ::blocking::, ()>::{closure#0} [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/builder.rs:168 [INFO] [stdout] 166 │ [INFO] [stdout] 167 │ unsafe { [INFO] [stdout]  168 >  TaskLocalsWrapper::set_current(&wrapped.tag, || { [INFO] [stdout] 169 │ let res = if should_run { [INFO] [stdout] 170 │ // The first call should run the executor [INFO] [stdout] 36: >>::try_with::<::blocking, ()>::{closure#0}, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/local.rs:400 [INFO] [stdout] 37: >>::with::<::blocking, ()>::{closure#0}, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/local.rs:376 [INFO] [stdout] 38: ::blocking::, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/builder.rs:161 [INFO] [stdout] 159 │ [INFO] [stdout] 160 │ // Run the future as a task. [INFO] [stdout]  161 >  NUM_NESTED_BLOCKING.with(|num_nested_blocking| { [INFO] [stdout] 162 │ let count = num_nested_blocking.get(); [INFO] [stdout] 163 │ let should_run = count == 0; [INFO] [stdout] 39: async_std[934e55d0994a9702]::task::block_on::block_on::, ()> [INFO] [stdout] at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/async-std-1.9.0/src/task/block_on.rs:33 [INFO] [stdout] 31 │ F: Future, [INFO] [stdout] 32 │ { [INFO] [stdout]  33 >  Builder::new().blocking(future) [INFO] [stdout] 34 │ } [INFO] [stdout] 35 │ [INFO] [stdout] 40: integration_test[f19c675723c90b7f]::test_e2e [INFO] [stdout] at /opt/rustwide/workdir/tests/integration_test.rs:5 [INFO] [stdout] 3 │ }; [INFO] [stdout] 4 │ [INFO] [stdout]  5 > #[async_std::test] [INFO] [stdout] 6 │ async fn test_e2e() { [INFO] [stdout] 7 │ color_eyre::install().unwrap(); [INFO] [stdout] 41: integration_test[f19c675723c90b7f]::test_e2e::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/integration_test.rs:5 [INFO] [stdout] 3 │ }; [INFO] [stdout] 4 │ [INFO] [stdout]  5 > #[async_std::test] [INFO] [stdout] 6 │ async fn test_e2e() { [INFO] [stdout] 7 │ color_eyre::install().unwrap(); [INFO] [stdout] 42: >::call_once [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227 [INFO] [stdout] 43: >::call_once [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227 [INFO] [stdout] 44: test[eeb9024d9ac7bc83]::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:577 [INFO] [stdout] 45:  + core[ee1ca6415511a9c4]::marker::Send> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575 [INFO] [stdout] 46:  + core[ee1ca6415511a9c4]::marker::Send>> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346 [INFO] [stdout] 47: std[77c0456e0eb29f0c]::panicking::try::do_call:: + core[ee1ca6415511a9c4]::marker::Send>>, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401 [INFO] [stdout] 48: std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe + core[ee1ca6415511a9c4]::marker::Send>>> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365 [INFO] [stdout] 49: std[77c0456e0eb29f0c]::panic::catch_unwind:: + core[ee1ca6415511a9c4]::marker::Send>>, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433 [INFO] [stdout] 50: test[eeb9024d9ac7bc83]::run_test_in_process [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:600 [INFO] [stdout] 51: test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#0} [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:492 [INFO] [stdout] 52: test[eeb9024d9ac7bc83]::run_test::run_test_inner::{closure#1} [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/test/src/lib.rs:519 [INFO] [stdout] 53: std[77c0456e0eb29f0c]::sys_common::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys_common/backtrace.rs:125 [INFO] [stdout] 54: ::spawn_unchecked::::{closure#0}::{closure#0} [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:481 [INFO] [stdout] 55: ::spawn_unchecked::{closure#0}::{closure#0}> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:346 [INFO] [stdout] 56: std[77c0456e0eb29f0c]::panicking::try::do_call::::spawn_unchecked::{closure#0}::{closure#0}>, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:401 [INFO] [stdout] 57: std[77c0456e0eb29f0c]::panicking::try::<(), std[77c0456e0eb29f0c]::panic::AssertUnwindSafe<::spawn_unchecked::{closure#0}::{closure#0}>> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panicking.rs:365 [INFO] [stdout] 58: std[77c0456e0eb29f0c]::panic::catch_unwind::::spawn_unchecked::{closure#0}::{closure#0}>, ()> [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/panic.rs:433 [INFO] [stdout] 59: ::spawn_unchecked::::{closure#0} [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/thread/mod.rs:480 [INFO] [stdout] 60: <::spawn_unchecked::{closure#0} as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/core/src/ops/function.rs:227 [INFO] [stdout] 61: > as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575 [INFO] [stdout] 62: >> as core[ee1ca6415511a9c4]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/alloc/src/boxed.rs:1575 [INFO] [stdout] 63: ::new::thread_start [INFO] [stdout] at /rustc/ce59db7a1b1b012fb2793c4641c1bdecad7a128b/library/std/src/sys/unix/thread.rs:71 [INFO] [stdout] 64: start_thread [INFO] [stdout] at : [INFO] [stdout] 65: clone [INFO] [stdout] at : [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.72s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass '--test integration_test' [INFO] running `Command { std: "docker" "inspect" "d6d1e4385a04ae2df46b8bbec194cd429ef45a4a04d6f4453af4ebf6eac4529e", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "d6d1e4385a04ae2df46b8bbec194cd429ef45a4a04d6f4453af4ebf6eac4529e", kill_on_drop: false }` [INFO] [stdout] d6d1e4385a04ae2df46b8bbec194cd429ef45a4a04d6f4453af4ebf6eac4529e