[INFO] cloning repository https://github.com/yupferris/kaze
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/yupferris/kaze" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fyupferris%2Fkaze", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fyupferris%2Fkaze'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 58c04571b2ed160f746f7e09e9ed2de5b981d595
[INFO] testing yupferris/kaze against 1.75.0 for beta-1.76-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fyupferris%2Fkaze" "/workspace/builds/worker-6-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/yupferris/kaze 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/yupferris/kaze
[INFO] finished tweaking git repo https://github.com/yupferris/kaze
[INFO] tweaked toml for git repo https://github.com/yupferris/kaze written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.75.0" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[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]  Downloading crates ...
[INFO] [stderr]   Downloaded vcd v0.6.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 4595bb17114ac2de4dd1c12c0884d1a4881f640abac206d4c80a6c716e7e81bb
[INFO] running `Command { std: "docker" "start" "-a" "4595bb17114ac2de4dd1c12c0884d1a4881f640abac206d4c80a6c716e7e81bb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "4595bb17114ac2de4dd1c12c0884d1a4881f640abac206d4c80a6c716e7e81bb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4595bb17114ac2de4dd1c12c0884d1a4881f640abac206d4c80a6c716e7e81bb", kill_on_drop: false }`
[INFO] [stdout] 4595bb17114ac2de4dd1c12c0884d1a4881f640abac206d4c80a6c716e7e81bb
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] dfac225cb136395b78c3bcc001519ad123e5648b0df3bfbdd91de6d4a2c5d25b
[INFO] running `Command { std: "docker" "start" "-a" "dfac225cb136395b78c3bcc001519ad123e5648b0df3bfbdd91de6d4a2c5d25b", kill_on_drop: false }`
[INFO] [stderr]    Compiling vcd v0.6.1
[INFO] [stderr]    Compiling typed-arena v2.0.2
[INFO] [stderr]    Compiling kaze v0.1.19 (/opt/rustwide/workdir/kaze)
[INFO] [stderr]    Compiling sim-tests v0.1.0 (/opt/rustwide/workdir/sim-tests)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.61s
[INFO] running `Command { std: "docker" "inspect" "dfac225cb136395b78c3bcc001519ad123e5648b0df3bfbdd91de6d4a2c5d25b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dfac225cb136395b78c3bcc001519ad123e5648b0df3bfbdd91de6d4a2c5d25b", kill_on_drop: false }`
[INFO] [stdout] dfac225cb136395b78c3bcc001519ad123e5648b0df3bfbdd91de6d4a2c5d25b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] e557fac6579cf821fcc1229411660a508a0661c3156f7891320c73f48945c251
[INFO] running `Command { std: "docker" "start" "-a" "e557fac6579cf821fcc1229411660a508a0661c3156f7891320c73f48945c251", kill_on_drop: false }`
[INFO] [stderr]    Compiling kaze v0.1.19 (/opt/rustwide/workdir/kaze)
[INFO] [stderr]    Compiling sim-tests v0.1.0 (/opt/rustwide/workdir/sim-tests)
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2130:5
[INFO] [stdout]      |
[INFO] [stdout] 2130 |     __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_address_6`
[INFO] [stdout]      |
[INFO] [stdout]      = note: `#[warn(non_snake_case)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2131:5
[INFO] [stdout]      |
[INFO] [stdout] 2131 |     __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_enable_7`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2132:5
[INFO] [stdout]      |
[INFO] [stdout] 2132 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_address_8`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2133:5
[INFO] [stdout]      |
[INFO] [stdout] 2133 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_value_9`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2134:5
[INFO] [stdout]      |
[INFO] [stdout] 2134 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_enable_10`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2148:13
[INFO] [stdout]      |
[INFO] [stdout] 2148 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6 = trace.add_signal("__mem_trace_test_module_3_mem_0_r...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_address_6`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2149:13
[INFO] [stdout]      |
[INFO] [stdout] 2149 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7 = trace.add_signal("__mem_trace_test_module_3_mem_0_re...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_enable_7`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2150:13
[INFO] [stdout]      |
[INFO] [stdout] 2150 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8 = trace.add_signal("__mem_trace_test_module_3_mem_0_wr...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_address_8`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2151:13
[INFO] [stdout]      |
[INFO] [stdout] 2151 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9 = trace.add_signal("__mem_trace_test_module_3_mem_0_writ...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_value_9`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2152:13
[INFO] [stdout]      |
[INFO] [stdout] 2152 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10 = trace.add_signal("__mem_trace_test_module_3_mem_0_wr...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_enable_10`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 10 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.40s
[INFO] running `Command { std: "docker" "inspect" "e557fac6579cf821fcc1229411660a508a0661c3156f7891320c73f48945c251", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e557fac6579cf821fcc1229411660a508a0661c3156f7891320c73f48945c251", kill_on_drop: false }`
[INFO] [stdout] e557fac6579cf821fcc1229411660a508a0661c3156f7891320c73f48945c251
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] abaec7642db1ee32456b076020cb74382715ca5dabc04460c458042d6de79610
[INFO] running `Command { std: "docker" "start" "-a" "abaec7642db1ee32456b076020cb74382715ca5dabc04460c458042d6de79610", kill_on_drop: false }`
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2130:5
[INFO] [stderr]      |
[INFO] [stderr] 2130 |     __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_address_6`
[INFO] [stderr]      |
[INFO] [stderr]      = note: `#[warn(non_snake_case)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2131:5
[INFO] [stderr]      |
[INFO] [stderr] 2131 |     __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_enable_7`
[INFO] [stderr] 
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2132:5
[INFO] [stderr]      |
[INFO] [stderr] 2132 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_address_8`
[INFO] [stderr] 
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2133:5
[INFO] [stderr]      |
[INFO] [stderr] 2133 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_value_9`
[INFO] [stderr] 
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2134:5
[INFO] [stderr]      |
[INFO] [stderr] 2134 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_enable_10`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2148:13
[INFO] [stderr]      |
[INFO] [stderr] 2148 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6 = trace.add_signal("__mem_trace_test_module_3_mem_0_r...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_address_6`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2149:13
[INFO] [stderr]      |
[INFO] [stderr] 2149 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7 = trace.add_signal("__mem_trace_test_module_3_mem_0_re...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_enable_7`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2150:13
[INFO] [stderr]      |
[INFO] [stderr] 2150 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8 = trace.add_signal("__mem_trace_test_module_3_mem_0_wr...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_address_8`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2151:13
[INFO] [stderr]      |
[INFO] [stderr] 2151 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9 = trace.add_signal("__mem_trace_test_module_3_mem_0_writ...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_value_9`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-d3edc0d6e45d9b1c/out/modules.rs:2152:13
[INFO] [stderr]      |
[INFO] [stderr] 2152 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10 = trace.add_signal("__mem_trace_test_module_3_mem_0_wr...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_enable_10`
[INFO] [stderr] 
[INFO] [stderr] warning: `sim-tests` (lib test) generated 10 warnings
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kaze-c59125b7494d773d)
[INFO] [stdout] 
[INFO] [stdout] running 111 tests
[INFO] [stdout] test graph::context::tests::new_context_has_no_modules ... ok
[INFO] [stdout] test graph::mem::tests::initial_contents_already_specified_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::initial_contents_element_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::initial_contents_length_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::read_port_address_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_value_cannot_bit_into_bit_width_error_3 - should panic ... ok
[INFO] [stdout] test graph::mem::tests::read_port_enable_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::write_port_value_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::write_port_enable_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_drive_already_driven_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_drive_different_module_than_parent_module_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::write_port_address_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_drive_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_bit_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_bit_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_value_cannot_bit_into_bit_width_error_1 - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_value_cannot_bit_into_bit_width_error_2 - should panic ... ok
[INFO] [stdout] test graph::mem::tests::write_port_already_specified_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_already_specified_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mem_address_bit_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mem_address_bit_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mem_element_bit_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mem_element_bit_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::drive_next_incompatible_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_cond_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_true_false_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_when_false_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_when_true_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::output_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::reg_bit_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::reg_bit_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_cannot_bit_into_bit_width_error_1 - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_value_cannot_bit_into_bit_width_error_4 - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_cannot_bit_into_bit_width_error_2 - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_cannot_bit_into_bit_width_error_3 - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_cannot_bit_into_bit_width_error_4 - should panic ... ok
[INFO] [stdout] test graph::register::tests::drive_next_already_driven_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_cond_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::drive_next_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::add_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::add_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitand_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitand_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitor_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitor_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bits_range_high_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bits_range_low_gt_high_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bits_range_low_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_signed_bit_width_1_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_signed_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::concat_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::eq_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_signed_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bit_index_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_signed_bit_width_1_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_signed_bit_width_1_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitxor_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitxor_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::concat_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_cond_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_signed_bit_width_1_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::eq_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_signed_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_signed_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mul_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mul_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mul_signed_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mul_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_cond_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_true_false_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_when_false_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_when_true_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ne_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ne_separate_module_error - should panic ... ok
[INFO] [stdout] test sim::tests::undriven_register_error1 - should panic ... ok
[INFO] [stdout] test graph::signal::tests::repeat_count_zero_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::shl_separate_module_error - should panic ... ok
[INFO] [stdout] test verilog::tests::mem_without_initial_contents_or_write_port_error1 - should panic ... ok
[INFO] [stdout] test graph::signal::tests::shr_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::sub_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::sub_separate_module_error - should panic ... ok
[INFO] [stdout] test sim::tests::combinational_loop_error - should panic ... ok
[INFO] [stdout] test verilog::tests::undriven_register_error2 - should panic ... ok
[INFO] [stdout] test sim::tests::mem_without_initial_contents_or_write_port_error2 - should panic ... ok
[INFO] [stdout] test sim::tests::mem_without_read_ports_error1 - should panic ... ok
[INFO] [stdout] test sim::tests::mem_without_read_ports_error2 - should panic ... ok
[INFO] [stdout] test sim::tests::undriven_instance_input_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::repeat_count_oob_error - should panic ... ok
[INFO] [stdout] test sim::tests::undriven_register_error2 - should panic ... ok
[INFO] [stdout] test verilog::tests::combinational_loop_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::shr_arithmetic_separate_module_error - should panic ... ok
[INFO] [stdout] test verilog::tests::mem_without_initial_contents_or_write_port_error2 - should panic ... ok
[INFO] [stdout] test verilog::tests::mem_without_read_ports_error1 - should panic ... ok
[INFO] [stdout] test verilog::tests::mem_without_read_ports_error2 - should panic ... ok
[INFO] [stdout] test verilog::tests::undriven_instance_input_error - should panic ... ok
[INFO] [stdout] test verilog::tests::undriven_register_error1 - should panic ... ok
[INFO] [stdout] test sim::tests::mem_without_initial_contents_or_write_port_error1 - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 111 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sim_tests-9d57618da59be4f6)
[INFO] [stdout] 
[INFO] [stdout] running 45 tests
[INFO] [stdout] test tests::add_test_module ... ok
[INFO] [stdout] test tests::bit_and_test_module ... ok
[INFO] [stdout] test tests::bit_or_test_module ... ok
[INFO] [stdout] test tests::bit_test_module_0 ... ok
[INFO] [stdout] test tests::bit_test_module_1 ... ok
[INFO] [stdout] test tests::bit_xor_test_module ... ok
[INFO] [stdout] test tests::bits_test_module_0 ... ok
[INFO] [stdout] test tests::bits_test_module_1 ... ok
[INFO] [stdout] test tests::concat_test_module ... ok
[INFO] [stdout] test tests::deep_graph_test_module ... ok
[INFO] [stdout] test tests::eq_test_module ... ok
[INFO] [stdout] test tests::ge_signed_test_module ... ok
[INFO] [stdout] test tests::ge_test_module ... ok
[INFO] [stdout] test tests::gt_signed_test_module ... ok
[INFO] [stdout] test tests::gt_test_module ... ok
[INFO] [stdout] test tests::input_masking ... ok
[INFO] [stdout] test tests::instantiation_test_module_comb ... ok
[INFO] [stdout] test tests::instantiation_test_module_reg ... ok
[INFO] [stdout] test tests::le_signed_test_module ... ok
[INFO] [stdout] test tests::le_test_module ... ok
[INFO] [stdout] test tests::lt_signed_test_module ... ok
[INFO] [stdout] test tests::lt_test_module ... ok
[INFO] [stdout] test tests::mem_test_module_1 ... ok
[INFO] [stdout] test tests::mem_test_module_0 ... ok
[INFO] [stdout] test tests::mem_test_module_2 ... ok
[INFO] [stdout] test tests::mul_signed_test_module ... ok
[INFO] [stdout] test tests::mul_test_module ... ok
[INFO] [stdout] test tests::mux_test_module ... ok
[INFO] [stdout] test tests::ne_test_module ... ok
[INFO] [stdout] test tests::nested_instantiation_test_module ... ok
[INFO] [stdout] test tests::not_test_module ... ok
[INFO] [stdout] test tests::reg_next_test_module ... ok
[INFO] [stdout] test tests::reg_next_with_default_test_module ... ok
[INFO] [stdout] test tests::reg_test_module ... ok
[INFO] [stdout] test tests::repeat_test_module ... ok
[INFO] [stdout] test tests::shl_test_module ... ok
[INFO] [stdout] test tests::shr_arithmetic_test_module ... ok
[INFO] [stdout] test tests::shr_test_module ... ok
[INFO] [stdout] test tests::simple_reg_delay ... ok
[INFO] [stdout] test tests::sub_test_module ... ok
[INFO] [stdout] test tests::trace_test_module_0 ... ok
[INFO] [stdout] test tests::widest_input ... ok
[INFO] [stdout] test tests::trace_test_module_1 ... ok
[INFO] [stdout] test tests::trace_test_module_2 ... FAILED
[INFO] [stdout] test tests::trace_test_module_3 ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::trace_test_module_2 stdout ----
[INFO] [stdout] thread 'tests::trace_test_module_2' panicked at sim-tests/src/lib.rs:2378:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: module trace_test_module_2:
[INFO] [stdout]     children:
[INFO] [stdout]         module inner1:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 i1: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(4294967295)
[INFO] [stdout]                     1: U32(4294967295)
[INFO] [stdout]                     2: U32(4294967295)
[INFO] [stdout]                 i2: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(4294901760)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]                 o: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]         module inner2:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 i1: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(16711680)
[INFO] [stdout]                     1: U32(16711680)
[INFO] [stdout]                     2: U32(16711680)
[INFO] [stdout]                 i2: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(983040)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]                 o: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]         module inner3:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 i1: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]                 i2: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]                 o: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(0)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(0)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]     signals:
[INFO] [stdout]         i1: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(4294967295)
[INFO] [stdout]             1: U32(4294967295)
[INFO] [stdout]             2: U32(4294967295)
[INFO] [stdout]         i2: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(4294901760)
[INFO] [stdout]             1: U32(4294901760)
[INFO] [stdout]             2: U32(4294901760)
[INFO] [stdout]         i3: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(16711680)
[INFO] [stdout]             1: U32(16711680)
[INFO] [stdout]             2: U32(16711680)
[INFO] [stdout]         i4: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(983040)
[INFO] [stdout]             1: U32(983040)
[INFO] [stdout]             2: U32(983040)
[INFO] [stdout]         o: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(983040)
[INFO] [stdout] 
[INFO] [stdout]  right: module trace_test_module_2:
[INFO] [stdout]     children:
[INFO] [stdout]         module inner1:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]         module inner2:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]         module inner3:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(0)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]     signals:
[INFO] [stdout]         i1: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(4294967295)
[INFO] [stdout]             1: U32(4294967295)
[INFO] [stdout]             2: U32(4294967295)
[INFO] [stdout]         i2: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(4294901760)
[INFO] [stdout]             1: U32(4294901760)
[INFO] [stdout]             2: U32(4294901760)
[INFO] [stdout]         i3: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(16711680)
[INFO] [stdout]             1: U32(16711680)
[INFO] [stdout]             2: U32(16711680)
[INFO] [stdout]         i4: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(983040)
[INFO] [stdout]             1: U32(983040)
[INFO] [stdout]             2: U32(983040)
[INFO] [stdout]         o: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(983040)
[INFO] [stdout] 
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55cbf360896c - 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:     0x55cbf360896c - 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:     0x55cbf360896c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55cbf360896c - <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:     0x55cbf36324d0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55cbf36324d0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55cbf360631f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x55cbf3608754 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55cbf3608754 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55cbf360a417 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x55cbf360a103 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55cbf35d7787 - <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:     0x55cbf35d7787 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55cbf360aa28 - <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:     0x55cbf360aa28 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55cbf360a77e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55cbf3608e36 - 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:     0x55cbf360a4e2 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55cbf354fd55 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55cbf355016b - core::panicking::assert_failed_inner::h0bba8b7c26ee4492
[INFO] [stdout]   20:     0x55cbf3597e0e - core::panicking::assert_failed::h9232acd31e3a79d5
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:279:5
[INFO] [stdout]   21:     0x55cbf357a358 - sim_tests::tests::trace_test_module_2::h100c3317f910e547
[INFO] [stdout]                                at /opt/rustwide/workdir/sim-tests/src/lib.rs:2378:9
[INFO] [stdout]   22:     0x55cbf3577c47 - sim_tests::tests::trace_test_module_2::{{closure}}::h9c0f19470b52cac7
[INFO] [stdout]                                at /opt/rustwide/workdir/sim-tests/src/lib.rs:2346:33
[INFO] [stdout]   23:     0x55cbf3592d06 - core::ops::function::FnOnce::call_once::he621709e36ec9e68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x55cbf35dcddf - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x55cbf35dcddf - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   26:     0x55cbf35dbdf5 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   27:     0x55cbf35dbdf5 - <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:     0x55cbf35dbdf5 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x55cbf35dbdf5 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x55cbf35dbdf5 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x55cbf35dbdf5 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   32:     0x55cbf35dbdf5 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   33:     0x55cbf35a40b6 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   34:     0x55cbf35a40b6 - 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:     0x55cbf35a9167 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x55cbf35a9167 - <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:     0x55cbf35a9167 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x55cbf35a9167 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x55cbf35a9167 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x55cbf35a9167 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x55cbf35a9167 - 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:     0x55cbf360f4b5 - <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:     0x55cbf360f4b5 - <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:     0x55cbf360f4b5 - 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:     0x7fb0b545aac3 - <unknown>
[INFO] [stdout]   46:     0x7fb0b54ebbf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::trace_test_module_3 stdout ----
[INFO] [stdout] thread 'tests::trace_test_module_3' panicked at sim-tests/src/lib.rs:2611:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: module trace_test_module_3:
[INFO] [stdout]     children:
[INFO] [stdout]     signals:
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_read_port_0_address: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_read_port_0_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(true)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_write_port_address: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_write_port_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_write_port_value: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(5)
[INFO] [stdout]             3: U32(5)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(0)
[INFO] [stdout]             4: U32(12)
[INFO] [stdout]             5: U32(12)
[INFO] [stdout]         read_addr: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         read_data: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(5)
[INFO] [stdout]             4: U32(5)
[INFO] [stdout]             5: U32(5)
[INFO] [stdout]         read_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(true)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         write_addr: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         write_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         write_value: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(5)
[INFO] [stdout]             3: U32(5)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(0)
[INFO] [stdout]             4: U32(12)
[INFO] [stdout]             5: U32(12)
[INFO] [stdout] 
[INFO] [stdout]  right: module trace_test_module_3:
[INFO] [stdout]     children:
[INFO] [stdout]     signals:
[INFO] [stdout]         mem_0_read_port_0_address: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         mem_0_read_port_0_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(true)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         mem_0_write_port_address: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         mem_0_write_port_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         mem_0_write_port_value: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(5)
[INFO] [stdout]             3: U32(5)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(0)
[INFO] [stdout]             4: U32(12)
[INFO] [stdout]             5: U32(12)
[INFO] [stdout]         read_addr: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         read_data: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(5)
[INFO] [stdout]             4: U32(5)
[INFO] [stdout]             5: U32(5)
[INFO] [stdout]         read_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(true)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         write_addr: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         write_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         write_value: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(5)
[INFO] [stdout]             3: U32(5)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(0)
[INFO] [stdout]             4: U32(12)
[INFO] [stdout]             5: U32(12)
[INFO] [stdout] 
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55cbf360896c - 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:     0x55cbf360896c - 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:     0x55cbf360896c - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x55cbf360896c - <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:     0x55cbf36324d0 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x55cbf36324d0 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x55cbf360631f - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x55cbf3608754 - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x55cbf3608754 - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x55cbf360a417 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]   10:     0x55cbf360a103 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x55cbf35d7787 - <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:     0x55cbf35d7787 - test::test_main::{{closure}}::h7500b54257359db6
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x55cbf360aa28 - <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:     0x55cbf360aa28 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x55cbf360a77e - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x55cbf3608e36 - 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:     0x55cbf360a4e2 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x55cbf354fd55 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x55cbf355016b - core::panicking::assert_failed_inner::h0bba8b7c26ee4492
[INFO] [stdout]   20:     0x55cbf3597e0e - core::panicking::assert_failed::h9232acd31e3a79d5
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:279:5
[INFO] [stdout]   21:     0x55cbf357f276 - sim_tests::tests::trace_test_module_3::h33e29e290fd0c017
[INFO] [stdout]                                at /opt/rustwide/workdir/sim-tests/src/lib.rs:2611:9
[INFO] [stdout]   22:     0x55cbf357a467 - sim_tests::tests::trace_test_module_3::{{closure}}::h68388fff10632775
[INFO] [stdout]                                at /opt/rustwide/workdir/sim-tests/src/lib.rs:2529:33
[INFO] [stdout]   23:     0x55cbf3592a66 - core::ops::function::FnOnce::call_once::ha159b9aa0764aa55
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x55cbf35dcddf - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x55cbf35dcddf - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   26:     0x55cbf35dbdf5 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   27:     0x55cbf35dbdf5 - <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:     0x55cbf35dbdf5 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x55cbf35dbdf5 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x55cbf35dbdf5 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x55cbf35dbdf5 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   32:     0x55cbf35dbdf5 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   33:     0x55cbf35a40b6 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   34:     0x55cbf35a40b6 - 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:     0x55cbf35a9167 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x55cbf35a9167 - <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:     0x55cbf35a9167 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x55cbf35a9167 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x55cbf35a9167 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x55cbf35a9167 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x55cbf35a9167 - 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:     0x55cbf360f4b5 - <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] [stderr] error: test failed, to rerun pass `-p sim-tests --lib`
[INFO] [stdout]   43:     0x55cbf360f4b5 - <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:     0x55cbf360f4b5 - 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:     0x7fb0b545aac3 - <unknown>
[INFO] [stdout]   46:     0x7fb0b54ebbf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::trace_test_module_2
[INFO] [stdout]     tests::trace_test_module_3
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 43 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "abaec7642db1ee32456b076020cb74382715ca5dabc04460c458042d6de79610", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "abaec7642db1ee32456b076020cb74382715ca5dabc04460c458042d6de79610", kill_on_drop: false }`
[INFO] [stdout] abaec7642db1ee32456b076020cb74382715ca5dabc04460c458042d6de79610
[INFO] testing yupferris/kaze 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%2Fyupferris%2Fkaze" "/workspace/builds/worker-6-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-6-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/yupferris/kaze 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/yupferris/kaze
[INFO] finished tweaking git repo https://github.com/yupferris/kaze
[INFO] tweaked toml for git repo https://github.com/yupferris/kaze written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2023-12-22" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[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-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 58e9ef469d915c894fe8138f2fef68507d87833951c1c7b43116f1fbeb1fd1fa
[INFO] running `Command { std: "docker" "start" "-a" "58e9ef469d915c894fe8138f2fef68507d87833951c1c7b43116f1fbeb1fd1fa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "58e9ef469d915c894fe8138f2fef68507d87833951c1c7b43116f1fbeb1fd1fa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "58e9ef469d915c894fe8138f2fef68507d87833951c1c7b43116f1fbeb1fd1fa", kill_on_drop: false }`
[INFO] [stdout] 58e9ef469d915c894fe8138f2fef68507d87833951c1c7b43116f1fbeb1fd1fa
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 47cf5d2921ffecb2e15eed1f4a977526997531f9afedee62b9e48cfe357c21d3
[INFO] running `Command { std: "docker" "start" "-a" "47cf5d2921ffecb2e15eed1f4a977526997531f9afedee62b9e48cfe357c21d3", kill_on_drop: false }`
[INFO] [stderr]    Compiling vcd v0.6.1
[INFO] [stderr]    Compiling typed-arena v2.0.2
[INFO] [stderr]    Compiling kaze v0.1.19 (/opt/rustwide/workdir/kaze)
[INFO] [stderr]    Compiling sim-tests v0.1.0 (/opt/rustwide/workdir/sim-tests)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.57s
[INFO] running `Command { std: "docker" "inspect" "47cf5d2921ffecb2e15eed1f4a977526997531f9afedee62b9e48cfe357c21d3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "47cf5d2921ffecb2e15eed1f4a977526997531f9afedee62b9e48cfe357c21d3", kill_on_drop: false }`
[INFO] [stdout] 47cf5d2921ffecb2e15eed1f4a977526997531f9afedee62b9e48cfe357c21d3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] 8d67651a22a074636ff8e9db09f26f53d2e5df9443273ede066c47c65683c085
[INFO] running `Command { std: "docker" "start" "-a" "8d67651a22a074636ff8e9db09f26f53d2e5df9443273ede066c47c65683c085", kill_on_drop: false }`
[INFO] [stderr]    Compiling kaze v0.1.19 (/opt/rustwide/workdir/kaze)
[INFO] [stderr]    Compiling sim-tests v0.1.0 (/opt/rustwide/workdir/sim-tests)
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2130:5
[INFO] [stdout]      |
[INFO] [stdout] 2130 |     __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_address_6`
[INFO] [stdout]      |
[INFO] [stdout]      = note: `#[warn(non_snake_case)]` on by default
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2131:5
[INFO] [stdout]      |
[INFO] [stdout] 2131 |     __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_enable_7`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2132:5
[INFO] [stdout]      |
[INFO] [stdout] 2132 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_address_8`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2133:5
[INFO] [stdout]      |
[INFO] [stdout] 2133 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_value_9`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2134:5
[INFO] [stdout]      |
[INFO] [stdout] 2134 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10: T::SignalId,
[INFO] [stdout]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_enable_10`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2148:13
[INFO] [stdout]      |
[INFO] [stdout] 2148 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6 = trace.add_signal("__mem_trace_test_module_3_mem_0_r...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_address_6`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2149:13
[INFO] [stdout]      |
[INFO] [stdout] 2149 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7 = trace.add_signal("__mem_trace_test_module_3_mem_0_re...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_enable_7`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2150:13
[INFO] [stdout]      |
[INFO] [stdout] 2150 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8 = trace.add_signal("__mem_trace_test_module_3_mem_0_wr...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_address_8`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2151:13
[INFO] [stdout]      |
[INFO] [stdout] 2151 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9 = trace.add_signal("__mem_trace_test_module_3_mem_0_writ...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_value_9`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10` should have a snake case name
[INFO] [stdout]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2152:13
[INFO] [stdout]      |
[INFO] [stdout] 2152 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10 = trace.add_signal("__mem_trace_test_module_3_mem_0_wr...
[INFO] [stdout]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_enable_10`
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 10 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.44s
[INFO] running `Command { std: "docker" "inspect" "8d67651a22a074636ff8e9db09f26f53d2e5df9443273ede066c47c65683c085", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8d67651a22a074636ff8e9db09f26f53d2e5df9443273ede066c47c65683c085", kill_on_drop: false }`
[INFO] [stdout] 8d67651a22a074636ff8e9db09f26f53d2e5df9443273ede066c47c65683c085
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-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] e69a2f80ea76ec10ccc049dfaea8eb0f0e22d4e60268d5f0a859cbfc55786b30
[INFO] running `Command { std: "docker" "start" "-a" "e69a2f80ea76ec10ccc049dfaea8eb0f0e22d4e60268d5f0a859cbfc55786b30", kill_on_drop: false }`
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2130:5
[INFO] [stderr]      |
[INFO] [stderr] 2130 |     __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_address_6`
[INFO] [stderr]      |
[INFO] [stderr]      = note: `#[warn(non_snake_case)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2131:5
[INFO] [stderr]      |
[INFO] [stderr] 2131 |     __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_enable_7`
[INFO] [stderr] 
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2132:5
[INFO] [stderr]      |
[INFO] [stderr] 2132 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_address_8`
[INFO] [stderr] 
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2133:5
[INFO] [stderr]      |
[INFO] [stderr] 2133 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_value_9`
[INFO] [stderr] 
[INFO] [stderr] warning: structure field `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2134:5
[INFO] [stderr]      |
[INFO] [stderr] 2134 |     __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10: T::SignalId,
[INFO] [stderr]      |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_enable_10`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2148:13
[INFO] [stderr]      |
[INFO] [stderr] 2148 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_address_6 = trace.add_signal("__mem_trace_test_module_3_mem_0_r...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_address_6`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2149:13
[INFO] [stderr]      |
[INFO] [stderr] 2149 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_read_port_0_enable_7 = trace.add_signal("__mem_trace_test_module_3_mem_0_re...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_read_port_0_enable_7`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2150:13
[INFO] [stderr]      |
[INFO] [stderr] 2150 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_address_8 = trace.add_signal("__mem_trace_test_module_3_mem_0_wr...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_address_8`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2151:13
[INFO] [stderr]      |
[INFO] [stderr] 2151 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_value_9 = trace.add_signal("__mem_trace_test_module_3_mem_0_writ...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_value_9`
[INFO] [stderr] 
[INFO] [stderr] warning: variable `__trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10` should have a snake case name
[INFO] [stderr]     --> /opt/rustwide/target/debug/build/sim-tests-374afe447932be5d/out/modules.rs:2152:13
[INFO] [stderr]      |
[INFO] [stderr] 2152 |         let __trace_signal_id___mem_trace_test_module_3_mem_0_write_port_enable_10 = trace.add_signal("__mem_trace_test_module_3_mem_0_wr...
[INFO] [stderr]      |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ help: convert the identifier to snake case: `__trace_signal_id_mem_trace_test_module_3_mem_0_write_port_enable_10`
[INFO] [stderr] 
[INFO] [stderr] warning: `sim-tests` (lib test) generated 10 warnings
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kaze-f3f4922bca38b998)
[INFO] [stdout] 
[INFO] [stdout] running 111 tests
[INFO] [stdout] test graph::context::tests::new_context_has_no_modules ... ok
[INFO] [stdout] test graph::mem::tests::initial_contents_element_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::initial_contents_already_specified_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::initial_contents_length_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::read_port_address_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::read_port_enable_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::write_port_address_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::write_port_already_specified_error - should panic ... ok
[INFO] [stdout] test graph::mem::tests::write_port_enable_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mem_element_bit_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_drive_already_driven_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_drive_different_module_than_parent_module_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_drive_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_true_false_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_when_true_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_bit_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_value_cannot_bit_into_bit_width_error_1 - should panic ... ok
[INFO] [stdout] test graph::module::tests::reg_bit_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_already_specified_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_cannot_bit_into_bit_width_error_1 - should panic ... ok
[INFO] [stdout] test graph::module::tests::mem_address_bit_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_cannot_bit_into_bit_width_error_3 - should panic ... ok
[INFO] [stdout] test graph::mem::tests::write_port_value_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mem_element_bit_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_cond_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::drive_next_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::add_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_when_false_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_bit_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::output_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::reg_bit_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_value_cannot_bit_into_bit_width_error_2 - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_value_cannot_bit_into_bit_width_error_3 - should panic ... ok
[INFO] [stdout] test graph::module::tests::lit_value_cannot_bit_into_bit_width_error_4 - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_cannot_bit_into_bit_width_error_2 - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bits_range_low_oob_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::default_value_cannot_bit_into_bit_width_error_4 - should panic ... ok
[INFO] [stdout] test graph::register::tests::drive_next_already_driven_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::concat_oob_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mux_cond_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::input_width_gt_max_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::add_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bit_index_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitand_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitand_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitor_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bits_range_high_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bits_range_low_gt_high_error - should panic ... ok
[INFO] [stdout] test graph::module::tests::mem_address_bit_width_lt_min_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitxor_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitxor_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::register::tests::drive_next_incompatible_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::concat_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::eq_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::eq_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_signed_bit_width_1_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ge_signed_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::bitor_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mul_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mul_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_signed_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_cond_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_cond_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_signed_bit_width_1_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_when_false_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ne_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_signed_bit_width_1_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_signed_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::gt_signed_bit_width_1_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mul_signed_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::sub_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_true_false_bit_width_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::le_signed_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mux_when_true_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::ne_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::lt_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::repeat_count_oob_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::repeat_count_zero_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::shl_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::shr_arithmetic_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::shr_separate_module_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::sub_incompatible_bit_widths_error - should panic ... ok
[INFO] [stdout] test graph::signal::tests::mul_signed_separate_module_error - should panic ... ok
[INFO] [stdout] test sim::tests::combinational_loop_error - should panic ... ok
[INFO] [stdout] test sim::tests::mem_without_initial_contents_or_write_port_error1 - should panic ... ok
[INFO] [stdout] test sim::tests::mem_without_initial_contents_or_write_port_error2 - should panic ... ok
[INFO] [stdout] test sim::tests::mem_without_read_ports_error1 - should panic ... ok
[INFO] [stdout] test sim::tests::mem_without_read_ports_error2 - should panic ... ok
[INFO] [stdout] test sim::tests::undriven_instance_input_error - should panic ... ok
[INFO] [stdout] test sim::tests::undriven_register_error1 - should panic ... ok
[INFO] [stdout] test sim::tests::undriven_register_error2 - should panic ... ok
[INFO] [stdout] test verilog::tests::combinational_loop_error - should panic ... ok
[INFO] [stdout] test verilog::tests::mem_without_initial_contents_or_write_port_error1 - should panic ... ok
[INFO] [stdout] test verilog::tests::mem_without_initial_contents_or_write_port_error2 - should panic ... ok
[INFO] [stdout] test verilog::tests::mem_without_read_ports_error1 - should panic ... ok
[INFO] [stdout] test verilog::tests::mem_without_read_ports_error2 - should panic ... ok
[INFO] [stdout] test verilog::tests::undriven_instance_input_error - should panic ... ok
[INFO] [stdout] test verilog::tests::undriven_register_error1 - should panic ... ok
[INFO] [stdout] test verilog::tests::undriven_register_error2 - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 111 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sim_tests-19df32f7851a4dcc)
[INFO] [stdout] 
[INFO] [stdout] running 45 tests
[INFO] [stdout] test tests::bit_or_test_module ... ok
[INFO] [stdout] test tests::add_test_module ... ok
[INFO] [stdout] test tests::bit_and_test_module ... ok
[INFO] [stdout] test tests::bit_test_module_0 ... ok
[INFO] [stdout] test tests::bit_test_module_1 ... ok
[INFO] [stdout] test tests::bit_xor_test_module ... ok
[INFO] [stdout] test tests::bits_test_module_0 ... ok
[INFO] [stdout] test tests::bits_test_module_1 ... ok
[INFO] [stdout] test tests::concat_test_module ... ok
[INFO] [stdout] test tests::deep_graph_test_module ... ok
[INFO] [stdout] test tests::eq_test_module ... ok
[INFO] [stdout] test tests::ge_signed_test_module ... ok
[INFO] [stdout] test tests::ge_test_module ... ok
[INFO] [stdout] test tests::gt_signed_test_module ... ok
[INFO] [stdout] test tests::gt_test_module ... ok
[INFO] [stdout] test tests::input_masking ... ok
[INFO] [stdout] test tests::instantiation_test_module_comb ... ok
[INFO] [stdout] test tests::instantiation_test_module_reg ... ok
[INFO] [stdout] test tests::le_signed_test_module ... ok
[INFO] [stdout] test tests::le_test_module ... ok
[INFO] [stdout] test tests::lt_signed_test_module ... ok
[INFO] [stdout] test tests::lt_test_module ... ok
[INFO] [stdout] test tests::mem_test_module_0 ... ok
[INFO] [stdout] test tests::mem_test_module_1 ... ok
[INFO] [stdout] test tests::mul_signed_test_module ... ok
[INFO] [stdout] test tests::ne_test_module ... ok
[INFO] [stdout] test tests::mem_test_module_2 ... ok
[INFO] [stdout] test tests::nested_instantiation_test_module ... ok
[INFO] [stdout] test tests::mux_test_module ... ok
[INFO] [stdout] test tests::mul_test_module ... ok
[INFO] [stdout] test tests::reg_next_test_module ... ok
[INFO] [stdout] test tests::not_test_module ... ok
[INFO] [stdout] test tests::reg_next_with_default_test_module ... ok
[INFO] [stdout] test tests::shl_test_module ... ok
[INFO] [stdout] test tests::shr_arithmetic_test_module ... ok
[INFO] [stdout] test tests::shr_test_module ... ok
[INFO] [stdout] test tests::simple_reg_delay ... ok
[INFO] [stdout] test tests::sub_test_module ... ok
[INFO] [stdout] test tests::reg_test_module ... ok
[INFO] [stdout] test tests::repeat_test_module ... ok
[INFO] [stdout] test tests::widest_input ... ok
[INFO] [stdout] test tests::trace_test_module_1 ... ok
[INFO] [stdout] test tests::trace_test_module_0 ... ok
[INFO] [stdout] test tests::trace_test_module_2 ... FAILED
[INFO] [stdout] test tests::trace_test_module_3 ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::trace_test_module_2 stdout ----
[INFO] [stdout] thread 'tests::trace_test_module_2' panicked at sim-tests/src/lib.rs:2378:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: module trace_test_module_2:
[INFO] [stdout]     children:
[INFO] [stdout]         module inner1:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 i1: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(4294967295)
[INFO] [stdout]                     1: U32(4294967295)
[INFO] [stdout]                     2: U32(4294967295)
[INFO] [stdout]                 i2: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(4294901760)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]                 o: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]         module inner2:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 i1: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(16711680)
[INFO] [stdout]                     1: U32(16711680)
[INFO] [stdout]                     2: U32(16711680)
[INFO] [stdout]                 i2: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(983040)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]                 o: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]         module inner3:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 i1: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]                 i2: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]                 o: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(0)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(0)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]     signals:
[INFO] [stdout]         i1: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(4294967295)
[INFO] [stdout]             1: U32(4294967295)
[INFO] [stdout]             2: U32(4294967295)
[INFO] [stdout]         i2: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(4294901760)
[INFO] [stdout]             1: U32(4294901760)
[INFO] [stdout]             2: U32(4294901760)
[INFO] [stdout]         i3: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(16711680)
[INFO] [stdout]             1: U32(16711680)
[INFO] [stdout]             2: U32(16711680)
[INFO] [stdout]         i4: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(983040)
[INFO] [stdout]             1: U32(983040)
[INFO] [stdout]             2: U32(983040)
[INFO] [stdout]         o: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(983040)
[INFO] [stdout] 
[INFO] [stdout]  right: module trace_test_module_2:
[INFO] [stdout]     children:
[INFO] [stdout]         module inner1:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(4294901760)
[INFO] [stdout]                     2: U32(4294901760)
[INFO] [stdout]         module inner2:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(983040)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]         module inner3:
[INFO] [stdout]             children:
[INFO] [stdout]             signals:
[INFO] [stdout]                 r: 32 bit(s) (U32)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     0: U32(0)
[INFO] [stdout]                     1: U32(0)
[INFO] [stdout]                     2: U32(983040)
[INFO] [stdout]     signals:
[INFO] [stdout]         i1: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(4294967295)
[INFO] [stdout]             1: U32(4294967295)
[INFO] [stdout]             2: U32(4294967295)
[INFO] [stdout]         i2: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(4294901760)
[INFO] [stdout]             1: U32(4294901760)
[INFO] [stdout]             2: U32(4294901760)
[INFO] [stdout]         i3: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(16711680)
[INFO] [stdout]             1: U32(16711680)
[INFO] [stdout]             2: U32(16711680)
[INFO] [stdout]         i4: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(983040)
[INFO] [stdout]             1: U32(983040)
[INFO] [stdout]             2: U32(983040)
[INFO] [stdout]         o: 32 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(983040)
[INFO] [stdout] 
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x56131d24ee06 - 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:     0x56131d24ee06 - 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:     0x56131d24ee06 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x56131d24ee06 - <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:     0x56131d277c70 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x56131d277c70 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x56131d24c86f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x56131d24ebe4 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x56131d24ebe4 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x56131d250957 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x56131d25063d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x56131d21d4d7 - <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:     0x56131d21d4d7 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x56131d250f76 - <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:     0x56131d250f76 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x56131d250cc2 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x56131d24f306 - 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:     0x56131d250a20 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x56131d194d35 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x56131d19516b - core::panicking::assert_failed_inner::h9f13e27dd63c3a08
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:342:17
[INFO] [stdout]   20:     0x56131d1db86e - core::panicking::assert_failed::he1c16134676c1a4d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:297:5
[INFO] [stdout]   21:     0x56131d1bef34 - sim_tests::tests::trace_test_module_2::hffeee39ed9ac16d8
[INFO] [stdout]                                at /opt/rustwide/workdir/sim-tests/src/lib.rs:2378:9
[INFO] [stdout]   22:     0x56131d1bc837 - sim_tests::tests::trace_test_module_2::{{closure}}::h169b234ab6a64093
[INFO] [stdout]                                at /opt/rustwide/workdir/sim-tests/src/lib.rs:2346:33
[INFO] [stdout]   23:     0x56131d1d9b96 - core::ops::function::FnOnce::call_once::hed318d678d5b3d86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x56131d222daf - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x56131d222daf - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   26:     0x56131d221b31 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   27:     0x56131d221b31 - <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:     0x56131d221b31 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x56131d221b31 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x56131d221b31 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x56131d221b31 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   32:     0x56131d221b31 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   33:     0x56131d1e8e66 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   34:     0x56131d1e8e66 - 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:     0x56131d1edec7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x56131d1edec7 - <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:     0x56131d1edec7 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x56131d1edec7 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x56131d1edec7 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x56131d1edec7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x56131d1edec7 - 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:     0x56131d255a25 - <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:     0x56131d255a25 - <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:     0x56131d255a25 - 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:     0x7f419e1d0ac3 - <unknown>
[INFO] [stdout]   46:     0x7f419e261bf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- tests::trace_test_module_3 stdout ----
[INFO] [stdout] thread 'tests::trace_test_module_3' panicked at sim-tests/src/lib.rs:2611:9:
[INFO] [stdout] assertion `left == right` failed
[INFO] [stdout]   left: module trace_test_module_3:
[INFO] [stdout]     children:
[INFO] [stdout]     signals:
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_read_port_0_address: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_read_port_0_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(true)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_write_port_address: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_write_port_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         __mem_trace_test_module_3_mem_0_write_port_value: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(5)
[INFO] [stdout]             3: U32(5)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(0)
[INFO] [stdout]             4: U32(12)
[INFO] [stdout]             5: U32(12)
[INFO] [stdout]         read_addr: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         read_data: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(5)
[INFO] [stdout]             4: U32(5)
[INFO] [stdout]             5: U32(5)
[INFO] [stdout]         read_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(true)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         write_addr: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         write_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         write_value: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(5)
[INFO] [stdout]             3: U32(5)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(0)
[INFO] [stdout]             4: U32(12)
[INFO] [stdout]             5: U32(12)
[INFO] [stdout] 
[INFO] [stdout]  right: module trace_test_module_3:
[INFO] [stdout]     children:
[INFO] [stdout]     signals:
[INFO] [stdout]         mem_0_read_port_0_address: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         mem_0_read_port_0_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(true)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         mem_0_write_port_address: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         mem_0_write_port_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         mem_0_write_port_value: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(5)
[INFO] [stdout]             3: U32(5)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(0)
[INFO] [stdout]             4: U32(12)
[INFO] [stdout]             5: U32(12)
[INFO] [stdout]         read_addr: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         read_data: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(5)
[INFO] [stdout]             4: U32(5)
[INFO] [stdout]             5: U32(5)
[INFO] [stdout]         read_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(true)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         write_addr: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             5: Bool(false)
[INFO] [stdout]         write_enable: 1 bit(s) (Bool)
[INFO] [stdout]             0: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             1: Bool(false)
[INFO] [stdout]             2: Bool(false)
[INFO] [stdout]             2: Bool(true)
[INFO] [stdout]             3: Bool(true)
[INFO] [stdout]             3: Bool(false)
[INFO] [stdout]             4: Bool(false)
[INFO] [stdout]             4: Bool(true)
[INFO] [stdout]             5: Bool(true)
[INFO] [stdout]         write_value: 4 bit(s) (U32)
[INFO] [stdout]             0: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             1: U32(0)
[INFO] [stdout]             2: U32(0)
[INFO] [stdout]             2: U32(5)
[INFO] [stdout]             3: U32(5)
[INFO] [stdout]             3: U32(0)
[INFO] [stdout]             4: U32(0)
[INFO] [stdout]             4: U32(12)
[INFO] [stdout]             5: U32(12)
[INFO] [stdout] 
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x56131d24ee06 - 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:     0x56131d24ee06 - 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:     0x56131d24ee06 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x56131d24ee06 - <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] [stderr] error: test failed, to rerun pass `-p sim-tests --lib`
[INFO] [stdout]    4:     0x56131d277c70 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x56131d277c70 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x56131d24c86f - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x56131d24ebe4 - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x56131d24ebe4 - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x56131d250957 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]   10:     0x56131d25063d - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x56131d21d4d7 - <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:     0x56131d21d4d7 - test::test_main::{{closure}}::h00d84697cefdcbb6
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:138:21
[INFO] [stdout]   13:     0x56131d250f76 - <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:     0x56131d250f76 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   15:     0x56131d250cc2 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   16:     0x56131d24f306 - 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:     0x56131d250a20 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   18:     0x56131d194d35 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   19:     0x56131d19516b - core::panicking::assert_failed_inner::h9f13e27dd63c3a08
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:342:17
[INFO] [stdout]   20:     0x56131d1db86e - core::panicking::assert_failed::he1c16134676c1a4d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:297:5
[INFO] [stdout]   21:     0x56131d1c3e48 - sim_tests::tests::trace_test_module_3::hc489ea1cab7afedd
[INFO] [stdout]                                at /opt/rustwide/workdir/sim-tests/src/lib.rs:2611:9
[INFO] [stdout]   22:     0x56131d1bf047 - sim_tests::tests::trace_test_module_3::{{closure}}::hb2f9353e34961098
[INFO] [stdout]                                at /opt/rustwide/workdir/sim-tests/src/lib.rs:2529:33
[INFO] [stdout]   23:     0x56131d1d9246 - core::ops::function::FnOnce::call_once::h459c560ff722667d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x56131d222daf - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x56131d222daf - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   26:     0x56131d221b31 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   27:     0x56131d221b31 - <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:     0x56131d221b31 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   29:     0x56131d221b31 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   30:     0x56131d221b31 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   31:     0x56131d221b31 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   32:     0x56131d221b31 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   33:     0x56131d1e8e66 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   34:     0x56131d1e8e66 - 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:     0x56131d1edec7 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   36:     0x56131d1edec7 - <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:     0x56131d1edec7 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   38:     0x56131d1edec7 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   39:     0x56131d1edec7 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   40:     0x56131d1edec7 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   41:     0x56131d1edec7 - 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:     0x56131d255a25 - <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:     0x56131d255a25 - <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:     0x56131d255a25 - 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:     0x7f419e1d0ac3 - <unknown>
[INFO] [stdout]   46:     0x7f419e261bf4 - __clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::trace_test_module_2
[INFO] [stdout]     tests::trace_test_module_3
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 43 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "e69a2f80ea76ec10ccc049dfaea8eb0f0e22d4e60268d5f0a859cbfc55786b30", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e69a2f80ea76ec10ccc049dfaea8eb0f0e22d4e60268d5f0a859cbfc55786b30", kill_on_drop: false }`
[INFO] [stdout] e69a2f80ea76ec10ccc049dfaea8eb0f0e22d4e60268d5f0a859cbfc55786b30
