[INFO] cloning repository https://github.com/sstepanchuk/pg_subscribe [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/sstepanchuk/pg_subscribe" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsstepanchuk%2Fpg_subscribe", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsstepanchuk%2Fpg_subscribe'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] e99e30a2698f77b155d14874214c633c801b06b2 [INFO] testing sstepanchuk/pg_subscribe against try#dec9417b8611e34e787a3e4c37686b5131f9e5c5 for pr-154210 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fsstepanchuk%2Fpg_subscribe" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'... [INFO] [stderr] done. [INFO] started tweaking git repo https://github.com/sstepanchuk/pg_subscribe [INFO] finished tweaking git repo https://github.com/sstepanchuk/pg_subscribe [INFO] tweaked toml for git repo https://github.com/sstepanchuk/pg_subscribe written to /workspace/builds/worker-0-tc2/source/Cargo.toml [INFO] validating manifest of git repo https://github.com/sstepanchuk/pg_subscribe on toolchain dec9417b8611e34e787a3e4c37686b5131f9e5c5 [INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] crate git repo https://github.com/sstepanchuk/pg_subscribe 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" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "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-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] cd2550f09bafbf5904aa82a55f151a3e3fa79e47639c09925586b72e6bc4ac38 [INFO] running `Command { std: "docker" "start" "-a" "cd2550f09bafbf5904aa82a55f151a3e3fa79e47639c09925586b72e6bc4ac38", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "cd2550f09bafbf5904aa82a55f151a3e3fa79e47639c09925586b72e6bc4ac38", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "cd2550f09bafbf5904aa82a55f151a3e3fa79e47639c09925586b72e6bc4ac38", kill_on_drop: false }` [INFO] [stdout] cd2550f09bafbf5904aa82a55f151a3e3fa79e47639c09925586b72e6bc4ac38 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 76079a4e95374b951094cb125ef6ac0e37f23a4661dce9f26cbb8f48d3b46e86 [INFO] running `Command { std: "docker" "start" "-a" "76079a4e95374b951094cb125ef6ac0e37f23a4661dce9f26cbb8f48d3b46e86", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.106 [INFO] [stderr] Compiling cfg-if v1.0.4 [INFO] [stderr] Compiling serde_core v1.0.228 [INFO] [stderr] Compiling find-msvc-tools v0.1.8 [INFO] [stderr] Compiling serde v1.0.228 [INFO] [stderr] Compiling libc v0.2.180 [INFO] [stderr] Compiling typenum v1.19.0 [INFO] [stderr] Compiling generic-array v0.14.7 [INFO] [stderr] Compiling subtle v2.6.1 [INFO] [stderr] Compiling zeroize v1.8.2 [INFO] [stderr] Compiling pin-project-lite v0.2.16 [INFO] [stderr] Compiling zerocopy v0.8.35 [INFO] [stderr] Compiling stable_deref_trait v1.2.1 [INFO] [stderr] Compiling quote v1.0.44 [INFO] [stderr] Compiling memchr v2.7.6 [INFO] [stderr] Compiling dunce v1.0.5 [INFO] [stderr] Compiling syn v2.0.114 [INFO] [stderr] Compiling once_cell v1.21.3 [INFO] [stderr] Compiling fs_extra v1.3.0 [INFO] [stderr] Compiling errno v0.3.14 [INFO] [stderr] Compiling getrandom v0.2.17 [INFO] [stderr] Compiling jobserver v0.1.34 [INFO] [stderr] Compiling signal-hook-registry v1.4.8 [INFO] [stderr] Compiling cc v1.2.54 [INFO] [stderr] Compiling socket2 v0.6.2 [INFO] [stderr] Compiling crypto-common v0.1.7 [INFO] [stderr] Compiling block-buffer v0.10.4 [INFO] [stderr] Compiling mio v1.1.1 [INFO] [stderr] Compiling digest v0.10.7 [INFO] [stderr] Compiling rustls-pki-types v1.14.0 [INFO] [stderr] Compiling cmake v0.1.57 [INFO] [stderr] Compiling log v0.4.29 [INFO] [stderr] Compiling smallvec v1.15.1 [INFO] [stderr] Compiling futures-core v0.3.31 [INFO] [stderr] Compiling getrandom v0.3.4 [INFO] [stderr] Compiling cpufeatures v0.2.17 [INFO] [stderr] Compiling futures-sink v0.3.31 [INFO] [stderr] Compiling aws-lc-rs v1.15.4 [INFO] [stderr] Compiling object v0.37.3 [INFO] [stderr] Compiling aws-lc-sys v0.37.0 [INFO] [stderr] Compiling ring v0.17.14 [INFO] [stderr] Compiling itoa v1.0.17 [INFO] [stderr] Compiling sha2 v0.10.9 [INFO] [stderr] Compiling litemap v0.8.1 [INFO] [stderr] Compiling zmij v1.0.17 [INFO] [stderr] Compiling untrusted v0.9.0 [INFO] [stderr] Compiling writeable v0.6.2 [INFO] [stderr] Compiling rand_core v0.9.5 [INFO] [stderr] Compiling rand_core v0.6.4 [INFO] [stderr] Compiling tracing-core v0.1.36 [INFO] [stderr] Compiling tinyvec_macros v0.1.1 [INFO] [stderr] Compiling base64 v0.22.1 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling synstructure v0.13.2 [INFO] [stderr] Compiling base64ct v1.8.3 [INFO] [stderr] Compiling serde_json v1.0.149 [INFO] [stderr] Compiling icu_properties_data v2.1.2 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling tinyvec v1.10.0 [INFO] [stderr] Compiling icu_normalizer_data v2.1.1 [INFO] [stderr] Compiling pem-rfc7468 v0.7.0 [INFO] [stderr] Compiling futures-channel v0.3.31 [INFO] [stderr] Compiling const-oid v0.9.6 [INFO] [stderr] Compiling slab v0.4.11 [INFO] [stderr] Compiling rustls v0.23.36 [INFO] [stderr] Compiling futures-io v0.3.31 [INFO] [stderr] Compiling pin-utils v0.1.0 [INFO] [stderr] Compiling futures-task v0.3.31 [INFO] [stderr] Compiling der v0.7.10 [INFO] [stderr] Compiling parking_lot_core v0.9.12 [INFO] [stderr] Compiling unicode-normalization v0.1.25 [INFO] [stderr] Compiling serde_derive v1.0.228 [INFO] [stderr] Compiling zerofrom-derive v0.1.6 [INFO] [stderr] Compiling yoke-derive v0.8.1 [INFO] [stderr] Compiling tokio-macros v2.6.0 [INFO] [stderr] Compiling zerovec-derive v0.11.2 [INFO] [stderr] Compiling zerofrom v0.1.6 [INFO] [stderr] Compiling yoke v0.8.1 [INFO] [stderr] Compiling displaydoc v0.2.5 [INFO] [stderr] Compiling ar_archive_writer v0.5.1 [INFO] [stderr] Compiling futures-macro v0.3.31 [INFO] [stderr] Compiling zerotrie v0.2.3 [INFO] [stderr] Compiling zerovec v0.11.5 [INFO] [stderr] Compiling psm v0.1.29 [INFO] [stderr] Compiling futures-util v0.3.31 [INFO] [stderr] Compiling tracing-attributes v0.1.31 [INFO] [stderr] Compiling tinystr v0.8.2 [INFO] [stderr] Compiling icu_locale_core v2.1.1 [INFO] [stderr] Compiling potential_utf v0.1.4 [INFO] [stderr] Compiling icu_provider v2.1.1 [INFO] [stderr] Compiling bytes v1.11.0 [INFO] [stderr] Compiling icu_collections v2.1.1 [INFO] [stderr] Compiling tokio v1.49.0 [INFO] [stderr] Compiling rand v0.9.2 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling signature v2.2.0 [INFO] [stderr] Compiling hmac v0.12.1 [INFO] [stderr] Compiling aho-corasick v1.1.4 [INFO] [stderr] Compiling unicode-bidi v0.3.18 [INFO] [stderr] Compiling scopeguard v1.2.0 [INFO] [stderr] Compiling percent-encoding v2.3.2 [INFO] [stderr] Compiling unicode-properties v0.1.4 [INFO] [stderr] Compiling regex-syntax v0.8.8 [INFO] [stderr] Compiling lock_api v0.4.14 [INFO] [stderr] Compiling stringprep v0.1.5 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling icu_properties v2.1.2 [INFO] [stderr] Compiling regex-automata v0.4.13 [INFO] [stderr] Compiling curve25519-dalek v4.1.3 [INFO] [stderr] Compiling icu_normalizer v2.1.1 [INFO] [stderr] Compiling tokio-util v0.7.18 [INFO] [stderr] Compiling tracing v0.1.44 [INFO] [stderr] Compiling spki v0.7.3 [INFO] [stderr] Compiling curve25519-dalek-derive v0.1.1 [INFO] [stderr] Compiling stacker v0.1.22 [INFO] [stderr] Compiling webpki-roots v1.0.5 [INFO] [stderr] Compiling md-5 v0.10.6 [INFO] [stderr] Compiling siphasher v1.0.2 [INFO] [stderr] Compiling iana-time-zone v0.1.65 [INFO] [stderr] Compiling byteorder v1.5.0 [INFO] [stderr] Compiling lazy_static v1.5.0 [INFO] [stderr] Compiling fallible-iterator v0.2.0 [INFO] [stderr] Compiling httparse v1.10.1 [INFO] [stderr] Compiling thiserror v1.0.69 [INFO] [stderr] Compiling phf_shared v0.13.1 [INFO] [stderr] Compiling postgres-protocol v0.6.10 [INFO] [stderr] Compiling chrono v0.4.43 [INFO] [stderr] Compiling webpki-roots v0.26.11 [INFO] [stderr] Compiling pkcs8 v0.10.2 [INFO] [stderr] Compiling idna_adapter v1.2.1 [INFO] [stderr] Compiling ed25519 v2.2.3 [INFO] [stderr] Compiling thiserror-impl v1.0.69 [INFO] [stderr] Compiling uuid v1.20.0 [INFO] [stderr] Compiling rustls-pemfile v2.2.0 [INFO] [stderr] Compiling powerfmt v0.2.0 [INFO] [stderr] Compiling utf8_iter v1.0.4 [INFO] [stderr] Compiling portable-atomic v1.13.0 [INFO] [stderr] Compiling crossbeam-utils v0.8.21 [INFO] [stderr] Compiling anyhow v1.0.100 [INFO] [stderr] Compiling idna v1.1.0 [INFO] [stderr] Compiling deranged v0.5.5 [INFO] [stderr] Compiling postgres-types v0.2.12 [INFO] [stderr] Compiling ed25519-dalek v2.2.0 [INFO] [stderr] Compiling signatory v0.27.1 [INFO] [stderr] Compiling phf v0.13.1 [INFO] [stderr] Compiling parking_lot v0.12.5 [INFO] [stderr] Compiling deadpool-runtime v0.1.4 [INFO] [stderr] Compiling form_urlencoded v1.2.2 [INFO] [stderr] Compiling http v1.4.0 [INFO] [stderr] Compiling recursive-proc-macro-impl v0.1.1 [INFO] [stderr] Compiling pin-project-internal v1.1.10 [INFO] [stderr] Compiling async-trait v0.1.89 [INFO] [stderr] Compiling num_cpus v1.17.0 [INFO] [stderr] Compiling time-core v0.1.8 [INFO] [stderr] Compiling openssl-probe v0.1.6 [INFO] [stderr] Compiling num-conv v0.2.0 [INFO] [stderr] Compiling data-encoding v2.10.0 [INFO] [stderr] Compiling whoami v2.1.0 [INFO] [stderr] Compiling tokio-postgres v0.7.16 [INFO] [stderr] Compiling nkeys v0.4.5 [INFO] [stderr] Compiling time v0.3.46 [INFO] [stderr] Compiling rustls-native-certs v0.7.3 [INFO] [stderr] Compiling deadpool v0.12.3 [INFO] [stderr] Compiling pin-project v1.1.10 [INFO] [stderr] Compiling recursive v0.1.1 [INFO] [stderr] Compiling url v2.5.8 [INFO] [stderr] Compiling matchers v0.2.0 [INFO] [stderr] Compiling regex v1.12.2 [INFO] [stderr] Compiling sharded-slab v0.1.7 [INFO] [stderr] Compiling tryhard v0.5.2 [INFO] [stderr] Compiling tokio-stream v0.1.18 [INFO] [stderr] Compiling nuid v0.5.0 [INFO] [stderr] Compiling futures-executor v0.3.31 [INFO] [stderr] Compiling tracing-serde v0.2.0 [INFO] [stderr] Compiling serde_nanos v0.1.4 [INFO] [stderr] Compiling serde_repr v0.1.20 [INFO] [stderr] Compiling tracing-log v0.2.0 [INFO] [stderr] Compiling rustls-webpki v0.102.8 [INFO] [stderr] Compiling thread_local v1.1.9 [INFO] [stderr] Compiling nu-ansi-term v0.50.3 [INFO] [stderr] Compiling hashbrown v0.14.5 [INFO] [stderr] Compiling futures v0.3.31 [INFO] [stderr] Compiling deadpool-postgres v0.14.1 [INFO] [stderr] Compiling tracing-subscriber v0.3.22 [INFO] [stderr] Compiling sqlparser v0.60.0 [INFO] [stderr] Compiling dashmap v6.1.0 [INFO] [stderr] Compiling dotenvy v0.15.7 [INFO] [stderr] Compiling rustc-hash v2.1.1 [INFO] [stderr] Compiling rustls-webpki v0.103.9 [INFO] [stderr] Compiling tokio-rustls v0.26.4 [INFO] [stderr] Compiling tokio-websockets v0.10.1 [INFO] [stderr] Compiling pgwire-replication v0.1.2 [INFO] [stderr] Compiling async-nats v0.46.0 [INFO] [stderr] Compiling livequery-server v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `dev` profile [optimized + debuginfo] target(s) in 11m 24s [INFO] running `Command { std: "docker" "inspect" "76079a4e95374b951094cb125ef6ac0e37f23a4661dce9f26cbb8f48d3b46e86", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "76079a4e95374b951094cb125ef6ac0e37f23a4661dce9f26cbb8f48d3b46e86", kill_on_drop: false }` [INFO] [stdout] 76079a4e95374b951094cb125ef6ac0e37f23a4661dce9f26cbb8f48d3b46e86 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] df773716b1c185199bd376490c15b7a8ff3f74b325ed5f3646825e1ab2fb37da [INFO] running `Command { std: "docker" "start" "-a" "df773716b1c185199bd376490c15b7a8ff3f74b325ed5f3646825e1ab2fb37da", kill_on_drop: false }` [INFO] [stderr] Compiling zerocopy v0.8.35 [INFO] [stderr] Compiling zerocopy-derive v0.8.35 [INFO] [stderr] Compiling num-traits v0.2.19 [INFO] [stderr] Compiling either v1.15.0 [INFO] [stderr] Compiling crossbeam-epoch v0.9.18 [INFO] [stderr] Compiling rayon-core v1.13.0 [INFO] [stderr] Compiling ciborium-io v0.2.2 [INFO] [stderr] Compiling plotters-backend v0.3.7 [INFO] [stderr] Compiling clap_lex v0.7.7 [INFO] [stderr] Compiling anstyle v1.0.13 [INFO] [stderr] Compiling crossbeam-deque v0.8.6 [INFO] [stderr] Compiling clap_builder v4.5.55 [INFO] [stderr] Compiling itertools v0.10.5 [INFO] [stderr] Compiling plotters-svg v0.3.7 [INFO] [stderr] Compiling cast v0.3.0 [INFO] [stderr] Compiling same-file v1.0.6 [INFO] [stderr] Compiling itertools v0.13.0 [INFO] [stderr] Compiling walkdir v2.5.0 [INFO] [stderr] Compiling tinytemplate v1.2.1 [INFO] [stderr] Compiling chrono v0.4.43 [INFO] [stderr] Compiling criterion-plot v0.5.0 [INFO] [stderr] Compiling plotters v0.3.7 [INFO] [stderr] Compiling clap v4.5.55 [INFO] [stderr] Compiling rayon v1.11.0 [INFO] [stderr] Compiling oorandom v11.1.5 [INFO] [stderr] Compiling anes v0.1.6 [INFO] [stderr] Compiling ppv-lite86 v0.2.21 [INFO] [stderr] Compiling rand_chacha v0.9.0 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling half v2.7.1 [INFO] [stderr] Compiling rand v0.9.2 [INFO] [stderr] Compiling rand v0.8.5 [INFO] [stderr] Compiling ciborium-ll v0.2.2 [INFO] [stderr] Compiling ciborium v0.2.2 [INFO] [stderr] Compiling postgres-protocol v0.6.10 [INFO] [stderr] Compiling pgwire-replication v0.1.2 [INFO] [stderr] Compiling criterion v0.6.0 [INFO] [stderr] Compiling postgres-types v0.2.12 [INFO] [stderr] Compiling nkeys v0.4.5 [INFO] [stderr] Compiling tokio-websockets v0.10.1 [INFO] [stderr] Compiling nuid v0.5.0 [INFO] [stderr] Compiling tokio-postgres v0.7.16 [INFO] [stderr] Compiling async-nats v0.46.0 [INFO] [stderr] Compiling deadpool-postgres v0.14.1 [INFO] [stderr] Compiling livequery-server v0.3.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished `test` profile [optimized + debuginfo] target(s) in 5m 10s [INFO] running `Command { std: "docker" "inspect" "df773716b1c185199bd376490c15b7a8ff3f74b325ed5f3646825e1ab2fb37da", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "df773716b1c185199bd376490c15b7a8ff3f74b325ed5f3646825e1ab2fb37da", kill_on_drop: false }` [INFO] [stdout] df773716b1c185199bd376490c15b7a8ff3f74b325ed5f3646825e1ab2fb37da [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+dec9417b8611e34e787a3e4c37686b5131f9e5c5" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 347ada3c5aae98e784a1c91e7fa92c9be7a09267b030bfd33699a602fa982038 [INFO] running `Command { std: "docker" "start" "-a" "347ada3c5aae98e784a1c91e7fa92c9be7a09267b030bfd33699a602fa982038", kill_on_drop: false }` [INFO] [stderr] Finished `test` profile [optimized + debuginfo] target(s) in 0.45s [INFO] [stderr] Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/livequery_server-60bfe9b2d8cf83d2) [INFO] [stdout] [INFO] [stdout] running 16 tests [INFO] [stdout] test core::query::tests::test_simple_select ... ok [INFO] [stdout] test core::query::tests::test_where_eq ... ok [INFO] [stdout] test core::query::tests::test_where_comparison ... ok [INFO] [stdout] test core::query::tests::test_where_in ... ok [INFO] [stdout] test core::query::tests::test_where_is_null ... ok [INFO] [stdout] test core::query::tests::test_where_and ... ok [INFO] [stdout] test core::query::tests::test_join ... ok [INFO] [stdout] test core::query::tests::test_where_or ... ok [INFO] [stdout] test core::query::tests::test_where_complex ... ok [INFO] [stdout] test core::query::tests::test_where_string ... ok [INFO] [stdout] test core::subscription::tests::test_shared_query ... ok [INFO] [stdout] test core::subscription::tests::test_unsubscribe ... ok [INFO] [stdout] test core::subscription::tests::test_qhash ... ok [INFO] [stdout] test infra::pgoutput::tests::test_decode_begin ... ok [INFO] [stdout] test core::query::tests::test_schema_qualified ... ok [INFO] [stdout] test infra::pgoutput::tests::test_parse_val ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running unittests src/main.rs (/opt/rustwide/target/debug/deps/livequery_server-5b497988b7d2cd6a) [INFO] [stdout] [INFO] [stdout] running 16 tests [INFO] [stdout] test core::query::tests::test_where_and ... ok [INFO] [stdout] test core::query::tests::test_where_eq ... ok [INFO] [stdout] test core::query::tests::test_join ... ok [INFO] [stdout] test core::query::tests::test_simple_select ... ok [INFO] [stdout] test core::query::tests::test_where_complex ... ok [INFO] [stdout] test core::query::tests::test_schema_qualified ... ok [INFO] [stdout] test core::query::tests::test_where_comparison ... ok [INFO] [stdout] test core::query::tests::test_where_is_null ... ok [INFO] [stdout] test core::query::tests::test_where_in ... ok [INFO] [stdout] test core::query::tests::test_where_string ... ok [INFO] [stdout] test core::subscription::tests::test_qhash ... ok [INFO] [stdout] test core::query::tests::test_where_or ... ok [INFO] [stdout] test core::subscription::tests::test_unsubscribe ... ok [INFO] [stdout] test infra::pgoutput::tests::test_decode_begin ... ok [INFO] [stdout] test infra::pgoutput::tests::test_parse_val ... ok [INFO] [stdout] test core::subscription::tests::test_shared_query ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running unittests scripts/test_db.rs (/opt/rustwide/target/debug/deps/test_db-33ca73b106f7ac0f) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running unittests scripts/test_queries.rs (/opt/rustwide/target/debug/deps/test_queries-f01c192079eeadf4) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 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-e122191404db313f) [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test test_full_subscribe_flow ... ignored, requires running PostgreSQL and NATS [INFO] [stdout] test test_query_deduplication ... ignored, requires running PostgreSQL and NATS [INFO] [stdout] test test_subscribe_request_format ... ok [INFO] [stdout] test test_unsubscribe_request_format ... ok [INFO] [stdout] test test_subscribe_response_format ... ok [INFO] [stdout] test test_event_format ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 4 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/query_test.rs (/opt/rustwide/target/debug/deps/query_test-d6b59092bac051d7) [INFO] [stdout] [INFO] [stdout] running 10 tests [INFO] [stdout] test test_invalid_query ... ok [INFO] [stdout] test test_inner_join ... ok [INFO] [stdout] test test_non_select ... ok [INFO] [stdout] test test_simple_select ... ok [INFO] [stdout] test test_schema_qualified ... ok [INFO] [stdout] test test_multiple_joins ... ok [INFO] [stdout] test test_cte ... ok [INFO] [stdout] test test_left_join ... ok [INFO] [stdout] test test_aggregation ... ok [INFO] [stdout] test test_subquery ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s [INFO] [stdout] [INFO] [stderr] Running tests/subscription_test.rs (/opt/rustwide/target/debug/deps/subscription_test-f43eeb9fb5b0bd80) [INFO] [stdout] [INFO] [stdout] running 20 tests [INFO] [stdout] test test_cleanup_new ... ok [INFO] [stdout] test test_duplicate_subscription_id ... ok [INFO] [stdout] test test_heartbeat_new ... ok [INFO] [stdout] test test_make_batch ... ok [INFO] [stdout] test test_reject_non_select ... ok [INFO] [stdout] test test_shared_query ... ok [INFO] [stdout] test test_snapshot_diff_delete ... ok [INFO] [stdout] test test_snapshot_diff_insert ... ok [INFO] [stdout] test test_snapshot_diff_update ... ok [INFO] [stdout] test test_snapshot_init ... ok [INFO] [stdout] test perf_subscribe_shared_query ... ok [INFO] [stdout] test perf_snapshot_diff_1000_rows ... ok [INFO] [stdout] test test_snapshot_no_changes ... ok [INFO] [stdout] test perf_hrow_identity ... ok [INFO] [stdout] test test_subscribe_new ... ok [INFO] [stdout] test test_unsubscribe_new ... ok [INFO] [stdout] test perf_where_filter_eval ... ok [INFO] [stdout] test perf_event_batch_serialize ... ok [INFO] [stdout] test perf_snapshot_diff_100_rows ... FAILED [INFO] [stdout] test perf_query_analyze_cached ... FAILED [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] [INFO] [stdout] ---- perf_snapshot_diff_100_rows stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'perf_snapshot_diff_100_rows' (73) panicked at tests/subscription_test.rs:286:5: [INFO] [stdout] diff too slow: 262.252833ms (262252 ns/op) [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x613d4f96115a - std[e72de78501789eb0]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x613d4f96115a - std[e72de78501789eb0]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x613d4f96115a - std[e72de78501789eb0]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x613d4f96115a - <::print::DisplayBacktrace as core[6aaeda2c7ad07a48]::fmt::Display>::fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x613d4f97747a - ::fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x613d4f97747a - core[6aaeda2c7ad07a48]::fmt::write [INFO] [stdout] 6: 0x613d4f965a32 - std[e72de78501789eb0]::io::default_write_fmt::> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x613d4f965a32 - as std[e72de78501789eb0]::io::Write>::write_fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x613d4f9400bf - ::print [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x613d4f9400bf - std[e72de78501789eb0]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x613d4f9594a9 - std[e72de78501789eb0]::panicking::default_hook [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x613d4f53c41c - core[6aaeda2c7ad07a48]::ops::function::Fn<(&'a std[e72de78501789eb0]::panic::PanicHookInfo<'b>,), Output = ()> + core[6aaeda2c7ad07a48]::marker::Sync + core[6aaeda2c7ad07a48]::marker::Send> as core[6aaeda2c7ad07a48]::ops::function::Fn<(&std[e72de78501789eb0]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 12: 0x613d4f53c41c - test[4f12b380f1fb68c5]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x613d4f959722 - core[6aaeda2c7ad07a48]::ops::function::Fn<(&'a std[e72de78501789eb0]::panic::PanicHookInfo<'b>,), Output = ()> + core[6aaeda2c7ad07a48]::marker::Sync + core[6aaeda2c7ad07a48]::marker::Send> as core[6aaeda2c7ad07a48]::ops::function::Fn<(&std[e72de78501789eb0]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 14: 0x613d4f959722 - std[e72de78501789eb0]::panicking::panic_with_hook [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x613d4f940178 - std[e72de78501789eb0]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x613d4f937b19 - std[e72de78501789eb0]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x613d4f940e8d - __rustc[78a4cf188af856fc]::rust_begin_unwind [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x613d4f977c2c - core[6aaeda2c7ad07a48]::panicking::panic_fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x613d4f52af90 - subscription_test[e1678f61d360658c]::perf_snapshot_diff_100_rows [INFO] [stdout] at /opt/rustwide/workdir/tests/subscription_test.rs:286:5 [INFO] [stdout] 20: 0x613d4f52af90 - subscription_test[e1678f61d360658c]::perf_snapshot_diff_100_rows::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/subscription_test.rs:262:33 [INFO] [stdout] 21: 0x613d4f52af90 - >::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x613d4f5304fb - core[6aaeda2c7ad07a48]::result::Result<(), alloc[28d2dab30c1dc666]::string::String> as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x613d4f5304fb - test[4f12b380f1fb68c5]::__rust_begin_short_backtrace::, fn() -> core[6aaeda2c7ad07a48]::result::Result<(), alloc[28d2dab30c1dc666]::string::String>> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:663:18 [INFO] [stdout] 24: 0x613d4f53ceeb - test[4f12b380f1fb68c5]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:686:74 [INFO] [stdout] 25: 0x613d4f53ceeb - as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 26: 0x613d4f53ceeb - std[e72de78501789eb0]::panicking::catch_unwind::do_call::, core[6aaeda2c7ad07a48]::result::Result<(), alloc[28d2dab30c1dc666]::string::String>> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:581:40 [INFO] [stdout] 27: 0x613d4f53ceeb - std[e72de78501789eb0]::panicking::catch_unwind::, core[6aaeda2c7ad07a48]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:544:19 [INFO] [stdout] 28: 0x613d4f53ceeb - std[e72de78501789eb0]::panic::catch_unwind::, core[6aaeda2c7ad07a48]::result::Result<(), alloc[28d2dab30c1dc666]::string::String>> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panic.rs:359:14 [INFO] [stdout] 29: 0x613d4f53ceeb - test[4f12b380f1fb68c5]::run_test_in_process [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:686:27 [INFO] [stdout] 30: 0x613d4f53ceeb - test[4f12b380f1fb68c5]::run_test::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:607:43 [INFO] [stdout] 31: 0x613d4f538604 - test[4f12b380f1fb68c5]::run_test::{closure#1} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:637:41 [INFO] [stdout] 32: 0x613d4f538604 - std[e72de78501789eb0]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 33: 0x613d4f53faf2 - std[e72de78501789eb0]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 34: 0x613d4f53faf2 - ::{closure#1}::{closure#0}> as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 35: 0x613d4f53faf2 - std[e72de78501789eb0]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:581:40 [INFO] [stdout] 36: 0x613d4f53faf2 - std[e72de78501789eb0]::panicking::catch_unwind::<(), core[6aaeda2c7ad07a48]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:544:19 [INFO] [stdout] 37: 0x613d4f53faf2 - std[e72de78501789eb0]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panic.rs:359:14 [INFO] [stdout] 38: 0x613d4f53faf2 - std[e72de78501789eb0]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 39: 0x613d4f53faf2 - ::{closure#1} as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 40: 0x613d4f960a2f - + core[6aaeda2c7ad07a48]::marker::Send> as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/alloc/src/boxed.rs:2240:9 [INFO] [stdout] 41: 0x613d4f960a2f - ::new::thread_start [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 42: 0x7211465b8aa4 - [INFO] [stdout] 43: 0x721146645a64 - clone [INFO] [stdout] 44: 0x0 - [INFO] [stdout] [INFO] [stdout] ---- perf_query_analyze_cached stdout ---- [INFO] [stdout] [INFO] [stdout] thread 'perf_query_analyze_cached' (71) panicked at tests/subscription_test.rs:377:5: [INFO] [stdout] analyze cache too slow: 291.016513ms (2910 ns/op) [INFO] [stdout] stack backtrace: [INFO] [stdout] 0: 0x613d4f96115a - std[e72de78501789eb0]::backtrace_rs::backtrace::libunwind::trace [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9 [INFO] [stdout] 1: 0x613d4f96115a - std[e72de78501789eb0]::backtrace_rs::backtrace::trace_unsynchronized:: [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14 [INFO] [stdout] 2: 0x613d4f96115a - std[e72de78501789eb0]::sys::backtrace::_print_fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:74:9 [INFO] [stdout] 3: 0x613d4f96115a - <::print::DisplayBacktrace as core[6aaeda2c7ad07a48]::fmt::Display>::fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:44:26 [INFO] [stdout] 4: 0x613d4f97747a - ::fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/fmt/rt.rs:152:76 [INFO] [stdout] 5: 0x613d4f97747a - core[6aaeda2c7ad07a48]::fmt::write [INFO] [stdout] 6: 0x613d4f965a32 - std[e72de78501789eb0]::io::default_write_fmt::> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/io/mod.rs:639:11 [INFO] [stdout] 7: 0x613d4f965a32 - as std[e72de78501789eb0]::io::Write>::write_fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/io/mod.rs:1994:13 [INFO] [stdout] 8: 0x613d4f9400bf - ::print [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:47:9 [INFO] [stdout] 9: 0x613d4f9400bf - std[e72de78501789eb0]::panicking::default_hook::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:292:27 [INFO] [stdout] 10: 0x613d4f9594a9 - std[e72de78501789eb0]::panicking::default_hook [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:316:9 [INFO] [stdout] 11: 0x613d4f53c41c - core[6aaeda2c7ad07a48]::ops::function::Fn<(&'a std[e72de78501789eb0]::panic::PanicHookInfo<'b>,), Output = ()> + core[6aaeda2c7ad07a48]::marker::Sync + core[6aaeda2c7ad07a48]::marker::Send> as core[6aaeda2c7ad07a48]::ops::function::Fn<(&std[e72de78501789eb0]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 12: 0x613d4f53c41c - test[4f12b380f1fb68c5]::test_main_with_exit_callback::::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:145:21 [INFO] [stdout] 13: 0x613d4f959722 - core[6aaeda2c7ad07a48]::ops::function::Fn<(&'a std[e72de78501789eb0]::panic::PanicHookInfo<'b>,), Output = ()> + core[6aaeda2c7ad07a48]::marker::Sync + core[6aaeda2c7ad07a48]::marker::Send> as core[6aaeda2c7ad07a48]::ops::function::Fn<(&std[e72de78501789eb0]::panic::PanicHookInfo,)>>::call [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/alloc/src/boxed.rs:2254:9 [INFO] [stdout] 14: 0x613d4f959722 - std[e72de78501789eb0]::panicking::panic_with_hook [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:833:13 [INFO] [stdout] 15: 0x613d4f940178 - std[e72de78501789eb0]::panicking::panic_handler::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:698:13 [INFO] [stdout] 16: 0x613d4f937b19 - std[e72de78501789eb0]::sys::backtrace::__rust_end_short_backtrace:: [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:182:18 [INFO] [stdout] 17: 0x613d4f940e8d - __rustc[78a4cf188af856fc]::rust_begin_unwind [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:689:5 [INFO] [stdout] 18: 0x613d4f977c2c - core[6aaeda2c7ad07a48]::panicking::panic_fmt [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/panicking.rs:80:14 [INFO] [stdout] 19: 0x613d4f528251 - subscription_test[e1678f61d360658c]::perf_query_analyze_cached [INFO] [stdout] at /opt/rustwide/workdir/tests/subscription_test.rs:377:5 [INFO] [stdout] 20: 0x613d4f528251 - subscription_test[e1678f61d360658c]::perf_query_analyze_cached::{closure#0} [INFO] [stdout] at /opt/rustwide/workdir/tests/subscription_test.rs:364:31 [INFO] [stdout] 21: 0x613d4f528251 - >::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 22: 0x613d4f5304fb - core[6aaeda2c7ad07a48]::result::Result<(), alloc[28d2dab30c1dc666]::string::String> as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 23: 0x613d4f5304fb - test[4f12b380f1fb68c5]::__rust_begin_short_backtrace::, fn() -> core[6aaeda2c7ad07a48]::result::Result<(), alloc[28d2dab30c1dc666]::string::String>> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:663:18 [INFO] [stdout] 24: 0x613d4f53ceeb - test[4f12b380f1fb68c5]::run_test_in_process::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:686:74 [INFO] [stdout] 25: 0x613d4f53ceeb - as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 26: 0x613d4f53ceeb - std[e72de78501789eb0]::panicking::catch_unwind::do_call::, core[6aaeda2c7ad07a48]::result::Result<(), alloc[28d2dab30c1dc666]::string::String>> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:581:40 [INFO] [stdout] 27: 0x613d4f53ceeb - std[e72de78501789eb0]::panicking::catch_unwind::, core[6aaeda2c7ad07a48]::panic::unwind_safe::AssertUnwindSafe> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:544:19 [INFO] [stdout] 28: 0x613d4f53ceeb - std[e72de78501789eb0]::panic::catch_unwind::, core[6aaeda2c7ad07a48]::result::Result<(), alloc[28d2dab30c1dc666]::string::String>> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panic.rs:359:14 [INFO] [stdout] 29: 0x613d4f53ceeb - test[4f12b380f1fb68c5]::run_test_in_process [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:686:27 [INFO] [stdout] 30: 0x613d4f53ceeb - test[4f12b380f1fb68c5]::run_test::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:607:43 [INFO] [stdout] 31: 0x613d4f538604 - test[4f12b380f1fb68c5]::run_test::{closure#1} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/test/src/lib.rs:637:41 [INFO] [stdout] 32: 0x613d4f538604 - std[e72de78501789eb0]::sys::backtrace::__rust_begin_short_backtrace:: [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/backtrace.rs:166:18 [INFO] [stdout] 33: 0x613d4f53faf2 - std[e72de78501789eb0]::thread::lifecycle::spawn_unchecked::::{closure#1}::{closure#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/thread/lifecycle.rs:91:13 [INFO] [stdout] 34: 0x613d4f53faf2 - ::{closure#1}::{closure#0}> as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/panic/unwind_safe.rs:275:9 [INFO] [stdout] 35: 0x613d4f53faf2 - std[e72de78501789eb0]::panicking::catch_unwind::do_call::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:581:40 [INFO] [stdout] 36: 0x613d4f53faf2 - std[e72de78501789eb0]::panicking::catch_unwind::<(), core[6aaeda2c7ad07a48]::panic::unwind_safe::AssertUnwindSafe::{closure#1}::{closure#0}>> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panicking.rs:544:19 [INFO] [stdout] 37: 0x613d4f53faf2 - std[e72de78501789eb0]::panic::catch_unwind::::{closure#1}::{closure#0}>, ()> [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/panic.rs:359:14 [INFO] [stdout] 38: 0x613d4f53faf2 - std[e72de78501789eb0]::thread::lifecycle::spawn_unchecked::::{closure#1} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/thread/lifecycle.rs:89:26 [INFO] [stdout] 39: 0x613d4f53faf2 - ::{closure#1} as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0} [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/core/src/ops/function.rs:250:5 [INFO] [stdout] 40: 0x613d4f960a2f - + core[6aaeda2c7ad07a48]::marker::Send> as core[6aaeda2c7ad07a48]::ops::function::FnOnce<()>>::call_once [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/alloc/src/boxed.rs:2240:9 [INFO] [stdout] 41: 0x613d4f960a2f - ::new::thread_start [INFO] [stdout] at /rustc/dec9417b8611e34e787a3e4c37686b5131f9e5c5/library/std/src/sys/thread/unix.rs:118:17 [INFO] [stdout] 42: 0x7211465b8aa4 - [INFO] [stdout] 43: 0x721146645a64 - clone [INFO] [stdout] 44: 0x0 - [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] failures: [INFO] [stdout] perf_query_analyze_cached [INFO] [stdout] perf_snapshot_diff_100_rows [INFO] [stdout] [INFO] [stdout] test result: FAILED. 18 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.08s [INFO] [stdout] [INFO] [stderr] error: test failed, to rerun pass `--test subscription_test` [INFO] running `Command { std: "docker" "inspect" "347ada3c5aae98e784a1c91e7fa92c9be7a09267b030bfd33699a602fa982038", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "347ada3c5aae98e784a1c91e7fa92c9be7a09267b030bfd33699a602fa982038", kill_on_drop: false }` [INFO] [stdout] 347ada3c5aae98e784a1c91e7fa92c9be7a09267b030bfd33699a602fa982038