[INFO] fetching crate mpdpopm 0.2.3...
[INFO] testing mpdpopm-0.2.3 against 1.54.0 for beta-1.55-1
[INFO] extracting crate mpdpopm 0.2.3 into /workspace/builds/worker-2/source
[INFO] validating manifest of crates.io crate mpdpopm 0.2.3 on toolchain 1.54.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate mpdpopm 0.2.3
[INFO] finished tweaking crates.io crate mpdpopm 0.2.3
[INFO] tweaked toml for crates.io crate mpdpopm 0.2.3 written to /workspace/builds/worker-2/source/Cargo.toml
[INFO] crate crates.io crate mpdpopm 0.2.3 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.54.0" "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-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 18abc0ba304563f92b6280d12a0a1daca0d18f841b6684050c84d493f31a5dd6
[INFO] running `Command { std: "docker" "start" "-a" "18abc0ba304563f92b6280d12a0a1daca0d18f841b6684050c84d493f31a5dd6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "18abc0ba304563f92b6280d12a0a1daca0d18f841b6684050c84d493f31a5dd6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "18abc0ba304563f92b6280d12a0a1daca0d18f841b6684050c84d493f31a5dd6", kill_on_drop: false }`
[INFO] [stdout] 18abc0ba304563f92b6280d12a0a1daca0d18f841b6684050c84d493f31a5dd6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 21bcda8da2a989f15fa572fe91c7d7cb3a5a926a09bc376c10547d0af618b94d
[INFO] running `Command { std: "docker" "start" "-a" "21bcda8da2a989f15fa572fe91c7d7cb3a5a926a09bc376c10547d0af618b94d", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling proc-macro2 v1.0.9
[INFO] [stderr]    Compiling syn v1.0.16
[INFO] [stderr]    Compiling libc v0.2.74
[INFO] [stderr]    Compiling serde v1.0.104
[INFO] [stderr]    Compiling log v0.4.8
[INFO] [stderr]    Compiling crunchy v0.2.2
[INFO] [stderr]    Compiling ryu v1.0.2
[INFO] [stderr]    Compiling proc-macro-nested v0.1.3
[INFO] [stderr]    Compiling cc v1.0.52
[INFO] [stderr]    Compiling siphasher v0.3.3
[INFO] [stderr]    Compiling tiny-keccak v2.0.2
[INFO] [stderr]    Compiling futures-core v0.3.5
[INFO] [stderr]    Compiling futures-sink v0.3.5
[INFO] [stderr]    Compiling bit-vec v0.6.3
[INFO] [stderr]    Compiling once_cell v1.4.0
[INFO] [stderr]    Compiling linked-hash-map v0.5.2
[INFO] [stderr]    Compiling pico-args v0.4.0
[INFO] [stderr]    Compiling futures-io v0.3.5
[INFO] [stderr]    Compiling arc-swap v0.4.4
[INFO] [stderr]    Compiling diff v0.1.12
[INFO] [stderr]    Compiling rustc-demangle v0.1.16
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling os_str_bytes v2.3.2
[INFO] [stderr]    Compiling boolinator v2.4.0
[INFO] [stderr]    Compiling num-traits v0.2.11
[INFO] [stderr]    Compiling proc-macro-error-attr v0.4.12
[INFO] [stderr]    Compiling proc-macro-error v0.4.12
[INFO] [stderr]    Compiling itertools v0.10.0
[INFO] [stderr]    Compiling petgraph v0.5.1
[INFO] [stderr]    Compiling lalrpop-util v0.19.5
[INFO] [stderr]    Compiling futures-task v0.3.5
[INFO] [stderr]    Compiling yaml-rust v0.4.3
[INFO] [stderr]    Compiling futures-channel v0.3.5
[INFO] [stderr]    Compiling phf_shared v0.8.0
[INFO] [stderr]    Compiling bit-set v0.5.2
[INFO] [stderr]    Compiling string_cache v0.8.1
[INFO] [stderr]    Compiling quote v1.0.3
[INFO] [stderr]    Compiling backtrace-sys v0.1.37
[INFO] [stderr]    Compiling dirs v1.0.5
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling iovec v0.1.4
[INFO] [stderr]    Compiling net2 v0.2.33
[INFO] [stderr]    Compiling time v0.1.44
[INFO] [stderr]    Compiling signal-hook-registry v1.2.0
[INFO] [stderr]    Compiling num_cpus v1.12.0
[INFO] [stderr]    Compiling flate2 v1.0.13
[INFO] [stderr]    Compiling thread-id v3.3.0
[INFO] [stderr]    Compiling errno v0.2.6
[INFO] [stderr]    Compiling num-integer v0.1.42
[INFO] [stderr]    Compiling ordered-float v1.0.2
[INFO] [stderr]    Compiling term v0.5.2
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling ascii-canvas v2.0.0
[INFO] [stderr]    Compiling backtrace v0.3.46
[INFO] [stderr]    Compiling syn-mid v0.5.0
[INFO] [stderr]    Compiling serde_derive v1.0.104
[INFO] [stderr]    Compiling proc-macro-hack v0.5.11
[INFO] [stderr]    Compiling pin-project-internal v0.4.17
[INFO] [stderr]    Compiling tokio-macros v0.2.5
[INFO] [stderr]    Compiling snafu-derive v0.6.7
[INFO] [stderr]    Compiling async-trait v0.1.31
[INFO] [stderr]    Compiling clap_derive v3.0.0-beta.1
[INFO] [stderr]    Compiling futures-macro v0.3.5
[INFO] [stderr]    Compiling lexpr-macros v0.2.1
[INFO] [stderr]    Compiling lexpr v0.2.4
[INFO] [stderr]    Compiling pin-project v0.4.17
[INFO] [stderr]    Compiling snafu v0.6.7
[INFO] [stderr]    Compiling futures-util v0.3.5
[INFO] [stderr]    Compiling clap v3.0.0-beta.1
[INFO] [stderr]    Compiling futures-executor v0.3.5
[INFO] [stderr]    Compiling futures v0.3.5
[INFO] [stderr]    Compiling serde_yaml v0.8.11
[INFO] [stderr]    Compiling serde-value v0.6.0
[INFO] [stderr]    Compiling serde_json v1.0.48
[INFO] [stderr]    Compiling serde-lexpr v0.1.1
[INFO] [stderr]    Compiling ena v0.14.0
[INFO] [stderr]    Compiling mio v0.6.21
[INFO] [stderr]    Compiling lalrpop v0.19.5
[INFO] [stderr]    Compiling mio-uds v0.6.7
[INFO] [stderr]    Compiling log4rs v0.10.0
[INFO] [stderr]    Compiling tokio v0.2.22
[INFO] [stderr]    Compiling mpdpopm v0.2.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unnecessary trailing semicolon
[INFO] [stdout]     --> src/clients.rs:1282:10
[INFO] [stdout]      |
[INFO] [stdout] 1282 |         };
[INFO] [stdout]      |          ^ help: remove this semicolon
[INFO] [stdout]      |
[INFO] [stdout]      = note: `#[warn(redundant_semicolons)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 39s
[INFO] running `Command { std: "docker" "inspect" "21bcda8da2a989f15fa572fe91c7d7cb3a5a926a09bc376c10547d0af618b94d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "21bcda8da2a989f15fa572fe91c7d7cb3a5a926a09bc376c10547d0af618b94d", kill_on_drop: false }`
[INFO] [stdout] 21bcda8da2a989f15fa572fe91c7d7cb3a5a926a09bc376c10547d0af618b94d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9adb87e49b9b6e53432ffaf3083c4802206280fc04d559a6fbd5d262ea7c24c5
[INFO] running `Command { std: "docker" "start" "-a" "9adb87e49b9b6e53432ffaf3083c4802206280fc04d559a6fbd5d262ea7c24c5", kill_on_drop: false }`
[INFO] [stderr]    Compiling mpdpopm v0.2.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unnecessary trailing semicolon
[INFO] [stdout]     --> src/clients.rs:1282:10
[INFO] [stdout]      |
[INFO] [stdout] 1282 |         };
[INFO] [stdout]      |          ^ help: remove this semicolon
[INFO] [stdout]      |
[INFO] [stdout]      = note: `#[warn(redundant_semicolons)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unnecessary trailing semicolon
[INFO] [stdout]     --> src/clients.rs:1282:10
[INFO] [stdout]      |
[INFO] [stdout] 1282 |         };
[INFO] [stdout]      |          ^ help: remove this semicolon
[INFO] [stdout]      |
[INFO] [stdout]      = note: `#[warn(redundant_semicolons)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 8.22s
[INFO] running `Command { std: "docker" "inspect" "9adb87e49b9b6e53432ffaf3083c4802206280fc04d559a6fbd5d262ea7c24c5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9adb87e49b9b6e53432ffaf3083c4802206280fc04d559a6fbd5d262ea7c24c5", kill_on_drop: false }`
[INFO] [stdout] 9adb87e49b9b6e53432ffaf3083c4802206280fc04d559a6fbd5d262ea7c24c5
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/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" "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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+1.54.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] aaacfd968eb5a2e2a6df5bf2bee2242467bd5ba2b2761634db57078d41409473
[INFO] running `Command { std: "docker" "start" "-a" "aaacfd968eb5a2e2a6df5bf2bee2242467bd5ba2b2761634db57078d41409473", kill_on_drop: false }`
[INFO] [stderr] warning: unnecessary trailing semicolon
[INFO] [stderr]     --> src/clients.rs:1282:10
[INFO] [stderr]      |
[INFO] [stderr] 1282 |         };
[INFO] [stderr]      |          ^ help: remove this semicolon
[INFO] [stderr]      |
[INFO] [stderr]      = note: `#[warn(redundant_semicolons)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: 1 warning emitted
[INFO] [stderr] 
[INFO] [stderr] warning: unnecessary trailing semicolon
[INFO] [stderr]     --> src/clients.rs:1282:10
[INFO] [stderr]      |
[INFO] [stderr] 1282 |         };
[INFO] [stderr]      |          ^ help: remove this semicolon
[INFO] [stderr]      |
[INFO] [stderr]      = note: `#[warn(redundant_semicolons)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: 1 warning emitted
[INFO] [stderr] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/mpdpopm-132013211dc417b0)
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test ratings::rating_request_tests::rating_request_smoke ... ok
[INFO] [stdout] test clients::idle_client_tests::test_get_messages ... ok
[INFO] [stdout] test messages::tokenize_tests::tokenize_smoke ... ok
[INFO] [stdout] test clients::client_tests::client_smoke_test ... ok
[INFO] [stdout] test filters_ast::iso_8601_tests::smoke_tests ... ok
[INFO] [stdout] test filters_ast::quoted_tests::smoke_tests ... ok
[INFO] [stdout] test clients::test_mock::mock_smoke_test ... ok
[INFO] [stdout] test messages::tokenize_tests::tokenize_filter ... ok
[INFO] [stdout] test commands::test_replacement_strings::test_process_replacements ... ok
[INFO] [stdout] test clients::idle_client_tests::test_issue_1 ... ok
[INFO] [stdout] test playcounts::player_state_tests::player_state_smoke ... FAILED
[INFO] [stdout] test clients::test_mock::mock_negative_test - should panic ... ok
[INFO] [stdout] test clients::client_tests::test_get_stored_playlists ... ok
[INFO] [stdout] test filters_ast::smoke_tests::test_disjunction ... ok
[INFO] [stdout] test filters_ast::evaluation_tests::smoke ... ok
[INFO] [stdout] test clients::client_tests::test_get_sticker ... ok
[INFO] [stdout] test filters_ast::smoke_tests::test_real_expression ... ok
[INFO] [stdout] test clients::client_tests::test_update ... ok
[INFO] [stdout] test clients::client_tests::test_send_to_playlist ... ok
[INFO] [stdout] test clients::client_tests::test_set_sticker ... ok
[INFO] [stdout] test clients::client_tests::test_status ... ok
[INFO] [stdout] test filters_ast::smoke_tests::test_quoted_expr ... ok
[INFO] [stdout] test playcounts::pc_lp_tests::pc_smoke ... ok
[INFO] [stdout] test filters_ast::smoke_tests::test_opcodes ... ok
[INFO] [stdout] test filters_ast::smoke_tests::test_expressions ... ok
[INFO] [stdout] test filters_ast::smoke_tests::test_conjunction ... ok
[INFO] [stdout] test filters_ast::smoke_tests::test_conditions ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- playcounts::player_state_tests::player_state_smoke stdout ----
[INFO] [stdout] thread 'playcounts::player_state_tests::player_state_smoke' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `"sticker set song \"E/Enya - Wild Child.mp3\" \"lp\" \"1628319413\""`,
[INFO] [stdout]  right: `"sticker set song \"E/Enya - Wild Child.mp3\" \"lp\" \"1628319412\""`', src/clients.rs:322:13
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55b7686491a0 - std::backtrace_rs::backtrace::libunwind::trace::h34055254b57d8e79
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/libunwind.rs:90:5
[INFO] [stdout]    1:     0x55b7686491a0 - std::backtrace_rs::backtrace::trace_unsynchronized::h8f1e3fbd9afff6ec
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55b7686491a0 - std::sys_common::backtrace::_print_fmt::h3a99a796b770c360
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55b7686491a0 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h32d1f94a80615d18
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:46:22
[INFO] [stdout]    4:     0x55b76866d0ec - core::fmt::write::h306731c068f7162c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/fmt/mod.rs:1110:17
[INFO] [stdout]    5:     0x55b768645b05 - std::io::Write::write_fmt::h87f19b0a2cd190bc
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/io/mod.rs:1588:15
[INFO] [stdout]    6:     0x55b76864b37b - std::sys_common::backtrace::_print::h5abaa2601a852287
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:49:5
[INFO] [stdout]    7:     0x55b76864b37b - std::sys_common::backtrace::print::h8d81445442bb638f
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:36:9
[INFO] [stdout]    8:     0x55b76864b37b - std::panicking::default_hook::{{closure}}::hcfe804496a9fa747
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:208:50
[INFO] [stdout]    9:     0x55b76864ae8c - std::panicking::default_hook::hbea8e3ccf2ba8901
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:222:9
[INFO] [stdout]   10:     0x55b76864ba44 - std::panicking::rust_panic_with_hook::h7ee9e1a2d0f8975a
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:622:17
[INFO] [stdout]   11:     0x55b76864b527 - std::panicking::begin_panic_handler::{{closure}}::h8ab3b4491718b2c7
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:519:13
[INFO] [stdout]   12:     0x55b76864969c - std::sys_common::backtrace::__rust_end_short_backtrace::hd489062ffa586a9f
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:141:18
[INFO] [stdout]   13:     0x55b76864b489 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:515:5
[INFO] [stdout]   14:     0x55b76823ac91 - core::panicking::panic_fmt::hca6330e3e14086b4
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/panicking.rs:92:14
[INFO] [stdout]   15:     0x55b76866b9d8 - core::panicking::assert_failed_inner::h33b45280069a80ed
[INFO] [stdout]   16:     0x55b7683202ae - core::panicking::assert_failed::h3570e33b91dd61a3
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/panicking.rs:117:5
[INFO] [stdout]   17:     0x55b76826cd69 - <mpdpopm::clients::test_mock::Mock as mpdpopm::clients::RequestResponse>::req_w_hint::__req_w_hint::{{closure}}::ha76d95dfe6d583ed
[INFO] [stdout]                                at /opt/rustwide/workdir/src/clients.rs:322:13
[INFO] [stdout]   18:     0x55b7683228f5 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h1ed0d06816e83917
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   19:     0x55b7683035a5 - <core::pin::Pin<P> as core::future::future::Future>::poll::h659539641bf8a9cd
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/future.rs:119:9
[INFO] [stdout]   20:     0x55b76826c97b - <mpdpopm::clients::test_mock::Mock as mpdpopm::clients::RequestResponse>::req::__req::{{closure}}::h27bc38aca08d99a7
[INFO] [stdout]                                at /opt/rustwide/workdir/src/clients.rs:319:13
[INFO] [stdout]   21:     0x55b768323b15 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h9890bcd6bed58e18
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   22:     0x55b7683035a5 - <core::pin::Pin<P> as core::future::future::Future>::poll::h659539641bf8a9cd
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/future.rs:119:9
[INFO] [stdout]   23:     0x55b768255597 - mpdpopm::clients::Client::set_sticker::{{closure}}::hfce68146a9c540f0
[INFO] [stdout]                                at /opt/rustwide/workdir/src/clients.rs:663:20
[INFO] [stdout]   24:     0x55b7683235d7 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h76bbe0bde7305613
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   25:     0x55b7682bafa1 - mpdpopm::playcounts::set_last_played::{{closure}}::h2fdc183b41f02f3a
[INFO] [stdout]                                at /opt/rustwide/workdir/src/playcounts.rs:135:5
[INFO] [stdout]   26:     0x55b768322551 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h0c0e2956aee1c93c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   27:     0x55b7682bd413 - mpdpopm::playcounts::PlayState::update::{{closure}}::h8683742d8167e912
[INFO] [stdout]                                at /opt/rustwide/workdir/src/playcounts.rs:270:21
[INFO] [stdout]   28:     0x55b7683231af - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h609118b10a3b0c02
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   29:     0x55b76831ac36 - mpdpopm::playcounts::player_state_tests::player_state_smoke::{{closure}}::h9bc018e181ac0268
[INFO] [stdout]                                at /opt/rustwide/workdir/src/playcounts.rs:454:15
[INFO] [stdout]   30:     0x55b768322bd9 - <core::future::from_generator::GenFuture<T> as core::future::future::Future>::poll::h36d2dad015b4bc45
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/future/mod.rs:80:19
[INFO] [stdout]   31:     0x55b7682ea7f0 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::{{closure}}::he9e9cfd706e36029
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:58
[INFO] [stdout]   32:     0x55b7682deb7c - tokio::coop::with_budget::{{closure}}::h2b62ef431817aa38
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/coop.rs:127:9
[INFO] [stdout]   33:     0x55b7682f2af1 - std::thread::local::LocalKey<T>::try_with::h25fd0043ecc41444
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/local.rs:400:16
[INFO] [stdout]   34:     0x55b7682f041d - std::thread::local::LocalKey<T>::with::h5326e2ca55e40c93
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/local.rs:376:9
[INFO] [stdout]   35:     0x55b7682e5107 - tokio::coop::with_budget::hd17cb10261d701da
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/coop.rs:120:5
[INFO] [stdout]   36:     0x55b7682e5107 - tokio::coop::budget::he73c89488f46fcc2
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/coop.rs:96:5
[INFO] [stdout]   37:     0x55b7682e5107 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::{{closure}}::h6601e05c3d5cd9c0
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/runtime/basic_scheduler.rs:131:35
[INFO] [stdout]   38:     0x55b7682edfa1 - tokio::runtime::basic_scheduler::enter::{{closure}}::h79a0845307edbe0e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:29
[INFO] [stdout]   39:     0x55b768267590 - tokio::macros::scoped_tls::ScopedKey<T>::set::hfd047ee71ad205db
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/macros/scoped_tls.rs:63:9
[INFO] [stdout]   40:     0x55b7682eb84e - tokio::runtime::basic_scheduler::enter::h0c3e70402eeac644
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/runtime/basic_scheduler.rs:213:5
[INFO] [stdout]   41:     0x55b7682e2210 - tokio::runtime::basic_scheduler::BasicScheduler<P>::block_on::h1cf9001017167472
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/runtime/basic_scheduler.rs:123:9
[INFO] [stdout]   42:     0x55b768279d8c - tokio::runtime::Runtime::block_on::{{closure}}::h3198ff5137088102
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/runtime/mod.rs:444:34
[INFO] [stdout]   43:     0x55b768267ffd - tokio::runtime::context::enter::h4c46a815bf939cd8
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/runtime/context.rs:72:5
[INFO] [stdout]   44:     0x55b76824b3a8 - tokio::runtime::handle::Handle::enter::h2c15338e6734167e
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/runtime/handle.rs:76:9
[INFO] [stdout]   45:     0x55b76827992d - tokio::runtime::Runtime::block_on::h89373f6e22eb5ff6
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/github.com-1ecc6299db9ec823/tokio-0.2.22/src/runtime/mod.rs:441:9
[INFO] [stdout]   46:     0x55b768319985 - mpdpopm::playcounts::player_state_tests::player_state_smoke::hf611d7d43ab2fad6
[INFO] [stdout]                                at /opt/rustwide/workdir/src/playcounts.rs:311:5
[INFO] [stdout]   47:     0x55b76831989a - mpdpopm::playcounts::player_state_tests::player_state_smoke::{{closure}}::h9e6b08446fb7c99c
[INFO] [stdout]                                at /opt/rustwide/workdir/src/playcounts.rs:311:5
[INFO] [stdout]   48:     0x55b7682c0ade - core::ops::function::FnOnce::call_once::hcaf980771f0527b0
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   49:     0x55b76834eee3 - core::ops::function::FnOnce::call_once::h152e7e439ff59e19
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   50:     0x55b76834eee3 - test::__rust_begin_short_backtrace::h0908f3b1fdbb72ab
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:577:5
[INFO] [stdout]   51:     0x55b76834d9a0 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hf6d2a51e5587546c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   52:     0x55b76834d9a0 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h8af660f3a89ef593
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:347:9
[INFO] [stdout]   53:     0x55b76834d9a0 - std::panicking::try::do_call::hd36aef60f84b6d36
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:401:40
[INFO] [stdout]   54:     0x55b76834d9a0 - std::panicking::try::h9932b4480e69817c
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:365:19
[INFO] [stdout]   55:     0x55b76834d9a0 - std::panic::catch_unwind::h6aa177099cfff5f8
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:434:14
[INFO] [stdout]   56:     0x55b76834d9a0 - test::run_test_in_process::h5884d6f2d99e20c3
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:600:18
[INFO] [stdout]   57:     0x55b76834d9a0 - test::run_test::run_test_inner::{{closure}}::h6fdc58c6d5f5b6e3
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:492:39
[INFO] [stdout]   58:     0x55b768327052 - test::run_test::run_test_inner::{{closure}}::h408365d67a78ade8
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/test/src/lib.rs:519:37
[INFO] [stdout]   59:     0x55b768327052 - std::sys_common::backtrace::__rust_begin_short_backtrace::hb560b77c4f701523
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys_common/backtrace.rs:125:18
[INFO] [stdout]   60:     0x55b76832ac08 - std::thread::Builder::spawn_unchecked::{{closure}}::{{closure}}::hf2e7831dad93c597
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/mod.rs:481:17
[INFO] [stdout]   61:     0x55b76832ac08 - <std::panic::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hd2e08783d8be4d02
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:347:9
[INFO] [stdout]   62:     0x55b76832ac08 - std::panicking::try::do_call::h062597b7acfd6b82
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:401:40
[INFO] [stdout]   63:     0x55b76832ac08 - std::panicking::try::h0d7b79db04c14552
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panicking.rs:365:19
[INFO] [stdout]   64:     0x55b76832ac08 - std::panic::catch_unwind::hb01a0b5e7c8cd43b
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/panic.rs:434:14
[INFO] [stdout]   65:     0x55b76832ac08 - std::thread::Builder::spawn_unchecked::{{closure}}::h5bde48cc887e0d1e
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/thread/mod.rs:480:30
[INFO] [stdout]   66:     0x55b76832ac08 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h745ea30807a29e55
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/core/src/ops/function.rs:227:5
[INFO] [stdout]   67:     0x55b7686507c7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h7ece6cfefaff1005
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   68:     0x55b7686507c7 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hb8b48e55c21f193e
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/alloc/src/boxed.rs:1575:9
[INFO] [stdout]   69:     0x55b7686507c7 - std::sys::unix::thread::Thread::new::thread_start::h8c7c4450dba62914
[INFO] [stdout]                                at /rustc/a178d0322ce20e33eac124758e837cbd80a6f633/library/std/src/sys/unix/thread.rs:71:17
[INFO] [stdout]   70:     0x7f27c7702609 - start_thread
[INFO] [stdout]   71:     0x7f27c74da293 - clone
[INFO] [stdout]   72:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     playcounts::player_state_tests::player_state_smoke
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 26 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.48s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass '--lib'
[INFO] running `Command { std: "docker" "inspect" "aaacfd968eb5a2e2a6df5bf2bee2242467bd5ba2b2761634db57078d41409473", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aaacfd968eb5a2e2a6df5bf2bee2242467bd5ba2b2761634db57078d41409473", kill_on_drop: false }`
[INFO] [stdout] aaacfd968eb5a2e2a6df5bf2bee2242467bd5ba2b2761634db57078d41409473
