[INFO] cloning repository https://github.com/BQSKit/PureMagic
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/BQSKit/PureMagic" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FBQSKit%2FPureMagic", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FBQSKit%2FPureMagic'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] 1894005684687cca72fb3ff7562b5d441cb3951c
[INFO] testing BQSKit/PureMagic against 1.97.0-beta.6 for beta-1.98-1
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FBQSKit%2FPureMagic" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] removed /workspace/builds/worker-3-tc1/source/.cargo/config.toml
[INFO] started tweaking git repo https://github.com/BQSKit/PureMagic
[INFO] finished tweaking git repo https://github.com/BQSKit/PureMagic
[INFO] tweaked toml for git repo https://github.com/BQSKit/PureMagic written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/BQSKit/PureMagic on toolchain 1.97.0-beta.6
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/BQSKit/PureMagic 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.97.0-beta.6" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded rustversion v1.0.21
[INFO] [stderr]   Downloaded vergen v8.3.2
[INFO] [stderr]   Downloaded proc-macro2 v1.0.95
[INFO] [stderr]   Downloaded errno v0.3.13
[INFO] [stderr]   Downloaded thread-id v3.3.0
[INFO] [stderr]   Downloaded pathfinder_geometry v0.5.1
[INFO] [stderr]   Downloaded yeslogic-fontconfig-sys v6.0.0
[INFO] [stderr]   Downloaded dlib v0.5.2
[INFO] [stderr]   Downloaded dirs v6.0.0
[INFO] [stderr]   Downloaded windows-result v0.4.0
[INFO] [stderr]   Downloaded float-ord v0.3.2
[INFO] [stderr]   Downloaded windows-strings v0.5.0
[INFO] [stderr]   Downloaded cfg-if v1.0.1
[INFO] [stderr]   Downloaded is-terminal v0.4.16
[INFO] [stderr]   Downloaded libloading v0.8.9
[INFO] [stderr]   Downloaded dirs-sys v0.5.0
[INFO] [stderr]   Downloaded wio v0.2.2
[INFO] [stderr]   Downloaded plotters-bitmap v0.3.7
[INFO] [stderr]   Downloaded anstyle-wincon v3.0.9
[INFO] [stderr]   Downloaded simple-logging v2.0.2
[INFO] [stderr]   Downloaded clap_lex v0.7.5
[INFO] [stderr]   Downloaded once_cell_polyfill v1.70.1
[INFO] [stderr]   Downloaded anstyle-query v1.1.3
[INFO] [stderr]   Downloaded core-graphics v0.23.2
[INFO] [stderr]   Downloaded thiserror v2.0.16
[INFO] [stderr]   Downloaded pathfinder_simd v0.5.5
[INFO] [stderr]   Downloaded redox_users v0.5.2
[INFO] [stderr]   Downloaded hermit-abi v0.5.2
[INFO] [stderr]   Downloaded find-msvc-tools v0.1.2
[INFO] [stderr]   Downloaded oorandom v11.1.5
[INFO] [stderr]   Downloaded core-text v20.1.0
[INFO] [stderr]   Downloaded anstyle v1.0.11
[INFO] [stderr]   Downloaded rand_simple v0.2.39
[INFO] [stderr]   Downloaded dwrote v0.11.4
[INFO] [stderr]   Downloaded windows-core v0.62.0
[INFO] [stderr]   Downloaded anstream v0.6.19
[INFO] [stderr]   Downloaded bitflags v2.9.1
[INFO] [stderr]   Downloaded redox_syscall v0.1.57
[INFO] [stderr]   Downloaded tempfile v3.20.0
[INFO] [stderr]   Downloaded clap_derive v4.5.41
[INFO] [stderr]   Downloaded colored v2.2.0
[INFO] [stderr]   Downloaded weezl v0.1.10
[INFO] [stderr]   Downloaded bytemuck v1.23.2
[INFO] [stderr]   Downloaded thiserror-impl v2.0.16
[INFO] [stderr]   Downloaded half v2.6.0
[INFO] [stderr]   Downloaded anyhow v1.0.98
[INFO] [stderr]   Downloaded yansi v1.0.1
[INFO] [stderr]   Downloaded flate2 v1.1.2
[INFO] [stderr]   Downloaded font-kit v0.14.3
[INFO] [stderr]   Downloaded memchr v2.7.5
[INFO] [stderr]   Downloaded clap v4.5.42
[INFO] [stderr]   Downloaded pretty_assertions v1.4.1
[INFO] [stderr]   Downloaded cc v1.2.38
[INFO] [stderr]   Downloaded png v0.17.16
[INFO] [stderr]   Downloaded ttf-parser v0.20.0
[INFO] [stderr]   Downloaded serde_json v1.0.142
[INFO] [stderr]   Downloaded clap_builder v4.5.42
[INFO] [stderr]   Downloaded syn v2.0.104
[INFO] [stderr]   Downloaded rustix v1.0.8
[INFO] [stderr]   Downloaded gif v0.12.0
[INFO] [stderr]   Downloaded jpeg-decoder v0.3.2
[INFO] [stderr]   Downloaded libc v0.2.174
[INFO] [stderr]   Downloaded linux-raw-sys v0.9.4
[INFO] [stderr]   Downloaded freetype-sys v0.20.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,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" "-m" "1610612736" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:3d5ced03c013a94a2f102a4510f48a6e9184255caf5fd8244f58017bde7f5210" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5
[INFO] running `Command { std: "docker" "start" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling cfg-if v1.0.1
[INFO] [stderr]    Compiling libc v0.2.174
[INFO] [stderr]    Compiling pkg-config v0.3.32
[INFO] [stderr]    Compiling semver v1.0.27
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling simd-adler32 v0.3.7
[INFO] [stderr]    Compiling find-msvc-tools v0.1.2
[INFO] [stderr]    Compiling rustversion v1.0.21
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling cc v1.2.38
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.95
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling anyhow v1.0.98
[INFO] [stderr]    Compiling unicode-ident v1.0.18
[INFO] [stderr]    Compiling pathfinder_simd v0.5.5
[INFO] [stderr]    Compiling zerocopy v0.8.27
[INFO] [stderr]    Compiling powerfmt v0.2.0
[INFO] [stderr]    Compiling yeslogic-fontconfig-sys v6.0.0
[INFO] [stderr]    Compiling deranged v0.5.5
[INFO] [stderr]    Compiling flate2 v1.1.2
[INFO] [stderr]    Compiling vergen v8.3.2
[INFO] [stderr]    Compiling fdeflate v0.3.7
[INFO] [stderr]    Compiling libloading v0.8.9
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling time-core v0.1.6
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling option-ext v0.2.0
[INFO] [stderr]    Compiling log v0.4.27
[INFO] [stderr]    Compiling itoa v1.0.15
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling num-conv v0.1.0
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling png v0.17.16
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling dlib v0.5.2
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling freetype-sys v0.20.1
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.1
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling jpeg-decoder v0.3.2
[INFO] [stderr]    Compiling weezl v0.1.10
[INFO] [stderr]    Compiling bytemuck v1.23.2
[INFO] [stderr]    Compiling time v0.3.44
[INFO] [stderr]    Compiling anstyle v1.0.11
[INFO] [stderr]    Compiling font-kit v0.14.3
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling anstyle-query v1.1.3
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling image v0.24.9
[INFO] [stderr]    Compiling anstream v0.6.19
[INFO] [stderr]    Compiling pathfinder_geometry v0.5.1
[INFO] [stderr]    Compiling gif v0.12.0
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling syn v2.0.104
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling bitflags v2.9.1
[INFO] [stderr]    Compiling clap_lex v0.7.5
[INFO] [stderr]    Compiling iana-time-zone v0.1.64
[INFO] [stderr]    Compiling float-ord v0.3.2
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling chrono v0.4.42
[INFO] [stderr]    Compiling clap_builder v4.5.42
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling thread-id v3.3.0
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling ttf-parser v0.20.0
[INFO] [stderr]    Compiling plotters-bitmap v0.3.7
[INFO] [stderr]    Compiling hashbrown v0.16.0
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling indexmap v2.11.4
[INFO] [stderr]    Compiling puremagic v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling simple-logging v2.0.2
[INFO] [stderr]    Compiling colored v2.2.0
[INFO] [stderr]    Compiling rand_simple v0.2.39
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling clap_derive v4.5.41
[INFO] [stderr]    Compiling clap v4.5.42
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 04s
[INFO] running `Command { std: "docker" "inspect" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.174
[INFO] [stderr]    Compiling cfg-if v1.0.1
[INFO] [stderr]    Compiling proc-macro2 v1.0.95
[INFO] [stderr]    Compiling unicode-ident v1.0.18
[INFO] [stderr]    Compiling pkg-config v0.3.32
[INFO] [stderr]    Compiling semver v1.0.27
[INFO] [stderr]    Compiling simd-adler32 v0.3.7
[INFO] [stderr]    Compiling find-msvc-tools v0.1.2
[INFO] [stderr]    Compiling autocfg v1.5.0
[INFO] [stderr]    Compiling shlex v1.3.0
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling cc v1.2.38
[INFO] [stderr]    Compiling adler2 v2.0.1
[INFO] [stderr]    Compiling rustversion v1.0.21
[INFO] [stderr]    Compiling anyhow v1.0.98
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling yeslogic-fontconfig-sys v6.0.0
[INFO] [stderr]    Compiling fdeflate v0.3.7
[INFO] [stderr]    Compiling libloading v0.8.9
[INFO] [stderr]    Compiling pathfinder_simd v0.5.5
[INFO] [stderr]    Compiling quote v1.0.40
[INFO] [stderr]    Compiling option-ext v0.2.0
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling syn v2.0.104
[INFO] [stderr]    Compiling flate2 v1.1.2
[INFO] [stderr]    Compiling powerfmt v0.2.0
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling bitflags v1.3.2
[INFO] [stderr]    Compiling log v0.4.27
[INFO] [stderr]    Compiling color_quant v1.1.0
[INFO] [stderr]    Compiling zerocopy v0.8.27
[INFO] [stderr]    Compiling bitflags v2.9.1
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling png v0.17.16
[INFO] [stderr]    Compiling deranged v0.5.5
[INFO] [stderr]    Compiling freetype-sys v0.20.1
[INFO] [stderr]    Compiling vergen v8.3.2
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling dirs-sys v0.5.0
[INFO] [stderr]    Compiling dlib v0.5.2
[INFO] [stderr]    Compiling colorchoice v1.0.4
[INFO] [stderr]    Compiling itoa v1.0.15
[INFO] [stderr]    Compiling num_threads v0.1.7
[INFO] [stderr]    Compiling num-conv v0.1.0
[INFO] [stderr]    Compiling bytemuck v1.23.2
[INFO] [stderr]    Compiling weezl v0.1.10
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.1
[INFO] [stderr]    Compiling anstyle v1.0.11
[INFO] [stderr]    Compiling anstyle-query v1.1.3
[INFO] [stderr]    Compiling plotters-backend v0.3.7
[INFO] [stderr]    Compiling time-core v0.1.6
[INFO] [stderr]    Compiling font-kit v0.14.3
[INFO] [stderr]    Compiling same-file v1.0.6
[INFO] [stderr]    Compiling jpeg-decoder v0.3.2
[INFO] [stderr]    Compiling time v0.3.44
[INFO] [stderr]    Compiling walkdir v2.5.0
[INFO] [stderr]    Compiling pathfinder_geometry v0.5.1
[INFO] [stderr]    Compiling gif v0.12.0
[INFO] [stderr]    Compiling anstream v0.6.19
[INFO] [stderr]    Compiling image v0.24.9
[INFO] [stderr]    Compiling dirs v6.0.0
[INFO] [stderr]    Compiling getrandom v0.2.16
[INFO] [stderr]    Compiling iana-time-zone v0.1.64
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling clap_lex v0.7.5
[INFO] [stderr]    Compiling strsim v0.11.1
[INFO] [stderr]    Compiling float-ord v0.3.2
[INFO] [stderr]    Compiling heck v0.5.0
[INFO] [stderr]    Compiling clap_builder v4.5.42
[INFO] [stderr]    Compiling clap_derive v4.5.41
[INFO] [stderr]    Compiling chrono v0.4.42
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling plotters-svg v0.3.7
[INFO] [stderr]    Compiling plotters-bitmap v0.3.7
[INFO] [stderr]    Compiling ttf-parser v0.20.0
[INFO] [stderr]    Compiling serde v1.0.219
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling puremagic v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling serde_derive v1.0.219
[INFO] [stderr]    Compiling thread-id v3.3.0
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling hashbrown v0.16.0
[INFO] [stderr]    Compiling clap v4.5.42
[INFO] [stderr]    Compiling indexmap v2.11.4
[INFO] [stderr]    Compiling simple-logging v2.0.2
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling plotters v0.3.7
[INFO] [stderr]    Compiling colored v2.2.0
[INFO] [stderr]    Compiling either v1.15.0
[INFO] [stderr]    Compiling rayon-core v1.12.1
[INFO] [stderr]    Compiling serde_json v1.0.142
[INFO] [stderr]    Compiling rand_simple v0.2.39
[INFO] [stderr]    Compiling crossbeam-deque v0.8.6
[INFO] [stderr]    Compiling half v2.6.0
[INFO] [stderr]    Compiling rustix v1.0.8
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling ciborium-io v0.2.2
[INFO] [stderr]    Compiling ryu v1.0.20
[INFO] [stderr]    Compiling memchr v2.7.5
[INFO] [stderr]    Compiling getrandom v0.3.3
[INFO] [stderr]    Compiling ciborium-ll v0.2.2
[INFO] [stderr]    Compiling itertools v0.10.5
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling linux-raw-sys v0.9.4
[INFO] [stderr]    Compiling cast v0.3.0
[INFO] [stderr]    Compiling criterion-plot v0.5.0
[INFO] [stderr]    Compiling rayon v1.10.0
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling tinytemplate v1.2.1
[INFO] [stderr]    Compiling ciborium v0.2.2
[INFO] [stderr]    Compiling is-terminal v0.4.16
[INFO] [stderr]    Compiling yansi v1.0.1
[INFO] [stderr]    Compiling anes v0.1.6
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling oorandom v11.1.5
[INFO] [stderr]    Compiling diff v0.1.13
[INFO] [stderr]    Compiling criterion v0.5.1
[INFO] [stderr]    Compiling tempfile v3.20.0
[INFO] [stderr]    Compiling pretty_assertions v1.4.1
[INFO] [stderr]     Finished `test` profile [optimized] target(s) in 4m 20s
[INFO] running `Command { std: "docker" "inspect" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "exec" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-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" "-w" "/opt/rustwide/workdir" "--user" "0:0" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [optimized] target(s) in 0.32s
[INFO] [stderr]      Running unittests src/circuit_stats.rs (/opt/rustwide/target/debug/deps/circuit_stats-5b7219b34744c2fa)
[INFO] [stdout] 
[INFO] [stdout] running 153 tests
[INFO] [stdout] test circuit::tests::build_coupling_matrix_symmetric_for_cx_gate ... ok
[INFO] [stdout] test circuit::tests::count_t_stats_all_t_gates_in_separate_layers ... ok
[INFO] [stdout] test circuit::tests::count_t_stats_no_t_gates ... ok
[INFO] [stdout] test circuit::tests::generate_dependencies_chain_of_three ... ok
[INFO] [stdout] test circuit::tests::generate_dependencies_independent_products_have_no_parents ... ok
[INFO] [stdout] test circuit::tests::generate_dependencies_sequential_same_qubit ... ok
[INFO] [stdout] test circuit::tests::get_layers_diamond_dependency ... ok
[INFO] [stdout] test circuit::tests::get_product_returns_correct_product ... ok
[INFO] [stdout] test circuit::tests::load_circuit_keeps_s_gate ... ok
[INFO] [stdout] test circuit::tests::load_circuit_keeps_cx_gate ... ok
[INFO] [stdout] test circuit::tests::load_circuit_nonexistent_file_returns_error ... ok
[INFO] [stdout] test circuit::tests::count_t_stats_counts_t_gates_and_t_layers ... ok
[INFO] [stdout] test circuit::tests::load_circuit_keeps_m_gate ... ok
[INFO] [stdout] test circuit::tests::load_circuit_assigns_sequential_ids ... ok
[INFO] [stdout] test circuit::tests::load_circuit_single_t_gate ... ok
[INFO] [stdout] test circuit::tests::load_circuit_skips_x_and_z_gates ... ok
[INFO] [stdout] test circuit::tests::n_cycles_parallel_cx_and_t ... ok
[INFO] [stdout] test circuit::tests::moving_average_does_not_panic_on_single_product ... ok
[INFO] [stdout] test circuit::tests::n_cycles_empty_circuit_is_zero ... ok
[INFO] [stdout] test circuit::tests::n_cycles_sequential_cx_then_s_sums_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_sequential_t_chain_with_t_failures_in_range ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_cx_gate_costs_two_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_sequential_t_chain_no_t_failures_is_exact ... ok
[INFO] [stdout] test circuit::tests::load_circuit_multiple_products ... ok
[INFO] [stdout] test circuit::tests::n_cycles_parallel_s_and_cx ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_s_gate_costs_three_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_t_gate_s_insertion_is_reproducible_with_same_seed ... ok
[INFO] [stdout] test circuit::tests::n_qubits_is_max_qubit_plus_one ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_t_gate_with_t_failures_costs_one_or_two_layers ... ok
[INFO] [stdout] test circuit::tests::n_products_matches_loaded_count ... ok
[INFO] [stdout] test circuit::tests::new_creates_empty_circuit ... ok
[INFO] [stdout] test node::tests::add_nb_increases_count ... ok
[INFO] [stdout] test node::tests::add_nb_no_duplicates ... ok
[INFO] [stdout] test node::tests::add_nb_up_to_max ... ok
[INFO] [stdout] test circuit::tests::print_statistics_returns_correct_layer_count_linear_chain ... ok
[INFO] [stdout] test circuit::tests::n_cycles_t_gate_s_insertion_varies_across_seeds ... ok
[INFO] [stdout] test node::tests::is_routing_bus_node_when_magic_routing_disabled ... ok
[INFO] [stdout] test circuit::tests::print_statistics_parallel_products_in_one_layer ... ok
[INFO] [stdout] test node::tests::is_routing_bus_when_magic_routing_disabled ... ok
[INFO] [stdout] test node::tests::is_routing_magic_when_magic_routing_disabled ... ok
[INFO] [stdout] test node::tests::is_routing_magic_when_magic_routing_enabled ... ok
[INFO] [stdout] test node::tests::max_nbs_is_six ... ok
[INFO] [stdout] test node::tests::nbs_slice_contains_added_nbs ... ok
[INFO] [stdout] test node::tests::nbs_slice_empty_initially ... ok
[INFO] [stdout] test node::tests::node_new_bus ... ok
[INFO] [stdout] test node::tests::node_new_data_with_pair ... ok
[INFO] [stdout] test node::tests::node_new_data_without_pair ... ok
[INFO] [stdout] test node::tests::node_new_magic ... ok
[INFO] [stdout] test node::tests::node_type_clone_and_copy ... ok
[INFO] [stdout] test node::tests::node_type_equality ... ok
[INFO] [stdout] test node::tests::set_magic_routing_toggles_global_flag ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_display ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_cx ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_s ... ok
[INFO] [stdout] test circuit::tests::initial_products_returns_products_with_no_parents ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_clifford ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_m ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_sx ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_t ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_sx_gate_costs_three_layers ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_x ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_clifford_covers_all_variants ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_z ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_t_gate_no_t_failures_is_exactly_one_layer ... ok
[INFO] [stdout] test pauliproduct::tests::get_qubits_empty_when_no_operators ... ok
[INFO] [stdout] test pauliproduct::tests::get_qubits_multi_operator ... ok
[INFO] [stdout] test pauliproduct::tests::get_qubits_returns_all_qubit_indices ... ok
[INFO] [stdout] test pauliproduct::tests::operator_display_z_basis ... ok
[INFO] [stdout] test pauliproduct::tests::max_qubit_set_correctly_for_multi_operator ... ok
[INFO] [stdout] test pauliproduct::tests::operator_display ... ok
[INFO] [stdout] test pauliproduct::tests::pauli_product_new_defaults ... ok
[INFO] [stdout] test pauliproduct::tests::pauli_product_display_contains_id_and_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_cx_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_illegal_char_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_h_gate_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_m_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_s_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_max_qubit_computed_correctly ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sdg_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sdg_maps_to_s ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sx_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sxdg_maps_to_sx ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sxdg_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_t_gate_multi_operator ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_tdg_gate_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_t_gate_single_x ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_unknown_gate_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_x_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_z_gate ... ok
[INFO] [stdout] test pauliproduct::tests::to_operator_str_format ... ok
[INFO] [stdout] test pauliproduct::tests::to_operator_str_no_operators_shows_gate_type ... ok
[INFO] [stdout] test topograph::tests::bus_routing_topo_has_data_qubits ... ok
[INFO] [stdout] test topograph::tests::bus_routing_topo_has_bus_qubits ... ok
[INFO] [stdout] test topograph::tests::add_edge_creates_bidirectional_connection ... ok
[INFO] [stdout] test topograph::tests::compact_bus_topo_has_bus_qubits ... ok
[INFO] [stdout] test topograph::tests::all_nodes_have_finite_positions ... ok
[INFO] [stdout] test topograph::tests::circuit_stem_returns_non_empty_string ... ok
[INFO] [stdout] test topograph::tests::data_node_labels_contain_basis ... ok
[INFO] [stdout] test topograph::tests::compact_bus_topo_has_enough_data_qubits ... ok
[INFO] [stdout] test topograph::tests::edges_are_symmetric ... ok
[INFO] [stdout] test topograph::tests::gen_pure_magic_topo_has_enough_data_qubits ... ok
[INFO] [stdout] test topograph::tests::gen_pure_magic_topo_has_only_magic_and_data_nodes ... ok
[INFO] [stdout] test topograph::tests::gen_pure_magic_topo_total_qubits_consistent ... ok
[INFO] [stdout] test topograph::tests::get_label_returns_non_empty_string ... ok
[INFO] [stdout] test topograph::tests::get_node_returns_correct_node ... ok
[INFO] [stdout] test topograph::tests::hsv_to_rgb_black ... ok
[INFO] [stdout] test topograph::tests::hsv_to_rgb_white ... ok
[INFO] [stdout] test topograph::tests::hsv_to_rgb_red ... ok
[INFO] [stdout] test topograph::tests::new_creates_empty_topology ... ok
[INFO] [stdout] test topograph::tests::is_cultivating_false_when_busy_equals_cultivation_time ... ok
[INFO] [stdout] test topograph::tests::set_topo_with_magic_routing_has_magic_nodes ... ok
[INFO] [stdout] test topograph::tests::set_topo_generates_topology_for_small_circuit ... ok
[INFO] [stdout] test treegraph::tests::add_edge_creates_bidirectional_edge ... ok
[INFO] [stdout] test topograph::tests::update_statistics_magic_count_matches_magic_nodes ... ok
[INFO] [stdout] test topograph::tests::update_statistics_data_count_matches_data_nodes ... ok
[INFO] [stdout] test topograph::tests::set_topo_without_magic_routing_has_bus_nodes ... ok
[INFO] [stdout] test topograph::tests::update_statistics_keeps_counts_consistent ... ok
[INFO] [stdout] test treegraph::tests::add_edge_increments_n_edges ... ok
[INFO] [stdout] test treegraph::tests::add_node_increments_n_nodes ... ok
[INFO] [stdout] test treegraph::tests::contains_node_false_before_add ... ok
[INFO] [stdout] test treegraph::tests::iter_nodes_empty_on_new_graph ... ok
[INFO] [stdout] test treegraph::tests::contains_node_true_after_add ... ok
[INFO] [stdout] test treegraph::tests::iter_nodes_yields_added_ids ... ok
[INFO] [stdout] test treegraph::tests::contains_edge_false_for_absent_edge ... ok
[INFO] [stdout] test treegraph::tests::contains_edge_false_when_node_absent ... ok
[INFO] [stdout] test treegraph::tests::n_edges_increments_on_add_edge ... ok
[INFO] [stdout] test treegraph::tests::nbs_contains_connected_node ... ok
[INFO] [stdout] test treegraph::tests::nbs_empty_before_edges ... ok
[INFO] [stdout] test treegraph::tests::new_creates_empty_graph ... ok
[INFO] [stdout] test treegraph::tests::trim_dangling_nodes_chain_removes_all_routing ... ok
[INFO] [stdout] test treegraph::tests::remove_double_edges_removes_extra_side_edge ... ok
[INFO] [stdout] test treegraph::tests::trim_dangling_nodes_keeps_root ... ok
[INFO] [stdout] test treegraph::tests::trim_dangling_nodes_keeps_data_nodes ... ok
[INFO] [stdout] test treegraph::tests::trim_dangling_nodes_removes_degree_one_routing_nodes ... ok
[INFO] [stdout] test treegraph::tests::trim_magic_root_noop_when_no_root ... ok
[INFO] [stdout] test treegraph::tests::trim_magic_root_removes_root_when_set ... ok
[INFO] [stdout] test utils::tests::accum_timer_guard_stops_on_drop ... ok
[INFO] [stdout] test utils::tests::add_or_get_returns_sequential_indices ... ok
[INFO] [stdout] test utils::tests::add_or_get_returns_zero_for_first_entry ... ok
[INFO] [stdout] test utils::tests::add_or_get_idempotent_for_same_name ... ok
[INFO] [stdout] test utils::tests::accum_timers_new_is_empty ... ok
[INFO] [stdout] test utils::tests::add_or_get_same_name_always_returns_same_index ... ok
[INFO] [stdout] test utils::tests::default_is_empty ... ok
[INFO] [stdout] test utils::tests::multiple_timers_do_not_interfere ... ok
[INFO] [stdout] test utils::tests::start_stop_out_of_bounds_index_is_noop ... ok
[INFO] [stdout] test utils::tests::start_stop_valid_index_does_not_panic ... ok
[INFO] [stdout] test utils::tests::stop_without_start_is_noop ... ok
[INFO] [stdout] test utils::tests::timer_new_does_not_panic ... ok
[INFO] [stdout] test utils::tests::start_stop_does_not_panic ... ok
[INFO] [stdout] test topograph::tests::get_data_node_id_returns_valid_node ... ok
[INFO] [stdout] test topograph::tests::is_cultivating_true_when_busy_less_than_cultivation_time ... ok
[INFO] [stdout] test utils::tests::multiple_start_stop_accumulates ... ok
[INFO] [stdout] test topograph::tests::is_cultivating_false_when_cultivation_time_zero ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 153 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stderr]      Running unittests src/gen_circuit.rs (/opt/rustwide/target/debug/deps/gen_circuit-ea5cf4253fa833e9)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 88 tests
[INFO] [stdout] test circuit::tests::count_t_stats_counts_t_gates_and_t_layers ... ok
[INFO] [stdout] test circuit::tests::count_t_stats_no_t_gates ... ok
[INFO] [stdout] test circuit::tests::generate_dependencies_chain_of_three ... ok
[INFO] [stdout] test circuit::tests::count_t_stats_all_t_gates_in_separate_layers ... ok
[INFO] [stdout] test circuit::tests::initial_products_returns_products_with_no_parents ... ok
[INFO] [stdout] test circuit::tests::generate_dependencies_independent_products_have_no_parents ... ok
[INFO] [stdout] test circuit::tests::build_coupling_matrix_symmetric_for_cx_gate ... ok
[INFO] [stdout] test circuit::tests::generate_dependencies_sequential_same_qubit ... ok
[INFO] [stdout] test circuit::tests::get_layers_diamond_dependency ... ok
[INFO] [stdout] test circuit::tests::get_product_returns_correct_product ... ok
[INFO] [stdout] test circuit::tests::load_circuit_keeps_cx_gate ... ok
[INFO] [stdout] test circuit::tests::load_circuit_nonexistent_file_returns_error ... ok
[INFO] [stdout] test circuit::tests::load_circuit_single_t_gate ... ok
[INFO] [stdout] test circuit::tests::load_circuit_keeps_m_gate ... ok
[INFO] [stdout] test circuit::tests::load_circuit_assigns_sequential_ids ... ok
[INFO] [stdout] test circuit::tests::n_cycles_parallel_cx_and_t ... ok
[INFO] [stdout] test circuit::tests::load_circuit_keeps_s_gate ... ok
[INFO] [stdout] test circuit::tests::load_circuit_multiple_products ... ok
[INFO] [stdout] test circuit::tests::n_cycles_parallel_s_and_cx ... ok
[INFO] [stdout] test circuit::tests::n_cycles_empty_circuit_is_zero ... ok
[INFO] [stdout] test circuit::tests::n_cycles_sequential_t_chain_no_t_failures_is_exact ... ok
[INFO] [stdout] test circuit::tests::n_cycles_sequential_t_chain_with_t_failures_in_range ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_s_gate_costs_three_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_sequential_cx_then_s_sums_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_cx_gate_costs_two_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_sx_gate_costs_three_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_t_gate_s_insertion_is_reproducible_with_same_seed ... ok
[INFO] [stdout] test circuit::tests::n_products_matches_loaded_count ... ok
[INFO] [stdout] test circuit::tests::n_qubits_is_max_qubit_plus_one ... ok
[INFO] [stdout] test circuit::tests::load_circuit_skips_x_and_z_gates ... ok
[INFO] [stdout] test circuit::tests::moving_average_does_not_panic_on_single_product ... ok
[INFO] [stdout] test circuit::tests::print_statistics_parallel_products_in_one_layer ... ok
[INFO] [stdout] test circuit::tests::new_creates_empty_circuit ... ok
[INFO] [stdout] test circuit::tests::n_cycles_t_gate_s_insertion_varies_across_seeds ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_clifford ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_clifford_covers_all_variants ... ok
[INFO] [stdout] test circuit::tests::print_statistics_returns_correct_layer_count_linear_chain ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_display ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_m ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_cx ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_sx ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_t ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_s ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_t_gate_no_t_failures_is_exactly_one_layer ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_x ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_t_gate_with_t_failures_costs_one_or_two_layers ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_z ... ok
[INFO] [stdout] test pauliproduct::tests::get_qubits_empty_when_no_operators ... ok
[INFO] [stdout] test pauliproduct::tests::get_qubits_multi_operator ... ok
[INFO] [stdout] test pauliproduct::tests::get_qubits_returns_all_qubit_indices ... ok
[INFO] [stdout] test pauliproduct::tests::max_qubit_set_correctly_for_multi_operator ... ok
[INFO] [stdout] test pauliproduct::tests::operator_display ... ok
[INFO] [stdout] test pauliproduct::tests::pauli_product_display_contains_id_and_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_illegal_char_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_cx_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_m_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_max_qubit_computed_correctly ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_h_gate_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::pauli_product_new_defaults ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_s_gate ... ok
[INFO] [stdout] test pauliproduct::tests::operator_display_z_basis ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sdg_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sdg_maps_to_s ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sx_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sxdg_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_t_gate_multi_operator ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sxdg_maps_to_sx ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_t_gate_single_x ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_tdg_gate_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_unknown_gate_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_x_gate ... ok
[INFO] [stdout] test pauliproduct::tests::to_operator_str_format ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_z_gate ... ok
[INFO] [stdout] test utils::tests::accum_timer_guard_stops_on_drop ... ok
[INFO] [stdout] test pauliproduct::tests::to_operator_str_no_operators_shows_gate_type ... ok
[INFO] [stdout] test utils::tests::accum_timers_new_is_empty ... ok
[INFO] [stdout] test utils::tests::add_or_get_returns_sequential_indices ... ok
[INFO] [stdout] test utils::tests::add_or_get_returns_zero_for_first_entry ... ok
[INFO] [stdout] test utils::tests::default_is_empty ... ok
[INFO] [stdout] test utils::tests::add_or_get_same_name_always_returns_same_index ... ok
[INFO] [stdout] test utils::tests::multiple_timers_do_not_interfere ... ok
[INFO] [stdout] test utils::tests::start_stop_out_of_bounds_index_is_noop ... ok
[INFO] [stdout] test utils::tests::start_stop_valid_index_does_not_panic ... ok
[INFO] [stdout] test utils::tests::timer_new_does_not_panic ... ok
[INFO] [stdout] test utils::tests::stop_without_start_is_noop ... ok
[INFO] [stdout] test utils::tests::add_or_get_idempotent_for_same_name ... ok
[INFO] [stdout] test utils::tests::multiple_start_stop_accumulates ... ok
[INFO] [stderr]      Running unittests src/puremagic.rs (/opt/rustwide/target/debug/deps/puremagic-98afbe45b8947556)
[INFO] [stdout] test utils::tests::start_stop_does_not_panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 88 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 195 tests
[INFO] [stdout] test astar::tests::compute_returns_no_path_when_no_magic_ready ... ok
[INFO] [stdout] test astar::tests::compute_finds_path_when_magic_ready ... ok
[INFO] [stdout] test astar::tests::heuristic_exact_match ... ok
[INFO] [stdout] test astar::tests::heuristic_single_candidate ... ok
[INFO] [stdout] test astar::tests::heuristic_empty_list_returns_max ... ok
[INFO] [stdout] test astar::tests::heuristic_picks_nearest ... ok
[INFO] [stdout] test astar::tests::manhattan_dist_diagonal ... ok
[INFO] [stdout] test astar::tests::manhattan_dist_horizontal ... ok
[INFO] [stdout] test astar::tests::manhattan_dist_negative_coords ... ok
[INFO] [stdout] test astar::tests::manhattan_dist_same_point ... ok
[INFO] [stdout] test astar::tests::manhattan_dist_vertical ... ok
[INFO] [stdout] test astar::tests::new_initialises_with_zero_calls ... ok
[INFO] [stdout] test astar::tests::n_calls_increments_on_each_compute ... ok
[INFO] [stdout] test circuit::tests::build_coupling_matrix_symmetric_for_cx_gate ... ok
[INFO] [stdout] test circuit::tests::count_t_stats_all_t_gates_in_separate_layers ... ok
[INFO] [stdout] test circuit::tests::count_t_stats_counts_t_gates_and_t_layers ... ok
[INFO] [stdout] test circuit::tests::count_t_stats_no_t_gates ... ok
[INFO] [stdout] test circuit::tests::generate_dependencies_chain_of_three ... ok
[INFO] [stdout] test circuit::tests::generate_dependencies_sequential_same_qubit ... ok
[INFO] [stdout] test circuit::tests::get_layers_diamond_dependency ... ok
[INFO] [stdout] test circuit::tests::generate_dependencies_independent_products_have_no_parents ... ok
[INFO] [stdout] test circuit::tests::load_circuit_assigns_sequential_ids ... ok
[INFO] [stdout] test circuit::tests::load_circuit_keeps_cx_gate ... ok
[INFO] [stdout] test circuit::tests::initial_products_returns_products_with_no_parents ... ok
[INFO] [stdout] test circuit::tests::load_circuit_keeps_m_gate ... ok
[INFO] [stdout] test circuit::tests::get_product_returns_correct_product ... ok
[INFO] [stdout] test circuit::tests::load_circuit_multiple_products ... ok
[INFO] [stdout] test circuit::tests::load_circuit_single_t_gate ... ok
[INFO] [stdout] test circuit::tests::load_circuit_keeps_s_gate ... ok
[INFO] [stdout] test circuit::tests::moving_average_does_not_panic_on_single_product ... ok
[INFO] [stdout] test circuit::tests::n_cycles_empty_circuit_is_zero ... ok
[INFO] [stdout] test circuit::tests::n_cycles_sequential_t_chain_no_t_failures_is_exact ... ok
[INFO] [stdout] test circuit::tests::n_cycles_sequential_cx_then_s_sums_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_sequential_t_chain_with_t_failures_in_range ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_cx_gate_costs_two_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_sx_gate_costs_three_layers ... ok
[INFO] [stdout] test circuit::tests::load_circuit_nonexistent_file_returns_error ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_s_gate_costs_three_layers ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_t_gate_no_t_failures_is_exactly_one_layer ... ok
[INFO] [stdout] test circuit::tests::load_circuit_skips_x_and_z_gates ... ok
[INFO] [stdout] test circuit::tests::n_cycles_parallel_cx_and_t ... ok
[INFO] [stdout] test circuit::tests::n_cycles_parallel_s_and_cx ... ok
[INFO] [stdout] test circuit::tests::n_cycles_single_t_gate_with_t_failures_costs_one_or_two_layers ... ok
[INFO] [stdout] test circuit::tests::n_qubits_is_max_qubit_plus_one ... ok
[INFO] [stdout] test circuit::tests::new_creates_empty_circuit ... ok
[INFO] [stdout] test circuit::tests::print_statistics_parallel_products_in_one_layer ... ok
[INFO] [stdout] test circuit::tests::n_cycles_t_gate_s_insertion_is_reproducible_with_same_seed ... ok
[INFO] [stdout] test circuit::tests::n_cycles_t_gate_s_insertion_varies_across_seeds ... ok
[INFO] [stdout] test circuit::tests::n_products_matches_loaded_count ... ok
[INFO] [stdout] test cultivation::tests::draw_increments_pool_index ... ok
[INFO] [stdout] test cultivation::tests::draw_returns_value_from_pool ... ok
[INFO] [stdout] test cultivation::tests::fill_pool_resets_pool_index ... ok
[INFO] [stdout] test circuit::tests::print_statistics_returns_correct_layer_count_linear_chain ... ok
[INFO] [stdout] test cultivation::tests::fill_pool_zero_produces_empty_pool ... ok
[INFO] [stdout] test cultivation::tests::draw_refills_when_pool_exhausted ... ok
[INFO] [stdout] test cultivation::tests::new_creates_empty_manager ... ok
[INFO] [stdout] test cultivation::tests::fill_pool_produces_correct_count ... ok
[INFO] [stdout] test cultivation::tests::init_magic_nodes_populates_ids_and_positions ... ok
[INFO] [stdout] test cultivation::tests::set_lambda_large_value_returns_ok ... ok
[INFO] [stdout] test cultivation::tests::init_magic_nodes_assigns_cultivation_times ... ok
[INFO] [stdout] test cultivation::tests::update_cultivators_increments_busy_count_for_cultivating_nodes ... ok
[INFO] [stdout] test cultivation::tests::update_cultivators_logs_completed_cultivation ... ok
[INFO] [stdout] test cultivation::tests::set_lambda_valid_returns_ok ... ok
[INFO] [stdout] test node::tests::add_nb_increases_count ... ok
[INFO] [stdout] test cultivation::tests::update_cultivators_ready_positions_sorted_by_x ... ok
[INFO] [stdout] test cultivation::tests::update_cultivators_used_nodes_get_new_cultivation_time ... ok
[INFO] [stdout] test node::tests::add_nb_no_duplicates ... ok
[INFO] [stdout] test node::tests::add_nb_up_to_max ... ok
[INFO] [stdout] test node::tests::is_routing_bus_node_when_magic_routing_disabled ... ok
[INFO] [stdout] test node::tests::is_routing_bus_when_magic_routing_disabled ... ok
[INFO] [stdout] test node::tests::is_routing_magic_when_magic_routing_disabled ... ok
[INFO] [stdout] test cultivation::tests::update_cultivators_returns_count_of_ready_magic_nodes ... ok
[INFO] [stdout] test node::tests::is_routing_magic_when_magic_routing_enabled ... ok
[INFO] [stdout] test node::tests::max_nbs_is_six ... ok
[INFO] [stdout] test node::tests::nbs_slice_contains_added_nbs ... ok
[INFO] [stdout] test node::tests::nbs_slice_empty_initially ... ok
[INFO] [stdout] test node::tests::node_new_bus ... ok
[INFO] [stdout] test node::tests::node_new_data_with_pair ... ok
[INFO] [stdout] test node::tests::node_new_data_without_pair ... ok
[INFO] [stdout] test node::tests::node_type_clone_and_copy ... ok
[INFO] [stdout] test node::tests::node_new_magic ... ok
[INFO] [stdout] test node::tests::set_magic_routing_toggles_global_flag ... ok
[INFO] [stdout] test node::tests::node_type_equality ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_display ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_s ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_clifford ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_t ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_sx ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_clifford_covers_all_variants ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_cx ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_m ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_x ... ok
[INFO] [stdout] test pauliproduct::tests::gate_type_is_z ... ok
[INFO] [stdout] test pauliproduct::tests::get_qubits_empty_when_no_operators ... ok
[INFO] [stdout] test pauliproduct::tests::get_qubits_multi_operator ... ok
[INFO] [stdout] test pauliproduct::tests::get_qubits_returns_all_qubit_indices ... ok
[INFO] [stdout] test pauliproduct::tests::max_qubit_set_correctly_for_multi_operator ... ok
[INFO] [stdout] test pauliproduct::tests::operator_display ... ok
[INFO] [stdout] test pauliproduct::tests::operator_display_z_basis ... ok
[INFO] [stdout] test pauliproduct::tests::pauli_product_display_contains_id_and_gate ... ok
[INFO] [stdout] test pauliproduct::tests::pauli_product_new_defaults ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_h_gate_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_illegal_char_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_cx_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_m_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_max_qubit_computed_correctly ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_s_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sdg_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sdg_maps_to_s ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sx_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sxdg_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_sxdg_maps_to_sx ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_t_gate_single_x ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_tdg_gate_returns_error ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_x_gate ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_z_gate ... ok
[INFO] [stdout] test pauliproduct::tests::to_operator_str_format ... ok
[INFO] [stdout] test pauliproduct::tests::to_operator_str_no_operators_shows_gate_type ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_t_gate_multi_operator ... ok
[INFO] [stdout] test pauliproduct::tests::set_from_str_unknown_gate_returns_error ... ok
[INFO] [stdout] test steinertree::tests::clear_resets_state ... ok
[INFO] [stdout] test steinertree::tests::compute_cx_gate_finds_tree_between_two_data_qubits ... ok
[INFO] [stdout] test scheduler::tests::failed_t_paths_empty_after_schedule_completes ... ok
[INFO] [stdout] test steinertree::tests::compute_increments_n_calls ... ok
[INFO] [stdout] test scheduler::tests::all_products_appear_exactly_once_in_lcycle_scheduled ... ok
[INFO] [stdout] test steinertree::tests::compute_t_gate_returns_none_when_no_magic_ready ... ok
[INFO] [stdout] test steinertree::tests::compute_t_gate_succeeds_when_magic_ready ... ok
[INFO] [stdout] test steinertree::tests::new_initialises_with_zero_calls ... ok
[INFO] [stdout] test topograph::tests::add_edge_creates_bidirectional_connection ... ok
[INFO] [stdout] test topograph::tests::all_nodes_have_finite_positions ... ok
[INFO] [stdout] test scheduler::tests::lcycle_scheduled_tot_entries_equals_n_products ... ok
[INFO] [stdout] test topograph::tests::bus_routing_topo_has_bus_qubits ... ok
[INFO] [stdout] test topograph::tests::bus_routing_topo_has_data_qubits ... ok
[INFO] [stdout] test scheduler::tests::t_gate_failures_bounded_by_total_t_gates ... ok
[INFO] [stdout] test topograph::tests::compact_bus_topo_has_bus_qubits ... ok
[INFO] [stdout] test topograph::tests::circuit_stem_returns_non_empty_string ... ok
[INFO] [stdout] test topograph::tests::compact_bus_topo_has_enough_data_qubits ... ok
[INFO] [stdout] test scheduler::tests::lcycle_count_bounded_by_t_gate_failure_overhead ... FAILED
[INFO] [stdout] test topograph::tests::data_node_labels_contain_basis ... ok
[INFO] [stdout] test topograph::tests::edges_are_symmetric ... ok
[INFO] [stdout] test topograph::tests::gen_pure_magic_topo_has_only_magic_and_data_nodes ... ok
[INFO] [stdout] test topograph::tests::gen_pure_magic_topo_total_qubits_consistent ... ok
[INFO] [stdout] test topograph::tests::gen_pure_magic_topo_has_enough_data_qubits ... ok
[INFO] [stdout] test topograph::tests::hsv_to_rgb_black ... ok
[INFO] [stdout] test topograph::tests::get_data_node_id_returns_valid_node ... ok
[INFO] [stdout] test topograph::tests::get_label_returns_non_empty_string ... ok
[INFO] [stdout] test topograph::tests::get_node_returns_correct_node ... ok
[INFO] [stdout] test topograph::tests::hsv_to_rgb_red ... ok
[INFO] [stdout] test scheduler::tests::t_gate_failures_deterministic_with_fixed_seed ... FAILED
[INFO] [stdout] test topograph::tests::hsv_to_rgb_white ... ok
[INFO] [stdout] test topograph::tests::is_cultivating_false_when_cultivation_time_zero ... ok
[INFO] [stdout] test topograph::tests::new_creates_empty_topology ... ok
[INFO] [stdout] test topograph::tests::is_cultivating_false_when_busy_equals_cultivation_time ... ok
[INFO] [stdout] test topograph::tests::set_topo_generates_topology_for_small_circuit ... ok
[INFO] [stdout] test topograph::tests::is_cultivating_true_when_busy_less_than_cultivation_time ... ok
[INFO] [stdout] test topograph::tests::set_topo_without_magic_routing_has_bus_nodes ... ok
[INFO] [stdout] test topograph::tests::set_topo_with_magic_routing_has_magic_nodes ... ok
[INFO] [stdout] test topograph::tests::update_statistics_magic_count_matches_magic_nodes ... ok
[INFO] [stdout] test topograph::tests::update_statistics_keeps_counts_consistent ... ok
[INFO] [stdout] test topograph::tests::update_statistics_data_count_matches_data_nodes ... ok
[INFO] [stdout] test treegraph::tests::add_edge_creates_bidirectional_edge ... ok
[INFO] [stdout] test treegraph::tests::add_node_increments_n_nodes ... ok
[INFO] [stdout] test treegraph::tests::add_edge_increments_n_edges ... ok
[INFO] [stdout] test treegraph::tests::contains_edge_false_when_node_absent ... ok
[INFO] [stdout] test treegraph::tests::contains_edge_false_for_absent_edge ... ok
[INFO] [stdout] test treegraph::tests::contains_node_false_before_add ... ok
[INFO] [stdout] test treegraph::tests::nbs_contains_connected_node ... ok
[INFO] [stdout] test treegraph::tests::contains_node_true_after_add ... ok
[INFO] [stdout] test treegraph::tests::nbs_empty_before_edges ... ok
[INFO] [stdout] test treegraph::tests::new_creates_empty_graph ... ok
[INFO] [stdout] test treegraph::tests::iter_nodes_yields_added_ids ... ok
[INFO] [stdout] test treegraph::tests::n_edges_increments_on_add_edge ... ok
[INFO] [stdout] test treegraph::tests::iter_nodes_empty_on_new_graph ... ok
[INFO] [stdout] test treegraph::tests::remove_double_edges_removes_extra_side_edge ... ok
[INFO] [stdout] test treegraph::tests::trim_dangling_nodes_keeps_root ... ok
[INFO] [stdout] test treegraph::tests::trim_dangling_nodes_chain_removes_all_routing ... ok
[INFO] [stdout] test treegraph::tests::trim_magic_root_removes_root_when_set ... ok
[INFO] [stdout] test utils::tests::accum_timers_new_is_empty ... ok
[INFO] [stdout] test utils::tests::accum_timer_guard_stops_on_drop ... ok
[INFO] [stdout] test treegraph::tests::trim_dangling_nodes_removes_degree_one_routing_nodes ... ok
[INFO] [stdout] test treegraph::tests::trim_dangling_nodes_keeps_data_nodes ... ok
[INFO] [stdout] test treegraph::tests::trim_magic_root_noop_when_no_root ... ok
[INFO] [stdout] test scheduler::tests::t_gate_failures_varies_with_seed ... ok
[INFO] [stdout] test utils::tests::add_or_get_idempotent_for_same_name ... ok
[INFO] [stdout] test utils::tests::add_or_get_returns_sequential_indices ... ok
[INFO] [stdout] test utils::tests::add_or_get_same_name_always_returns_same_index ... ok
[INFO] [stdout] test utils::tests::default_is_empty ... ok
[INFO] [stdout] test utils::tests::multiple_timers_do_not_interfere ... ok
[INFO] [stdout] test utils::tests::start_stop_out_of_bounds_index_is_noop ... ok
[INFO] [stdout] test utils::tests::start_stop_valid_index_does_not_panic ... ok
[INFO] [stdout] test utils::tests::stop_without_start_is_noop ... ok
[INFO] [stdout] test utils::tests::timer_new_does_not_panic ... ok
[INFO] [stdout] test utils::tests::add_or_get_returns_zero_for_first_entry ... ok
[INFO] [stdout] test utils::tests::start_stop_does_not_panic ... ok
[INFO] [stdout] test utils::tests::multiple_start_stop_accumulates ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- scheduler::tests::lcycle_count_bounded_by_t_gate_failure_overhead stdout ----
[INFO] [stdout] Loaded circuit with 4 products and 4 qubits
[INFO] [stdout] Timing: Circuit::load_circuit took 0.00 s
[INFO] [stdout] Generated topology with dimensions: 5 4
[INFO] [stdout] Number of qubits:
[INFO] [stdout]   data:         4 (0.200)
[INFO] [stdout]   bus:          0 (0.000)
[INFO] [stdout]   magic:        16 (0.800)
[INFO] [stdout]   total:        20
[INFO] [stdout] Precomputed terminals and root candidates for 4 products
[INFO] [stdout] Timing: precompute_terminals_and_roots took 0.00 s
[INFO] [stdout] Precomputed 0 multi-term Clifford trees
[INFO] [stdout] Timing: precompute_clifford_trees took 0.00 s
[INFO] [stdout] 
[INFO] [stdout] thread 'scheduler::tests::lcycle_count_bounded_by_t_gate_failure_overhead' (4327) panicked at src/scheduler.rs:665:17:
[INFO] [stdout] lcycle 3: Cannot schedule products [0X<T>, 1X<T>, 2X<T>, 3X<T>] on current layout (1 magic)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5df46f14d498 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5df46f163e1a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    2:     0x5df46f151e92 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x5df46f12b2d6 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5df46f145779 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]    5:     0x5df46f08ffec - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5df46f145932 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5df46f12b392 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5df46f1203f9 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5df46f12c0ad - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]   10:     0x5df46f16459c - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5df46f004eff - <puremagic[5a7797b07f161cc6]::scheduler::Scheduler>::sched_circuit
[INFO] [stdout]   12:     0x5df46f039f08 - puremagic[5a7797b07f161cc6]::scheduler::tests::run_scheduler
[INFO] [stdout]   13:     0x5df46f03a6f3 - puremagic[5a7797b07f161cc6]::scheduler::tests::lcycle_count_bounded_by_t_gate_failure_overhead
[INFO] [stdout]   14:     0x5df46f0198d9 - <puremagic[5a7797b07f161cc6]::scheduler::tests::lcycle_count_bounded_by_t_gate_failure_overhead::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   15:     0x5df46f0830cb - test[213991da798b1c03]::__rust_begin_short_backtrace::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]   16:     0x5df46f090945 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]   17:     0x5df46f08a254 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]   18:     0x5df46f0939c2 - <std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   19:     0x5df46f14cdff - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   20:     0x7cc48cac5aa4 - <unknown>
[INFO] [stdout]   21:     0x7cc48cb52a64 - clone
[INFO] [stdout]   22:                0x0 - <unknown>
[INFO] [stdout] Timing: Scheduler::sched_circuit took 0.00 s
[INFO] [stdout] Accumulated timings (ms):
[INFO] [stdout]   schedule loop             total:    1.99 μs  avg:    0.99 μs  max:    1.18 μs  calls: 2
[INFO] [stdout]   other                     total:    1.48 μs  avg:    0.49 μs  max:    0.63 μs  calls: 3
[INFO] [stdout] 
[INFO] [stdout] ---- scheduler::tests::t_gate_failures_deterministic_with_fixed_seed stdout ----
[INFO] [stdout] Loaded circuit with 4 products and 4 qubits
[INFO] [stdout] Timing: Circuit::load_circuit took 0.00 s
[INFO] [stdout] Generated topology with dimensions: 5 4
[INFO] [stdout] Number of qubits:
[INFO] [stdout]   data:         4 (0.200)
[INFO] [stdout]   bus:          0 (0.000)
[INFO] [stdout]   magic:        16 (0.800)
[INFO] [stdout]   total:        20
[INFO] [stdout] Precomputed terminals and root candidates for 4 products
[INFO] [stdout] Timing: precompute_terminals_and_roots took 0.00 s
[INFO] [stdout] Precomputed 0 multi-term Clifford trees
[INFO] [stdout] Timing: precompute_clifford_trees took 0.00 s
[INFO] [stdout] 25%50%75%100%
[INFO] [stdout] Qubit fractions used:
[INFO] [stdout]   data:        0.107
[INFO] [stdout]   bus:         NaN
[INFO] [stdout]   magic:       0.000
[INFO] [stdout] Magic unused 0.018
[INFO] [stdout] Magic state cultivation time:
[INFO] [stdout]   number:  5
[INFO] [stdout]   average: 3.40
[INFO] [stdout]   min:     1
[INFO] [stdout]   max:     7
[INFO] [stdout] T gate failures: 3/4 (75.0%)
[INFO] [stdout] Steiner tree computation called 0 times
[INFO] [stdout] A* computation called 4 times
[INFO] [stdout] Warning: could not write cultivation dist: Read-only file system (os error 30)
[INFO] [stdout] Clifford repetition check passed (0 CX, 0 S/SX products)
[INFO] [stdout] Schedule check passed: all 4 products scheduled
[INFO] [stdout] Timing: Scheduler::sched_circuit took 0.00 s
[INFO] [stdout] Loaded circuit with 4 products and 4 qubits
[INFO] [stdout] Timing: Circuit::load_circuit took 0.00 s
[INFO] [stdout] Generated topology with dimensions: 5 4
[INFO] [stdout] Number of qubits:
[INFO] [stdout]   data:         4 (0.200)
[INFO] [stdout]   bus:          0 (0.000)
[INFO] [stdout]   magic:        16 (0.800)
[INFO] [stdout]   total:        20
[INFO] [stdout] Precomputed terminals and root candidates for 4 products
[INFO] [stdout] Timing: precompute_terminals_and_roots took 0.00 s
[INFO] [stdout] Precomputed 0 multi-term Clifford trees
[INFO] [stdout] Timing: precompute_clifford_trees took 0.00 s
[INFO] [stdout] 
[INFO] [stdout] thread 'scheduler::tests::t_gate_failures_deterministic_with_fixed_seed' (4330) panicked at src/scheduler.rs:665:17:
[INFO] [stdout] lcycle 3: Cannot schedule products [0X<T>, 1X<T>, 2X<T>, 3X<T>] on current layout (1 magic)
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5df46f14d498 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x5df46f163e1a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    2:     0x5df46f151e92 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]    3:     0x5df46f12b2d6 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x5df46f145779 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]    5:     0x5df46f08ffec - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x5df46f145932 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x5df46f12b392 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x5df46f1203f9 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x5df46f12c0ad - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]   10:     0x5df46f16459c - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]   11:     0x5df46f004eff - <puremagic[5a7797b07f161cc6]::scheduler::Scheduler>::sched_circuit
[INFO] [stdout]   12:     0x5df46f039f08 - puremagic[5a7797b07f161cc6]::scheduler::tests::run_scheduler
[INFO] [stdout]   13:     0x5df46f03a54d - puremagic[5a7797b07f161cc6]::scheduler::tests::t_gate_failures_deterministic_with_fixed_seed
[INFO] [stdout]   14:     0x5df46f019899 - <puremagic[5a7797b07f161cc6]::scheduler::tests::t_gate_failures_deterministic_with_fixed_seed::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   15:     0x5df46f0830cb - test[213991da798b1c03]::__rust_begin_short_backtrace::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]   16:     0x5df46f090945 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]   17:     0x5df46f08a254 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]   18:     0x5df46f0939c2 - <std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   19:     0x5df46f14cdff - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   20:     0x7cc48cac5aa4 - <unknown>
[INFO] [stdout]   21:     0x7cc48cb52a64 - clone
[INFO] [stdout]   22:                0x0 - <unknown>
[INFO] [stdout] Timing: Scheduler::sched_circuit took 0.00 s
[INFO] [stdout] Accumulated timings (ms):
[INFO] [stdout]   schedule loop             total:    2.64 μs  avg:    1.32 μs  max:    1.83 μs  calls: 2
[INFO] [stdout]   other                     total:    1.98 μs  avg:    0.66 μs  max:    0.99 μs  calls: 3
[INFO] [stdout] Accumulated timings (ms):
[INFO] [stdout]   schedule loop             total:   23.66 μs  avg:    3.38 μs  max:    6.57 μs  calls: 7
[INFO] [stdout]   other                     total:   10.38 μs  avg:    1.48 μs  max:    6.04 μs  calls: 7
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     scheduler::tests::lcycle_count_bounded_by_t_gate_failure_overhead
[INFO] [stdout]     scheduler::tests::t_gate_failures_deterministic_with_fixed_seed
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 193 passed; 2 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--bin puremagic`
[INFO] running `Command { std: "docker" "inspect" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5", kill_on_drop: false }`
[INFO] [stdout] 9da616d72025c47f217fa56c0f32b9cea6e249d2282a029759485b3e736e44f5
