[INFO] cloning repository https://github.com/Hellrespawn/taprtools
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Hellrespawn/taprtools" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FHellrespawn%2Ftaprtools", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FHellrespawn%2Ftaprtools'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 2516a117f8d3ad2e723c554ca53c2948b1295d9e
[INFO] testing Hellrespawn/taprtools against 1.75.0 for beta-1.76-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FHellrespawn%2Ftaprtools" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Hellrespawn/taprtools on toolchain 1.75.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.75.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/Hellrespawn/taprtools
[INFO] finished tweaking git repo https://github.com/Hellrespawn/taprtools
[INFO] tweaked toml for git repo https://github.com/Hellrespawn/taprtools written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] crate git repo https://github.com/Hellrespawn/taprtools 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" "+1.75.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Updating git repository `https://github.com/Hellrespawn/tapr.git`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded difflib v0.4.0
[INFO] [stderr]   Downloaded thiserror-impl v1.0.40
[INFO] [stderr]   Downloaded quote v1.0.28
[INFO] [stderr]   Downloaded clipboard-win v4.5.0
[INFO] [stderr]   Downloaded str-buf v1.0.6
[INFO] [stderr]   Downloaded normalize-line-endings v0.3.0
[INFO] [stderr]   Downloaded termtree v0.2.4
[INFO] [stderr]   Downloaded lofty_attr v0.8.0
[INFO] [stderr]   Downloaded error-code v2.3.1
[INFO] [stderr]   Downloaded endian-type v0.1.2
[INFO] [stderr]   Downloaded doc-comment v0.3.3
[INFO] [stderr]   Downloaded predicates-core v1.0.3
[INFO] [stderr]   Downloaded os_str_bytes v6.0.0
[INFO] [stderr]   Downloaded predicates v2.1.1
[INFO] [stderr]   Downloaded thiserror v1.0.40
[INFO] [stderr]   Downloaded clap v3.1.5
[INFO] [stderr]   Downloaded rustyline v10.1.1
[INFO] [stderr]   Downloaded libc v0.2.146
[INFO] [stderr]   Downloaded pest v2.6.1
[INFO] [stderr]   Downloaded serde_json v1.0.79
[INFO] [stderr]   Downloaded lofty v0.14.0
[INFO] [stderr]   Downloaded rustix v0.37.20
[INFO] [stderr]   Downloaded syn v2.0.18
[INFO] [stderr]   Downloaded paste v1.0.12
[INFO] [stderr]   Downloaded clap_derive v3.1.4
[INFO] [stderr]   Downloaded assert_cmd v2.0.4
[INFO] [stderr]   Downloaded ryu v1.0.9
[INFO] [stderr]   Downloaded pest_generator v2.6.1
[INFO] [stderr]   Downloaded anyhow v1.0.55
[INFO] [stderr]   Downloaded crossbeam-utils v0.8.7
[INFO] [stderr]   Downloaded base64 v0.21.2
[INFO] [stderr]   Downloaded unicode-ident v1.0.9
[INFO] [stderr]   Downloaded io-lifetimes v1.0.11
[INFO] [stderr]   Downloaded pest_derive v2.6.1
[INFO] [stderr]   Downloaded proc-macro2 v1.0.60
[INFO] [stderr]   Downloaded pest_meta v2.6.1
[INFO] [stderr]   Downloaded radix_trie v0.2.1
[INFO] [stderr]   Downloaded predicates-tree v1.0.5
[INFO] [stderr]   Downloaded getrandom v0.2.5
[INFO] [stderr]   Downloaded fd-lock v3.0.12
[INFO] [stderr]   Downloaded assert_fs v1.0.7
[INFO] [stderr]   Downloaded nibble_vec v0.1.0
[INFO] [stderr]   Downloaded float-cmp v0.9.0
[INFO] [stderr]   Downloaded redox_syscall v0.2.11
[INFO] [stderr]   Downloaded dirs-next v2.0.0
[INFO] [stderr]   Downloaded which v4.4.0
[INFO] [stderr]   Downloaded ogg_pager v0.5.0
[INFO] [stderr]   Downloaded wait-timeout v0.2.0
[INFO] [stderr]   Downloaded cpufeatures v0.2.8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.75.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 64ca4b3c97015b81bea35e75690d988db88f4e0222414f65edad48bd72b6a1d0
[INFO] running `Command { std: "docker" "start" "-a" "64ca4b3c97015b81bea35e75690d988db88f4e0222414f65edad48bd72b6a1d0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "64ca4b3c97015b81bea35e75690d988db88f4e0222414f65edad48bd72b6a1d0", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "64ca4b3c97015b81bea35e75690d988db88f4e0222414f65edad48bd72b6a1d0", kill_on_drop: false }`
[INFO] [stdout] 64ca4b3c97015b81bea35e75690d988db88f4e0222414f65edad48bd72b6a1d0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.75.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 3cd09138de2cf955eddddceec47d5371344beac6f0d3bbe97f0094f3231b1a66
[INFO] running `Command { std: "docker" "start" "-a" "3cd09138de2cf955eddddceec47d5371344beac6f0d3bbe97f0094f3231b1a66", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.60
[INFO] [stderr]    Compiling quote v1.0.28
[INFO] [stderr]    Compiling unicode-ident v1.0.9
[INFO] [stderr]    Compiling libc v0.2.146
[INFO] [stderr]    Compiling syn v1.0.86
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling once_cell v1.18.0
[INFO] [stderr]    Compiling io-lifetimes v1.0.11
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling rustix v0.37.20
[INFO] [stderr]    Compiling ucd-trie v0.1.5
[INFO] [stderr]    Compiling serde_derive v1.0.136
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling smallvec v1.10.0
[INFO] [stderr]    Compiling crc32fast v1.3.2
[INFO] [stderr]    Compiling log v0.4.19
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling syn v2.0.18
[INFO] [stderr]    Compiling linux-raw-sys v0.3.8
[INFO] [stderr]    Compiling indexmap v1.8.0
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling paste v1.0.12
[INFO] [stderr]    Compiling serde_json v1.0.79
[INFO] [stderr]    Compiling endian-type v0.1.2
[INFO] [stderr]    Compiling miniz_oxide v0.7.1
[INFO] [stderr]    Compiling radix_trie v0.2.1
[INFO] [stderr]    Compiling unicode-width v0.1.10
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling unicode-segmentation v1.10.1
[INFO] [stderr]    Compiling custom_derive v0.1.7
[INFO] [stderr]    Compiling ryu v1.0.9
[INFO] [stderr]    Compiling heck v0.4.0
[INFO] [stderr]    Compiling terminal_size v0.1.17
[INFO] [stderr]    Compiling dirs-sys-next v0.1.2
[INFO] [stderr]    Compiling nix v0.25.1
[INFO] [stderr]    Compiling utf8parse v0.2.1
[INFO] [stderr]    Compiling itoa v1.0.1
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling dirs-next v2.0.0
[INFO] [stderr]    Compiling anyhow v1.0.55
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling which v4.4.0
[INFO] [stderr]    Compiling textwrap v0.15.0
[INFO] [stderr]    Compiling console v0.15.0
[INFO] [stderr]    Compiling ogg_pager v0.5.0
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling dirs-sys v0.3.6
[INFO] [stderr]    Compiling conv v0.3.3
[INFO] [stderr]    Compiling flate2 v1.0.26
[INFO] [stderr]    Compiling fd-lock v3.0.12
[INFO] [stderr]    Compiling rustyline v10.1.1
[INFO] [stderr]    Compiling os_str_bytes v6.0.0
[INFO] [stderr]    Compiling base64 v0.21.2
[INFO] [stderr]    Compiling termcolor v1.1.3
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling number_prefix v0.4.0
[INFO] [stderr]    Compiling indicatif v0.16.2
[INFO] [stderr]    Compiling dirs v4.0.0
[INFO] [stderr]    Compiling buffered-iterator v0.1.0 (/opt/rustwide/workdir/buffered-iterator)
[INFO] [stderr]    Compiling dunce v1.0.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling lofty_attr v0.8.0
[INFO] [stderr]    Compiling clap_derive v3.1.4
[INFO] [stderr]    Compiling lofty v0.14.0
[INFO] [stderr]    Compiling pest v2.6.1
[INFO] [stderr]    Compiling clap v3.1.5
[INFO] [stderr]    Compiling pest_meta v2.6.1
[INFO] [stderr]    Compiling pest_generator v2.6.1
[INFO] [stderr]    Compiling pest_derive v2.6.1
[INFO] [stderr]    Compiling tapr v0.1.0 (https://github.com/Hellrespawn/tapr.git#b174fafd)
[INFO] [stderr]    Compiling file-history v0.1.0 (/opt/rustwide/workdir/file-history)
[INFO] [stderr]    Compiling taprtools v0.11.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 56.39s
[INFO] running `Command { std: "docker" "inspect" "3cd09138de2cf955eddddceec47d5371344beac6f0d3bbe97f0094f3231b1a66", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3cd09138de2cf955eddddceec47d5371344beac6f0d3bbe97f0094f3231b1a66", kill_on_drop: false }`
[INFO] [stdout] 3cd09138de2cf955eddddceec47d5371344beac6f0d3bbe97f0094f3231b1a66
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.75.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 82e0534cd806abd65a45e9623d0efb746cbfb06ba8f80814b60d0e1ad963636f
[INFO] running `Command { std: "docker" "start" "-a" "82e0534cd806abd65a45e9623d0efb746cbfb06ba8f80814b60d0e1ad963636f", kill_on_drop: false }`
[INFO] [stderr]    Compiling aho-corasick v0.7.18
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling crossbeam-utils v0.8.7
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling doc-comment v0.3.3
[INFO] [stderr]    Compiling predicates-core v1.0.3
[INFO] [stderr]    Compiling itertools v0.10.3
[INFO] [stderr]    Compiling walkdir v2.3.2
[INFO] [stderr]    Compiling bstr v0.2.17
[INFO] [stderr]    Compiling thread_local v1.1.4
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling termtree v0.2.4
[INFO] [stderr]    Compiling predicates-tree v1.0.5
[INFO] [stderr]    Compiling fastrand v1.7.0
[INFO] [stderr]    Compiling wait-timeout v0.2.0
[INFO] [stderr]    Compiling float-cmp v0.9.0
[INFO] [stderr]    Compiling test-harness v0.1.0 (/opt/rustwide/workdir/test-harness)
[INFO] [stderr]    Compiling tempfile v3.3.0
[INFO] [stderr]    Compiling indicatif v0.16.2
[INFO] [stderr]    Compiling globset v0.4.8
[INFO] [stderr]    Compiling predicates v2.1.1
[INFO] [stderr]    Compiling ignore v0.4.18
[INFO] [stderr]    Compiling taprtools v0.11.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling globwalk v0.8.1
[INFO] [stderr]    Compiling assert_fs v1.0.7
[INFO] [stderr]    Compiling assert_cmd v2.0.4
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 21.43s
[INFO] running `Command { std: "docker" "inspect" "82e0534cd806abd65a45e9623d0efb746cbfb06ba8f80814b60d0e1ad963636f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "82e0534cd806abd65a45e9623d0efb746cbfb06ba8f80814b60d0e1ad963636f", kill_on_drop: false }`
[INFO] [stdout] 82e0534cd806abd65a45e9623d0efb746cbfb06ba8f80814b60d0e1ad963636f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+1.75.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 9da6bad53315243a276170aced57404ed6acc9065a4d8b61e1c0fdcf9abaf6fb
[INFO] running `Command { std: "docker" "start" "-a" "9da6bad53315243a276170aced57404ed6acc9065a4d8b61e1c0fdcf9abaf6fb", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.17s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/taprtools-bb1c95688591a230)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stderr]      Running unittests src/bin/histviewer.rs (/opt/rustwide/target/debug/deps/histviewer-684e2635e2a26b0d)
[INFO] [stdout] test cli::commands::rename::validate::test::validate_collisions_test ... ok
[INFO] [stdout] test cli::commands::rename::tests::test_remove_dir_error_codes ... ok
[INFO] [stdout] test cli::args::test::test_preview_aggregate ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[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 src/bin/ptapr.rs (/opt/rustwide/target/debug/deps/ptapr-6a1bdfc6d220315b)
[INFO] [stderr]      Running unittests src/bin/tapr.rs (/opt/rustwide/target/debug/deps/tapr-2aa5ff301c3ae590)
[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] [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/test_tfmttools.rs (/opt/rustwide/target/debug/deps/test_tfmttools-33fff3436c8be6a5)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test test_rename_simple_input ... ok
[INFO] [stdout] test test_rename_typical_input ... FAILED
[INFO] [stdout] test test_redo_typical_input ... FAILED
[INFO] [stdout] test test_undo_typical_input ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_rename_typical_input stdout ----
[INFO] [stdout] 
[INFO] [stdout] -- assert initial config files exists --
[INFO] [stdout] /tmp/.tmpP9oYZO/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpP9oYZO/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial audio files exist --
[INFO] [stdout] /tmp/.tmpP9oYZO/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpP9oYZO/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] An error occurred:
[INFO] [stdout] [006:011] Undefined symbol 'parse-date'
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial files are missing --
[INFO] [stdout] /tmp/.tmpP9oYZO/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpP9oYZO/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpP9oYZO/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] thread 'test_rename_typical_input' panicked at tests/test_tfmttools.rs:148:19:
[INFO] [stdout] Unexpected file, failed missing(var)
[INFO] [stdout] └── var: /tmp/.tmpP9oYZO/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] 
[INFO] [stdout] path=/tmp/.tmpP9oYZO/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x562bf880bc7c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x562bf880bc7c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x562bf880bc7c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x562bf880bc7c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x562bf8837ad0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x562bf8837ad0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x562bf8808d6f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x562bf880ba64 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x562bf880ba64 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x562bf880d7a7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x562bf880d493 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x562bf878d6f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x562bf878d6f7 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x562bf880ddb8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x562bf880ddb8 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x562bf880db0e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x562bf880c146 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x562bf880d872 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x562bf874a0e5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x562bf87534d1 - assert_fs::assert::assert::h6bd869a40a1e7b25
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:151:9
[INFO] [stdout]   20:     0x562bf8752e1b - <assert_fs::fixture::child::ChildPath as assert_fs::assert::PathAssert>::assert::hb4765a9197dc5313
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:137:9
[INFO] [stdout]   21:     0x562bf8755128 - test_tfmttools::TestEnv::assert_files_missing::h6d6d91e2f1eef923
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:148:13
[INFO] [stdout]   22:     0x562bf8756aa2 - test_tfmttools::test_rename_typical_input::{{closure}}::h78574a722815388f
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:290:13
[INFO] [stdout]   23:     0x562bf875115d - test_harness::test_runner::{{closure}}::heeb8aac57a2fc7e6
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:46
[INFO] [stdout]   24:     0x562bf874bcda - std::panicking::try::do_call::h3033d6ebfcbfed78
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   25:     0x562bf874ff7b - __rust_try
[INFO] [stdout]   26:     0x562bf874ba63 - std::panicking::try::h64f3997aa1d7338c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   27:     0x562bf874b776 - std::panic::catch_unwind::h55b8d1e693948bda
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   28:     0x562bf8750e31 - test_harness::test_runner::hde4778265a268c43
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:18
[INFO] [stdout]   29:     0x562bf8756a36 - test_tfmttools::test_rename_typical_input::hd97c55bd5d5c1f71
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:284:5
[INFO] [stdout]   30:     0x562bf8756a17 - test_tfmttools::test_rename_typical_input::{{closure}}::hca0d98c07eac9be8
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:283:35
[INFO] [stdout]   31:     0x562bf874c606 - core::ops::function::FnOnce::call_once::hfc2ae045b466a499
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   32:     0x562bf8792d4f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   33:     0x562bf8792d4f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   34:     0x562bf8791d65 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   35:     0x562bf8791d65 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   36:     0x562bf8791d65 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   37:     0x562bf8791d65 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   38:     0x562bf8791d65 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   39:     0x562bf8791d65 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   40:     0x562bf8791d65 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   41:     0x562bf875a026 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   42:     0x562bf875a026 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   43:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   44:     0x562bf875f0d7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x562bf875f0d7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x562bf875f0d7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x562bf875f0d7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   49:     0x562bf875f0d7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   50:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   51:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   52:     0x562bf8814575 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   53:     0x7f472af45ac3 - <unknown>
[INFO] [stdout]   54:     0x7f472afd6bf4 - __clone
[INFO] [stdout]   55:                0x0 - <unknown>
[INFO] [stdout] thread 'test_rename_typical_input' panicked at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5:
[INFO] [stdout] assertion failed: result.is_ok()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x562bf880bc7c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x562bf880bc7c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x562bf880bc7c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x562bf880bc7c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x562bf8837ad0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x562bf8837ad0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x562bf8808d6f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x562bf880ba64 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x562bf880ba64 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x562bf880d7a7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x562bf880d493 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x562bf878d6f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x562bf878d6f7 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x562bf880ddb8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x562bf880ddb8 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x562bf880dad9 - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:649:13
[INFO] [stdout]   16:     0x562bf880c146 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x562bf880d872 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x562bf874a0e5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x562bf874a183 - core::panicking::panic::h195fc2a96298d4c3
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:127:5
[INFO] [stdout]   20:     0x562bf8750fa8 - test_harness::test_runner::hde4778265a268c43
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5
[INFO] [stdout]   21:     0x562bf8756a36 - test_tfmttools::test_rename_typical_input::hd97c55bd5d5c1f71
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:284:5
[INFO] [stdout]   22:     0x562bf8756a17 - test_tfmttools::test_rename_typical_input::{{closure}}::hca0d98c07eac9be8
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:283:35
[INFO] [stdout]   23:     0x562bf874c606 - core::ops::function::FnOnce::call_once::hfc2ae045b466a499
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x562bf8792d4f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x562bf8792d4f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   26:     0x562bf8791d65 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   27:     0x562bf8791d65 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x562bf8791d65 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x562bf8791d65 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x562bf8791d65 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x562bf8791d65 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   32:     0x562bf8791d65 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   33:     0x562bf875a026 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   34:     0x562bf875a026 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   35:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x562bf875f0d7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x562bf875f0d7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x562bf875f0d7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x562bf875f0d7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x562bf875f0d7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   43:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   44:     0x562bf8814575 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   45:     0x7f472af45ac3 - <unknown>
[INFO] [stdout]   46:     0x7f472afd6bf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_redo_typical_input stdout ----
[INFO] [stdout] 
[INFO] [stdout] -- assert initial config files exists --
[INFO] [stdout] /tmp/.tmpKGxFIS/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpKGxFIS/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial audio files exist --
[INFO] [stdout] /tmp/.tmpKGxFIS/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpKGxFIS/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] An error occurred:
[INFO] [stdout] [006:011] Undefined symbol 'parse-date'
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial files are missing --
[INFO] [stdout] /tmp/.tmpKGxFIS/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpKGxFIS/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpKGxFIS/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] thread 'test_redo_typical_input' panicked at tests/test_tfmttools.rs:148:19:
[INFO] [stdout] Unexpected file, failed missing(var)
[INFO] [stdout] └── var: /tmp/.tmpKGxFIS/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] 
[INFO] [stdout] path=/tmp/.tmpKGxFIS/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x562bf880bc7c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x562bf880bc7c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x562bf880bc7c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x562bf880bc7c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x562bf8837ad0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x562bf8837ad0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x562bf8808d6f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x562bf880ba64 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x562bf880ba64 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x562bf880d7a7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x562bf880d493 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x562bf878d6f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x562bf878d6f7 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x562bf880ddb8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x562bf880ddb8 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x562bf880db0e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x562bf880c146 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x562bf880d872 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x562bf874a0e5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x562bf87534d1 - assert_fs::assert::assert::h6bd869a40a1e7b25
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:151:9
[INFO] [stdout]   20:     0x562bf8752e1b - <assert_fs::fixture::child::ChildPath as assert_fs::assert::PathAssert>::assert::hb4765a9197dc5313
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:137:9
[INFO] [stdout]   21:     0x562bf8755128 - test_tfmttools::TestEnv::assert_files_missing::h6d6d91e2f1eef923
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:148:13
[INFO] [stdout]   22:     0x562bf8756ce2 - test_tfmttools::test_redo_typical_input::{{closure}}::h9ebeddba70e4bd31
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:342:13
[INFO] [stdout]   23:     0x562bf87510cd - test_harness::test_runner::{{closure}}::h9800e5e48b7ed814
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:46
[INFO] [stdout]   24:     0x562bf874bdca - std::panicking::try::do_call::hd894510e87355a6e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   25:     0x562bf874ff7b - __rust_try
[INFO] [stdout]   26:     0x562bf874bba3 - std::panicking::try::hbd5689d2841f2b80
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   27:     0x562bf874b7b6 - std::panic::catch_unwind::hb569d609f50ec2a9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   28:     0x562bf87503b1 - test_harness::test_runner::h1482b63a8377da1d
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:18
[INFO] [stdout]   29:     0x562bf8756c76 - test_tfmttools::test_redo_typical_input::h3dadee6c52ec4c20
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:337:5
[INFO] [stdout]   30:     0x562bf8756c57 - test_tfmttools::test_redo_typical_input::{{closure}}::hd84343748c4b2f36
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:336:33
[INFO] [stdout]   31:     0x562bf874c4b6 - core::ops::function::FnOnce::call_once::h8bf58d0272db921b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   32:     0x562bf8792d4f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   33:     0x562bf8792d4f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   34:     0x562bf8791d65 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   35:     0x562bf8791d65 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   36:     0x562bf8791d65 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   37:     0x562bf8791d65 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   38:     0x562bf8791d65 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   39:     0x562bf8791d65 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   40:     0x562bf8791d65 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   41:     0x562bf875a026 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   42:     0x562bf875a026 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   43:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   44:     0x562bf875f0d7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x562bf875f0d7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x562bf875f0d7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x562bf875f0d7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   49:     0x562bf875f0d7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   50:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   51:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   52:     0x562bf8814575 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   53:     0x7f472af45ac3 - <unknown>
[INFO] [stdout]   54:     0x7f472afd6bf4 - __clone
[INFO] [stdout]   55:                0x0 - <unknown>
[INFO] [stdout] thread 'test_redo_typical_input' panicked at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5:
[INFO] [stdout] assertion failed: result.is_ok()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x562bf880bc7c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x562bf880bc7c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x562bf880bc7c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x562bf880bc7c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x562bf8837ad0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x562bf8837ad0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x562bf8808d6f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x562bf880ba64 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x562bf880ba64 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x562bf880d7a7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x562bf880d493 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x562bf878d6f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x562bf878d6f7 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x562bf880ddb8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x562bf880ddb8 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x562bf880dad9 - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:649:13
[INFO] [stdout]   16:     0x562bf880c146 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x562bf880d872 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x562bf874a0e5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x562bf874a183 - core::panicking::panic::h195fc2a96298d4c3
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:127:5
[INFO] [stdout]   20:     0x562bf8750528 - test_harness::test_runner::h1482b63a8377da1d
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5
[INFO] [stdout]   21:     0x562bf8756c76 - test_tfmttools::test_redo_typical_input::h3dadee6c52ec4c20
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:337:5
[INFO] [stdout]   22:     0x562bf8756c57 - test_tfmttools::test_redo_typical_input::{{closure}}::hd84343748c4b2f36
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:336:33
[INFO] [stdout]   23:     0x562bf874c4b6 - core::ops::function::FnOnce::call_once::h8bf58d0272db921b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x562bf8792d4f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x562bf8792d4f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   26:     0x562bf8791d65 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   27:     0x562bf8791d65 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x562bf8791d65 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x562bf8791d65 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x562bf8791d65 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x562bf8791d65 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   32:     0x562bf8791d65 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   33:     0x562bf875a026 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   34:     0x562bf875a026 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   35:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x562bf875f0d7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x562bf875f0d7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x562bf875f0d7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x562bf875f0d7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x562bf875f0d7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   43:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   44:     0x562bf8814575 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   45:     0x7f472af45ac3 - <unknown>
[INFO] [stdout]   46:     0x7f472afd6bf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_undo_typical_input stdout ----
[INFO] [stdout] 
[INFO] [stdout] -- assert initial config files exists --
[INFO] [stdout] /tmp/.tmpDChd1t/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpDChd1t/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpDChd1t/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial audio files exist --
[INFO] [stdout] /tmp/.tmpDChd1t/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpDChd1t/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpDChd1t/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] An error occurred:
[INFO] [stdout] [006:011] Undefined symbol 'parse-date'
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial files are missing --
[INFO] [stdout] /tmp/.tmpDChd1t/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpDChd1t/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpDChd1t/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpDChd1t/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpDChd1t/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] thread 'test_undo_typical_input' panicked at tests/test_tfmttools.rs:148:19:
[INFO] [stdout] Unexpected file, failed missing(var)
[INFO] [stdout] └── var: /tmp/.tmpDChd1t/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] 
[INFO] [stdout] path=/tmp/.tmpDChd1t/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x562bf880bc7c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x562bf880bc7c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x562bf880bc7c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x562bf880bc7c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x562bf8837ad0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x562bf8837ad0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x562bf8808d6f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x562bf880ba64 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x562bf880ba64 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x562bf880d7a7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x562bf880d493 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x562bf878d6f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x562bf878d6f7 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x562bf880ddb8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x562bf880ddb8 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x562bf880db0e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x562bf880c146 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x562bf880d872 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x562bf874a0e5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x562bf87534d1 - assert_fs::assert::assert::h6bd869a40a1e7b25
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:151:9
[INFO] [stdout]   20:     0x562bf8752e1b - <assert_fs::fixture::child::ChildPath as assert_fs::assert::PathAssert>::assert::hb4765a9197dc5313
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:137:9
[INFO] [stdout]   21:     0x562bf8755128 - test_tfmttools::TestEnv::assert_files_missing::h6d6d91e2f1eef923
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:148:13
[INFO] [stdout]   22:     0x562bf8756b92 - test_tfmttools::test_undo_typical_input::{{closure}}::h5f0f9980e8f5668c
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:311:13
[INFO] [stdout]   23:     0x562bf875112d - test_harness::test_runner::{{closure}}::hce6e9813c7e9eaa8
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:46
[INFO] [stdout]   24:     0x562bf874bd2a - std::panicking::try::do_call::h5fd62e2ec9817479
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   25:     0x562bf874ff7b - __rust_try
[INFO] [stdout]   26:     0x562bf874bb03 - std::panicking::try::h946fe12e52c76813
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   27:     0x562bf874b796 - std::panic::catch_unwind::h9ed2141746615a2b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   28:     0x562bf8750ac1 - test_harness::test_runner::h6b4eee6ff7eb9787
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:18
[INFO] [stdout]   29:     0x562bf8756b26 - test_tfmttools::test_undo_typical_input::h2585642aef4e9f04
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:306:5
[INFO] [stdout]   30:     0x562bf8756b07 - test_tfmttools::test_undo_typical_input::{{closure}}::h2540869373eb700a
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:305:33
[INFO] [stdout]   31:     0x562bf874c436 - core::ops::function::FnOnce::call_once::h291d1f1ac30fc15e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   32:     0x562bf8792d4f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   33:     0x562bf8792d4f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   34:     0x562bf8791d65 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   35:     0x562bf8791d65 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   36:     0x562bf8791d65 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   37:     0x562bf8791d65 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   38:     0x562bf8791d65 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   39:     0x562bf8791d65 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   40:     0x562bf8791d65 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   41:     0x562bf875a026 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   42:     0x562bf875a026 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   43:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   44:     0x562bf875f0d7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x562bf875f0d7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x562bf875f0d7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x562bf875f0d7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   49:     0x562bf875f0d7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   50:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   51:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   52:     0x562bf8814575 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   53:     0x7f472af45ac3 - <unknown>
[INFO] [stdout]   54:     0x7f472afd6bf4 - __clone
[INFO] [stdout]   55:                0x0 - <unknown>
[INFO] [stdout] thread 'test_undo_typical_input' panicked at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5:
[INFO] [stdout] assertion failed: result.is_ok()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x562bf880bc7c - std::backtrace_rs::backtrace::libunwind::trace::ha637c64ce894333a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x562bf880bc7c - std::backtrace_rs::backtrace::trace_unsynchronized::h47f62dea28e0c88d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x562bf880bc7c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x562bf880bc7c - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::hed7f999df88cc644
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x562bf8837ad0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x562bf8837ad0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x562bf8808d6f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x562bf880ba64 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x562bf880ba64 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x562bf880d7a7 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x562bf880d493 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x562bf878d6f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0ad024c9bdc6d768
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   12:     0x562bf878d6f7 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x562bf880ddb8 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h1f8f335eaa9cfaee
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2021:9
[INFO] [stdout]   14:     0x562bf880ddb8 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x562bf880dad9 - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:649:13
[INFO] [stdout]   16:     0x562bf880c146 - std::sys_common::backtrace::__rust_end_short_backtrace::h6e893f24d7ebbff8
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:170:18
[INFO] [stdout]   17:     0x562bf880d872 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x562bf874a0e5 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x562bf874a183 - core::panicking::panic::h195fc2a96298d4c3
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:127:5
[INFO] [stdout]   20:     0x562bf8750c38 - test_harness::test_runner::h6b4eee6ff7eb9787
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5
[INFO] [stdout]   21:     0x562bf8756b26 - test_tfmttools::test_undo_typical_input::h2585642aef4e9f04
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:306:5
[INFO] [stdout]   22:     0x562bf8756b07 - test_tfmttools::test_undo_typical_input::{{closure}}::h2540869373eb700a
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:305:33
[INFO] [stdout]   23:     0x562bf874c436 - core::ops::function::FnOnce::call_once::h291d1f1ac30fc15e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x562bf8792d4f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x562bf8792d4f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   26:     0x562bf8791d65 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   27:     0x562bf8791d65 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h76c106ea31c14d7b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x562bf8791d65 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x562bf8791d65 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x562bf8791d65 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x562bf8791d65 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   32:     0x562bf8791d65 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   33:     0x562bf875a026 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   34:     0x562bf875a026 - std::sys_common::backtrace::__rust_begin_short_backtrace::he6df152596625789
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:154:18
[INFO] [stdout]   35:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x562bf875f0d7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h9dc6bd6372f16606
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x562bf875f0d7 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x562bf875f0d7 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x562bf875f0d7 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x562bf875f0d7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x562bf875f0d7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hc7eafaff61e32df9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   43:     0x562bf8814575 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h6ba4a5de48dd2304
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/alloc/src/boxed.rs:2007:9
[INFO] [stdout]   44:     0x562bf8814575 - std::sys::unix::thread::Thread::new::thread_start::he469335aef763e45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   45:     0x7f472af45ac3 - <unknown>
[INFO] [stdout]   46:     0x7f472afd6bf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_redo_typical_input
[INFO] [stdout]     test_rename_typical_input
[INFO] [stdout]     test_undo_typical_input
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 1 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.15s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test test_tfmttools`
[INFO] running `Command { std: "docker" "inspect" "9da6bad53315243a276170aced57404ed6acc9065a4d8b61e1c0fdcf9abaf6fb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9da6bad53315243a276170aced57404ed6acc9065a4d8b61e1c0fdcf9abaf6fb", kill_on_drop: false }`
[INFO] [stdout] 9da6bad53315243a276170aced57404ed6acc9065a4d8b61e1c0fdcf9abaf6fb
[INFO] testing Hellrespawn/taprtools against beta-2023-12-22 for beta-1.76-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FHellrespawn%2Ftaprtools" "/workspace/builds/worker-3-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Hellrespawn/taprtools on toolchain beta-2023-12-22
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2023-12-22" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/Hellrespawn/taprtools
[INFO] finished tweaking git repo https://github.com/Hellrespawn/taprtools
[INFO] tweaked toml for git repo https://github.com/Hellrespawn/taprtools written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/Hellrespawn/taprtools already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2023-12-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-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:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-12-22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] ea6a2f2b1abd360a6aea19e9054b071413d649f3a5a031c4f9efc1e273b0d556
[INFO] running `Command { std: "docker" "start" "-a" "ea6a2f2b1abd360a6aea19e9054b071413d649f3a5a031c4f9efc1e273b0d556", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ea6a2f2b1abd360a6aea19e9054b071413d649f3a5a031c4f9efc1e273b0d556", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ea6a2f2b1abd360a6aea19e9054b071413d649f3a5a031c4f9efc1e273b0d556", kill_on_drop: false }`
[INFO] [stdout] ea6a2f2b1abd360a6aea19e9054b071413d649f3a5a031c4f9efc1e273b0d556
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-12-22" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] bd24cfb74905e281f2c00021bebdfa93f6bd308778ea77dccb85faf2483f5cf1
[INFO] running `Command { std: "docker" "start" "-a" "bd24cfb74905e281f2c00021bebdfa93f6bd308778ea77dccb85faf2483f5cf1", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.60
[INFO] [stderr]    Compiling quote v1.0.28
[INFO] [stderr]    Compiling unicode-ident v1.0.9
[INFO] [stderr]    Compiling libc v0.2.146
[INFO] [stderr]    Compiling syn v1.0.86
[INFO] [stderr]    Compiling version_check v0.9.4
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling once_cell v1.18.0
[INFO] [stderr]    Compiling io-lifetimes v1.0.11
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling rustix v0.37.20
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling ucd-trie v0.1.5
[INFO] [stderr]    Compiling serde_derive v1.0.136
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling smallvec v1.10.0
[INFO] [stderr]    Compiling crc32fast v1.3.2
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling log v0.4.19
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling linux-raw-sys v0.3.8
[INFO] [stderr]    Compiling nibble_vec v0.1.0
[INFO] [stderr]    Compiling syn v2.0.18
[INFO] [stderr]    Compiling indexmap v1.8.0
[INFO] [stderr]    Compiling paste v1.0.12
[INFO] [stderr]    Compiling serde_json v1.0.79
[INFO] [stderr]    Compiling endian-type v0.1.2
[INFO] [stderr]    Compiling radix_trie v0.2.1
[INFO] [stderr]    Compiling miniz_oxide v0.7.1
[INFO] [stderr]    Compiling utf8parse v0.2.1
[INFO] [stderr]    Compiling anyhow v1.0.55
[INFO] [stderr]    Compiling heck v0.4.0
[INFO] [stderr]    Compiling itoa v1.0.1
[INFO] [stderr]    Compiling regex-syntax v0.6.25
[INFO] [stderr]    Compiling terminal_size v0.1.17
[INFO] [stderr]    Compiling dirs-sys-next v0.1.2
[INFO] [stderr]    Compiling dirs-next v2.0.0
[INFO] [stderr]    Compiling nix v0.25.1
[INFO] [stderr]    Compiling custom_derive v0.1.7
[INFO] [stderr]    Compiling byteorder v1.4.3
[INFO] [stderr]    Compiling unicode-segmentation v1.10.1
[INFO] [stderr]    Compiling ryu v1.0.9
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling unicode-width v0.1.10
[INFO] [stderr]    Compiling ogg_pager v0.5.0
[INFO] [stderr]    Compiling conv v0.3.3
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling which v4.4.0
[INFO] [stderr]    Compiling console v0.15.0
[INFO] [stderr]    Compiling textwrap v0.15.0
[INFO] [stderr]    Compiling fd-lock v3.0.12
[INFO] [stderr]    Compiling rustyline v10.1.1
[INFO] [stderr]    Compiling dirs-sys v0.3.6
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling flate2 v1.0.26
[INFO] [stderr]    Compiling os_str_bytes v6.0.0
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling termcolor v1.1.3
[INFO] [stderr]    Compiling base64 v0.21.2
[INFO] [stderr]    Compiling number_prefix v0.4.0
[INFO] [stderr]    Compiling indicatif v0.16.2
[INFO] [stderr]    Compiling dirs v4.0.0
[INFO] [stderr]    Compiling buffered-iterator v0.1.0 (/opt/rustwide/workdir/buffered-iterator)
[INFO] [stderr]    Compiling dunce v1.0.2
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling lofty_attr v0.8.0
[INFO] [stderr]    Compiling clap_derive v3.1.4
[INFO] [stderr]    Compiling lofty v0.14.0
[INFO] [stderr]    Compiling pest v2.6.1
[INFO] [stderr]    Compiling clap v3.1.5
[INFO] [stderr]    Compiling pest_meta v2.6.1
[INFO] [stderr]    Compiling pest_generator v2.6.1
[INFO] [stderr]    Compiling pest_derive v2.6.1
[INFO] [stderr]    Compiling tapr v0.1.0 (https://github.com/Hellrespawn/tapr.git#b174fafd)
[INFO] [stderr]    Compiling file-history v0.1.0 (/opt/rustwide/workdir/file-history)
[INFO] [stderr]    Compiling taprtools v0.11.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 40.73s
[INFO] running `Command { std: "docker" "inspect" "bd24cfb74905e281f2c00021bebdfa93f6bd308778ea77dccb85faf2483f5cf1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "bd24cfb74905e281f2c00021bebdfa93f6bd308778ea77dccb85faf2483f5cf1", kill_on_drop: false }`
[INFO] [stdout] bd24cfb74905e281f2c00021bebdfa93f6bd308778ea77dccb85faf2483f5cf1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-12-22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 41608b99fee099c1aefa0f0f9512c538538bd6353894169677505a67107c6832
[INFO] running `Command { std: "docker" "start" "-a" "41608b99fee099c1aefa0f0f9512c538538bd6353894169677505a67107c6832", kill_on_drop: false }`
[INFO] [stderr]    Compiling aho-corasick v0.7.18
[INFO] [stderr]    Compiling num-traits v0.2.14
[INFO] [stderr]    Compiling regex-automata v0.1.10
[INFO] [stderr]    Compiling crossbeam-utils v0.8.7
[INFO] [stderr]    Compiling predicates-core v1.0.3
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling doc-comment v0.3.3
[INFO] [stderr]    Compiling itertools v0.10.3
[INFO] [stderr]    Compiling walkdir v2.3.2
[INFO] [stderr]    Compiling thread_local v1.1.4
[INFO] [stderr]    Compiling bstr v0.2.17
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling termtree v0.2.4
[INFO] [stderr]    Compiling difflib v0.4.0
[INFO] [stderr]    Compiling normalize-line-endings v0.3.0
[INFO] [stderr]    Compiling predicates-tree v1.0.5
[INFO] [stderr]    Compiling fastrand v1.7.0
[INFO] [stderr]    Compiling wait-timeout v0.2.0
[INFO] [stderr]    Compiling test-harness v0.1.0 (/opt/rustwide/workdir/test-harness)
[INFO] [stderr]    Compiling tempfile v3.3.0
[INFO] [stderr]    Compiling indicatif v0.16.2
[INFO] [stderr]    Compiling globset v0.4.8
[INFO] [stderr]    Compiling float-cmp v0.9.0
[INFO] [stderr]    Compiling predicates v2.1.1
[INFO] [stderr]    Compiling ignore v0.4.18
[INFO] [stderr]    Compiling taprtools v0.11.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling assert_cmd v2.0.4
[INFO] [stderr]    Compiling globwalk v0.8.1
[INFO] [stderr]    Compiling assert_fs v1.0.7
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 10.59s
[INFO] running `Command { std: "docker" "inspect" "41608b99fee099c1aefa0f0f9512c538538bd6353894169677505a67107c6832", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "41608b99fee099c1aefa0f0f9512c538538bd6353894169677505a67107c6832", kill_on_drop: false }`
[INFO] [stdout] 41608b99fee099c1aefa0f0f9512c538538bd6353894169677505a67107c6832
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:2788e3201cd34a07e3172128adcd8b3090168a8e3bcc40d7c032b9dda1df7d1c" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-12-22" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] d9051c976b29f8504b386d6148bc7fa150a9f373327fe5e93d01d22610fe6764
[INFO] running `Command { std: "docker" "start" "-a" "d9051c976b29f8504b386d6148bc7fa150a9f373327fe5e93d01d22610fe6764", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/taprtools-e59729f4e6d09dd8)
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test cli::args::test::test_preview_aggregate ... ok
[INFO] [stdout] test cli::commands::rename::tests::test_remove_dir_error_codes ... ok
[INFO] [stdout] test cli::commands::rename::validate::test::validate_collisions_test ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/bin/histviewer.rs (/opt/rustwide/target/debug/deps/histviewer-2edf91ff78a1fa2a)
[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 src/bin/ptapr.rs (/opt/rustwide/target/debug/deps/ptapr-1c000b34aa29e79d)
[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 src/bin/tapr.rs (/opt/rustwide/target/debug/deps/tapr-ab07c556e7884c61)
[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/test_tfmttools.rs (/opt/rustwide/target/debug/deps/test_tfmttools-8792b7dcb9f26a6b)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stdout] test test_rename_simple_input ... ok
[INFO] [stdout] test test_rename_typical_input ... FAILED
[INFO] [stdout] test test_undo_typical_input ... FAILED
[INFO] [stdout] test test_redo_typical_input ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- test_rename_typical_input stdout ----
[INFO] [stdout] 
[INFO] [stdout] -- assert initial config files exists --
[INFO] [stdout] /tmp/.tmpnvFYLu/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpnvFYLu/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial audio files exist --
[INFO] [stdout] /tmp/.tmpnvFYLu/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpnvFYLu/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] An error occurred:
[INFO] [stdout] [006:011] Undefined symbol 'parse-date'
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial files are missing --
[INFO] [stdout] /tmp/.tmpnvFYLu/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpnvFYLu/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpnvFYLu/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] thread 'test_rename_typical_input' panicked at tests/test_tfmttools.rs:148:19:
[INFO] [stdout] Unexpected file, failed missing(var)
[INFO] [stdout] └── var: /tmp/.tmpnvFYLu/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] 
[INFO] [stdout] path=/tmp/.tmpnvFYLu/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55a457667396 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55a457667396 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55a457667396 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x55a457667396 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55a457692530 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55a457692530 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55a45766448f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x55a457667174 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55a457667174 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55a457668f67 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x55a457668c4d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55a4575e80f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x55a4575e80f7 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55a457669586 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x55a457669586 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55a4576692d2 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55a457667896 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x55a457669030 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55a4575a30f5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55a4575ad24b - assert_fs::assert::assert::hbe8134e3eda3d6ae
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:151:9
[INFO] [stdout]   20:     0x55a4575acb7b - <assert_fs::fixture::child::ChildPath as assert_fs::assert::PathAssert>::assert::hbcd47cb729090f2b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:137:9
[INFO] [stdout]   21:     0x55a4575ae888 - test_tfmttools::TestEnv::assert_files_missing::h967075ddffe6b30f
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:148:13
[INFO] [stdout]   22:     0x55a4575b01e2 - test_tfmttools::test_rename_typical_input::{{closure}}::hf5486de18c24a591
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:290:13
[INFO] [stdout]   23:     0x55a4575a51ed - test_harness::test_runner::{{closure}}::hc047f9c25d61fc96
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:46
[INFO] [stdout]   24:     0x55a4575a59ea - std::panicking::try::do_call::hdf18d91bb0328c7a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   25:     0x55a4575a92cb - __rust_try
[INFO] [stdout]   26:     0x55a4575a57d3 - std::panicking::try::hc46f16def7d5cdfa
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   27:     0x55a4575a9a26 - std::panic::catch_unwind::he8803ae71dfdcba4
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   28:     0x55a4575a4413 - test_harness::test_runner::h15ed0331bb29013d
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:18
[INFO] [stdout]   29:     0x55a4575b0176 - test_tfmttools::test_rename_typical_input::h7ed1270bd53eb440
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:284:5
[INFO] [stdout]   30:     0x55a4575b0157 - test_tfmttools::test_rename_typical_input::{{closure}}::h4100fa97e48afae2
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:283:35
[INFO] [stdout]   31:     0x55a4575a6016 - core::ops::function::FnOnce::call_once::ha2072431f68a9500
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   32:     0x55a4575ed9cf - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   33:     0x55a4575ed9cf - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   34:     0x55a4575ec751 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   35:     0x55a4575ec751 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   36:     0x55a4575ec751 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   37:     0x55a4575ec751 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   38:     0x55a4575ec751 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   39:     0x55a4575ec751 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   40:     0x55a4575ec751 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   41:     0x55a4575b3a86 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   42:     0x55a4575b3a86 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   43:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   44:     0x55a4575b8ae7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x55a4575b8ae7 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x55a4575b8ae7 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x55a4575b8ae7 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   49:     0x55a4575b8ae7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   50:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   51:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   52:     0x55a45766fdb5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   53:     0x7efc46077ac3 - <unknown>
[INFO] [stdout]   54:     0x7efc46108bf4 - __clone
[INFO] [stdout]   55:                0x0 - <unknown>
[INFO] [stdout] thread 'test_rename_typical_input' panicked at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5:
[INFO] [stdout] assertion failed: result.is_ok()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55a457667396 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55a457667396 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55a457667396 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x55a457667396 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55a457692530 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55a457692530 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55a45766448f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x55a457667174 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55a457667174 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55a457668f67 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x55a457668c4d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55a4575e80f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x55a4575e80f7 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55a457669586 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x55a457669586 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55a457669299 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:649:13
[INFO] [stdout]   16:     0x55a457667896 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x55a457669030 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55a4575a30f5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55a4575a31b3 - core::panicking::panic::h5a1259c1164bd480
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:144:5
[INFO] [stdout]   20:     0x55a4575a458a - test_harness::test_runner::h15ed0331bb29013d
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5
[INFO] [stdout]   21:     0x55a4575b0176 - test_tfmttools::test_rename_typical_input::h7ed1270bd53eb440
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:284:5
[INFO] [stdout]   22:     0x55a4575b0157 - test_tfmttools::test_rename_typical_input::{{closure}}::h4100fa97e48afae2
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:283:35
[INFO] [stdout]   23:     0x55a4575a6016 - core::ops::function::FnOnce::call_once::ha2072431f68a9500
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x55a4575ed9cf - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x55a4575ed9cf - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   26:     0x55a4575ec751 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   27:     0x55a4575ec751 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x55a4575ec751 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x55a4575ec751 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x55a4575ec751 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x55a4575ec751 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   32:     0x55a4575ec751 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   33:     0x55a4575b3a86 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   34:     0x55a4575b3a86 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   35:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x55a4575b8ae7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x55a4575b8ae7 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x55a4575b8ae7 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x55a4575b8ae7 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x55a4575b8ae7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   43:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   44:     0x55a45766fdb5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   45:     0x7efc46077ac3 - <unknown>
[INFO] [stdout]   46:     0x7efc46108bf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_undo_typical_input stdout ----
[INFO] [stdout] 
[INFO] [stdout] -- assert initial config files exists --
[INFO] [stdout] /tmp/.tmpr8MMhC/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpr8MMhC/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial audio files exist --
[INFO] [stdout] /tmp/.tmpr8MMhC/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpr8MMhC/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] An error occurred:
[INFO] [stdout] [006:011] Undefined symbol 'parse-date'
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial files are missing --
[INFO] [stdout] /tmp/.tmpr8MMhC/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpr8MMhC/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpr8MMhC/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] thread 'test_undo_typical_input' panicked at tests/test_tfmttools.rs:148:19:
[INFO] [stdout] Unexpected file, failed missing(var)
[INFO] [stdout] └── var: /tmp/.tmpr8MMhC/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] 
[INFO] [stdout] path=/tmp/.tmpr8MMhC/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55a457667396 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55a457667396 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55a457667396 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x55a457667396 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55a457692530 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55a457692530 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55a45766448f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x55a457667174 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55a457667174 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55a457668f67 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x55a457668c4d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55a4575e80f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x55a4575e80f7 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55a457669586 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x55a457669586 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55a4576692d2 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55a457667896 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x55a457669030 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55a4575a30f5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55a4575ad24b - assert_fs::assert::assert::hbe8134e3eda3d6ae
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:151:9
[INFO] [stdout]   20:     0x55a4575acb7b - <assert_fs::fixture::child::ChildPath as assert_fs::assert::PathAssert>::assert::hbcd47cb729090f2b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:137:9
[INFO] [stdout]   21:     0x55a4575ae888 - test_tfmttools::TestEnv::assert_files_missing::h967075ddffe6b30f
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:148:13
[INFO] [stdout]   22:     0x55a4575b02d2 - test_tfmttools::test_undo_typical_input::{{closure}}::h19695911a14f8cd9
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:311:13
[INFO] [stdout]   23:     0x55a4575a51bd - test_harness::test_runner::{{closure}}::h4c8896075b54e61c
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:46
[INFO] [stdout]   24:     0x55a4575a58fa - std::panicking::try::do_call::h1ba4987d5c3db155
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   25:     0x55a4575a92cb - __rust_try
[INFO] [stdout]   26:     0x55a4575a5873 - std::panicking::try::hd15e28709b96e39c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   27:     0x55a4575a99e6 - std::panic::catch_unwind::h3288aff7c6fc1035
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   28:     0x55a4575a4b13 - test_harness::test_runner::hc1932fd4e51ad469
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:18
[INFO] [stdout]   29:     0x55a4575b0266 - test_tfmttools::test_undo_typical_input::hf2c58ccd92e372d1
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:306:5
[INFO] [stdout]   30:     0x55a4575b0247 - test_tfmttools::test_undo_typical_input::{{closure}}::h822d257b423bb887
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:305:33
[INFO] [stdout]   31:     0x55a4575a5ec6 - core::ops::function::FnOnce::call_once::h5f1a6fc5313ba706
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   32:     0x55a4575ed9cf - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   33:     0x55a4575ed9cf - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   34:     0x55a4575ec751 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   35:     0x55a4575ec751 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   36:     0x55a4575ec751 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   37:     0x55a4575ec751 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   38:     0x55a4575ec751 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   39:     0x55a4575ec751 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   40:     0x55a4575ec751 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   41:     0x55a4575b3a86 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   42:     0x55a4575b3a86 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   43:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   44:     0x55a4575b8ae7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x55a4575b8ae7 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x55a4575b8ae7 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x55a4575b8ae7 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   49:     0x55a4575b8ae7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   50:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   51:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   52:     0x55a45766fdb5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   53:     0x7efc46077ac3 - <unknown>
[INFO] [stdout]   54:     0x7efc46108bf4 - __clone
[INFO] [stdout]   55:                0x0 - <unknown>
[INFO] [stdout] thread 'test_undo_typical_input' panicked at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5:
[INFO] [stdout] assertion failed: result.is_ok()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55a457667396 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55a457667396 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55a457667396 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x55a457667396 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55a457692530 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55a457692530 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55a45766448f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x55a457667174 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55a457667174 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55a457668f67 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x55a457668c4d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55a4575e80f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x55a4575e80f7 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55a457669586 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x55a457669586 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55a457669299 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:649:13
[INFO] [stdout]   16:     0x55a457667896 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x55a457669030 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55a4575a30f5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55a4575a31b3 - core::panicking::panic::h5a1259c1164bd480
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:144:5
[INFO] [stdout]   20:     0x55a4575a4c8a - test_harness::test_runner::hc1932fd4e51ad469
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5
[INFO] [stdout]   21:     0x55a4575b0266 - test_tfmttools::test_undo_typical_input::hf2c58ccd92e372d1
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:306:5
[INFO] [stdout]   22:     0x55a4575b0247 - test_tfmttools::test_undo_typical_input::{{closure}}::h822d257b423bb887
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:305:33
[INFO] [stdout]   23:     0x55a4575a5ec6 - core::ops::function::FnOnce::call_once::h5f1a6fc5313ba706
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x55a4575ed9cf - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x55a4575ed9cf - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   26:     0x55a4575ec751 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   27:     0x55a4575ec751 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x55a4575ec751 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x55a4575ec751 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x55a4575ec751 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x55a4575ec751 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   32:     0x55a4575ec751 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   33:     0x55a4575b3a86 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   34:     0x55a4575b3a86 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   35:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x55a4575b8ae7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x55a4575b8ae7 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x55a4575b8ae7 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x55a4575b8ae7 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x55a4575b8ae7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   43:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   44:     0x55a45766fdb5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   45:     0x7efc46077ac3 - <unknown>
[INFO] [stdout]   46:     0x7efc46108bf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- test_redo_typical_input stdout ----
[INFO] [stdout] 
[INFO] [stdout] -- assert initial config files exists --
[INFO] [stdout] /tmp/.tmpqshAUL/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpqshAUL/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpqshAUL/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial audio files exist --
[INFO] [stdout] /tmp/.tmpqshAUL/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpqshAUL/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpqshAUL/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] An error occurred:
[INFO] [stdout] [006:011] Undefined symbol 'parse-date'
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] -- assert initial files are missing --
[INFO] [stdout] /tmp/.tmpqshAUL/files/While Your Lips Are Still Red - Nightwish.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/Welcome To Heaven - Damjan Mravunac.ogg
[INFO] [stdout] /tmp/.tmpqshAUL/files/Dune - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/SET MIDI=SYNTH1 MAPG MODE1 - MASTER BOOT RECORD.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] /tmp/.tmpqshAUL/files/Under Siege - Amon Amarth.mp3
[INFO] [stdout] /tmp/.tmpqshAUL/config/simple_input.tapr
[INFO] [stdout] /tmp/.tmpqshAUL/config/typical_input.tapr
[INFO] [stdout] -----------
[INFO] [stdout] 
[INFO] [stdout] thread 'test_redo_typical_input' panicked at tests/test_tfmttools.rs:148:19:
[INFO] [stdout] Unexpected file, failed missing(var)
[INFO] [stdout] └── var: /tmp/.tmpqshAUL/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] 
[INFO] [stdout] path=/tmp/.tmpqshAUL/files/Die Antwoord - Gucci Coochie (feat. Dita Von Teese).mp3
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55a457667396 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55a457667396 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55a457667396 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x55a457667396 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55a457692530 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55a457692530 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55a45766448f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x55a457667174 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55a457667174 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55a457668f67 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x55a457668c4d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55a4575e80f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x55a4575e80f7 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55a457669586 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x55a457669586 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55a4576692d2 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55a457667896 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x55a457669030 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55a4575a30f5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55a4575ad24b - assert_fs::assert::assert::hbe8134e3eda3d6ae
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:151:9
[INFO] [stdout]   20:     0x55a4575acb7b - <assert_fs::fixture::child::ChildPath as assert_fs::assert::PathAssert>::assert::hbcd47cb729090f2b
[INFO] [stdout]                                at /opt/rustwide/cargo-home/registry/src/index.crates.io-6f17d22bba15001f/assert_fs-1.0.7/src/assert.rs:137:9
[INFO] [stdout]   21:     0x55a4575ae888 - test_tfmttools::TestEnv::assert_files_missing::h967075ddffe6b30f
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:148:13
[INFO] [stdout]   22:     0x55a4575b0422 - test_tfmttools::test_redo_typical_input::{{closure}}::hbdcd8deb607d7347
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:342:13
[INFO] [stdout]   23:     0x55a4575a518d - test_harness::test_runner::{{closure}}::h2dee0a282972dc95
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:46
[INFO] [stdout]   24:     0x55a4575a599a - std::panicking::try::do_call::h6bd6d15013371f38
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   25:     0x55a4575a92cb - __rust_try
[INFO] [stdout]   26:     0x55a4575a5683 - std::panicking::try::h4aca0e70ecbb33c8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   27:     0x55a4575a9a06 - std::panic::catch_unwind::h47d5bfbf17b1178d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   28:     0x55a4575a4793 - test_harness::test_runner::h5ecb9d30b43be53a
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:38:18
[INFO] [stdout]   29:     0x55a4575b03b6 - test_tfmttools::test_redo_typical_input::hd5708de3c3559ebc
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:337:5
[INFO] [stdout]   30:     0x55a4575b0397 - test_tfmttools::test_redo_typical_input::{{closure}}::h7a79a92357364252
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:336:33
[INFO] [stdout]   31:     0x55a4575a5de6 - core::ops::function::FnOnce::call_once::h4d2594b7b7ccf4c5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   32:     0x55a4575ed9cf - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   33:     0x55a4575ed9cf - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   34:     0x55a4575ec751 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   35:     0x55a4575ec751 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   36:     0x55a4575ec751 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   37:     0x55a4575ec751 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   38:     0x55a4575ec751 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   39:     0x55a4575ec751 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   40:     0x55a4575ec751 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   41:     0x55a4575b3a86 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   42:     0x55a4575b3a86 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   43:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   44:     0x55a4575b8ae7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   45:     0x55a4575b8ae7 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   46:     0x55a4575b8ae7 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   47:     0x55a4575b8ae7 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   48:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   49:     0x55a4575b8ae7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   50:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   51:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   52:     0x55a45766fdb5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   53:     0x7efc46077ac3 - <unknown>
[INFO] [stdout]   54:     0x7efc46108bf4 - __clone
[INFO] [stdout]   55:                0x0 - <unknown>
[INFO] [stderr] error: test failed, to rerun pass `--test test_tfmttools`
[INFO] [stdout] thread 'test_redo_typical_input' panicked at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5:
[INFO] [stdout] assertion failed: result.is_ok()
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55a457667396 - std::backtrace_rs::backtrace::libunwind::trace::h261606ad26a499c1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/libunwind.rs:104:5
[INFO] [stdout]    1:     0x55a457667396 - std::backtrace_rs::backtrace::trace_unsynchronized::hd183f0625477fb28
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55a457667396 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x55a457667396 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h623d9b51f2f453f1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55a457692530 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55a457692530 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55a45766448f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x55a457667174 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55a457667174 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55a457668f67 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x55a457668c4d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55a4575e80f7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h616ac37fa3cd6c8f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   12:     0x55a4575e80f7 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55a457669586 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hcb3fe3b9bb537ba8
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2029:9
[INFO] [stdout]   14:     0x55a457669586 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55a457669299 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:649:13
[INFO] [stdout]   16:     0x55a457667896 - std::sys_common::backtrace::__rust_end_short_backtrace::hf3289479464f7dfe
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:171:18
[INFO] [stdout]   17:     0x55a457669030 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55a4575a30f5 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55a4575a31b3 - core::panicking::panic::h5a1259c1164bd480
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:144:5
[INFO] [stdout]   20:     0x55a4575a490a - test_harness::test_runner::h5ecb9d30b43be53a
[INFO] [stdout]                                at /opt/rustwide/workdir/test-harness/src/lib.rs:42:5
[INFO] [stdout]   21:     0x55a4575b03b6 - test_tfmttools::test_redo_typical_input::hd5708de3c3559ebc
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:337:5
[INFO] [stdout]   22:     0x55a4575b0397 - test_tfmttools::test_redo_typical_input::{{closure}}::h7a79a92357364252
[INFO] [stdout]                                at /opt/rustwide/workdir/tests/test_tfmttools.rs:336:33
[INFO] [stdout]   23:     0x55a4575a5de6 - core::ops::function::FnOnce::call_once::h4d2594b7b7ccf4c5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x55a4575ed9cf - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x55a4575ed9cf - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   26:     0x55a4575ec751 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   27:     0x55a4575ec751 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h330011ad032aadc0
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x55a4575ec751 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x55a4575ec751 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x55a4575ec751 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x55a4575ec751 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   32:     0x55a4575ec751 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   33:     0x55a4575b3a86 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   34:     0x55a4575b3a86 - std::sys_common::backtrace::__rust_begin_short_backtrace::h2ee174b9d5954948
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:155:18
[INFO] [stdout]   35:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x55a4575b8ae7 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h33d0dddec5216160
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x55a4575b8ae7 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x55a4575b8ae7 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x55a4575b8ae7 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x55a4575b8ae7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x55a4575b8ae7 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h5d7c8f150ab9c84c
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   43:     0x55a45766fdb5 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h570d5b005c242c15
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/alloc/src/boxed.rs:2015:9
[INFO] [stdout]   44:     0x55a45766fdb5 - std::sys::unix::thread::Thread::new::thread_start::h36b0a20c0b2361ad
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   45:     0x7efc46077ac3 - <unknown>
[INFO] [stdout]   46:     0x7efc46108bf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     test_redo_typical_input
[INFO] [stdout]     test_rename_typical_input
[INFO] [stdout]     test_undo_typical_input
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 1 passed; 3 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.09s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "d9051c976b29f8504b386d6148bc7fa150a9f373327fe5e93d01d22610fe6764", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d9051c976b29f8504b386d6148bc7fa150a9f373327fe5e93d01d22610fe6764", kill_on_drop: false }`
[INFO] [stdout] d9051c976b29f8504b386d6148bc7fa150a9f373327fe5e93d01d22610fe6764
