[INFO] cloning repository https://github.com/Neccolini/recsimu-rs
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Neccolini/recsimu-rs" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FNeccolini%2Frecsimu-rs", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FNeccolini%2Frecsimu-rs'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 74dbb01dd170a97fe17fc3a29855e41fe1b22f82
[INFO] testing Neccolini/recsimu-rs against 1.75.0 for beta-1.76-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FNeccolini%2Frecsimu-rs" "/workspace/builds/worker-5-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Neccolini/recsimu-rs 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/Neccolini/recsimu-rs
[INFO] finished tweaking git repo https://github.com/Neccolini/recsimu-rs
[INFO] tweaked toml for git repo https://github.com/Neccolini/recsimu-rs written to /workspace/builds/worker-5-tc1/source/Cargo.toml
[INFO] crate git repo https://github.com/Neccolini/recsimu-rs already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.75.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] ca9e58911b61a8840c12d41b0191c0151352a2889fcb5b6a9c8e983bf80792ae
[INFO] running `Command { std: "docker" "start" "-a" "ca9e58911b61a8840c12d41b0191c0151352a2889fcb5b6a9c8e983bf80792ae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "ca9e58911b61a8840c12d41b0191c0151352a2889fcb5b6a9c8e983bf80792ae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ca9e58911b61a8840c12d41b0191c0151352a2889fcb5b6a9c8e983bf80792ae", kill_on_drop: false }`
[INFO] [stdout] ca9e58911b61a8840c12d41b0191c0151352a2889fcb5b6a9c8e983bf80792ae
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 6c6839e5135af990d617081d8e31a5765e56ca13343927250112459e591c0394
[INFO] running `Command { std: "docker" "start" "-a" "6c6839e5135af990d617081d8e31a5765e56ca13343927250112459e591c0394", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.69
[INFO] [stderr]    Compiling unicode-ident v1.0.12
[INFO] [stderr]    Compiling libc v0.2.149
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling serde v1.0.189
[INFO] [stderr]    Compiling utf8parse v0.2.1
[INFO] [stderr]    Compiling colorchoice v1.0.0
[INFO] [stderr]    Compiling anstyle-query v1.0.0
[INFO] [stderr]    Compiling anstyle-parse v0.2.2
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling anstyle v1.0.4
[INFO] [stderr]    Compiling clap_lex v0.5.1
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling ppv-lite86 v0.2.17
[INFO] [stderr]    Compiling anstream v0.6.4
[INFO] [stderr]    Compiling heck v0.4.1
[INFO] [stderr]    Compiling serde_json v1.0.107
[INFO] [stderr]    Compiling num-traits v0.2.17
[INFO] [stderr]    Compiling itoa v1.0.9
[INFO] [stderr]    Compiling clap_builder v4.4.6
[INFO] [stderr]    Compiling ryu v1.0.15
[INFO] [stderr]    Compiling once_cell v1.18.0
[INFO] [stderr]    Compiling quote v1.0.33
[INFO] [stderr]    Compiling syn v2.0.38
[INFO] [stderr]    Compiling getrandom v0.2.10
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling uuid v1.5.0
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling serde_derive v1.0.189
[INFO] [stderr]    Compiling clap_derive v4.4.2
[INFO] [stderr]    Compiling clap v4.4.6
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling recsimu v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [optimized] target(s) in 35.79s
[INFO] running `Command { std: "docker" "inspect" "6c6839e5135af990d617081d8e31a5765e56ca13343927250112459e591c0394", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6c6839e5135af990d617081d8e31a5765e56ca13343927250112459e591c0394", kill_on_drop: false }`
[INFO] [stdout] 6c6839e5135af990d617081d8e31a5765e56ca13343927250112459e591c0394
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 11e3f3431c6df30a93556cac7fc4bb03a06fb93e4fdc926674dbee0b02d98613
[INFO] running `Command { std: "docker" "start" "-a" "11e3f3431c6df30a93556cac7fc4bb03a06fb93e4fdc926674dbee0b02d98613", kill_on_drop: false }`
[INFO] [stderr]    Compiling recsimu v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [optimized] target(s) in 12.93s
[INFO] running `Command { std: "docker" "inspect" "11e3f3431c6df30a93556cac7fc4bb03a06fb93e4fdc926674dbee0b02d98613", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "11e3f3431c6df30a93556cac7fc4bb03a06fb93e4fdc926674dbee0b02d98613", kill_on_drop: false }`
[INFO] [stdout] 11e3f3431c6df30a93556cac7fc4bb03a06fb93e4fdc926674dbee0b02d98613
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] ede4a795d2edbefbb59e0f8bd9ffdeabd40af61d326b230da0ba18e70d7575da
[INFO] running `Command { std: "docker" "start" "-a" "ede4a795d2edbefbb59e0f8bd9ffdeabd40af61d326b230da0ba18e70d7575da", kill_on_drop: false }`
[INFO] [stderr]     Finished test [optimized] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/recsimu-f1669e07a7028f9a)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test hardware::blocking::tests::test_check_received_flit ... ok
[INFO] [stdout] test gen::config::tests::test_read_json ... ok
[INFO] [stdout] test log::tests::test_update_packet_log ... ok
[INFO] [stdout] test log::tests::test_get_packet_log ... ok
[INFO] [stdout] test network::core_functions::default::tests::test_process_received_packet_coordinator ... ok
[INFO] [stdout] test log::tests::test_post_new_packet_log ... ok
[INFO] [stdout] test hardware::tests::test_send_flit ... ok
[INFO] [stdout] test network::flit::tests::test_flits_to_data ... ok
[INFO] [stdout] test network::flit_buffer::tests::test_flit_buffer ... ok
[INFO] [stdout] test network::core_functions::default::tests::test_process_received_packet_router ... ok
[INFO] [stdout] test network::tests::test_send_flit1 ... ok
[INFO] [stdout] test sim::nodes::tests::test_run_cycle ... ok
[INFO] [stdout] test network::tests::test_send_flit2 ... ok
[INFO] [stdout] test sim::tests::test_sim_build ... ok
[INFO] [stdout] test network::flit_buffer::tests::test_remove_duplicate_and_sort ... ok
[INFO] [stdout] test hardware::tests::test_receive_flit ... ok
[INFO] [stdout] test network::flit::tests::test_data_to_flits ... ok
[INFO] [stdout] test hardware::tests::test_calc_wait_cycles ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/recsimu-f04a7c5b5e5ef96b)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_run ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_run stdout ----
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/2_m.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/2_m.json"
[INFO] [stdout] {"average_cycle": 2.4285714285714284, "total_flits": 9.0, "average_flits_len": 1.0, "undelivered_packets": 2.0, "collision_count": 1.0, "total_packets": 9.0}
[INFO] [stdout] {"undelivered_packets": 2.0, "total_packets": 9.0, "average_cycle": 3.0, "average_flits_len": 1.0, "collision_count": 4.0, "total_flits": 9.0}
[INFO] [stdout] {"total_packets": 8.0, "average_cycle": 6.833333333333333, "total_flits": 8.0, "undelivered_packets": 2.0, "average_flits_len": 1.0, "collision_count": 6.0}
[INFO] [stdout] {"total_packets": 9.0, "undelivered_packets": 2.0, "total_flits": 9.0, "average_flits_len": 1.0, "average_cycle": 4.142857142857143, "collision_count": 7.0}
[INFO] [stdout] {"collision_count": 8.0, "undelivered_packets": 2.0, "average_cycle": 2.4285714285714284, "total_flits": 9.0, "total_packets": 9.0, "average_flits_len": 1.0}
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/9_50_0.001_s.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/9_50_0.001_s.json"
[INFO] [stdout] {"total_flits": 60499.0, "average_flits_len": 7.694137097799822, "total_packets": 7863.0, "undelivered_packets": 5523.0, "average_cycle": 1511.440569445986, "collision_count": 24794.0}
[INFO] [stdout] {"collision_count": 47928.0, "undelivered_packets": 5614.0, "total_packets": 7883.0, "average_cycle": 1628.1147012211165, "average_flits_len": 7.684637828237981, "total_flits": 60578.0}
[INFO] [stdout] {"undelivered_packets": 5651.0, "average_cycle": 1713.8767658479328, "total_packets": 7880.0, "total_flits": 60732.0, "average_flits_len": 7.707106598984772, "collision_count": 70902.0}
[INFO] [stdout] {"total_flits": 60551.0, "undelivered_packets": 5453.0, "average_flits_len": 7.68999237998476, "collision_count": 97250.0, "total_packets": 7874.0, "average_cycle": 1323.0089029344592}
[INFO] [stdout] {"collision_count": 122109.0, "average_cycle": 1577.8079555787745, "total_packets": 7901.0, "total_flits": 60599.0, "undelivered_packets": 5527.0, "average_flits_len": 7.669788634350082}
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/9_m.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/9_m.json"
[INFO] [stdout] {"average_cycle": 1369.6504065950317, "total_flits": 61796.0, "total_packets": 9464.0, "average_flits_len": 6.529585798816568, "undelivered_packets": 7278.0, "collision_count": 149947.0}
[INFO] [stdout] {"total_packets": 9428.0, "collision_count": 177829.0, "undelivered_packets": 7220.0, "total_flits": 61712.0, "average_flits_len": 6.5456088247772595, "average_cycle": 1450.120870633746}
[INFO] [stdout] {"average_cycle": 1498.4518798950903, "total_packets": 9681.0, "total_flits": 62301.0, "average_flits_len": 6.435388906104741, "collision_count": 205534.0, "undelivered_packets": 7296.0}
[INFO] [stdout] {"total_packets": 9848.0, "average_flits_len": 6.310418359057676, "total_flits": 62145.0, "collision_count": 232339.0, "average_cycle": 1337.3569974291227, "undelivered_packets": 7737.0}
[INFO] [stdout] {"average_cycle": 1412.281031630131, "undelivered_packets": 7149.0, "total_packets": 9390.0, "total_flits": 61735.0, "average_flits_len": 6.57454739084132, "collision_count": 260494.0}
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/1_m.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/1_m.json"
[INFO] [stdout] {"undelivered_packets": 1.0, "average_cycle": 1.5, "total_packets": 5.0, "total_flits": 5.0, "average_flits_len": 1.0, "collision_count": 260494.0}
[INFO] [stdout] {"average_cycle": 2.2, "undelivered_packets": 1.0, "total_flits": 6.0, "collision_count": 260494.0, "average_flits_len": 1.0, "total_packets": 6.0}
[INFO] [stdout] {"total_packets": 6.0, "total_flits": 6.0, "average_flits_len": 1.0, "undelivered_packets": 1.0, "collision_count": 260494.0, "average_cycle": 2.2}
[INFO] [stdout] {"undelivered_packets": 1.0, "average_flits_len": 1.0, "collision_count": 260494.0, "average_cycle": 2.2, "total_packets": 6.0, "total_flits": 6.0}
[INFO] [stdout] {"undelivered_packets": 1.0, "average_cycle": 1.5, "average_flits_len": 1.0, "total_flits": 5.0, "collision_count": 260494.0, "total_packets": 5.0}
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/6_c.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/6_c.json"
[INFO] [stdout] {"average_flits_len": 1.0, "undelivered_packets": 9.0, "collision_count": 260524.0, "total_flits": 198.0, "average_cycle": 7.8994708994708995, "total_packets": 198.0}
[INFO] [stdout] {"undelivered_packets": 9.0, "total_flits": 194.0, "average_cycle": 7.92972972972973, "average_flits_len": 1.0, "collision_count": 260557.0, "total_packets": 194.0}
[INFO] [stdout] {"undelivered_packets": 9.0, "collision_count": 260584.0, "total_packets": 192.0, "average_cycle": 7.180327868852459, "total_flits": 192.0, "average_flits_len": 1.0}
[INFO] [stdout] {"average_flits_len": 1.0, "total_packets": 199.0, "undelivered_packets": 9.0, "total_flits": 199.0, "average_cycle": 7.3052631578947365, "collision_count": 260609.0}
[INFO] [stdout] {"average_cycle": 8.015625, "total_flits": 201.0, "average_flits_len": 1.0, "undelivered_packets": 9.0, "total_packets": 201.0, "collision_count": 260640.0}
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/10_2trees6.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/10_2trees6.json"
[INFO] [stdout] {"collision_count": 260719.0, "average_cycle": 12.948717948717949, "undelivered_packets": 123.0, "total_packets": 201.0, "total_flits": 201.0, "average_flits_len": 1.0}
[INFO] [stdout] {"collision_count": 260754.0, "total_packets": 111.0, "total_flits": 111.0, "average_cycle": 15.232558139534884, "undelivered_packets": 68.0, "average_flits_len": 1.0}
[INFO] [stdout] {"total_packets": 142.0, "collision_count": 260802.0, "total_flits": 142.0, "undelivered_packets": 76.0, "average_cycle": 11.803030303030303, "average_flits_len": 1.0}
[INFO] [stdout] {"average_flits_len": 1.0, "average_cycle": 11.656716417910447, "undelivered_packets": 160.0, "collision_count": 260882.0, "total_flits": 227.0, "total_packets": 227.0}
[INFO] [stdout] {"total_flits": 264.0, "average_flits_len": 1.0, "average_cycle": 16.043478260869566, "collision_count": 260978.0, "total_packets": 264.0, "undelivered_packets": 172.0}
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/10_2trees4.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/10_2trees4.json"
[INFO] [stdout] {"collision_count": 261017.0, "total_packets": 124.0, "average_cycle": 8.028169014084508, "total_flits": 124.0, "average_flits_len": 1.0, "undelivered_packets": 53.0}
[INFO] [stdout] {"average_cycle": 8.948717948717949, "total_flits": 75.0, "undelivered_packets": 36.0, "total_packets": 75.0, "average_flits_len": 1.0, "collision_count": 261035.0}
[INFO] [stdout] {"average_flits_len": 1.0, "collision_count": 261074.0, "average_cycle": 9.318181818181818, "undelivered_packets": 71.0, "total_packets": 137.0, "total_flits": 137.0}
[INFO] [stdout] {"average_cycle": 9.490196078431373, "total_packets": 104.0, "collision_count": 261111.0, "undelivered_packets": 53.0, "average_flits_len": 1.0, "total_flits": 104.0}
[INFO] [stdout] {"average_cycle": 9.237704918032787, "total_flits": 232.0, "average_flits_len": 1.0, "undelivered_packets": 110.0, "total_packets": 232.0, "collision_count": 261197.0}
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/4_c.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/4_c.json"
[INFO] [stdout] {"average_flits_len": 1.0, "collision_count": 261231.0, "average_cycle": 17.94871794871795, "undelivered_packets": 9.0, "total_packets": 48.0, "total_flits": 48.0}
[INFO] [stdout] {"total_flits": 42.0, "average_flits_len": 1.0, "collision_count": 261275.0, "total_packets": 42.0, "undelivered_packets": 9.0, "average_cycle": 13.212121212121213}
[INFO] [stdout] {"average_cycle": 7.543478260869565, "undelivered_packets": 9.0, "total_flits": 55.0, "collision_count": 261307.0, "total_packets": 55.0, "average_flits_len": 1.0}
[INFO] [stdout] {"undelivered_packets": 9.0, "average_cycle": 14.022222222222222, "total_flits": 54.0, "total_packets": 54.0, "average_flits_len": 1.0, "collision_count": 261343.0}
[INFO] [stdout] {"collision_count": 261373.0, "total_flits": 46.0, "undelivered_packets": 9.0, "average_cycle": 7.972972972972973, "total_packets": 46.0, "average_flits_len": 1.0}
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/8_50_0.015_s.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/8_50_0.015_s.json"
[INFO] [stdout] {"undelivered_packets": 1157.0, "total_flits": 5443.0, "total_packets": 3435.0, "average_flits_len": 1.584570596797671, "collision_count": 267590.0, "average_cycle": 1459.9457126134037}
[INFO] [stdout] {"average_cycle": 1402.3349018003273, "average_flits_len": 1.5841814480953766, "undelivered_packets": 995.0, "total_flits": 5448.0, "collision_count": 273139.0, "total_packets": 3439.0}
[INFO] [stdout] {"undelivered_packets": 1173.0, "total_packets": 3434.0, "collision_count": 278641.0, "average_flits_len": 1.5847408270238788, "average_cycle": 1537.6660032434022, "total_flits": 5442.0}
[INFO] [stdout] {"total_flits": 5436.0, "total_packets": 3428.0, "collision_count": 284155.0, "average_cycle": 1322.3820077326704, "average_flits_len": 1.5857642940490082, "undelivered_packets": 1014.0}
[INFO] [stdout] {"collision_count": 290019.0, "average_cycle": 1304.4780159384445, "undelivered_packets": 1029.0, "total_flits": 5463.0, "total_packets": 3455.0, "average_flits_len": 1.5811866859623733}
[INFO] [stdout] [src/main.rs:98] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/2_c.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98] path.clone() = "tests/run/auto/2_c.json"
[INFO] [stdout] {"total_flits": 9.0, "average_flits_len": 1.0, "undelivered_packets": 2.0, "average_cycle": 5.857142857142857, "total_packets": 9.0, "collision_count": 290021.0}
[INFO] [stdout] {"undelivered_packets": 2.0, "collision_count": 290022.0, "average_flits_len": 1.0, "total_packets": 8.0, "total_flits": 8.0, "average_cycle": 2.0}
[INFO] [stdout] {"average_cycle": 2.4285714285714284, "total_packets": 9.0, "total_flits": 9.0, "collision_count": 290023.0, "average_flits_len": 1.0, "undelivered_packets": 2.0}
[INFO] [stdout] thread 'tests::test_run' panicked at src/main.rs:108:25:
[INFO] [stdout] assertion `left == right` failed: "tests/run/auto/2_c.json"
[INFO] [stdout]   left: false
[INFO] [stdout]  right: true
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5564a617cf9e - 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:     0x5564a617cf9e - 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:     0x5564a617cf9e - std::sys_common::backtrace::_print_fmt::h9eef0abe20ede486
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:67:5
[INFO] [stdout]    3:     0x5564a617cf9e - <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:     0x5564a60faa50 - core::fmt::rt::Argument::fmt::h1539a9308b8d058d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x5564a60faa50 - core::fmt::write::h3a39390d8560d9c9
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x5564a6180302 - std::io::Write::write_fmt::h040b369f3a0f9cbc
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/io/mod.rs:1762:15
[INFO] [stdout]    7:     0x5564a61804ee - std::sys_common::backtrace::_print::h894006fb5c6f3d45
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x5564a61804ee - std::sys_common::backtrace::print::h23a2d212c6fff936
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x5564a617fc60 - std::panicking::default_hook::{{closure}}::h8a1d2ee00185001a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:272:22
[INFO] [stdout]   10:     0x5564a617f731 - std::panicking::default_hook::h6038f2eba384e475
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x5564a6180b37 - <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]   12:     0x5564a6180b37 - std::panicking::rust_panic_with_hook::h2b5517d590cab22e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:783:13
[INFO] [stdout]   13:     0x5564a618084c - std::panicking::begin_panic_handler::{{closure}}::h233112c06e0ef43e
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:657:13
[INFO] [stdout]   14:     0x5564a61807a6 - 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]   15:     0x5564a6180791 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:645:5
[INFO] [stdout]   16:     0x5564a60e92f4 - core::panicking::panic_fmt::hbf0e066aabfa482c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/panicking.rs:72:14
[INFO] [stdout]   17:     0x5564a60e9699 - core::panicking::assert_failed_inner::h0bba8b7c26ee4492
[INFO] [stdout]   18:     0x5564a60e909e - core::panicking::assert_failed::h94062364fe3a249c
[INFO] [stdout]   19:     0x5564a60f6d09 - core::ops::function::FnOnce::call_once::h4b17f7ea56c177a5
[INFO] [stdout]   20:     0x5564a619dd0f - core::ops::function::FnOnce::call_once::h2b5d431d5046312d
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   21:     0x5564a619dd0f - test::__rust_begin_short_backtrace::h7714669af176e207
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:628:18
[INFO] [stdout]   22:     0x5564a619a6b6 - test::types::RunnableTest::run::hed5dba14d01a1cb0
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/types.rs:146:40
[INFO] [stdout]   23:     0x5564a619a6b6 - test::run_test_in_process::{{closure}}::h85218797dcbcec12
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:60
[INFO] [stdout]   24:     0x5564a619a6b6 - <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]   25:     0x5564a619a6b6 - std::panicking::try::do_call::h3bd5d0f6620ee946
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   26:     0x5564a619a6b6 - std::panicking::try::h232e535e4744fe31
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   27:     0x5564a619a6b6 - std::panic::catch_unwind::h3ce3bd6ca8dbac68
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   28:     0x5564a619a6b6 - test::run_test_in_process::hc97b257c9621286a
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:651:27
[INFO] [stdout]   29:     0x5564a619a6b6 - test::run_test::{{closure}}::h2aa798823a438d38
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:574:43
[INFO] [stdout]   30:     0x5564a619e1d9 - test::run_test::{{closure}}::h87d231c78fb59832
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/test/src/lib.rs:602:41
[INFO] [stdout]   31:     0x5564a619e1d9 - 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]   32:     0x5564a619df85 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::ha94be15d1e0acf36
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   33:     0x5564a619df85 - <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]   34:     0x5564a619df85 - std::panicking::try::do_call::h9057517f80303cd4
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:552:40
[INFO] [stdout]   35:     0x5564a619df85 - std::panicking::try::he3a30b11ee45340c
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panicking.rs:516:19
[INFO] [stdout]   36:     0x5564a619df85 - std::panic::catch_unwind::h410458cfd3528b8b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/panic.rs:142:14
[INFO] [stdout]   37:     0x5564a619df85 - std::thread::Builder::spawn_unchecked_::{{closure}}::h72ac3bdb567b737b
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   38:     0x5564a619df85 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h38f34da3654a8344
[INFO] [stdout]                                at /rustc/82e1608dfa6e0b5569232559e3d385fea5a93112/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   39:     0x5564a6181455 - <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]   40:     0x5564a6181455 - <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]   41:     0x5564a6181455 - 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]   42:     0x7f82e3111ac3 - <unknown>
[INFO] [stdout]   43:     0x7f82e31a2bf4 - __clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::test_run
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 28.23s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--bin recsimu`
[INFO] running `Command { std: "docker" "inspect" "ede4a795d2edbefbb59e0f8bd9ffdeabd40af61d326b230da0ba18e70d7575da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ede4a795d2edbefbb59e0f8bd9ffdeabd40af61d326b230da0ba18e70d7575da", kill_on_drop: false }`
[INFO] [stdout] ede4a795d2edbefbb59e0f8bd9ffdeabd40af61d326b230da0ba18e70d7575da
[INFO] testing Neccolini/recsimu-rs 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%2FNeccolini%2Frecsimu-rs" "/workspace/builds/worker-5-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-5-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/Neccolini/recsimu-rs 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/Neccolini/recsimu-rs
[INFO] finished tweaking git repo https://github.com/Neccolini/recsimu-rs
[INFO] tweaked toml for git repo https://github.com/Neccolini/recsimu-rs written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] crate git repo https://github.com/Neccolini/recsimu-rs already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2023-12-22" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] f913b88fb41b9627b3c78dc861845410c6c302bdd129595f16fdbd1ce244dd5a
[INFO] running `Command { std: "docker" "start" "-a" "f913b88fb41b9627b3c78dc861845410c6c302bdd129595f16fdbd1ce244dd5a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f913b88fb41b9627b3c78dc861845410c6c302bdd129595f16fdbd1ce244dd5a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f913b88fb41b9627b3c78dc861845410c6c302bdd129595f16fdbd1ce244dd5a", kill_on_drop: false }`
[INFO] [stdout] f913b88fb41b9627b3c78dc861845410c6c302bdd129595f16fdbd1ce244dd5a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] e7783296b2aa4f0743ac04d8e9698d69d4b648e5b3311592ac24fe620ee1e3f6
[INFO] running `Command { std: "docker" "start" "-a" "e7783296b2aa4f0743ac04d8e9698d69d4b648e5b3311592ac24fe620ee1e3f6", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.69
[INFO] [stderr]    Compiling unicode-ident v1.0.12
[INFO] [stderr]    Compiling libc v0.2.149
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling utf8parse v0.2.1
[INFO] [stderr]    Compiling serde v1.0.189
[INFO] [stderr]    Compiling colorchoice v1.0.0
[INFO] [stderr]    Compiling anstyle-query v1.0.0
[INFO] [stderr]    Compiling anstyle-parse v0.2.2
[INFO] [stderr]    Compiling anstyle v1.0.4
[INFO] [stderr]    Compiling autocfg v1.1.0
[INFO] [stderr]    Compiling strsim v0.10.0
[INFO] [stderr]    Compiling serde_json v1.0.107
[INFO] [stderr]    Compiling anstream v0.6.4
[INFO] [stderr]    Compiling ppv-lite86 v0.2.17
[INFO] [stderr]    Compiling heck v0.4.1
[INFO] [stderr]    Compiling clap_lex v0.5.1
[INFO] [stderr]    Compiling num-traits v0.2.17
[INFO] [stderr]    Compiling clap_builder v4.4.6
[INFO] [stderr]    Compiling itoa v1.0.9
[INFO] [stderr]    Compiling ryu v1.0.15
[INFO] [stderr]    Compiling once_cell v1.18.0
[INFO] [stderr]    Compiling quote v1.0.33
[INFO] [stderr]    Compiling syn v2.0.38
[INFO] [stderr]    Compiling getrandom v0.2.10
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling uuid v1.5.0
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling serde_derive v1.0.189
[INFO] [stderr]    Compiling clap_derive v4.4.2
[INFO] [stderr]    Compiling clap v4.4.6
[INFO] [stderr]    Compiling bincode v1.3.3
[INFO] [stderr]    Compiling recsimu v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [optimized] target(s) in 44.00s
[INFO] running `Command { std: "docker" "inspect" "e7783296b2aa4f0743ac04d8e9698d69d4b648e5b3311592ac24fe620ee1e3f6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e7783296b2aa4f0743ac04d8e9698d69d4b648e5b3311592ac24fe620ee1e3f6", kill_on_drop: false }`
[INFO] [stdout] e7783296b2aa4f0743ac04d8e9698d69d4b648e5b3311592ac24fe620ee1e3f6
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 948a09776652339b867089ad9d27d7a3e10f1d93631f0d252f445fa53f0ea275
[INFO] running `Command { std: "docker" "start" "-a" "948a09776652339b867089ad9d27d7a3e10f1d93631f0d252f445fa53f0ea275", kill_on_drop: false }`
[INFO] [stderr]    Compiling recsimu v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [optimized] target(s) in 24.09s
[INFO] running `Command { std: "docker" "inspect" "948a09776652339b867089ad9d27d7a3e10f1d93631f0d252f445fa53f0ea275", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "948a09776652339b867089ad9d27d7a3e10f1d93631f0d252f445fa53f0ea275", kill_on_drop: false }`
[INFO] [stdout] 948a09776652339b867089ad9d27d7a3e10f1d93631f0d252f445fa53f0ea275
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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] 12a40fb9fde978d8c1b6fa26f292ac1f4ae50f2007a4a3b0c4b5f051ef8ab12e
[INFO] running `Command { std: "docker" "start" "-a" "12a40fb9fde978d8c1b6fa26f292ac1f4ae50f2007a4a3b0c4b5f051ef8ab12e", kill_on_drop: false }`
[INFO] [stderr]     Finished test [optimized] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/recsimu-ef709399d26982db)
[INFO] [stdout] 
[INFO] [stdout] running 18 tests
[INFO] [stdout] test hardware::tests::test_calc_wait_cycles ... ok
[INFO] [stdout] test hardware::blocking::tests::test_check_received_flit ... ok
[INFO] [stdout] test hardware::tests::test_send_flit ... ok
[INFO] [stdout] test hardware::tests::test_receive_flit ... ok
[INFO] [stdout] test gen::config::tests::test_read_json ... ok
[INFO] [stdout] test log::tests::test_get_packet_log ... ok
[INFO] [stdout] test log::tests::test_post_new_packet_log ... ok
[INFO] [stdout] test log::tests::test_update_packet_log ... ok
[INFO] [stdout] test network::flit_buffer::tests::test_flit_buffer ... ok
[INFO] [stdout] test network::flit_buffer::tests::test_remove_duplicate_and_sort ... ok
[INFO] [stdout] test network::tests::test_send_flit1 ... ok
[INFO] [stdout] test network::tests::test_send_flit2 ... ok
[INFO] [stdout] test sim::tests::test_sim_build ... ok
[INFO] [stdout] test network::flit::tests::test_data_to_flits ... ok
[INFO] [stdout] test network::flit::tests::test_flits_to_data ... ok
[INFO] [stdout] test network::core_functions::default::tests::test_process_received_packet_coordinator ... ok
[INFO] [stdout] test network::core_functions::default::tests::test_process_received_packet_router ... ok
[INFO] [stdout] test sim::nodes::tests::test_run_cycle ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 18 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/recsimu-358839143175f843)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test tests::test_run ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::test_run stdout ----
[INFO] [stdout] [src/main.rs:98:13] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/2_m.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98:13] path.clone() = "tests/run/auto/2_m.json"
[INFO] [stdout] {"average_flits_len": 1.0, "collision_count": 1.0, "average_cycle": 2.4285714285714284, "total_packets": 9.0, "total_flits": 9.0, "undelivered_packets": 2.0}
[INFO] [stdout] {"average_cycle": 2.4285714285714284, "undelivered_packets": 2.0, "average_flits_len": 1.0, "total_packets": 9.0, "total_flits": 9.0, "collision_count": 3.0}
[INFO] [stdout] {"total_flits": 8.0, "average_cycle": 4.166666666666667, "undelivered_packets": 2.0, "average_flits_len": 1.0, "collision_count": 4.0, "total_packets": 8.0}
[INFO] [stdout] {"total_flits": 8.0, "average_cycle": 3.0, "undelivered_packets": 2.0, "average_flits_len": 1.0, "collision_count": 6.0, "total_packets": 8.0}
[INFO] [stdout] {"total_packets": 9.0, "total_flits": 9.0, "undelivered_packets": 2.0, "average_flits_len": 1.0, "collision_count": 7.0, "average_cycle": 2.4285714285714284}
[INFO] [stdout] [src/main.rs:98:13] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/9_50_0.001_s.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98:13] path.clone() = "tests/run/auto/9_50_0.001_s.json"
[INFO] [stdout] {"total_packets": 7894.0, "undelivered_packets": 5524.0, "average_flits_len": 7.690777805928553, "average_cycle": 1204.2342013717666, "collision_count": 24297.0, "total_flits": 60711.0}
[INFO] [stdout] {"collision_count": 51781.0, "total_packets": 7833.0, "total_flits": 60287.0, "average_flits_len": 7.696540278309715, "average_cycle": 1174.2874923330658, "undelivered_packets": 5558.0}
[INFO] [stdout] {"total_packets": 7826.0, "undelivered_packets": 5612.0, "average_cycle": 1601.843530168765, "total_flits": 60039.0, "average_flits_len": 7.671735241502684, "collision_count": 79016.0}
[INFO] [stdout] {"total_flits": 60445.0, "average_flits_len": 7.685314685314685, "average_cycle": 1276.4460051366138, "collision_count": 106156.0, "total_packets": 7865.0, "undelivered_packets": 5544.0}
[INFO] [stdout] {"collision_count": 131952.0, "undelivered_packets": 5546.0, "total_flits": 60559.0, "total_packets": 7865.0, "average_cycle": 1633.1265305989093, "average_flits_len": 7.699809281627464}
[INFO] [stdout] [src/main.rs:98:13] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/9_m.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98:13] path.clone() = "tests/run/auto/9_m.json"
[INFO] [stdout] {"total_packets": 9780.0, "undelivered_packets": 7500.0, "average_flits_len": 6.381901840490798, "average_cycle": 1659.0578791834384, "total_flits": 62415.0, "collision_count": 159419.0}
[INFO] [stdout] {"average_cycle": 1606.1434842033805, "total_packets": 10267.0, "collision_count": 186343.0, "undelivered_packets": 8142.0, "total_flits": 62818.0, "average_flits_len": 6.118437713061264}
[INFO] [stdout] {"collision_count": 213249.0, "average_cycle": 1536.701733874555, "total_packets": 9942.0, "undelivered_packets": 7704.0, "average_flits_len": 6.2750955542144435, "total_flits": 62387.0}
[INFO] [stdout] {"undelivered_packets": 7171.0, "total_flits": 62228.0, "average_flits_len": 6.516020942408377, "average_cycle": 1577.4440020665427, "collision_count": 240712.0, "total_packets": 9550.0}
[INFO] [stdout] {"collision_count": 266557.0, "undelivered_packets": 7591.0, "total_packets": 9743.0, "average_cycle": 1742.0204660116822, "total_flits": 62348.0, "average_flits_len": 6.39926100790311}
[INFO] [stdout] [src/main.rs:98:13] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/1_m.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98:13] path.clone() = "tests/run/auto/1_m.json"
[INFO] [stdout] {"undelivered_packets": 1.0, "collision_count": 266557.0, "total_packets": 5.0, "total_flits": 5.0, "average_cycle": 1.5, "average_flits_len": 1.0}
[INFO] [stdout] {"total_flits": 6.0, "average_flits_len": 1.0, "collision_count": 266557.0, "undelivered_packets": 1.0, "average_cycle": 2.2, "total_packets": 6.0}
[INFO] [stdout] {"total_flits": 5.0, "undelivered_packets": 1.0, "total_packets": 5.0, "average_flits_len": 1.0, "average_cycle": 1.5, "collision_count": 266557.0}
[INFO] [stdout] {"average_cycle": 1.5, "collision_count": 266557.0, "undelivered_packets": 1.0, "total_flits": 5.0, "average_flits_len": 1.0, "total_packets": 5.0}
[INFO] [stdout] {"average_cycle": 2.1666666666666665, "collision_count": 266557.0, "total_flits": 7.0, "total_packets": 7.0, "undelivered_packets": 1.0, "average_flits_len": 1.0}
[INFO] [stdout] [src/main.rs:98:13] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/6_c.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98:13] path.clone() = "tests/run/auto/6_c.json"
[INFO] [stdout] {"undelivered_packets": 9.0, "average_cycle": 7.417525773195877, "total_flits": 203.0, "collision_count": 266596.0, "average_flits_len": 1.0, "total_packets": 203.0}
[INFO] [stdout] {"total_packets": 204.0, "average_cycle": 9.76923076923077, "total_flits": 204.0, "collision_count": 266637.0, "average_flits_len": 1.0, "undelivered_packets": 9.0}
[INFO] [stdout] {"average_cycle": 7.16751269035533, "total_packets": 206.0, "undelivered_packets": 9.0, "average_flits_len": 1.0, "total_flits": 206.0, "collision_count": 266668.0}
[INFO] [stdout] {"average_cycle": 7.433155080213904, "undelivered_packets": 9.0, "average_flits_len": 1.0, "total_packets": 196.0, "collision_count": 266696.0, "total_flits": 196.0}
[INFO] [stdout] {"collision_count": 266751.0, "total_flits": 198.0, "total_packets": 198.0, "average_cycle": 8.079365079365079, "average_flits_len": 1.0, "undelivered_packets": 9.0}
[INFO] [stdout] [src/main.rs:98:13] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/10_2trees6.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98:13] path.clone() = "tests/run/auto/10_2trees6.json"
[INFO] [stdout] {"collision_count": 266795.0, "undelivered_packets": 76.0, "average_cycle": 16.650793650793652, "total_packets": 139.0, "total_flits": 139.0, "average_flits_len": 1.0}
[INFO] [stdout] {"average_cycle": 12.391304347826088, "average_flits_len": 1.0, "undelivered_packets": 104.0, "collision_count": 266862.0, "total_flits": 173.0, "total_packets": 173.0}
[INFO] [stdout] {"average_cycle": 13.819277108433734, "total_flits": 182.0, "average_flits_len": 1.0, "collision_count": 266933.0, "undelivered_packets": 99.0, "total_packets": 182.0}
[INFO] [stdout] {"average_cycle": 9.607142857142858, "average_flits_len": 1.0, "total_packets": 134.0, "collision_count": 266972.0, "total_flits": 134.0, "undelivered_packets": 78.0}
[INFO] [stdout] {"average_flits_len": 1.0, "collision_count": 266996.0, "average_cycle": 8.533333333333333, "undelivered_packets": 50.0, "total_packets": 95.0, "total_flits": 95.0}
[INFO] [stdout] [src/main.rs:98:13] entry = DirEntry(
[INFO] [stdout]     "tests/run/auto/10_2trees4.json",
[INFO] [stdout] )
[INFO] [stdout] [src/main.rs:98:13] path.clone() = "tests/run/auto/10_2trees4.json"
[INFO] [stdout] {"undelivered_packets": 265.0, "total_flits": 284.0, "collision_count": 267099.0, "average_flits_len": 1.0, "average_cycle": 29.63157894736842, "total_packets": 284.0}
[INFO] [stdout] thread 'tests::test_run' panicked at src/main.rs:108:25:
[INFO] [stdout] assertion `left == right` failed: "tests/run/auto/10_2trees4.json"
[INFO] [stdout]   left: false
[INFO] [stdout]  right: true
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x561dae55c1f3 - 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:     0x561dae55c1f3 - 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:     0x561dae55c1f3 - std::sys_common::backtrace::_print_fmt::hd7f8fef21b4eda67
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:68:5
[INFO] [stdout]    3:     0x561dae55c1f3 - <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:     0x561dae4dbe50 - core::fmt::rt::Argument::fmt::h9f417ac76a86f368
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/rt.rs:142:9
[INFO] [stdout]    5:     0x561dae4dbe50 - core::fmt::write::hc9b6faf4ac2aeff7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/fmt/mod.rs:1120:17
[INFO] [stdout]    6:     0x561dae55f082 - std::io::Write::write_fmt::he04625a3a989fec3
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/io/mod.rs:1810:15
[INFO] [stdout]    7:     0x561dae55f26e - std::sys_common::backtrace::_print::hd5d66399c7df88a2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    8:     0x561dae55f26e - std::sys_common::backtrace::print::he81ed2da642d37e5
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    9:     0x561dae55e9f0 - std::panicking::default_hook::{{closure}}::h85773f4fa117163d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:272:22
[INFO] [stdout]   10:     0x561dae55e4e6 - std::panicking::default_hook::h6a1694a91d09b278
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:289:9
[INFO] [stdout]   11:     0x561dae55f8a7 - <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]   12:     0x561dae55f8a7 - std::panicking::rust_panic_with_hook::h0a7ad96e90f7145b
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:783:13
[INFO] [stdout]   13:     0x561dae55f5c0 - std::panicking::begin_panic_handler::{{closure}}::h7919090525c6485e
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:657:13
[INFO] [stdout]   14:     0x561dae55f516 - 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]   15:     0x561dae55f50f - rust_begin_unwind
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:645:5
[INFO] [stdout]   16:     0x561dae4c9224 - core::panicking::panic_fmt::hcc9f77c5c132af55
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:72:14
[INFO] [stdout]   17:     0x561dae4c95c7 - core::panicking::assert_failed_inner::h9f13e27dd63c3a08
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/panicking.rs:337:23
[INFO] [stdout]   18:     0x561dae4c909e - core::panicking::assert_failed::h39209c683f71f567
[INFO] [stdout]   19:     0x561dae4d66b0 - core::ops::function::FnOnce::call_once::h3b9ff68d2a42b71c
[INFO] [stdout]   20:     0x561dae57debf - core::ops::function::FnOnce::call_once::hd64d26f405258157
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   21:     0x561dae57debf - test::__rust_begin_short_backtrace::he21b0b7a6d731bf9
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:627:18
[INFO] [stdout]   22:     0x561dae57a5f2 - test::types::RunnableTest::run::h179fcd40176ceb05
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/types.rs:146:40
[INFO] [stdout]   23:     0x561dae57a5f2 - test::run_test_in_process::{{closure}}::hf5c73986d7bdfde2
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:60
[INFO] [stdout]   24:     0x561dae57a5f2 - <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]   25:     0x561dae57a5f2 - std::panicking::try::do_call::he61b0a958b795a41
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   26:     0x561dae57a5f2 - std::panicking::try::h7309da130f906eb7
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   27:     0x561dae57a5f2 - std::panic::catch_unwind::hc5c3a06fdaf0a92a
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   28:     0x561dae57a5f2 - test::run_test_in_process::h7e7b7c71c3324e0f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:650:27
[INFO] [stdout]   29:     0x561dae57a5f2 - test::run_test::{{closure}}::h1f509f28f5cf20b1
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:573:43
[INFO] [stdout]   30:     0x561dae57e379 - test::run_test::{{closure}}::h1754218abf443f6d
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/test/src/lib.rs:601:41
[INFO] [stdout]   31:     0x561dae57e379 - 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]   32:     0x561dae57e135 - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::hf60bee9c1a17ef09
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:529:17
[INFO] [stdout]   33:     0x561dae57e135 - <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]   34:     0x561dae57e135 - std::panicking::try::do_call::h144b3048b546f835
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:552:40
[INFO] [stdout]   35:     0x561dae57e135 - std::panicking::try::h978244d04646189f
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panicking.rs:516:19
[INFO] [stdout]   36:     0x561dae57e135 - std::panic::catch_unwind::hdf436369d188fe86
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/panic.rs:142:14
[INFO] [stdout]   37:     0x561dae57e135 - std::thread::Builder::spawn_unchecked_::{{closure}}::h87329cbdd33c79ec
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/std/src/thread/mod.rs:528:30
[INFO] [stdout]   38:     0x561dae57e135 - core::ops::function::FnOnce::call_once{{vtable.shim}}::h401abbe67897d450
[INFO] [stdout]                                at /rustc/0e09125c6c3c2fd70d7de961bcf0e51575235fad/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   39:     0x561dae5601d5 - <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]   40:     0x561dae5601d5 - <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]   41:     0x561dae5601d5 - 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]   42:     0x7f74c1f98ac3 - <unknown>
[INFO] [stdout]   43:     0x7f74c2029bf4 - __clone
[INFO] [stdout]   44:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::test_run
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 25.74s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--bin recsimu`
[INFO] running `Command { std: "docker" "inspect" "12a40fb9fde978d8c1b6fa26f292ac1f4ae50f2007a4a3b0c4b5f051ef8ab12e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "12a40fb9fde978d8c1b6fa26f292ac1f4ae50f2007a4a3b0c4b5f051ef8ab12e", kill_on_drop: false }`
[INFO] [stdout] 12a40fb9fde978d8c1b6fa26f292ac1f4ae50f2007a4a3b0c4b5f051ef8ab12e
