[INFO] cloning repository https://github.com/huboles/metaforge
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/huboles/metaforge" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhuboles%2Fmetaforge", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhuboles%2Fmetaforge'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 38df1063ffc8ccb7666038f0d7d289d647cca767
[INFO] testing huboles/metaforge against beta-2024-12-08 for beta-1.84.0-4-retry
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fhuboles%2Fmetaforge" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/huboles/metaforge on toolchain beta-2024-12-08
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/huboles/metaforge
[INFO] finished tweaking git repo https://github.com/huboles/metaforge
[INFO] tweaked toml for git repo https://github.com/huboles/metaforge written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/huboles/metaforge 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-2024-12-08" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cea3a45e2c6f566474c596f9791bc911e0505fc69a069105fd9b7a98961ff915
[INFO] running `Command { std: "docker" "start" "-a" "cea3a45e2c6f566474c596f9791bc911e0505fc69a069105fd9b7a98961ff915", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cea3a45e2c6f566474c596f9791bc911e0505fc69a069105fd9b7a98961ff915", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cea3a45e2c6f566474c596f9791bc911e0505fc69a069105fd9b7a98961ff915", kill_on_drop: false }`
[INFO] [stdout] cea3a45e2c6f566474c596f9791bc911e0505fc69a069105fd9b7a98961ff915
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d25295bc8ac73c41b988e61a404d96f0da5880fdce833a413549d012b37be02b
[INFO] running `Command { std: "docker" "start" "-a" "d25295bc8ac73c41b988e61a404d96f0da5880fdce833a413549d012b37be02b", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.59
[INFO] [stderr]    Compiling unicode-ident v1.0.9
[INFO] [stderr]    Compiling quote v1.0.28
[INFO] [stderr]    Compiling libc v0.2.144
[INFO] [stderr]    Compiling memchr v2.5.0
[INFO] [stderr]    Compiling crossbeam-utils v0.8.15
[INFO] [stderr]    Compiling io-lifetimes v1.0.11
[INFO] [stderr]    Compiling memoffset v0.8.0
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling rustix v0.37.19
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.14
[INFO] [stderr]    Compiling linux-raw-sys v0.3.8
[INFO] [stderr]    Compiling once_cell v1.17.2
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling indexmap v1.9.3
[INFO] [stderr]    Compiling ucd-trie v0.1.5
[INFO] [stderr]    Compiling utf8parse v0.2.1
[INFO] [stderr]    Compiling anstyle-parse v0.2.0
[INFO] [stderr]    Compiling either v1.8.1
[INFO] [stderr]    Compiling rayon-core v1.11.0
[INFO] [stderr]    Compiling anstyle-query v1.0.0
[INFO] [stderr]    Compiling colorchoice v1.0.0
[INFO] [stderr]    Compiling anstyle v1.0.0
[INFO] [stderr]    Compiling hashbrown v0.12.3
[INFO] [stderr]    Compiling convert_case v0.4.0
[INFO] [stderr]    Compiling clap_lex v0.5.0
[INFO] [stderr]    Compiling heck v0.4.1
[INFO] [stderr]    Compiling eyre v0.6.8
[INFO] [stderr]    Compiling itertools v0.8.2
[INFO] [stderr]    Compiling rustc-hash v1.1.0
[INFO] [stderr]    Compiling indenter v0.3.3
[INFO] [stderr]    Compiling crossbeam-channel v0.5.8
[INFO] [stderr]    Compiling aho-corasick v0.7.20
[INFO] [stderr]    Compiling nom v7.1.3
[INFO] [stderr]    Compiling crossbeam-deque v0.8.3
[INFO] [stderr]    Compiling syn v2.0.18
[INFO] [stderr]    Compiling pandoc v0.8.10
[INFO] [stderr]    Compiling parse-js v0.10.3
[INFO] [stderr]    Compiling minify-js v0.4.3
[INFO] [stderr]    Compiling num_cpus v1.15.0
[INFO] [stderr]    Compiling derive_more v0.99.17
[INFO] [stderr]    Compiling rayon v1.7.0
[INFO] [stderr]    Compiling is-terminal v0.4.7
[INFO] [stderr]    Compiling anstream v0.3.2
[INFO] [stderr]    Compiling clap_builder v4.3.1
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling clap_derive v4.3.1
[INFO] [stderr]    Compiling pest v2.6.0
[INFO] [stderr]    Compiling css-minify v0.3.1
[INFO] [stderr]    Compiling clap v4.3.1
[INFO] [stderr]    Compiling minify-html v0.11.1
[INFO] [stderr]    Compiling pest_meta v2.6.0
[INFO] [stderr]    Compiling pest_generator v2.6.0
[INFO] [stderr]    Compiling pest_derive v2.6.0
[INFO] [stderr]    Compiling metaforge v0.1.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `node::*`
[INFO] [stdout]  --> src/metafile/dir.rs:4:9
[INFO] [stdout]   |
[INFO] [stdout] 4 | pub use node::*;
[INFO] [stdout]   |         ^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `parallel::*`
[INFO] [stdout]  --> src/metafile/dir.rs:5:9
[INFO] [stdout]   |
[INFO] [stdout] 5 | pub use parallel::*;
[INFO] [stdout]   |         ^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 40.36s
[INFO] running `Command { std: "docker" "inspect" "d25295bc8ac73c41b988e61a404d96f0da5880fdce833a413549d012b37be02b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d25295bc8ac73c41b988e61a404d96f0da5880fdce833a413549d012b37be02b", kill_on_drop: false }`
[INFO] [stdout] d25295bc8ac73c41b988e61a404d96f0da5880fdce833a413549d012b37be02b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5aa6a97f4d2386aa596e9e4c27c1012768b8660a0f8f7e19d26a3c765f463631
[INFO] running `Command { std: "docker" "start" "-a" "5aa6a97f4d2386aa596e9e4c27c1012768b8660a0f8f7e19d26a3c765f463631", kill_on_drop: false }`
[INFO] [stderr]    Compiling either v1.8.1
[INFO] [stderr]    Compiling indexmap v1.9.3
[INFO] [stderr]    Compiling serde v1.0.163
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling serde_derive v1.0.163
[INFO] [stderr]    Compiling serde_json v1.0.96
[INFO] [stderr]    Compiling half v1.8.2
[INFO] [stderr]    Compiling plotters-backend v0.3.4
[INFO] [stderr]    Compiling os_str_bytes v6.5.0
[INFO] [stderr]    Compiling ciborium-io v0.2.1
[INFO] [stderr]    Compiling itoa v1.0.6
[INFO] [stderr]    Compiling ryu v1.0.13
[INFO] [stderr]    Compiling textwrap v0.16.0
[INFO] [stderr]    Compiling regex-syntax v0.7.2
[INFO] [stderr]    Compiling walkdir v2.3.3
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling oorandom v11.1.3
[INFO] [stderr]    Compiling ciborium-ll v0.2.1
[INFO] [stderr]    Compiling itertools v0.8.2
[INFO] [stderr]    Compiling rayon v1.7.0
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling plotters-svg v0.3.3
[INFO] [stderr]    Compiling clap_lex v0.2.4
[INFO] [stderr]    Compiling css-minify v0.3.1
[INFO] [stderr]    Compiling clap v3.2.25
[INFO] [stderr]    Compiling pandoc v0.8.10
[INFO] [stderr]    Compiling plotters v0.3.4
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling regex v1.8.3
[INFO] [stderr]    Compiling minify-html v0.11.1
[INFO] [stderr]    Compiling ciborium v0.2.1
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling criterion v0.4.0
[INFO] [stderr]    Compiling metaforge v0.1.3 (/opt/rustwide/workdir)
[INFO] [stdout] warning: unused import: `node::*`
[INFO] [stdout]  --> src/metafile/dir.rs:4:9
[INFO] [stdout]   |
[INFO] [stdout] 4 | pub use node::*;
[INFO] [stdout]   |         ^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `parallel::*`
[INFO] [stdout]  --> src/metafile/dir.rs:5:9
[INFO] [stdout]   |
[INFO] [stdout] 5 | pub use parallel::*;
[INFO] [stdout]   |         ^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `node::*`
[INFO] [stdout]  --> src/metafile/dir.rs:4:9
[INFO] [stdout]   |
[INFO] [stdout] 4 | pub use node::*;
[INFO] [stdout]   |         ^^^^^^^
[INFO] [stdout]   |
[INFO] [stdout]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: unused import: `parallel::*`
[INFO] [stdout]  --> src/metafile/dir.rs:5:9
[INFO] [stdout]   |
[INFO] [stdout] 5 | pub use parallel::*;
[INFO] [stdout]   |         ^^^^^^^^^^^
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 34.61s
[INFO] running `Command { std: "docker" "inspect" "5aa6a97f4d2386aa596e9e4c27c1012768b8660a0f8f7e19d26a3c765f463631", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5aa6a97f4d2386aa596e9e4c27c1012768b8660a0f8f7e19d26a3c765f463631", kill_on_drop: false }`
[INFO] [stdout] 5aa6a97f4d2386aa596e9e4c27c1012768b8660a0f8f7e19d26a3c765f463631
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=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:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2024-12-08" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 2ba9b21e52a0b597cf3acfc876113eabbc0a61d8306703d9b8f7b2ae7aa8e2d4
[INFO] running `Command { std: "docker" "start" "-a" "2ba9b21e52a0b597cf3acfc876113eabbc0a61d8306703d9b8f7b2ae7aa8e2d4", kill_on_drop: false }`
[INFO] [stderr] warning: unused import: `node::*`
[INFO] [stderr]  --> src/metafile/dir.rs:4:9
[INFO] [stderr]   |
[INFO] [stderr] 4 | pub use node::*;
[INFO] [stderr]   |         ^^^^^^^
[INFO] [stderr]   |
[INFO] [stderr]   = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused import: `parallel::*`
[INFO] [stderr]  --> src/metafile/dir.rs:5:9
[INFO] [stderr]   |
[INFO] [stderr] 5 | pub use parallel::*;
[INFO] [stderr]   |         ^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: `metaforge` (lib) generated 2 warnings (run `cargo fix --lib -p metaforge` to apply 2 suggestions)
[INFO] [stderr] warning: `metaforge` (lib test) generated 2 warnings (2 duplicates)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.22s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/metaforge-db2aeb02fc596471)
[INFO] [stdout] 
[INFO] [stdout] running 38 tests
[INFO] [stdout] test parser::tests::just_source_string ... ok
[INFO] [stdout] test metafile::tests::test_name ... ok
[INFO] [stdout] test parser::tests::no_spaces_in_def ... ok
[INFO] [stdout] test parser::tests::newlines_in_array ... ok
[INFO] [stdout] test parser::tests::trailing_commas ... ok
[INFO] [stdout] test tests::blank_array ... ok
[INFO] [stdout] test parser::tests::one_line ... ok
[INFO] [stdout] test tests::blank_pattern ... ok
[INFO] [stdout] test tests::blank_comment ... ok
[INFO] [stdout] test tests::direct_call ... FAILED
[INFO] [stdout] test tests::blank_variable ... ok
[INFO] [stdout] test tests::expand_arr_in_pat ... ok
[INFO] [stdout] test tests::expand_pat_in_pat ... ok
[INFO] [stdout] test tests::expand_pat_in_src ... FAILED
[INFO] [stdout] test tests::header_blank ... ok
[INFO] [stdout] test tests::expand_arr_in_src ... FAILED
[INFO] [stdout] test tests::expand_var_in_src ... FAILED
[INFO] [stdout] test tests::expand_var_in_pat ... ok
[INFO] [stdout] test tests::header_no_pandoc ... ok
[INFO] [stdout] test tests::override_pat ... ok
[INFO] [stdout] test tests::expandoc ... FAILED
[INFO] [stdout] test tests::test_filetype_header ... ok
[INFO] [stdout] test tests::expand_spaces ... FAILED
[INFO] [stdout] test tests::override_var ... FAILED
[INFO] [stdout] test tests::test_global ... FAILED
[INFO] [stdout] test tests::include_source ... FAILED
[INFO] [stdout] test tests::inline_comment ... FAILED
[INFO] [stdout] test tests::pat_file ... FAILED
[INFO] [stdout] test parser::tests::header_not_first - should panic ... ok
[INFO] [stdout] test parser::tests::map_in_source - should panic ... ok
[INFO] [stdout] test parser::tests::missing_closing_brace - should panic ... ok
[INFO] [stdout] test parser::tests::spaces_in_substitution - should panic ... ok
[INFO] [stdout] test tests::copy_header ... FAILED
[INFO] [stdout] test parser::tests::value_missing_quote - should panic ... ok
[INFO] [stdout] test parser::tests::key_with_spaces - should panic ... ok
[INFO] [stdout] test parser::tests::mixed_quotes - should panic ... ok
[INFO] [stdout] test parser::tests::map_source_map - should panic ... ok
[INFO] [stdout] test tests::ignore - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::direct_call stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:126:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::expand_pat_in_src stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:92:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::expand_arr_in_src stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:82:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::expand_var_in_src stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:72:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::expandoc stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:144:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::expand_spaces stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:132:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::override_var stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:102:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_global stdout ----
[INFO] [stdout] Error: Read-only file system (os error 30)
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/metafile/dir/node.rs:31:13
[INFO] [stdout] 
[INFO] [stdout] ---- tests::include_source stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:150:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::inline_comment stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:67:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::pat_file stdout ----
[INFO] [stdout] Error: Pandoc not found, did you forget to install pandoc?
[INFO] [stdout] 
[INFO] [stdout] Location:
[INFO] [stdout]     src/tests.rs:120:1
[INFO] [stdout] 
[INFO] [stdout] ---- tests::copy_header stdout ----
[INFO] [stdout] thread 'tests::copy_header' panicked at src/metafile/file.rs:69:42:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x57df66fcb8da - std::backtrace_rs::backtrace::libunwind::trace::h8810477743020387
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/libunwind.rs:116:5
[INFO] [stdout]    1:     0x57df66fcb8da - std::backtrace_rs::backtrace::trace_unsynchronized::h3aa55355dd6c54a6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x57df66fcb8da - std::sys::backtrace::_print_fmt::h8588b0f62410823f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:66:9
[INFO] [stdout]    3:     0x57df66fcb8da - <std::sys::backtrace::BacktraceLock::print::DisplayBacktrace as core::fmt::Display>::fmt::h98c26ac25ffe89bb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:39:26
[INFO] [stdout]    4:     0x57df66ff4d03 - core::fmt::rt::Argument::fmt::hf95377f4aebd453b
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/rt.rs:177:76
[INFO] [stdout]    5:     0x57df66ff4d03 - core::fmt::write::h0dd5f6e2238c7982
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/fmt/mod.rs:1189:21
[INFO] [stdout]    6:     0x57df66fc8373 - std::io::Write::write_fmt::h03bb0ca26e6faf8c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/io/mod.rs:1884:15
[INFO] [stdout]    7:     0x57df66fcb722 - std::sys::backtrace::BacktraceLock::print::h5c19c1c038ee186d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:42:9
[INFO] [stdout]    8:     0x57df66fccddd - std::panicking::default_hook::{{closure}}::h77172f079a1fcb13
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:268:22
[INFO] [stdout]    9:     0x57df66fccbe7 - std::panicking::default_hook::he5f8e3b203ccddba
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:292:9
[INFO] [stdout]   10:     0x57df66d758c7 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h7a3c7b4a1ae77f2f
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   11:     0x57df66d758c7 - test::test_main::{{closure}}::hf0d3b69ae9b353d1
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:134:21
[INFO] [stdout]   12:     0x57df66fcd488 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6332e82e7b189abd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1986:9
[INFO] [stdout]   13:     0x57df66fcd488 - std::panicking::rust_panic_with_hook::h53863d4e9018df39
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:809:13
[INFO] [stdout]   14:     0x57df66fcd24a - std::panicking::begin_panic_handler::{{closure}}::h67280e6fa0757873
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:674:13
[INFO] [stdout]   15:     0x57df66fcbdb9 - std::sys::backtrace::__rust_end_short_backtrace::h1dac3f54d6fbbeb2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:170:18
[INFO] [stdout]   16:     0x57df66fccedc - rust_begin_unwind
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:665:5
[INFO] [stdout]   17:     0x57df66cc3260 - core::panicking::panic_fmt::h6792bd1b2bf01041
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panicking.rs:76:14
[INFO] [stdout]   18:     0x57df66cc36e6 - core::result::unwrap_failed::h05e0602ed34287c5
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1699:5
[INFO] [stdout]   19:     0x57df66d2c3ec - core::result::Result<T,E>::unwrap::hd590a263ad2768ae
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/result.rs:1104:23
[INFO] [stdout]   20:     0x57df66d2c3ec - metaforge::metafile::file::MetaFile::construct::h1d2e3d6e079568f2
[INFO] [stdout]                                at /opt/rustwide/workdir/src/metafile/file.rs:69:13
[INFO] [stdout]   21:     0x57df66cf98cb - metaforge::tests::copy_header::h2e123a610c7509bf
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests.rs:22:29
[INFO] [stdout]   22:     0x57df66cf9237 - metaforge::tests::copy_header::{{closure}}::hbbc2c5503a513c70
[INFO] [stdout]                                at /opt/rustwide/workdir/src/tests.rs:8:23
[INFO] [stdout]   23:     0x57df66d06a86 - core::ops::function::FnOnce::call_once::hec3d585d1cd1f8d7
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x57df66d7a3eb - core::ops::function::FnOnce::call_once::h871bf86719ec9aa4
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x57df66d7a3eb - test::__rust_begin_short_backtrace::h2167df1e2b7d76fd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:632:18
[INFO] [stdout]   26:     0x57df66d79dd8 - test::run_test_in_process::{{closure}}::h15d92f75a3adfb79
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:60
[INFO] [stdout]   27:     0x57df66d79dd8 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hb6c8955835a8dbbb
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   28:     0x57df66d79dd8 - std::panicking::try::do_call::hc79d0fc888a0bd30
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   29:     0x57df66d79dd8 - std::panicking::try::hb8a7878e3a8589d6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   30:     0x57df66d79dd8 - std::panic::catch_unwind::hb8e4600ff0ff5cfa
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   31:     0x57df66d79dd8 - test::run_test_in_process::hc2900b0b18688dd6
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:655:27
[INFO] [stdout]   32:     0x57df66d79dd8 - test::run_test::{{closure}}::hac2a9cb07be3d48d
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:576:43
[INFO] [stdout]   33:     0x57df66d3d87a - test::run_test::{{closure}}::h4a5b729e66a38cd8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/test/src/lib.rs:606:41
[INFO] [stdout]   34:     0x57df66d3d87a - std::sys::backtrace::__rust_begin_short_backtrace::h0496fb742492f573
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/backtrace.rs:154:18
[INFO] [stdout]   35:     0x57df66d411f4 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hbb6d257c550a54bd
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:561:17
[INFO] [stdout]   36:     0x57df66d411f4 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h46696fe4a6832328
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/panic/unwind_safe.rs:272:9
[INFO] [stdout]   37:     0x57df66d411f4 - std::panicking::try::do_call::h2625a51b667bfb64
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:557:40
[INFO] [stdout]   38:     0x57df66d411f4 - std::panicking::try::hb956a59a1973aa4c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panicking.rs:520:19
[INFO] [stdout]   39:     0x57df66d411f4 - std::panic::catch_unwind::h64f3b9d1067ef6a0
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/panic.rs:358:14
[INFO] [stdout]   40:     0x57df66d411f4 - std::thread::Builder::spawn_unchecked_::{{closure}}::h42b2841295b6c0b2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   41:     0x57df66d411f4 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h6127de71b8124639
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x57df66fd29db - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h42f0ba71002a1b2c
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   43:     0x57df66fd29db - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::had9e47d7a3dcecb8
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/alloc/src/boxed.rs:1972:9
[INFO] [stdout]   44:     0x57df66fd29db - std::sys::pal::unix::thread::Thread::new::thread_start::h48cf765408f6f5f2
[INFO] [stdout]                                at /rustc/202008a1b8de96d2e5b6bc02d379db03a877d34d/library/std/src/sys/pal/unix/thread.rs:105:17
[INFO] [stdout]   45:     0x7be24fec8ac3 - <unknown>
[INFO] [stdout]   46:     0x7be24ff59a04 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::copy_header
[INFO] [stdout]     tests::direct_call
[INFO] [stdout]     tests::expand_arr_in_src
[INFO] [stdout]     tests::expand_pat_in_src
[INFO] [stdout]     tests::expand_spaces
[INFO] [stdout]     tests::expand_var_in_src
[INFO] [stdout]     tests::expandoc
[INFO] [stdout]     tests::include_source
[INFO] [stdout]     tests::inline_comment
[INFO] [stdout]     tests::override_var
[INFO] [stdout]     tests::pat_file
[INFO] [stdout]     tests::test_global
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 26 passed; 12 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.11s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "2ba9b21e52a0b597cf3acfc876113eabbc0a61d8306703d9b8f7b2ae7aa8e2d4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2ba9b21e52a0b597cf3acfc876113eabbc0a61d8306703d9b8f7b2ae7aa8e2d4", kill_on_drop: false }`
[INFO] [stdout] 2ba9b21e52a0b597cf3acfc876113eabbc0a61d8306703d9b8f7b2ae7aa8e2d4
