[INFO] fetching crate minijinja 0.13.0...
[INFO] testing minijinja-0.13.0 against beta-2022-02-22 for beta-1.60-1
[INFO] extracting crate minijinja 0.13.0 into /workspace/builds/worker-16/source
[INFO] validating manifest of crates.io crate minijinja 0.13.0 on toolchain beta-2022-02-22
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate minijinja 0.13.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate minijinja 0.13.0
[INFO] tweaked toml for crates.io crate minijinja 0.13.0 written to /workspace/builds/worker-16/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-02-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/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:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 5f91c8bb4106feeb044baec1f646c1ed8b513b938e75b159d0792bb19de33a94
[INFO] running `Command { std: "docker" "start" "-a" "5f91c8bb4106feeb044baec1f646c1ed8b513b938e75b159d0792bb19de33a94", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "5f91c8bb4106feeb044baec1f646c1ed8b513b938e75b159d0792bb19de33a94", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5f91c8bb4106feeb044baec1f646c1ed8b513b938e75b159d0792bb19de33a94", kill_on_drop: false }`
[INFO] [stdout] 5f91c8bb4106feeb044baec1f646c1ed8b513b938e75b159d0792bb19de33a94
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 569cf53263c65b1a49907fb98570a411168b7255a7258d8541bcd4f27b50eaa6
[INFO] running `Command { std: "docker" "start" "-a" "569cf53263c65b1a49907fb98570a411168b7255a7258d8541bcd4f27b50eaa6", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling minijinja v0.13.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.80s
[INFO] running `Command { std: "docker" "inspect" "569cf53263c65b1a49907fb98570a411168b7255a7258d8541bcd4f27b50eaa6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "569cf53263c65b1a49907fb98570a411168b7255a7258d8541bcd4f27b50eaa6", kill_on_drop: false }`
[INFO] [stdout] 569cf53263c65b1a49907fb98570a411168b7255a7258d8541bcd4f27b50eaa6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] c709a5e1db0739ad2d9f4143859a126038dbae27a28935e05e487f1d59319e80
[INFO] running `Command { std: "docker" "start" "-a" "c709a5e1db0739ad2d9f4143859a126038dbae27a28935e05e487f1d59319e80", kill_on_drop: false }`
[INFO] [stderr]    Compiling linked-hash-map v0.5.4
[INFO] [stderr]    Compiling hashbrown v0.11.2
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling similar v2.1.0
[INFO] [stderr]    Compiling indexmap v1.8.0
[INFO] [stderr]    Compiling terminal_size v0.1.17
[INFO] [stderr]    Compiling bstr v0.2.17
[INFO] [stderr]    Compiling serde_json v1.0.79
[INFO] [stderr]    Compiling walkdir v2.3.2
[INFO] [stderr]    Compiling console v0.15.0
[INFO] [stderr]    Compiling yaml-rust v0.4.5
[INFO] [stderr]    Compiling globset v0.4.8
[INFO] [stderr]    Compiling serde_yaml v0.8.23
[INFO] [stderr]    Compiling insta v1.12.0
[INFO] [stderr]    Compiling minijinja v0.13.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 6.40s
[INFO] running `Command { std: "docker" "inspect" "c709a5e1db0739ad2d9f4143859a126038dbae27a28935e05e487f1d59319e80", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c709a5e1db0739ad2d9f4143859a126038dbae27a28935e05e487f1d59319e80", kill_on_drop: false }`
[INFO] [stdout] c709a5e1db0739ad2d9f4143859a126038dbae27a28935e05e487f1d59319e80
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-16/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:0cd99ca24d8e8c98e67c542213511d985b8778b5bdcbb160e038429496686047" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-02-22" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] afad35177eb12c98e8fa708b66968591ea08876747259db5557af2f9492cee9e
[INFO] running `Command { std: "docker" "start" "-a" "afad35177eb12c98e8fa708b66968591ea08876747259db5557af2f9492cee9e", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/minijinja-10de91a1e742d1d4)
[INFO] [stdout] 
[INFO] [stdout] running 26 tests
[INFO] [stdout] test filters::builtins::test_basics ... ok
[INFO] [stdout] test instructions::test_sizes ... ok
[INFO] [stdout] test context::test_macro ... ok
[INFO] [stdout] test lexer::test_find_marker ... ok
[INFO] [stdout] test filters::builtins::test_optional_args ... ok
[INFO] [stdout] test utils::test_html_escape ... ok
[INFO] [stdout] test tests::builtins::test_basics ... ok
[INFO] [stdout] test value::test_adding ... ok
[INFO] [stdout] test utils::test_unescape ... ok
[INFO] [stdout] test value::test_concat ... ok
[INFO] [stdout] test value::test_dynamic_object_roundtrip ... ok
[INFO] [stdout] test environment::test_expression_lifetimes ... ok
[INFO] [stdout] test value::test_float_to_string ... ok
[INFO] [stdout] test environment::test_clone ... ok
[INFO] [stdout] test environment::test_expression ... ok
[INFO] [stdout] test value::test_int_key_lookup ... ok
[INFO] [stdout] test value::test_key_interning ... ok
[INFO] [stdout] test value::test_safe_string_roundtrip ... ok
[INFO] [stdout] test value::test_sizes ... ok
[INFO] [stdout] test environment::test_basic ... ok
[INFO] [stdout] test environment::test_globals ... ok
[INFO] [stdout] test value::test_string_key_lookup ... ok
[INFO] [stdout] test value::test_value_serialization ... ok
[INFO] [stdout] test value::test_undefined_roundtrip ... ok
[INFO] [stdout] test lexer::test_whitespace_filter ... ok
[INFO] [stdout] test value::test_sort ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_compiler.rs (/opt/rustwide/target/debug/deps/test_compiler-c64ce7d954cc0c9b)
[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_lexer.rs (/opt/rustwide/target/debug/deps/test_lexer-5fc1823db2e461d7)
[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_parser.rs (/opt/rustwide/target/debug/deps/test_parser-ff6c5b1bb4921ff1)
[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_source.rs (/opt/rustwide/target/debug/deps/test_source-142cfaf94bd1d01a)
[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_vm.rs (/opt/rustwide/target/debug/deps/test_vm-ae49fbf51283214b)
[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]    Doc-tests minijinja
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test src/value.rs - value (line 16) ... ok
[INFO] [stdout] test src/value.rs - value (line 33) ... ok
[INFO] [stdout] test src/value.rs - value (line 25) ... ok
[INFO] [stdout] test src/value.rs - value::Value::downcast_object_ref (line 862) ... ok
[INFO] [stdout] test src/context.rs - context::context (line 14) ... ok
[INFO] [stdout] test src/context.rs - context::context (line 3) ... ok
[INFO] [stdout] test src/tests.rs - tests (line 36) ... ok
[INFO] [stdout] test src/functions.rs - functions (line 28) ... ok
[INFO] [stdout] test src/error.rs - error::Error (line 14) ... ok
[INFO] [stdout] test src/filters.rs - filters (line 35) ... ok
[INFO] [stdout] test src/context.rs - context::context (line 25) ... ok
[INFO] [stdout] test src/lib.rs - (line 59) ... ok
[INFO] [stdout] test src/environment.rs - environment::Expression (line 249) ... ok
[INFO] [stdout] test src/lib.rs - (line 39) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.47s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "afad35177eb12c98e8fa708b66968591ea08876747259db5557af2f9492cee9e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "afad35177eb12c98e8fa708b66968591ea08876747259db5557af2f9492cee9e", kill_on_drop: false }`
[INFO] [stdout] afad35177eb12c98e8fa708b66968591ea08876747259db5557af2f9492cee9e