[INFO] cloning repository https://github.com/kotabrog/Rust_DeZero
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/kotabrog/Rust_DeZero" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkotabrog%2FRust_DeZero", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkotabrog%2FRust_DeZero'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] af149e28950346c831d1417927ad3efaa8b6e398
[INFO] testing kotabrog/Rust_DeZero against 1.97.0-beta.6 for beta-1.98-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fkotabrog%2FRust_DeZero" "/workspace/builds/worker-2-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-2-tc1/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/kotabrog/Rust_DeZero
[INFO] finished tweaking git repo https://github.com/kotabrog/Rust_DeZero
[INFO] tweaked toml for git repo https://github.com/kotabrog/Rust_DeZero written to /workspace/builds/worker-2-tc1/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/kotabrog/Rust_DeZero 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/kotabrog/Rust_DeZero 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] warning: virtual workspace defaulting to `resolver = "1"` despite one or more workspace members being on edition 2021 which implies `resolver = "2"`
[INFO] [stderr]   |
[INFO] [stderr]   = note: to keep the current resolver, specify `workspace.resolver = "1"` in the workspace root's manifest
[INFO] [stderr]   = note: to use the edition 2021 resolver, specify `workspace.resolver = "2"` in the workspace root's manifest
[INFO] [stderr]   = note: for more details see https://doc.rust-lang.org/cargo/reference/resolver.html#resolver-versions
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded plotters-backend v0.3.5
[INFO] [stderr]   Downloaded plotters-svg v0.3.5
[INFO] [stderr]   Downloaded float-ord v0.2.0
[INFO] [stderr]   Downloaded yeslogic-fontconfig-sys v3.2.0
[INFO] [stderr]   Downloaded const-cstr v0.3.0
[INFO] [stderr]   Downloaded plotters-bitmap v0.3.3
[INFO] [stderr]   Downloaded pathfinder_geometry v0.5.1
[INFO] [stderr]   Downloaded core-graphics-types v0.1.2
[INFO] [stderr]   Downloaded pathfinder_simd v0.5.1
[INFO] [stderr]   Downloaded freetype v0.7.0
[INFO] [stderr]   Downloaded syn v2.0.22
[INFO] [stderr]   Downloaded font-kit v0.11.0
[INFO] [stderr]   Downloaded pest v2.7.0
[INFO] [stderr]   Downloaded plotters v0.3.5
[INFO] [stderr]   Downloaded ttf-parser v0.17.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2-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] 666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e
[INFO] running `Command { std: "docker" "start" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e", 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" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e" "/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" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e", 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" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] warning: virtual workspace defaulting to `resolver = "1"` despite one or more workspace members being on edition 2021 which implies `resolver = "2"`
[INFO] [stderr]   |
[INFO] [stderr]   = note: to keep the current resolver, specify `workspace.resolver = "1"` in the workspace root's manifest
[INFO] [stderr]   = note: to use the edition 2021 resolver, specify `workspace.resolver = "2"` in the workspace root's manifest
[INFO] [stderr]   = note: for more details see https://doc.rust-lang.org/cargo/reference/resolver.html#resolver-versions
[INFO] [stderr]    Compiling libc v0.2.146
[INFO] [stderr]    Compiling getrandom v0.2.10
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling ktensor v0.1.0 (/opt/rustwide/workdir/ktensor)
[INFO] [stderr]    Compiling kdezero v0.1.0 (/opt/rustwide/workdir/kdezero)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.22s
[INFO] running `Command { std: "docker" "inspect" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e", 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" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] warning: virtual workspace defaulting to `resolver = "1"` despite one or more workspace members being on edition 2021 which implies `resolver = "2"`
[INFO] [stderr]   |
[INFO] [stderr]   = note: to keep the current resolver, specify `workspace.resolver = "1"` in the workspace root's manifest
[INFO] [stderr]   = note: to use the edition 2021 resolver, specify `workspace.resolver = "2"` in the workspace root's manifest
[INFO] [stderr]   = note: for more details see https://doc.rust-lang.org/cargo/reference/resolver.html#resolver-versions
[INFO] [stderr]    Compiling proc-macro2 v1.0.62
[INFO] [stderr]    Compiling unicode-ident v1.0.9
[INFO] [stderr]    Compiling quote v1.0.28
[INFO] [stderr]    Compiling thiserror v1.0.40
[INFO] [stderr]    Compiling pkg-config v0.3.27
[INFO] [stderr]    Compiling ucd-trie v0.1.5
[INFO] [stderr]    Compiling cc v1.0.79
[INFO] [stderr]    Compiling simd-adler32 v0.3.5
[INFO] [stderr]    Compiling libloading v0.8.0
[INFO] [stderr]    Compiling num-traits v0.2.15
[INFO] [stderr]    Compiling num-integer v0.1.45
[INFO] [stderr]    Compiling num-rational v0.4.1
[INFO] [stderr]    Compiling const-cstr v0.3.0
[INFO] [stderr]    Compiling dirs-sys-next v0.1.2
[INFO] [stderr]    Compiling bytemuck v1.13.1
[INFO] [stderr]    Compiling weezl v0.1.7
[INFO] [stderr]    Compiling once_cell v1.18.0
[INFO] [stderr]    Compiling plotters-backend v0.3.5
[INFO] [stderr]    Compiling miniz_oxide v0.7.1
[INFO] [stderr]    Compiling fdeflate v0.3.0
[INFO] [stderr]    Compiling dlib v0.5.2
[INFO] [stderr]    Compiling log v0.4.19
[INFO] [stderr]    Compiling font-kit v0.11.0
[INFO] [stderr]    Compiling jpeg-decoder v0.3.0
[INFO] [stderr]    Compiling gif v0.12.0
[INFO] [stderr]    Compiling dirs-next v2.0.0
[INFO] [stderr]    Compiling walkdir v2.3.3
[INFO] [stderr]    Compiling time v0.1.45
[INFO] [stderr]    Compiling float-ord v0.2.0
[INFO] [stderr]    Compiling iana-time-zone v0.1.57
[INFO] [stderr]    Compiling plotters-svg v0.3.5
[INFO] [stderr]    Compiling ttf-parser v0.17.1
[INFO] [stderr]    Compiling cmake v0.1.50
[INFO] [stderr]    Compiling flate2 v1.0.26
[INFO] [stderr]    Compiling yeslogic-fontconfig-sys v3.2.0
[INFO] [stderr]    Compiling freetype-sys v0.13.1
[INFO] [stderr]    Compiling png v0.17.9
[INFO] [stderr]    Compiling syn v2.0.22
[INFO] [stderr]    Compiling chrono v0.4.26
[INFO] [stderr]    Compiling freetype v0.7.0
[INFO] [stderr]    Compiling image v0.24.6
[INFO] [stderr]    Compiling plotters-bitmap v0.3.3
[INFO] [stderr]    Compiling thiserror-impl v1.0.40
[INFO] [stderr]    Compiling pest v2.7.0
[INFO] [stderr]    Compiling semver-parser v0.10.2
[INFO] [stderr]    Compiling semver v0.11.0
[INFO] [stderr]    Compiling rustc_version v0.3.3
[INFO] [stderr]    Compiling pathfinder_simd v0.5.1
[INFO] [stderr]    Compiling pathfinder_geometry v0.5.1
[INFO] [stderr]    Compiling plotters v0.3.5
[INFO] [stderr]    Compiling kdezero v0.1.0 (/opt/rustwide/workdir/kdezero)
[INFO] [stderr]    Compiling ktensor v0.1.0 (/opt/rustwide/workdir/ktensor)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 16.44s
[INFO] running `Command { std: "docker" "inspect" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e", 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" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e" "/opt/rustwide/cargo-home/bin/cargo" "+1.97.0-beta.6" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] warning: virtual workspace defaulting to `resolver = "1"` despite one or more workspace members being on edition 2021 which implies `resolver = "2"`
[INFO] [stderr]   |
[INFO] [stderr]   = note: to keep the current resolver, specify `workspace.resolver = "1"` in the workspace root's manifest
[INFO] [stderr]   = note: to use the edition 2021 resolver, specify `workspace.resolver = "2"` in the workspace root's manifest
[INFO] [stderr]   = note: for more details see https://doc.rust-lang.org/cargo/reference/resolver.html#resolver-versions
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kdezero-24829bacc4abcdfb)
[INFO] [stdout] 
[INFO] [stdout] running 66 tests
[INFO] [stdout] test function::function::linear::tests::backward_normal ... ok
[INFO] [stdout] test function::function::linear::tests::forward_add_b ... ok
[INFO] [stdout] test function::function::linear::tests::forward_normal ... ok
[INFO] [stdout] test function::function::sigmoid::tests::forward_normal ... ok
[INFO] [stdout] test function::function::sigmoid::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::add::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::broadcast_to::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::cos::tests::backward_backward_normal ... ok
[INFO] [stdout] test function::operator::cos::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::div::tests::backward_x_2 ... ok
[INFO] [stdout] test function::operator::exp::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::exp::tests::backward_backward_normal ... ok
[INFO] [stdout] test function::operator::exp::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::add::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::div::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::matmul::tests::backward_backward_x_2 ... ok
[INFO] [stdout] test function::operator::div::tests::backward_backward_x_2 ... ok
[INFO] [stdout] test function::operator::mean_squared_error::tests::backward_backward_x_2 ... ok
[INFO] [stdout] test function::operator::mean_squared_error::tests::backward_backward_x_y ... ok
[INFO] [stdout] test function::operator::broadcast_to::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::matmul::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::mean_squared_error::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::mean_squared_error::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::cos::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::mul::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::mul::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::div::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::neg::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::mul::tests::backward_backward_x_2 ... ok
[INFO] [stdout] test function::operator::pow::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::neg::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::pow::tests::backward_backward_normal ... ok
[INFO] [stdout] test function::operator::matmul::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::pow::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::reshape::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::reshape::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::sin::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::square::tests::backward_backward_normal ... ok
[INFO] [stdout] test function::operator::sin::tests::backward_backward_normal ... ok
[INFO] [stdout] test function::operator::square::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::square::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::sin::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::sub::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::sub::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::sum::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::sum::tests::backward_reshape ... ok
[INFO] [stdout] test function::operator::sum_to::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::sum_to::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::tanh::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::transpose::tests::backward_normal ... ok
[INFO] [stdout] test function::operator::sum::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::tanh::tests::forward_normal ... ok
[INFO] [stdout] test function::operator::transpose::tests::forward_normal ... ok
[INFO] [stdout] test variable::tests::new_normal ... ok
[INFO] [stdout] test variable::variable_table::tests::generate_variable_from_f64_tensor_normal ... ok
[INFO] [stdout] test function::operator::add::tests::backward_backward_normal - should panic ... ok
[INFO] [stdout] test function::operator::broadcast_to::tests::backward_backward_normal - should panic ... ok
[INFO] [stdout] test function::operator::div::tests::backward_backward_x_y - should panic ... ok
[INFO] [stdout] test function::operator::matmul::tests::backward_backward_x_y - should panic ... ok
[INFO] [stdout] test function::operator::mul::tests::backward_backward_x_y - should panic ... ok
[INFO] [stdout] test function::operator::neg::tests::backward_backward_normal - should panic ... ok
[INFO] [stdout] test function::operator::reshape::tests::backward_backward_normal - should panic ... ok
[INFO] [stdout] test function::operator::sub::tests::backward_backward_normal - should panic ... ok
[INFO] [stdout] test function::operator::sum_to::tests::backward_backward_normal - should panic ... ok
[INFO] [stdout] test function::operator::sum::tests::backward_backward_normal - should panic ... ok
[INFO] [stdout] test function::operator::transpose::tests::backward_backward_normal - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 66 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/step_test.rs (/opt/rustwide/target/debug/deps/step_test-ed40c405a4cb7b8a)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test step1 ... ok
[INFO] [stdout] test step11 ... ok
[INFO] [stdout] test step13 ... ok
[INFO] [stdout] test step16 ... ok
[INFO] [stdout] test step18_1 ... ok
[INFO] [stdout] test step14 ... ok
[INFO] [stdout] test step18_2 ... ok
[INFO] [stdout] test step2 ... ok
[INFO] [stdout] test step19 ... ok
[INFO] [stdout] test step3 ... ok
[INFO] [stdout] test step27 ... ok
[INFO] [stdout] test step4 ... ok
[INFO] [stdout] test step36 ... ok
[INFO] [stdout] test step7 ... ok
[INFO] [stdout] test step20 ... ok
[INFO] [stdout] test step33 ... ok
[INFO] [stdout] test step26 ... FAILED
[INFO] [stdout] test step35 ... FAILED
[INFO] [stdout] test step42 ... FAILED
[INFO] [stdout] test step43 ... FAILED
[INFO] [stderr] error: test failed, to rerun pass `-p kdezero --test step_test`
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- step26 stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'step26' (1342) panicked at kdezero/src/variable/variable_table.rs:362:52:
[INFO] [stdout] Failed to create file: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5d15f52a83a8 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5d15f52bd83a - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5d15f52bd83a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x5d15f52acd22 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5d15f52acd22 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5d15f5286646 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5d15f5286646 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5d15f52a08f9 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5d15f51d153c - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x5d15f51d153c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5d15f52a0ab2 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x5d15f52a0ab2 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5d15f5286702 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5d15f527b7f9 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5d15f528741d - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5d15f52bdfec - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5d15f52bdd32 - core[8fb95b77d25ab6c8]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5d15f522015e - <core[8fb95b77d25ab6c8]::result::Result<std[10d71ac2c42b111e]::fs::File, std[10d71ac2c42b111e]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5d15f5209891 - <kdezero[7d2b18222edca255]::variable::variable_table::VariableTable>::plot_dot_graph
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/src/variable/variable_table.rs:362:52
[INFO] [stdout]   22:     0x5d15f5074175 - step_test[84b7108232e31243]::step26
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/tests/step_test.rs:431:20
[INFO] [stdout]   23:     0x5d15f506a427 - step_test[84b7108232e31243]::step26::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/tests/step_test.rs:401:12
[INFO] [stdout]   24:     0x5d15f50d5826 - <step_test[84b7108232e31243]::step26::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5d15f51c461b - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5d15f51c461b - 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]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   27:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   28:     0x5d15f51d1e95 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   33:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   34:     0x5d15f51cb7a4 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   35:     0x5d15f51cb7a4 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x5d15f51d4f12 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x5d15f51d4f12 - <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]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5d15f52a7d0f - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   44:     0x5d15f52a7d0f - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7b5f8ea4eaa4 - <unknown>
[INFO] [stdout]   46:     0x7b5f8eadba64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- step35 stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'step35' (1346) panicked at kdezero/src/variable/variable_table.rs:362:52:
[INFO] [stdout] Failed to create file: Os { code: 2, kind: NotFound, message: "No such file or directory" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5d15f52a83a8 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5d15f52bd83a - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5d15f52bd83a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x5d15f52acd22 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5d15f52acd22 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5d15f5286646 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5d15f5286646 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5d15f52a08f9 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5d15f51d153c - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x5d15f51d153c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5d15f52a0ab2 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x5d15f52a0ab2 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5d15f5286702 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5d15f527b7f9 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5d15f528741d - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5d15f52bdfec - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5d15f52bdd32 - core[8fb95b77d25ab6c8]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5d15f522015e - <core[8fb95b77d25ab6c8]::result::Result<std[10d71ac2c42b111e]::fs::File, std[10d71ac2c42b111e]::io::error::Error>>::expect
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5d15f5209891 - <kdezero[7d2b18222edca255]::variable::variable_table::VariableTable>::plot_dot_graph
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/src/variable/variable_table.rs:362:52
[INFO] [stdout]   22:     0x5d15f50763dd - step_test[84b7108232e31243]::step35
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/tests/step_test.rs:552:20
[INFO] [stdout]   23:     0x5d15f506a4b7 - step_test[84b7108232e31243]::step35::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/tests/step_test.rs:517:12
[INFO] [stdout]   24:     0x5d15f50d58e6 - <step_test[84b7108232e31243]::step35::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5d15f51c461b - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   26:     0x5d15f51c461b - 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]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   27:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   28:     0x5d15f51d1e95 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   29:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   30:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   31:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   32:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   33:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   34:     0x5d15f51cb7a4 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   35:     0x5d15f51cb7a4 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   36:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   37:     0x5d15f51d4f12 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   38:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   39:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   40:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   41:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   42:     0x5d15f51d4f12 - <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]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x5d15f52a7d0f - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   44:     0x5d15f52a7d0f - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   45:     0x7b5f8ea4eaa4 - <unknown>
[INFO] [stdout]   46:     0x7b5f8eadba64 - clone
[INFO] [stdout]   47:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- step42 stdout ----
[INFO] [stdout] iter 0 w: Tensor { data: [Scaler { data: 0.7499527166090297 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 1.322578046699788 }], shape: [] }, loss: Tensor { data: [Scaler { data: 44.17055636084619 }], shape: [] }
[INFO] [stdout] iter 10 w: Tensor { data: [Scaler { data: 2.6738554464768174 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 4.908410061908846 }], shape: [] }, loss: Tensor { data: [Scaler { data: 0.23333358775003085 }], shape: [] }
[INFO] [stdout] iter 20 w: Tensor { data: [Scaler { data: 2.6701833283142276 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 5.13415521813709 }], shape: [] }, loss: Tensor { data: [Scaler { data: 0.120104913914657 }], shape: [] }
[INFO] [stdout] iter 30 w: Tensor { data: [Scaler { data: 2.587194917057982 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 5.192896394545298 }], shape: [] }, loss: Tensor { data: [Scaler { data: 0.10939373001594585 }], shape: [] }
[INFO] [stdout] iter 40 w: Tensor { data: [Scaler { data: 2.511198983267513 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 5.237453435449118 }], shape: [] }, loss: Tensor { data: [Scaler { data: 0.10145602504667942 }], shape: [] }
[INFO] [stdout] iter 50 w: Tensor { data: [Scaler { data: 2.444901589058945 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 5.275906809540488 }], shape: [] }, loss: Tensor { data: [Scaler { data: 0.09544829027063298 }], shape: [] }
[INFO] [stdout] iter 60 w: Tensor { data: [Scaler { data: 2.3872139326978226 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 5.309346623188036 }], shape: [] }, loss: Tensor { data: [Scaler { data: 0.09090098383852706 }], shape: [] }
[INFO] [stdout] iter 70 w: Tensor { data: [Scaler { data: 2.3370249714951528 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 5.338438725347694 }], shape: [] }, loss: Tensor { data: [Scaler { data: 0.08745908760027689 }], shape: [] }
[INFO] [stdout] iter 80 w: Tensor { data: [Scaler { data: 2.2933603020801607 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 5.363748967780793 }], shape: [] }, loss: Tensor { data: [Scaler { data: 0.08485388605986972 }], shape: [] }
[INFO] [stdout] iter 90 w: Tensor { data: [Scaler { data: 2.255371818012844 }], shape: [1, 1] }, b: Tensor { data: [Scaler { data: 5.3857690050618485 }], shape: [] }, loss: Tensor { data: [Scaler { data: 0.08288198609649308 }], shape: [] }
[INFO] [stdout] 
[INFO] [stdout] thread 'step42' (1349) panicked at kdezero/tests/step_test.rs:710:65:
[INFO] [stdout] Failed to plot: BackendError(DrawingError(ImageError(IoError(Os { code: 2, kind: NotFound, message: "No such file or directory" }))))
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5d15f52a83a8 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5d15f52bd83a - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5d15f52bd83a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x5d15f52acd22 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5d15f52acd22 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5d15f5286646 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5d15f5286646 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5d15f52a08f9 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5d15f51d153c - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x5d15f51d153c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5d15f52a0ab2 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x5d15f52a0ab2 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5d15f5286702 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5d15f527b7f9 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5d15f528741d - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5d15f52bdfec - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5d15f52bdd32 - core[8fb95b77d25ab6c8]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5d15f50bed3b - <core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::error::Error>>>::expect
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5d15f50783a0 - step_test[84b7108232e31243]::step42
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/tests/step_test.rs:710:65
[INFO] [stdout]   22:     0x5d15f506a517 - step_test[84b7108232e31243]::step42::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/tests/step_test.rs:590:12
[INFO] [stdout]   23:     0x5d15f50d5966 - <step_test[84b7108232e31243]::step42::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5d15f51c461b - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5d15f51c461b - 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]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x5d15f51d1e95 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x5d15f51cb7a4 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x5d15f51cb7a4 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x5d15f51d4f12 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x5d15f51d4f12 - <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]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5d15f52a7d0f - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   43:     0x5d15f52a7d0f - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7b5f8ea4eaa4 - <unknown>
[INFO] [stdout]   45:     0x7b5f8eadba64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- step43 stdout ----
[INFO] [stdout] iter 0
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.6381261364098983 }, Scaler { data: 0.8230518236621251 }, Scaler { data: 0.6564440514225688 }, Scaler { data: 0.021881554573041084 }, Scaler { data: 0.8347632179197378 }, Scaler { data: 0.04880388841806982 }, Scaler { data: 0.1602232050855731 }, Scaler { data: 0.39777818797029996 }, Scaler { data: 0.49281122544527306 }, Scaler { data: -0.041555008070955295 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.29282505201028913 }, Scaler { data: -0.13409199297927307 }, Scaler { data: -0.23788827382642475 }, Scaler { data: -0.15648533422209734 }, Scaler { data: -0.13314501106642157 }, Scaler { data: -0.2547441218816823 }, Scaler { data: -0.29198233111080013 }, Scaler { data: -0.26494845343318857 }, Scaler { data: -0.08556061142649461 }, Scaler { data: -0.07752015490621658 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.2097356487033888 }, Scaler { data: -0.33677913148865724 }, Scaler { data: 0.024173068346833526 }, Scaler { data: -0.15850570980099143 }, Scaler { data: -0.3410206846365811 }, Scaler { data: 0.13882469330990965 }, Scaler { data: 0.23908605801246752 }, Scaler { data: 0.12936466106844757 }, Scaler { data: -0.45531090503011706 }, Scaler { data: -0.3878552735864462 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -1.264229728807222 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 10.920118586054492 }], shape: [] }
[INFO] [stdout] iter 10
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.5614667846667591 }, Scaler { data: 0.7771037811076973 }, Scaler { data: 0.5902085993073789 }, Scaler { data: -0.03143998929967581 }, Scaler { data: 0.789058513400144 }, Scaler { data: -0.020843667812560984 }, Scaler { data: 0.08370183741900272 }, Scaler { data: 0.3257717049011743 }, Scaler { data: 0.4538946731536486 }, Scaler { data: -0.08228161582157147 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.2861569667988459 }, Scaler { data: -0.2283351502492977 }, Scaler { data: -0.26523998180447494 }, Scaler { data: -0.21295803419848594 }, Scaler { data: -0.2281839323169034 }, Scaler { data: -0.25711579103216736 }, Scaler { data: -0.2780375931676461 }, Scaler { data: -0.2727887492661968 }, Scaler { data: -0.20056288513958107 }, Scaler { data: -0.1761270052687808 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.474475708211956 }, Scaler { data: -0.04379712266596806 }, Scaler { data: 0.30173683160192033 }, Scaler { data: 0.18164592047040062 }, Scaler { data: -0.04855309980348215 }, Scaler { data: 0.4528222184135824 }, Scaler { data: 0.5365459741667495 }, Scaler { data: 0.417534793198026 }, Scaler { data: -0.12835648749574569 }, Scaler { data: -0.023926327787168845 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -0.5361316959959375 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 0.6631040433474475 }], shape: [] }
[INFO] [stdout] iter 20
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.4933881660529286 }, Scaler { data: 0.7881800571245097 }, Scaler { data: 0.5485930206940731 }, Scaler { data: -0.06135269968012648 }, Scaler { data: 0.800885788578736 }, Scaler { data: -0.09030635418582802 }, Scaler { data: 0.0020783368091241757 }, Scaler { data: 0.2632762143590041 }, Scaler { data: 0.47491677924957715 }, Scaler { data: -0.08227592534373278 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.2763396423152104 }, Scaler { data: -0.23082884915235743 }, Scaler { data: -0.25869651657127035 }, Scaler { data: -0.2083797094225368 }, Scaler { data: -0.23089880009802896 }, Scaler { data: -0.24630976647291478 }, Scaler { data: -0.2665622216637147 }, Scaler { data: -0.2648258793674576 }, Scaler { data: -0.20384880256914423 }, Scaler { data: -0.1761354705818425 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.43297052868457053 }, Scaler { data: -0.12062837491865883 }, Scaler { data: 0.25461824280666456 }, Scaler { data: 0.22782500580201231 }, Scaler { data: -0.12712347832894838 }, Scaler { data: 0.49912563487513867 }, Scaler { data: 0.5677950290851607 }, Scaler { data: 0.41131097713952897 }, Scaler { data: -0.15802414300719853 }, Scaler { data: 0.02856476557682582 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -0.4476197123621045 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 0.6346624728314625 }], shape: [] }
[INFO] [stdout] iter 30
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.4328675915903028 }, Scaler { data: 0.809487633665626 }, Scaler { data: 0.5147496013989887 }, Scaler { data: -0.09669434828820021 }, Scaler { data: 0.8231232383522856 }, Scaler { data: -0.16354991214875053 }, Scaler { data: -0.08089504887698942 }, Scaler { data: 0.2035020451862479 }, Scaler { data: 0.49974686291500947 }, Scaler { data: -0.0894774366696824 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.26858856827969585 }, Scaler { data: -0.2354816047524597 }, Scaler { data: -0.2538876638447491 }, Scaler { data: -0.20314882845041748 }, Scaler { data: -0.23585659965299433 }, Scaler { data: -0.23468106809491904 }, Scaler { data: -0.2546995617275483 }, Scaler { data: -0.25774316244142376 }, Scaler { data: -0.20754582831703652 }, Scaler { data: -0.1750746189960716 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.3999471338792178 }, Scaler { data: -0.19960130319144379 }, Scaler { data: 0.21222080523716888 }, Scaler { data: 0.27452600450320636 }, Scaler { data: -0.20789319999761158 }, Scaler { data: 0.5515637724246751 }, Scaler { data: 0.6074062721313067 }, Scaler { data: 0.4118475295518265 }, Scaler { data: -0.19257867682652507 }, Scaler { data: 0.07707753511534242 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -0.3679593917347129 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 0.6066361217450223 }], shape: [] }
[INFO] [stdout] iter 40
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.3787331236046553 }, Scaler { data: 0.840343262026243 }, Scaler { data: 0.4877754780525154 }, Scaler { data: -0.13688807937747383 }, Scaler { data: 0.8550680799635835 }, Scaler { data: -0.24039417022051734 }, Scaler { data: -0.16544560083431112 }, Scaler { data: 0.14577093511423683 }, Scaler { data: 0.5285532752548991 }, Scaler { data: -0.10284869921924938 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.26229563135839834 }, Scaler { data: -0.24214460178751662 }, Scaler { data: -0.2503670016308855 }, Scaler { data: -0.197265919306523 }, Scaler { data: -0.24291138370997856 }, Scaler { data: -0.22185389345424858 }, Scaler { data: -0.24197145804326142 }, Scaler { data: -0.251208753919516 }, Scaler { data: -0.21170365908361077 }, Scaler { data: -0.17318447507057047 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.3745116951061622 }, Scaler { data: -0.2808755244121493 }, Scaler { data: 0.17394930265954756 }, Scaler { data: 0.3226469678060953 }, Scaler { data: -0.2910272476169846 }, Scaler { data: 0.6102933524679561 }, Scaler { data: 0.65512333382836 }, Scaler { data: 0.41879193510586427 }, Scaler { data: -0.23143122420547196 }, Scaler { data: 0.12308628677206174 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -0.29579400121696225 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 0.5778210205555611 }], shape: [] }
[INFO] [stdout] iter 50
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.3300484266884377 }, Scaler { data: 0.8798049307611967 }, Scaler { data: 0.4668552786466768 }, Scaler { data: -0.18126945992955842 }, Scaler { data: 0.8957522089794158 }, Scaler { data: -0.320309770598852 }, Scaler { data: -0.25137735276671935 }, Scaler { data: 0.08967013135701805 }, Scaler { data: 0.5612237390300677 }, Scaler { data: -0.12145427976813894 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.25703977924694943 }, Scaler { data: -0.2507421962836126 }, Scaler { data: -0.24781698622840692 }, Scaler { data: -0.19069678476686266 }, Scaler { data: -0.2519915174161267 }, Scaler { data: -0.20747038246003646 }, Scaler { data: -0.227950551466678 }, Scaler { data: -0.24497393621082578 }, Scaler { data: -0.21635874632331442 }, Scaler { data: -0.17061798959412888 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.3558808002351812 }, Scaler { data: -0.36424804992635385 }, Scaler { data: 0.13936857563276714 }, Scaler { data: 0.37265952777767175 }, Scaler { data: -0.37631763418877806 }, Scaler { data: 0.6750356966303828 }, Scaler { data: 0.7103489835364024 }, Scaler { data: 0.4316974295374919 }, Scaler { data: -0.2739204177879337 }, Scaler { data: 0.1676089338377794 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -0.23012092956386537 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 0.5475230368287165 }], shape: [] }
[INFO] [stdout] iter 60
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.28608759600694494 }, Scaler { data: 0.9265890868352205 }, Scaler { data: 0.4512129863635165 }, Scaler { data: -0.22900086907545314 }, Scaler { data: 0.9438591658569957 }, Scaler { data: -0.40237126804082374 }, Scaler { data: -0.338045821518679 }, Scaler { data: 0.03506325841659277 }, Scaler { data: 0.5973327940759378 }, Scaler { data: -0.14436127023659465 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.25252701421113627 }, Scaler { data: -0.26121496003785344 }, Scaler { data: -0.24600618392744303 }, Scaler { data: -0.1833998070367147 }, Scaler { data: -0.26303963497859384 }, Scaler { data: -0.19124166862731626 }, Scaler { data: -0.21229696982610208 }, Scaler { data: -0.23885347432900325 }, Scaler { data: -0.22153013195401977 }, Scaler { data: -0.16747809795923457 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.3433191911383479 }, Scaler { data: -0.44908938610742105 }, Scaler { data: 0.1081852458046347 }, Scaler { data: 0.4246063695120653 }, Scaler { data: -0.4631190399878764 }, Scaler { data: 0.7450249836364944 }, Scaler { data: 0.7720714711854537 }, Scaler { data: 0.44996194990508953 }, Scaler { data: -0.3192250689461326 }, Scaler { data: 0.21125257060241112 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -0.1702011102017881 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 0.5155932172115139 }], shape: [] }
[INFO] [stdout] iter 70
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.24631659121551394 }, Scaler { data: 0.9790490285698771 }, Scaler { data: 0.440082282636335 }, Scaler { data: -0.2790264069042815 }, Scaler { data: 0.9977040293558648 }, Scaler { data: -0.4852692268161042 }, Scaler { data: -0.42438432928532505 }, Scaler { data: -0.017909399480013792 }, Scaler { data: 0.636135701429323 }, Scaler { data: -0.1705723807514944 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.24855684025811023 }, Scaler { data: -0.2734536967093138 }, Scaler { data: -0.244762924997586 }, Scaler { data: -0.17536093288052199 }, Scaler { data: -0.2759430897914429 }, Scaler { data: -0.1730282647248541 }, Scaler { data: -0.19482878677626397 }, Scaler { data: -0.23272451318327966 }, Scaler { data: -0.227205521783794 }, Scaler { data: -0.16384732394606677 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.33606560072628366 }, Scaler { data: -0.5343531118564576 }, Scaler { data: 0.08020099336402266 }, Scaler { data: 0.4780811287037371 }, Scaler { data: -0.5503591077031963 }, Scaler { data: 0.8189741875173421 }, Scaler { data: 0.8388147771664063 }, Scaler { data: 0.47276164998268366 }, Scaler { data: -0.36634477968736406 }, Scaler { data: 0.25421937221348695 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -0.11554650001954864 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 0.48245526287696167 }], shape: [] }
[INFO] [stdout] iter 80
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.21037477371705526 }, Scaler { data: 1.0352324343375636 }, Scaler { data: 0.432697832685113 }, Scaler { data: -0.33008098294201615 }, Scaler { data: 1.055294030155823 }, Scaler { data: -0.5673938218176001 }, Scaler { data: -0.5089958793383889 }, Scaler { data: -0.06885547570342228 }, Scaler { data: 0.6766059150679614 }, Scaler { data: -0.19899971358220286 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.244999408493023 }, Scaler { data: -0.2872352389147633 }, Scaler { data: -0.24395614009338445 }, Scaler { data: -0.16662942940014197 }, Scaler { data: -0.29046668989391916 }, Scaler { data: -0.152921384434616 }, Scaler { data: -0.1755960319209392 }, Scaler { data: -0.22653118625979637 }, Scaler { data: -0.23332425770391557 }, Scaler { data: -0.159812196901744 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.33329077391843004 }, Scaler { data: -0.6186403152138639 }, Scaler { data: 0.055273300112769 }, Scaler { data: 0.5322546225499103 }, Scaler { data: -0.636605063448828 }, Scaler { data: 0.8951217841456115 }, Scaler { data: 0.9086733285688994 }, Scaler { data: 0.49903229267410953 }, Scaler { data: -0.41411964904324317 }, Scaler { data: 0.2963341173317863 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -0.06589188818674721 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 0.4490575225785648 }], shape: [] }
[INFO] [stdout] iter 90
[INFO] [stdout] w1: Tensor { data: [Scaler { data: 0.17804694437012256 }, Scaler { data: 1.0930185859917565 }, Scaler { data: 0.4283053208797802 }, Scaler { data: -0.38076176241133136 }, Scaler { data: 1.11446972422924 }, Scaler { data: -0.646987909655898 }, Scaler { data: -0.5903103811333326 }, Scaler { data: -0.11719265795994917 }, Scaler { data: 0.7175239559773162 }, Scaler { data: -0.22848615996428437 }], shape: [1, 10] }
[INFO] [stdout] b1: Tensor { data: [Scaler { data: -0.24177820266168656 }, Scaler { data: -0.3021804214501797 }, Scaler { data: -0.24348168532113829 }, Scaler { data: -0.15734442670209606 }, Scaler { data: -0.3062093932467013 }, Scaler { data: -0.1312923322245792 }, Scaler { data: -0.15492596439172723 }, Scaler { data: -0.2202879024605032 }, Scaler { data: -0.23976493158618867 }, Scaler { data: -0.15548026128765424 }], shape: [10] }
[INFO] [stdout] w2: Tensor { data: [Scaler { data: 0.33409577465946105 }, Scaler { data: -0.7003264315976715 }, Scaler { data: 0.033285264689618684 }, Scaler { data: 0.5859689335622039 }, Scaler { data: -0.7201941594326927 }, Scaler { data: 0.971374542159664 }, Scaler { data: 0.9794445489733511 }, Scaler { data: 0.5275131582804705 }, Scaler { data: -0.46129186874083855 }, Scaler { data: 0.33711476117023753 }], shape: [10, 1] }
[INFO] [stdout] b2: Tensor { data: [Scaler { data: -0.021136566962504537 }], shape: [1] }
[INFO] [stdout] loss: Tensor { data: [Scaler { data: 0.4167076240444883 }], shape: [] }
[INFO] [stdout] 
[INFO] [stdout] thread 'step43' (1350) panicked at kdezero/tests/step_test.rs:846:59:
[INFO] [stdout] Failed to plot: BackendError(DrawingError(ImageError(IoError(Os { code: 2, kind: NotFound, message: "No such file or directory" }))))
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::libunwind::trace
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/libunwind.rs:117:9
[INFO] [stdout]    1:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::backtrace_rs::backtrace::trace_unsynchronized::<std[10d71ac2c42b111e]::sys::backtrace::_print_fmt::{closure#1}>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/../../backtrace/src/backtrace/mod.rs:66:14
[INFO] [stdout]    2:     0x5d15f52a83a8 - std[10d71ac2c42b111e]::sys::backtrace::_print_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:74:9
[INFO] [stdout]    3:     0x5d15f52a83a8 - <<std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[8fb95b77d25ab6c8]::fmt::Display>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:44:26
[INFO] [stdout]    4:     0x5d15f52bd83a - <core[8fb95b77d25ab6c8]::fmt::rt::Argument>::fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/fmt/rt.rs:152:76
[INFO] [stdout]    5:     0x5d15f52bd83a - core[8fb95b77d25ab6c8]::fmt::write
[INFO] [stdout]    6:     0x5d15f52acd22 - std[10d71ac2c42b111e]::io::default_write_fmt::<alloc[a7ee25936407c584]::vec::Vec<u8>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:622:11
[INFO] [stdout]    7:     0x5d15f52acd22 - <alloc[a7ee25936407c584]::vec::Vec<u8> as std[10d71ac2c42b111e]::io::Write>::write_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/io/mod.rs:1977:13
[INFO] [stdout]    8:     0x5d15f5286646 - <std[10d71ac2c42b111e]::sys::backtrace::BacktraceLock>::print
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:47:9
[INFO] [stdout]    9:     0x5d15f5286646 - std[10d71ac2c42b111e]::panicking::default_hook::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:292:27
[INFO] [stdout]   10:     0x5d15f52a08f9 - std[10d71ac2c42b111e]::panicking::default_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:316:9
[INFO] [stdout]   11:     0x5d15f51d153c - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   12:     0x5d15f51d153c - test[213991da798b1c03]::test_main_inner::<test[213991da798b1c03]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:155:21
[INFO] [stdout]   13:     0x5d15f52a0ab2 - <alloc[a7ee25936407c584]::boxed::Box<dyn for<'a, 'b> core[8fb95b77d25ab6c8]::ops::function::Fn<(&'a std[10d71ac2c42b111e]::panic::PanicHookInfo<'b>,), Output = ()> + core[8fb95b77d25ab6c8]::marker::Sync + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::Fn<(&std[10d71ac2c42b111e]::panic::PanicHookInfo,)>>::call
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2289:9
[INFO] [stdout]   14:     0x5d15f52a0ab2 - std[10d71ac2c42b111e]::panicking::panic_with_hook
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:833:13
[INFO] [stdout]   15:     0x5d15f5286702 - std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:698:13
[INFO] [stdout]   16:     0x5d15f527b7f9 - std[10d71ac2c42b111e]::sys::backtrace::__rust_end_short_backtrace::<std[10d71ac2c42b111e]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:182:18
[INFO] [stdout]   17:     0x5d15f528741d - __rustc[3be9ba60078d4c86]::rust_begin_unwind
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:689:5
[INFO] [stdout]   18:     0x5d15f52bdfec - core[8fb95b77d25ab6c8]::panicking::panic_fmt
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panicking.rs:80:14
[INFO] [stdout]   19:     0x5d15f52bdd32 - core[8fb95b77d25ab6c8]::result::unwrap_failed
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1867:5
[INFO] [stdout]   20:     0x5d15f50bed3b - <core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::error::Error>>>::expect
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/result.rs:1185:23
[INFO] [stdout]   21:     0x5d15f507a2cd - step_test[84b7108232e31243]::step43
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/tests/step_test.rs:846:59
[INFO] [stdout]   22:     0x5d15f506a547 - step_test[84b7108232e31243]::step43::{closure#0}
[INFO] [stdout]                                at /opt/rustwide/workdir/kdezero/tests/step_test.rs:714:12
[INFO] [stdout]   23:     0x5d15f50d59a6 - <step_test[84b7108232e31243]::step43::{closure#0} as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x5d15f51c461b - <fn() -> core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   25:     0x5d15f51c461b - 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]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:724:18
[INFO] [stdout]   26:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test_in_process::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:74
[INFO] [stdout]   27:     0x5d15f51d1e95 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   28:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   29:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panicking::catch_unwind::<core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>, core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   30:     0x5d15f51d1e95 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<test[213991da798b1c03]::run_test_in_process::{closure#0}>, core[8fb95b77d25ab6c8]::result::Result<(), alloc[a7ee25936407c584]::string::String>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   31:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test_in_process
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:747:27
[INFO] [stdout]   32:     0x5d15f51d1e95 - test[213991da798b1c03]::run_test::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:668:43
[INFO] [stdout]   33:     0x5d15f51cb7a4 - test[213991da798b1c03]::run_test::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/test/src/lib.rs:698:41
[INFO] [stdout]   34:     0x5d15f51cb7a4 - std[10d71ac2c42b111e]::sys::backtrace::__rust_begin_short_backtrace::<test[213991da798b1c03]::run_test::{closure#1}, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/backtrace.rs:166:18
[INFO] [stdout]   35:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:70:13
[INFO] [stdout]   36:     0x5d15f51d4f12 - <core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/panic/unwind_safe.rs:275:9
[INFO] [stdout]   37:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panicking::catch_unwind::do_call::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:581:40
[INFO] [stdout]   38:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panicking::catch_unwind::<(), core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panicking.rs:544:19
[INFO] [stdout]   39:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::panic::catch_unwind::<core[8fb95b77d25ab6c8]::panic::unwind_safe::AssertUnwindSafe<std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}::{closure#0}>, ()>
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/panic.rs:359:14
[INFO] [stdout]   40:     0x5d15f51d4f12 - std[10d71ac2c42b111e]::thread::lifecycle::spawn_unchecked::<test[213991da798b1c03]::run_test::{closure#1}, ()>::{closure#1}
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/thread/lifecycle.rs:68:26
[INFO] [stdout]   41:     0x5d15f51d4f12 - <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]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   42:     0x5d15f52a7d0f - <alloc[a7ee25936407c584]::boxed::Box<dyn core[8fb95b77d25ab6c8]::ops::function::FnOnce<(), Output = ()> + core[8fb95b77d25ab6c8]::marker::Send> as core[8fb95b77d25ab6c8]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/alloc/src/boxed.rs:2275:9
[INFO] [stdout]   43:     0x5d15f52a7d0f - <std[10d71ac2c42b111e]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]                                at /rustc/b2282dd5646a57d570fc86fbe8df0e8826665ef6/library/std/src/sys/thread/unix.rs:118:17
[INFO] [stdout]   44:     0x7b5f8ea4eaa4 - <unknown>
[INFO] [stdout]   45:     0x7b5f8eadba64 - clone
[INFO] [stdout]   46:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     step26
[INFO] [stdout]     step35
[INFO] [stdout]     step42
[INFO] [stdout]     step43
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 16 passed; 4 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.46s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e", kill_on_drop: false }`
[INFO] [stdout] 666670c9baa6bf034fc473550b29760767430349d0510f335cf87687a2465a2e
