[INFO] fetching crate shedron 0.1.4...
[INFO] testing shedron-0.1.4 against try#fc4ba03ef77ca5018fb78a097d3b924d30f15bfc+target=i686-unknown-linux-musl for musl_upgrade_1_2_take4
[INFO] extracting crate shedron 0.1.4 into /workspace/builds/worker-3/source
[INFO] validating manifest of crates.io crate shedron 0.1.4 on toolchain fc4ba03ef77ca5018fb78a097d3b924d30f15bfc
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate shedron 0.1.4
[INFO] finished tweaking crates.io crate shedron 0.1.4
[INFO] tweaked toml for crates.io crate shedron 0.1.4 written to /workspace/builds/worker-3/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 260824b8da12fbf42c2e5e8c134c93890c6f69c4ed6b32add49a88829611b56a
[INFO] running `Command { std: "docker" "start" "-a" "260824b8da12fbf42c2e5e8c134c93890c6f69c4ed6b32add49a88829611b56a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "260824b8da12fbf42c2e5e8c134c93890c6f69c4ed6b32add49a88829611b56a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "260824b8da12fbf42c2e5e8c134c93890c6f69c4ed6b32add49a88829611b56a", kill_on_drop: false }`
[INFO] [stdout] 260824b8da12fbf42c2e5e8c134c93890c6f69c4ed6b32add49a88829611b56a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "build" "--frozen" "--message-format=json" "--target" "i686-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 79296a1a2028e2ccaff28b0493eb2bded20eab3ad32a5e0ab380f89eec5cee60
[INFO] running `Command { std: "docker" "start" "-a" "79296a1a2028e2ccaff28b0493eb2bded20eab3ad32a5e0ab380f89eec5cee60", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.138
[INFO] [stderr]    Compiling proc-macro2 v1.0.47
[INFO] [stderr]    Compiling unicode-ident v1.0.5
[INFO] [stderr]    Compiling quote v1.0.21
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling syn v1.0.105
[INFO] [stderr]    Compiling paste v1.0.10
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling ppv-lite86 v0.2.17
[INFO] [stderr]    Compiling regex-syntax v0.6.28
[INFO] [stderr]    Compiling beef v0.5.2
[INFO] [stderr]    Compiling getrandom v0.2.8
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling logos-derive v0.12.1
[INFO] [stderr]    Compiling logos v0.12.1
[INFO] [stderr]    Compiling shedron v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.44s
[INFO] running `Command { std: "docker" "inspect" "79296a1a2028e2ccaff28b0493eb2bded20eab3ad32a5e0ab380f89eec5cee60", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "79296a1a2028e2ccaff28b0493eb2bded20eab3ad32a5e0ab380f89eec5cee60", kill_on_drop: false }`
[INFO] [stdout] 79296a1a2028e2ccaff28b0493eb2bded20eab3ad32a5e0ab380f89eec5cee60
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "test" "--frozen" "--no-run" "--message-format=json" "--target" "i686-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] d51bed9345334b95aa63607fd3dab1cc7efebf3bc6c416db2c748ee30829a937
[INFO] running `Command { std: "docker" "start" "-a" "d51bed9345334b95aa63607fd3dab1cc7efebf3bc6c416db2c748ee30829a937", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling shedron v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.96s
[INFO] running `Command { std: "docker" "inspect" "d51bed9345334b95aa63607fd3dab1cc7efebf3bc6c416db2c748ee30829a937", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d51bed9345334b95aa63607fd3dab1cc7efebf3bc6c416db2c748ee30829a937", kill_on_drop: false }`
[INFO] [stdout] d51bed9345334b95aa63607fd3dab1cc7efebf3bc6c416db2c748ee30829a937
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+fc4ba03ef77ca5018fb78a097d3b924d30f15bfc" "test" "--frozen" "--target" "i686-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 391ec1c1282307625441c3c44da96810a2945727e9c60517345d147415cd4d4c
[INFO] running `Command { std: "docker" "start" "-a" "391ec1c1282307625441c3c44da96810a2945727e9c60517345d147415cd4d4c", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/shedron-1554e08375356696)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test interpret::test::test_drop ... ok
[INFO] [stdout] test parser::test::parse_parenthesis ... ok
[INFO] [stdout] test parser::test::parse_complicated_syntax ... ok
[INFO] [stdout] test interpret::test::test_negative ... ok
[INFO] [stdout] test interpret::test::test_run_blind ... ok
[INFO] [stdout] test parser::test::parse_brackets ... ok
[INFO] [stdout] test parser::test::display ... ok
[INFO] [stdout] test interpret::test::test_append ... ok
[INFO] [stdout] test parser::test::parse_things ... ok
[INFO] [stdout] test parser::test::parse_invalid_syntax ... ok
[INFO] [stdout] test interpret::test::test_fail_len - should panic ... ok
[INFO] [stdout] test interpret::test::test_fail_index_out_of_bounds - should panic ... ok
[INFO] [stdout] test interpret::test::test_expect_dice ... FAILED
[INFO] [stdout] test interpret::test::test_fail_range - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- interpret::test::test_expect_dice stdout ----
[INFO] [stdout] parsing [1]
[INFO] [stdout] [src/parser.rs:233] call_depth = 0
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "["
[INFO] [stdout] [src/parser.rs:236] &next.data = OpenSquare
[INFO] [stdout] -> eval content of open_square
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "1"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = CloseSquare
[INFO] [stdout] lhs num(1)
[INFO] [stdout] <- close square 1
[INFO] [stdout] ::: emitting sum sum(num(1))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 0
[INFO] [stdout] evaluating [1]
[INFO] [stdout] evaluated [1]
[INFO] [stdout] [src/interpret.rs:371] &result = Ok(
[INFO] [stdout]     Output {
[INFO] [stdout]         rolls: [
[INFO] [stdout]             1,
[INFO] [stdout]         ],
[INFO] [stdout]     },
[INFO] [stdout] )
[INFO] [stdout] parsing 2d6
[INFO] [stdout] [src/parser.rs:233] call_depth = 0
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "2"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "6"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 1
[INFO] [stdout] ::: emitting op roll(num(2), num(6))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 0
[INFO] [stdout] evaluating 2d6
[INFO] [stdout] evaluated 2d6
[INFO] [stdout] [src/interpret.rs:371] &result = Ok(
[INFO] [stdout]     Output {
[INFO] [stdout]         rolls: [
[INFO] [stdout]             5,
[INFO] [stdout]             2,
[INFO] [stdout]         ],
[INFO] [stdout]     },
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout] )
[INFO] [stdout] parsing ([1d5]+1)d6
[INFO] [stdout] [src/parser.rs:233] call_depth = 0
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "("
[INFO] [stdout] [src/parser.rs:236] &next.data = OpenParen
[INFO] [stdout] -> eval content of open_paren
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "["
[INFO] [stdout] [src/parser.rs:236] &next.data = OpenSquare
[INFO] [stdout] -> eval content of open_square
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "1"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 3
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "5"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = CloseSquare
[INFO] [stdout] lhs num(5)
[INFO] [stdout] <- close square 3
[INFO] [stdout] ::: emitting op roll(num(1), num(5))
[INFO] [stdout] target brace is Square Bracket
[INFO] [stdout] current brace is Square Bracket
[INFO] [stdout] <- breaking out due to matching brackets 2
[INFO] [stdout] [src/parser.rs:244] &lhs = roll(
[INFO] [stdout]     num(
[INFO] [stdout]         1,
[INFO] [stdout]     ),
[INFO] [stdout]     num(
[INFO] [stdout]         5,
[INFO] [stdout]     ),
[INFO] [stdout] )
[INFO] [stdout] ::: emitting sum sum(roll(num(1), num(5)))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Add
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "+"
[INFO] [stdout] -> eval rhs of op Add
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "1"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = CloseParen
[INFO] [stdout] lhs num(1)
[INFO] [stdout] <- close paren 2
[INFO] [stdout] ::: emitting op add(sum(roll(num(1), num(5))), num(1))
[INFO] [stdout] target brace is Parenthesis
[INFO] [stdout] current brace is Parenthesis
[INFO] [stdout] <- breaking out due to matching brackets 1
[INFO] [stdout] [src/parser.rs:244] &lhs = add(
[INFO] [stdout]     sum(
[INFO] [stdout]         roll(
[INFO] [stdout]             num(
[INFO] [stdout]                 1,
[INFO] [stdout]             ),
[INFO] [stdout]             num(
[INFO] [stdout]                 5,
[INFO] [stdout]             ),
[INFO] [stdout]         ),
[INFO] [stdout]     ),
[INFO] [stdout]     num(
[INFO] [stdout]         1,
[INFO] [stdout]     ),
[INFO] [stdout] )
[INFO] [stdout] ::: emitting parens expr paren(add(sum(roll(num(1), num(5))), num(1)))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "6"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 1
[INFO] [stdout] ::: emitting op roll(paren(add(sum(roll(num(1), num(5))), num(1))), num(6))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 0
[INFO] [stdout] evaluating ([1d5]+1)d6
[INFO] [stdout] evaluated ([1d5]+1)d6
[INFO] [stdout] [src/interpret.rs:371] &result = Ok(
[INFO] [stdout]     Output {
[INFO] [stdout]         rolls: [
[INFO] [stdout]             2,
[INFO] [stdout]             6,
[INFO] [stdout]             4,
[INFO] [stdout]         ],
[INFO] [stdout]     },
[INFO] [stdout] )
[INFO] [stdout] parsing [1d5+=1]d6
[INFO] [stdout] [src/parser.rs:233] call_depth = 0
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "["
[INFO] [stdout] [src/parser.rs:236] &next.data = OpenSquare
[INFO] [stdout] -> eval content of open_square
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "1"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "5"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = AddEq
[INFO] [stdout] ::: emitting op roll(num(1), num(5))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = AddEq
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "+="
[INFO] [stdout] -> eval rhs of op AddEq
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "1"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = CloseSquare
[INFO] [stdout] lhs num(1)
[INFO] [stdout] <- close square 2
[INFO] [stdout] ::: emitting op add_eq(roll(num(1), num(5)), num(1))
[INFO] [stdout] target brace is Square Bracket
[INFO] [stdout] current brace is Square Bracket
[INFO] [stdout] <- breaking out due to matching brackets 1
[INFO] [stdout] [src/parser.rs:244] &lhs = add_eq(
[INFO] [stdout]     roll(
[INFO] [stdout]         num(
[INFO] [stdout]             1,
[INFO] [stdout]         ),
[INFO] [stdout]         num(
[INFO] [stdout]             5,
[INFO] [stdout]         ),
[INFO] [stdout]     ),
[INFO] [stdout]     num(
[INFO] [stdout]         1,
[INFO] [stdout]     ),
[INFO] [stdout] )
[INFO] [stdout] ::: emitting sum sum(add_eq(roll(num(1), num(5)), num(1)))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "6"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 1
[INFO] [stdout] ::: emitting op roll(sum(add_eq(roll(num(1), num(5)), num(1))), num(6))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 0
[INFO] [stdout] evaluating [1d5+=1]d6
[INFO] [stdout] evaluated [1d5+=1]d6
[INFO] [stdout] [src/interpret.rs:371] &result = Ok(
[INFO] [stdout]     Output {
[INFO] [stdout]         rolls: [
[INFO] [stdout]             5,
[INFO] [stdout]             5,
[INFO] [stdout]             6,
[INFO] [stdout]         ],
[INFO] [stdout]     },
[INFO] [stdout] )
[INFO] [stdout] parsing ([2d2]+1)d6
[INFO] [stdout] [src/parser.rs:233] call_depth = 0
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "("
[INFO] [stdout] [src/parser.rs:236] &next.data = OpenParen
[INFO] [stdout] -> eval content of open_paren
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "["
[INFO] [stdout] [src/parser.rs:236] &next.data = OpenSquare
[INFO] [stdout] -> eval content of open_square
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "2"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 3
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "2"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = CloseSquare
[INFO] [stdout] lhs num(2)
[INFO] [stdout] <- close square 3
[INFO] [stdout] ::: emitting op roll(num(2), num(2))
[INFO] [stdout] target brace is Square Bracket
[INFO] [stdout] current brace is Square Bracket
[INFO] [stdout] <- breaking out due to matching brackets 2
[INFO] [stdout] [src/parser.rs:244] &lhs = roll(
[INFO] [stdout]     num(
[INFO] [stdout]         2,
[INFO] [stdout]     ),
[INFO] [stdout]     num(
[INFO] [stdout]         2,
[INFO] [stdout]     ),
[INFO] [stdout] )
[INFO] [stdout] ::: emitting sum sum(roll(num(2), num(2)))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Add
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "+"
[INFO] [stdout] -> eval rhs of op Add
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "1"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = CloseParen
[INFO] [stdout] lhs num(1)
[INFO] [stdout] <- close paren 2
[INFO] [stdout] ::: emitting op add(sum(roll(num(2), num(2))), num(1))
[INFO] [stdout] target brace is Parenthesis
[INFO] [stdout] current brace is Parenthesis
[INFO] [stdout] <- breaking out due to matching brackets 1
[INFO] [stdout] [src/parser.rs:244] &lhs = add(
[INFO] [stdout]     sum(
[INFO] [stdout]         roll(
[INFO] [stdout]             num(
[INFO] [stdout]                 2,
[INFO] [stdout]             ),
[INFO] [stdout]             num(
[INFO] [stdout]                 2,
[INFO] [stdout]             ),
[INFO] [stdout]         ),
[INFO] [stdout]     ),
[INFO] [stdout]     num(
[INFO] [stdout]         1,
[INFO] [stdout]     ),
[INFO] [stdout] )
[INFO] [stdout] ::: emitting parens expr paren(add(sum(roll(num(2), num(2))), num(1)))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "6"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 1
[INFO] [stdout] ::: emitting op roll(paren(add(sum(roll(num(2), num(2))), num(1))), num(6))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 0
[INFO] [stdout] evaluating ([2d2]+1)d6
[INFO] [stdout] evaluated ([2d2]+1)d6
[INFO] [stdout] [src/interpret.rs:371] &result = Ok(
[INFO] [stdout]     Output {
[INFO] [stdout]         rolls: [
[INFO] [stdout]             3,
[INFO] [stdout]             1,
[INFO] [stdout]             2,
[INFO] [stdout]             2,
[INFO] [stdout]         ],
[INFO] [stdout]     },
[INFO] [stdout] )
[INFO] [stdout] parsing [2d2+1]d6
[INFO] [stdout] [src/parser.rs:233] call_depth = 0
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "["
[INFO] [stdout] [src/parser.rs:236] &next.data = OpenSquare
[INFO] [stdout] -> eval content of open_square
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "2"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "2"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Add
[INFO] [stdout] ::: emitting op roll(num(2), num(2))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Add
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "+"
[INFO] [stdout] -> eval rhs of op Add
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "1"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = CloseSquare
[INFO] [stdout] lhs num(1)
[INFO] [stdout] <- close square 2
[INFO] [stdout] ::: emitting op add(roll(num(2), num(2)), num(1))
[INFO] [stdout] target brace is Square Bracket
[INFO] [stdout] current brace is Square Bracket
[INFO] [stdout] <- breaking out due to matching brackets 1
[INFO] [stdout] [src/parser.rs:244] &lhs = add(
[INFO] [stdout]     roll(
[INFO] [stdout]         num(
[INFO] [stdout]             2,
[INFO] [stdout]         ),
[INFO] [stdout]         num(
[INFO] [stdout]             2,
[INFO] [stdout]         ),
[INFO] [stdout]     ),
[INFO] [stdout]     num(
[INFO] [stdout]         1,
[INFO] [stdout]     ),
[INFO] [stdout] )
[INFO] [stdout] ::: emitting sum sum(add(roll(num(2), num(2)), num(1)))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "6"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 1
[INFO] [stdout] ::: emitting op roll(sum(add(roll(num(2), num(2)), num(1))), num(6))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 0
[INFO] [stdout] evaluating [2d2+1]d6
[INFO] [stdout] evaluated [2d2+1]d6
[INFO] [stdout] [src/interpret.rs:371] &result = Ok(
[INFO] [stdout]     Output {
[INFO] [stdout]         rolls: [
[INFO] [stdout]             1,
[INFO] [stdout]             1,
[INFO] [stdout]             5,
[INFO] [stdout]             1,
[INFO] [stdout]             3,
[INFO] [stdout]         ],
[INFO] [stdout]     },
[INFO] [stdout] )
[INFO] [stdout] parsing [2d2+=1]d6
[INFO] [stdout] [src/parser.rs:233] call_depth = 0
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "["
[INFO] [stdout] [src/parser.rs:236] &next.data = OpenSquare
[INFO] [stdout] -> eval content of open_square
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "2"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "2"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = AddEq
[INFO] [stdout] ::: emitting op roll(num(2), num(2))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = AddEq
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "+="
[INFO] [stdout] -> eval rhs of op AddEq
[INFO] [stdout] [src/parser.rs:233] call_depth = 2
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "1"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = CloseSquare
[INFO] [stdout] lhs num(1)
[INFO] [stdout] <- close square 2
[INFO] [stdout] ::: emitting op add_eq(roll(num(2), num(2)), num(1))
[INFO] [stdout] target brace is Square Bracket
[INFO] [stdout] current brace is Square Bracket
[INFO] [stdout] <- breaking out due to matching brackets 1
[INFO] [stdout] [src/parser.rs:244] &lhs = add_eq(
[INFO] [stdout]     roll(
[INFO] [stdout]         num(
[INFO] [stdout]             2,
[INFO] [stdout]         ),
[INFO] [stdout]         num(
[INFO] [stdout]             2,
[INFO] [stdout]         ),
[INFO] [stdout]     ),
[INFO] [stdout]     num(
[INFO] [stdout]         1,
[INFO] [stdout]     ),
[INFO] [stdout] )
[INFO] [stdout] ::: emitting sum sum(add_eq(roll(num(2), num(2)), num(1)))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Roll
[INFO] [stdout] [src/parser.rs:295] &self.tokens.slice() = "d"
[INFO] [stdout] -> eval rhs of op Roll
[INFO] [stdout] [src/parser.rs:233] call_depth = 1
[INFO] [stdout] [src/parser.rs:235] self.tokens.slice() = "6"
[INFO] [stdout] [src/parser.rs:236] &next.data = Number
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 1
[INFO] [stdout] ::: emitting op roll(sum(add_eq(roll(num(2), num(2)), num(1))), num(6))
[INFO] [stdout] [src/parser.rs:250] &maybe_operator.data = Eof
[INFO] [stdout] <- eof 0
[INFO] [stdout] evaluating [2d2+=1]d6
[INFO] [stdout] evaluated [2d2+=1]d6
[INFO] [stdout] [src/interpret.rs:371] &result = Ok(
[INFO] [stdout]     Output {
[INFO] [stdout]         rolls: [
[INFO] [stdout]             3,
[INFO] [stdout]             4,
[INFO] [stdout]             2,
[INFO] [stdout]             4,
[INFO] [stdout]             2,
[INFO] [stdout]             4,
[INFO] [stdout]         ],
[INFO] [stdout]     },
[INFO] [stdout] )
[INFO] [stdout] thread 'interpret::test::test_expect_dice' panicked at 'output length is not in the expected range Output { rolls: [3, 4, 2, 4, 2, 4] }.len() != 3..=5', src/interpret.rs:308:13
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:  0x810cab1 - std::backtrace_rs::backtrace::libunwind::trace::h5f291319ef5c6762
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:  0x810cab1 - std::backtrace_rs::backtrace::trace_unsynchronized::h96ca96ef06a343d3
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:  0x810cab1 - std::sys_common::backtrace::_print_fmt::h9ecddad7ef420251
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:65:5
[INFO] [stdout]    3:  0x810cab1 - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h7345cc970529ac34
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:  0x814a43c - core::fmt::write::hf580cd49f879cb74
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/fmt/mod.rs:1208:17
[INFO] [stdout]    5:  0x8109b4b - std::io::Write::write_fmt::hceb49ab886ea57c9
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/io/mod.rs:1682:15
[INFO] [stdout]    6:  0x810c8b6 - std::sys_common::backtrace::_print::h8b6713f1e30cd3b1
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    7:  0x810c8b6 - std::sys_common::backtrace::print::h228371403e861751
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    8:  0x810e495 - std::panicking::default_hook::{{closure}}::h6da55f6f475e59d6
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:267:22
[INFO] [stdout]    9:  0x810e195 - std::panicking::default_hook::h8f14cf6f2f2f52d8
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:283:9
[INFO] [stdout]   10:  0x80ebb6c - core::ops::function::Fn::call::h9b26c25f04212ebd
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:161:5
[INFO] [stdout]   11:  0x80becd9 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h0b6006386399b354
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2032:9
[INFO] [stdout]   12:  0x80becd9 - test::test_main::{{closure}}::hf462dccab4831d1f
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:135:21
[INFO] [stdout]   13:  0x810ebd4 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h9163b46de7e7a7ba
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2032:9
[INFO] [stdout]   14:  0x810ebd4 - std::panicking::rust_panic_with_hook::h2f79ffe424d88114
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:692:13
[INFO] [stdout]   15:  0x810e98c - std::panicking::begin_panic_handler::{{closure}}::h59ef6a1246219cbe
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:579:13
[INFO] [stdout]   16:  0x810cf2a - std::sys_common::backtrace::__rust_end_short_backtrace::h3d3587da31656282
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:137:18
[INFO] [stdout]   17:  0x810e663 - rust_begin_unwind
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:575:5
[INFO] [stdout]   18:  0x804c600 - core::panicking::panic_fmt::h40e949315ccf1c11
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/panicking.rs:64:14
[INFO] [stdout]   19:  0x806462f - shedron::interpret::test::<impl shedron::interpret::Output>::expect_len_in::h51363228e15feac7
[INFO] [stdout]                        at /opt/rustwide/workdir/src/interpret.rs:308:13
[INFO] [stdout]   20:  0x8087d7a - shedron::interpret::test::test_expect_dice::ha7799a1616cfe1d4
[INFO] [stdout]                        at /opt/rustwide/workdir/src/interpret.rs:415:9
[INFO] [stdout]   21:  0x80875f7 - shedron::interpret::test::test_expect_dice::{{closure}}::hb19deef582699eb4
[INFO] [stdout]                        at /opt/rustwide/workdir/src/interpret.rs:390:27
[INFO] [stdout]   22:  0x8080e2d - core::ops::function::FnOnce::call_once::h0f8f714efe5f6c7b
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:507:5
[INFO] [stdout]   23:  0x80c371e - core::ops::function::FnOnce::call_once::hecc3c5fab6cb88cd
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:507:5
[INFO] [stdout]   24:  0x80c371e - test::__rust_begin_short_backtrace::h18e977d49f646cd0
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:657:18
[INFO] [stdout]   25:  0x80966c0 - test::run_test::{{closure}}::ha39325b57d1cb768
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:648:30
[INFO] [stdout]   26:  0x80966c0 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h5040e45b1e845123
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:507:5
[INFO] [stdout]   27:  0x80c2897 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h26c70f40318b0360
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2000:9
[INFO] [stdout]   28:  0x80c2897 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::hfa679c02d5269ea1
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   29:  0x80c2897 - std::panicking::try::do_call::h5bc1d3d4ab3d7acd
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:483:40
[INFO] [stdout]   30:  0x80c2897 - std::panicking::try::h0d0734d848512873
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:447:19
[INFO] [stdout]   31:  0x80c2897 - std::panic::catch_unwind::h1b17ff745af6bff3
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panic.rs:137:14
[INFO] [stdout]   32:  0x80c2897 - test::run_test_in_process::h7545f915ef03cbbe
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:680:27
[INFO] [stdout]   33:  0x80c2897 - test::run_test::run_test_inner::{{closure}}::he5f64ab41218f776
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:574:39
[INFO] [stdout]   34:  0x8090f2a - test::run_test::run_test_inner::{{closure}}::h74ad460a34a68702
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/test/src/lib.rs:601:37
[INFO] [stdout]   35:  0x8090f2a - std::sys_common::backtrace::__rust_begin_short_backtrace::h3e8f4d074e786dcf
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys_common/backtrace.rs:121:18
[INFO] [stdout]   36:  0x809653b - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h9aa166e39b65b836
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/thread/mod.rs:550:17
[INFO] [stdout]   37:  0x809653b - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h49c1c6ee61f36b13
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   38:  0x809653b - std::panicking::try::do_call::h6c0758e2b02f2859
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:483:40
[INFO] [stdout]   39:  0x809653b - std::panicking::try::h3684f436e633cc77
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panicking.rs:447:19
[INFO] [stdout]   40:  0x809653b - std::panic::catch_unwind::hc37306cbaab1bf43
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/panic.rs:137:14
[INFO] [stdout]   41:  0x809653b - std::thread::Builder::spawn_unchecked_::{{closure}}::h6a4963ec3f0e3be6
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/thread/mod.rs:549:30
[INFO] [stdout]   42:  0x809653b - core::ops::function::FnOnce::call_once{{vtable.shim}}::h0914fb32932929dc
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/core/src/ops/function.rs:507:5
[INFO] [stdout]   43:  0x811279d - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hb6157d95beb62c18
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2000:9
[INFO] [stdout]   44:  0x811279d - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h710bd3383b288449
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/alloc/src/boxed.rs:2000:9
[INFO] [stdout]   45:  0x811279d - std::sys::unix::thread::Thread::new::thread_start::ha4036db4cbfe1239
[INFO] [stdout]                        at /rustc/fc4ba03ef77ca5018fb78a097d3b924d30f15bfc/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     interpret::test::test_expect_dice
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 13 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "391ec1c1282307625441c3c44da96810a2945727e9c60517345d147415cd4d4c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "391ec1c1282307625441c3c44da96810a2945727e9c60517345d147415cd4d4c", kill_on_drop: false }`
[INFO] [stdout] 391ec1c1282307625441c3c44da96810a2945727e9c60517345d147415cd4d4c