[INFO] fetching crate dsmc 0.18.0...
[INFO] testing dsmc-0.18.0 against 1.99.0-beta.8+cargoflags=--release for beta-release-1.100-2
[INFO] extracting crate dsmc 0.18.0 into /workspace/builds/worker-1-tc1/source
[INFO] started tweaking crates.io crate dsmc 0.18.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate dsmc 0.18.0
[INFO] tweaked toml for crates.io crate dsmc 0.18.0 written to /workspace/builds/worker-1-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate dsmc 0.18.0 on toolchain 1.99.0-beta.8
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate dsmc 0.18.0 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.99.0-beta.8" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded glam v0.33.8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1-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:77db811e55d90add9212f6832c23229e3de5f1c1f9905e8cb07319ea15df73ac" "sleep" "infinity", kill_on_drop: false }`
[INFO] [stdout] 14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f
[INFO] running `Command { std: "docker" "start" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f", 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" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f", 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" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "build" "--frozen" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling strength_reduce v0.2.4
[INFO] [stderr]    Compiling memchr v2.8.0
[INFO] [stderr]    Compiling safe_arch v1.2.0
[INFO] [stderr]    Compiling primal-check v0.3.4
[INFO] [stderr]    Compiling transpose v0.2.3
[INFO] [stderr]    Compiling csv-core v0.1.13
[INFO] [stderr]    Compiling csv v1.4.0
[INFO] [stderr]    Compiling wide v1.7.1
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling nalgebra-macros v0.3.0
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling num-complex v0.4.6
[INFO] [stderr]    Compiling rustfft v6.4.1
[INFO] [stderr]    Compiling simba v0.10.2
[INFO] [stderr]    Compiling nalgebra v0.35.0
[INFO] [stderr]    Compiling dsmc v0.18.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 34.91s
[INFO] running `Command { std: "docker" "inspect" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f", 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" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--no-run" "--message-format=json" "--release", kill_on_drop: false }`
[INFO] [stderr]    Compiling dsmc v0.18.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 1m 29s
[INFO] running `Command { std: "docker" "inspect" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f", 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" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f" "/opt/rustwide/cargo-home/bin/cargo" "+1.99.0-beta.8" "test" "--frozen" "--release", kill_on_drop: false }`
[INFO] [stderr]     Finished `release` profile [optimized] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/release/deps/dsmc-53498374f5efd242)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test sampling::tests::periods_of_the_fundamental ... ok
[INFO] [stdout] test system_identification::arx::tests::schur_cohn_stability ... ok
[INFO] [stdout] test system_identification::frequency_response::vector_fitting::tests::test_pair_basis ... ok
[INFO] [stdout] test system_identification::validation::check::tests::binomial_quantile_values ... ok
[INFO] [stdout] test sampling::tests::whole_numbers_of_samples ... ok
[INFO] [stdout] test system_identification::arx::tests::stabilized_reflects_unstable_roots ... ok
[INFO] [stdout] test discretize::state_variable_filter::tests::identity_without_poles ... ok
[INFO] [stdout] test system_identification::frequency_response::vector_fitting::tests::test_zeros_of_sigma ... ok
[INFO] [stdout] test system_identification::preprocessing::tests::removes_a_constant_and_keeps_high_frequencies ... ok
[INFO] [stdout] test system_identification::validation::check::tests::normal_quantile_values ... ok
[INFO] [stdout] test system_identification::validation::cross_correlation::tests::correlation_by_fft_matches_the_direct_sum ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/integration/main.rs (/opt/rustwide/target/release/deps/integration-87f324e2a0111320)
[INFO] [stdout] 
[INFO] [stdout] running 181 tests
[INFO] [stdout] test discretize::backward_difference::poles_and_dc_gain ... ok
[INFO] [stdout] test discretize::backward_difference::state_space_formula ... ok
[INFO] [stdout] test discretize::matched_z::low_frequency_response ... ok
[INFO] [stdout] test discretize::matched_z::errors ... ok
[INFO] [stdout] test discretize::matched_z::dead_time ... ok
[INFO] [stdout] test discretize::matched_z::first_order ... ok
[INFO] [stdout] test discretize::matched_z::perturbed_nyquist_zeros ... ok
[INFO] [stdout] test discretize::matched_z::time_advance ... ok
[INFO] [stdout] test discretize::backward_difference::second_order ... ok
[INFO] [stdout] test discretize::methods::multiple_inputs_and_outputs ... ok
[INFO] [stdout] test discretize::matched_z::unmappable_zeros_are_dropped ... ok
[INFO] [stdout] test discretize::matched_z::round_trip_z_s_z ... ok
[INFO] [stdout] test discretize::methods::static_gain ... ok
[INFO] [stdout] test discretize::methods::transfer_function_and_state_space_agree ... ok
[INFO] [stdout] test discretize::matched_z::round_trip_s_z_s ... ok
[INFO] [stdout] test discretize::state_variable_filter::test_state_variable_filter_constructors ... ok
[INFO] [stdout] test excitation::chirp_sweeps_linearly ... ok
[INFO] [stdout] test discretize::zoh::first_order ... ok
[INFO] [stdout] test discretize::zoh::state_space_formula ... ok
[INFO] [stdout] test excitation::durations_and_fundamental_must_be_whole_samples ... ok
[INFO] [stdout] test discretize::zoh::static_gain_and_improper ... ok
[INFO] [stdout] test discretize::tustin::first_order ... ok
[INFO] [stdout] test discretize::tustin::state_space_formula ... ok
[INFO] [stdout] test discretize::zoh::step_invariant ... ok
[INFO] [stdout] test excitation::chirp_duration_must_be_whole_samples ... ok
[INFO] [stdout] test excitation::m_sequence_holds_each_bit_for_the_clock ... ok
[INFO] [stdout] test discretize::state_variable_filter::test_state_variable_filter_foh_sinusoid ... ok
[INFO] [stdout] test discretize::backward_difference::first_order ... ok
[INFO] [stdout] test excitation::shaped_m_sequence_is_the_filter_output ... ok
[INFO] [stdout] test excitation::multisine_rejects_invalid_arguments ... ok
[INFO] [stdout] test math::test_discrete_transfer_function ... ok
[INFO] [stdout] test math::test_parse_variable_errors ... ok
[INFO] [stdout] test logger::test_data_storage_separator_header ... FAILED
[INFO] [stdout] test logger::test_data_storage_string_header ... FAILED
[INFO] [stdout] test excitation::shaped_chirp_follows_the_gain_at_the_instantaneous_frequency ... ok
[INFO] [stdout] test math::test_tf_macro_domain_detection ... ok
[INFO] [stdout] test math::test_tf_macro_with_format_args ... ok
[INFO] [stdout] test excitation::m_sequence_rejects_invalid_arguments ... ok
[INFO] [stdout] test math::test_transfer_function_parser ... ok
[INFO] [stdout] test discretize::state_variable_filter::test_state_variable_filter_zoh ... ok
[INFO] [stdout] test math::test_pz_map ... ok
[INFO] [stdout] test math::test_transfer_function_display ... ok
[INFO] [stdout] test math::test_search_roots ... ok
[INFO] [stdout] test math::test_transfer_function_scalar_gain ... ok
[INFO] [stdout] test partial_fraction::close_distinct_poles_not_merged ... ok
[INFO] [stdout] test math::test_vieta_formula ... ok
[INFO] [stdout] test partial_fraction::complex_poles ... ok
[INFO] [stdout] test partial_fraction::improper ... ok
[INFO] [stdout] test partial_fraction::reduced_repeated_and_complex_common_factors ... ok
[INFO] [stdout] test partial_fraction::time_function_closure ... ok
[INFO] [stdout] test partial_fraction::distinct_real_poles ... ok
[INFO] [stdout] test partial_fraction::repeated_complex_poles ... ok
[INFO] [stdout] test excitation::flat_output_multisine_flattens_the_output ... ok
[INFO] [stdout] test partial_fraction::repeated_poles ... ok
[INFO] [stdout] test partial_fraction::reduced_keeps_remaining_repeated_root ... ok
[INFO] [stdout] test partial_fraction::repeated_poles_exact_coefficients ... ok
[INFO] [stdout] test ptc_output::arbitrary_realization ... ok
[INFO] [stdout] test root_locus::test_roots_plot_2order ... FAILED
[INFO] [stdout] test partial_fraction::high_multiplicity_pole ... ok
[INFO] [stdout] test root_locus::test_roots_plot ... FAILED
[INFO] [stdout] test signal::test_delayer ... ok
[INFO] [stdout] test spectrogram::spectrogram_rejects_a_non_positive_window - should panic ... ok
[INFO] [stdout] test ptc_output::errors ... ok
[INFO] [stdout] test spectrum::amplitude_spectrum_of_an_empty_record_is_empty ... ok
[INFO] [stdout] test discretize::state_variable_filter::test_state_variable_filter_high_order_low_cutoff ... ok
[INFO] [stdout] test spectrogram::periodic_hann_leaks_a_sinusoid_on_a_bin_into_its_neighbours_only ... ok
[INFO] [stdout] test spectrogram::spectrogram_averages_to_the_psd_with_the_same_segments ... ok
[INFO] [stdout] test spectrum::amplitude_spectrum_doubles_the_last_bin_of_an_odd_length ... ok
[INFO] [stdout] test spectrogram::spectrogram_clamps_the_window_to_the_record ... ok
[INFO] [stdout] test spectrum::amplitude_spectrum_does_not_double_the_nyquist_bin_of_an_even_length ... ok
[INFO] [stdout] test spectrogram::spectrogram_has_the_segments_of_the_window_time ... ok
[INFO] [stdout] test spectrum::psd_has_the_frequencies_of_welch ... ok
[INFO] [stdout] test stable_inverse::errors ... ok
[INFO] [stdout] test spectrum::psd_of_a_sinusoid_integrates_to_its_variance ... ok
[INFO] [stdout] test stable_inverse::nonminimum_phase_first_order ... ok
[INFO] [stdout] test stable_inverse::polynomial_reference::normalized_coefficients ... ok
[INFO] [stdout] test stable_inverse::polynomial_reference::not_smooth_enough ... ok
[INFO] [stdout] test stable_inverse::polynomial_reference::smoothness_at_both_ends ... ok
[INFO] [stdout] test spectrum::psd_of_fewer_than_two_samples_is_empty ... ok
[INFO] [stdout] test stable_inverse::polynomial_reference::generate_matches_piecewise ... ok
[INFO] [stdout] test spectrum::psd_of_white_noise_is_twice_the_variance_times_ts ... ok
[INFO] [stdout] test stable_inverse::polynomial_reference::output_equation_holds_long_after_the_move ... ok
[INFO] [stdout] test stable_inverse::minimum_phase_is_causal ... ok
[INFO] [stdout] test stable_inverse::polynomial_reference::without_zeros_reference_is_derivatives ... ok
[INFO] [stdout] test spectrogram::spectrogram_follows_a_change_of_frequency ... ok
[INFO] [stdout] test stable_inverse::mixed_stable_and_unstable_poles ... ok
[INFO] [stdout] test spectrum::amplitude_spectrum_reads_the_amplitudes_of_a_sinusoid_and_dc ... ok
[INFO] [stdout] test excitation::multisine_does_not_drift_through_integrators ... ok
[INFO] [stdout] test state_space::realization_round_trip ... ok
[INFO] [stdout] test state_space::normalized_realization ... ok
[INFO] [stdout] test state_space::siso_and_mimo ... ok
[INFO] [stdout] test status::test_motion_scalar_ops ... ok
[INFO] [stdout] test stable_inverse::state_reference::errors ... ok
[INFO] [stdout] test stable_inverse::state_reference::sin_laplace_matches_generate ... ok
[INFO] [stdout] test state_space::discrete_system_of_transfer_function ... ok
[INFO] [stdout] test stable_inverse::state_reference::without_zeros_reference_is_trajectory ... ok
[INFO] [stdout] test stable_inverse::unstable_complex_poles ... ok
[INFO] [stdout] test state_space::realizations_simulate_like_tf ... ok
[INFO] [stdout] test system_identification::frequency_response::test_vector_fitting_into_transfer_function_scale ... ok
[INFO] [stdout] test system_identification::frequency_response::test_vector_fitting_noisy_pair ... ok
[INFO] [stdout] test system_identification::frequency_response::test_vector_fitting_noisy_real_pole ... ok
[INFO] [stdout] test frequency_transfer_function::test_frequency_transfer_function ... ok
[INFO] [stdout] test system_identification::arx::test_lsm_polynomial ... ok
[INFO] [stdout] test system_identification::gpr::test_gpr ... ok
[INFO] [stdout] test system_identification::frequency_response::test_levy ... ok
[INFO] [stdout] test system_identification::frequency_response::test_vector_fitting_noisy_band_limited ... ok
[INFO] [stdout] test excitation::shaped_multisine_takes_the_gain_of_the_filter ... ok
[INFO] [stdout] test system_identification::oe::test_oe_errors ... ok
[INFO] [stdout] test system_identification::arx::test_lsm_arx ... ok
[INFO] [stdout] test system_identification::frequency_response::test_vector_fitting_weighted ... ok
[INFO] [stdout] test system_identification::arx::test_arx_mismatched_orders ... ok
[INFO] [stdout] test system_identification::sml::test_sml_continuous_resonance ... ok
[INFO] [stdout] test stable_inverse::polynomial_reference::matches_delayed_rational_sum_path_near_the_move ... ok
[INFO] [stdout] test system_identification::arx::test_arx_input_delay ... ok
[INFO] [stdout] test excitation::multisine_does_not_drift_through_a_sampled_double_integrator ... ok
[INFO] [stdout] test system_identification::oe::test_oe_noise_free ... ok
[INFO] [stdout] test system_identification::sml::test_sml_errors ... ok
[INFO] [stdout] test system_identification::sml::test_sml_continuous_wide_band ... ok
[INFO] [stdout] test system_identification::sml::test_sml_discrete_errors_in_variables ... FAILED
[INFO] [stdout] test system_identification::sml::test_sml_cost_detects_model_error ... ok
[INFO] [stdout] test system_identification::frequency_response::test_vector_fitting ... ok
[INFO] [stdout] test system_identification::srivc::pure_integrator::test_srivc_pure_integrator_invalid_order ... ok
[INFO] [stdout] test excitation::m_sequence_is_a_maximum_length_sequence ... ok
[INFO] [stdout] test excitation::multisine_has_the_given_amplitudes ... ok
[INFO] [stdout] test system_identification::frequency_response::test_vector_fitting_welch_measurement ... ok
[INFO] [stdout] test system_identification::srivc::basic::test_srivc_with_delay ... ok
[INFO] [stdout] test time_expression::amplitude_phase ... ok
[INFO] [stdout] test time_expression::amplitude_phase_of_powers_of_t ... ok
[INFO] [stdout] test time_expression::amplitude_phase_reconstructs_signal ... ok
[INFO] [stdout] test time_expression::conjugate_pair_is_one_mode ... ok
[INFO] [stdout] test time_expression::eval_matches_time_response ... ok
[INFO] [stdout] test time_expression::impulses_ascending ... ok
[INFO] [stdout] test time_expression::negation ... ok
[INFO] [stdout] test time_expression::pure_cosine_keeps_frequency ... ok
[INFO] [stdout] test time_expression::repeated_complex_pole ... ok
[INFO] [stdout] test time_expression::repeated_real_pole ... ok
[INFO] [stdout] test trajectory::traits::kind_matches_individual_types ... ok
[INFO] [stdout] test trajectory::traits::reference_matches_profile ... ok
[INFO] [stdout] test trajectory::traits::reference_trajectories_drive_ptc ... ok
[INFO] [stdout] test trajectory::traits::rest_to_rest_with_consistent_derivatives ... ok
[INFO] [stdout] test transfer_function::negative_powers::parse_keeps_non_common_root_at_origin ... ok
[INFO] [stdout] test transfer_function::negative_powers::parse_long_fir_keeps_minimal_degree ... ok
[INFO] [stdout] test system_identification::iv::test_iv_arx ... ok
[INFO] [stdout] test transfer_function::negative_powers::parse_moving_average_with_negative_powers ... ok
[INFO] [stdout] test transfer_function::negative_powers::parse_recursive_moving_average ... ok
[INFO] [stdout] test transfer_function::negative_powers::reduced_cancels_high_multiplicity_root_at_origin ... ok
[INFO] [stdout] test transfer_function::test_closed_tf ... ok
[INFO] [stdout] test transfer_function::test_delay_samples ... ok
[INFO] [stdout] test transfer_function::negative_powers::reduced_cancels_high_multiplicity_root_at_origin_continuous ... ok
[INFO] [stdout] test validation::test_validation_aic ... ok
[INFO] [stdout] test validation::test_validation_bic ... ok
[INFO] [stdout] test validation::test_validation_coherence_band ... ok
[INFO] [stdout] test system_identification::srivc::basic::test_srivc ... ok
[INFO] [stdout] test system_identification::srivc::pure_integrator::test_srivc_pure_integrator_rigid_body ... ok
[INFO] [stdout] test validation::test_validation_durations_in_seconds ... ok
[INFO] [stdout] test validation::test_validation_coherence_test ... ok
[INFO] [stdout] test validation::test_validation_line_test ... ok
[INFO] [stdout] test validation::test_validation_frequency_response ... ok
[INFO] [stdout] test system_identification::iv::test_sriv_arx ... ok
[INFO] [stdout] test validation::test_validation_one_step_prediction ... ok
[INFO] [stdout] test system_identification::oe::test_oe_noisy ... ok
[INFO] [stdout] test welch::lengths_must_match - should panic ... ok
[INFO] [stdout] test validation::test_validation_whiteness ... ok
[INFO] [stdout] test validation::test_validation_cross_correlation ... ok
[INFO] [stdout] test validation::test_validation_check ... ok
[INFO] [stdout] test welch::zero_signals_give_zero ... ok
[INFO] [stdout] test system_identification::oe::test_oe_lightly_damped ... ok
[INFO] [stdout] test welch::unexcited_bins_are_zero ... ok
[INFO] [stdout] test validation::test_validation_scale_and_zero_signals ... ok
[INFO] [stdout] test welch::small_signals_keep_their_coherence ... ok
[INFO] [stdout] test welch::coherence_does_not_depend_on_the_units ... ok
[INFO] [stdout] test system_identification::sml::test_sml_discrete_monte_carlo ... ok
[INFO] [stdout] test welch::segment_is_at_most_the_data ... ok
[INFO] [stdout] test system_identification::srivc::pure_integrator::test_srivc_pure_integrator ... ok
[INFO] [stdout] test system_identification::srivc::high_order::test_srivc_high_order ... ok
[INFO] [stdout] test system_identification::srivc::pseudo_integration::test_srivc_pseudo_integration ... ok
[INFO] [stdout] test system_identification::srivc::pure_integrator::test_srivc_pure_integrator_search ... ok
[INFO] [stdout] test system_identification::srivc::input_offset::test_srivc_input_offset ... ok
[INFO] [stdout] test system_identification::srivc::search::test_srivc_structure_search ... ok
[INFO] [stdout] test system_identification::srivc::pseudo_integration::test_srivc_pseudo_integration_two_integrators ... ok
[INFO] [stdout] test system_identification::srivc::search::test_srivc_integrator_search ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- logger::test_data_storage_separator_header stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'logger::test_data_storage_separator_header' (1115) panicked at tests/integration/logger.rs:6:46:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x650409620b51 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x65040963755a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x650409624fec - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6504095fc4a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x650409618f49 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6504095a1720 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x650409619102 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6504095fc552 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6504095f5029 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6504095fd14d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x650409637c8c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x650409637a62 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x650409417a0b - integration[7d2fac0c557a6fae]::logger::test_data_storage_separator_header
[INFO] [stdout]   13:     0x65040948b049 - <integration[7d2fac0c557a6fae]::logger::test_data_storage_separator_header::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x650409594a0b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   15:     0x6504095a2075 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x65040959b934 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x6504095a51d2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x6504096200b9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x78a58501adfa - <unknown>
[INFO] [stdout]   20:     0x78a5850ae3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- logger::test_data_storage_string_header stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'logger::test_data_storage_string_header' (1116) panicked at tests/integration/logger.rs:18:62:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x650409620b51 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x65040963755a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x650409624fec - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6504095fc4a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x650409618f49 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6504095a1720 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x650409619102 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6504095fc552 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6504095f5029 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6504095fd14d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x650409637c8c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x650409637a62 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x650409416f6b - integration[7d2fac0c557a6fae]::logger::test_data_storage_string_header
[INFO] [stdout]   13:     0x65040948b029 - <integration[7d2fac0c557a6fae]::logger::test_data_storage_string_header::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x650409594a0b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   15:     0x6504095a2075 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x65040959b934 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x6504095a51d2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x6504096200b9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x78a58501adfa - <unknown>
[INFO] [stdout]   20:     0x78a5850ae3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- root_locus::test_roots_plot_2order stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'root_locus::test_roots_plot_2order' (1141) panicked at tests/integration/root_locus.rs:111:115:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x650409620b51 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x65040963755a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x650409624fec - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6504095fc4a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x650409618f49 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6504095a1720 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x650409619102 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6504095fc552 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6504095f5029 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6504095fd14d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x650409637c8c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x650409637a62 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x6504094127e7 - integration[7d2fac0c557a6fae]::root_locus::test_roots_plot_2order
[INFO] [stdout]   13:     0x65040948a789 - <integration[7d2fac0c557a6fae]::root_locus::test_roots_plot_2order::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x650409594a0b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   15:     0x6504095a2075 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x65040959b934 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x6504095a51d2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x6504096200b9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x78a58501adfa - <unknown>
[INFO] [stdout]   20:     0x78a5850ae3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- root_locus::test_roots_plot stdout ----
[INFO] [stdout] 
[INFO] [stdout] thread 'root_locus::test_roots_plot' (1140) panicked at tests/integration/root_locus.rs:66:110:
[INFO] [stdout] called `Result::unwrap()` on an `Err` value: Os { code: 30, kind: ReadOnlyFilesystem, message: "Read-only file system" }
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x650409620b51 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x65040963755a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x650409624fec - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6504095fc4a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x650409618f49 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6504095a1720 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x650409619102 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6504095fc552 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6504095f5029 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6504095fd14d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x650409637c8c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x650409637a62 - core[df12db4294e9bfd3]::result::unwrap_failed
[INFO] [stdout]   12:     0x650409411fb6 - integration[7d2fac0c557a6fae]::root_locus::test_roots_plot
[INFO] [stdout]   13:     0x65040948a769 - <integration[7d2fac0c557a6fae]::root_locus::test_roots_plot::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   14:     0x650409594a0b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   15:     0x6504095a2075 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   16:     0x65040959b934 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   17:     0x6504095a51d2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   18:     0x6504096200b9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   19:     0x78a58501adfa - <unknown>
[INFO] [stdout]   20:     0x78a5850ae3d4 - clone
[INFO] [stdout]   21:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] ---- system_identification::sml::test_sml_discrete_errors_in_variables stdout ----
[INFO] [stdout] TransferFunction { numerator: Polynomial([0.0, 0.9858478213657579, 0.49268140086228374]), denominator: Polynomial([1.0, -1.5047660214670373, 0.7040175838933341]), _domain: PhantomData<dsmc::system::domain::Discrete> }
[INFO] [stdout] std [0.0, 0.017578241515478255, 0.023829333057262786] [0.0, 0.0034988187021338327, 0.0028407746815210483]
[INFO] [stdout] cost 147.1, expected 114.3 ± 13.8, 3 iterations
[INFO] [stdout] 
[INFO] [stdout] thread 'system_identification::sml::test_sml_discrete_errors_in_variables' (1200) panicked at tests/integration/system_identification/sml.rs:68:5:
[INFO] [stdout] Stalled
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x650409620b51 - <<std[70759c8f55707aa4]::sys::backtrace::BacktraceLock>::print::DisplayBacktrace as core[df12db4294e9bfd3]::fmt::Display>::fmt
[INFO] [stdout]    1:     0x65040963755a - core[df12db4294e9bfd3]::fmt::write
[INFO] [stdout]    2:     0x650409624fec - <alloc[2182bb758b4b3781]::vec::Vec<u8> as core[df12db4294e9bfd3]::io::write::Write>::write_fmt
[INFO] [stdout]    3:     0x6504095fc4a6 - std[70759c8f55707aa4]::panicking::default_hook::{closure#0}
[INFO] [stdout]    4:     0x650409618f49 - std[70759c8f55707aa4]::panicking::default_hook
[INFO] [stdout]    5:     0x6504095a1720 - test[9d35eded1c95d3be]::test_main_inner::<test[9d35eded1c95d3be]::test_main_static::{closure#0}>::{closure#0}
[INFO] [stdout]    6:     0x650409619102 - std[70759c8f55707aa4]::panicking::panic_with_hook
[INFO] [stdout]    7:     0x6504095fc552 - std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}
[INFO] [stdout]    8:     0x6504095f5029 - std[70759c8f55707aa4]::sys::backtrace::__rust_end_short_backtrace::<std[70759c8f55707aa4]::panicking::panic_handler::{closure#0}, !>
[INFO] [stdout]    9:     0x6504095fd14d - __rustc[8fa7c3cbc660c2b3]::rust_begin_unwind
[INFO] [stdout]   10:     0x650409637c8c - core[df12db4294e9bfd3]::panicking::panic_fmt
[INFO] [stdout]   11:     0x65040942484f - integration[7d2fac0c557a6fae]::system_identification::sml::test_sml_discrete_errors_in_variables
[INFO] [stdout]   12:     0x65040948bac9 - <integration[7d2fac0c557a6fae]::system_identification::sml::test_sml_discrete_errors_in_variables::{closure#0} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once
[INFO] [stdout]   13:     0x650409594a0b - test[9d35eded1c95d3be]::__rust_begin_short_backtrace::<core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>, fn() -> core[df12db4294e9bfd3]::result::Result<(), alloc[2182bb758b4b3781]::string::String>>
[INFO] [stdout]   14:     0x6504095a2075 - test[9d35eded1c95d3be]::run_test::{closure#0}
[INFO] [stdout]   15:     0x65040959b934 - std[70759c8f55707aa4]::sys::backtrace::__rust_begin_short_backtrace::<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>
[INFO] [stdout]   16:     0x6504095a51d2 - <std[70759c8f55707aa4]::thread::lifecycle::spawn_unchecked<test[9d35eded1c95d3be]::run_test::{closure#1}, ()>::{closure#1} as core[df12db4294e9bfd3]::ops::function::FnOnce<()>>::call_once::{shim:vtable#0}
[INFO] [stdout]   17:     0x6504096200b9 - <std[70759c8f55707aa4]::sys::thread::unix::Thread>::new::thread_start
[INFO] [stdout]   18:     0x78a58501adfa - <unknown>
[INFO] [stdout]   19:     0x78a5850ae3d4 - clone
[INFO] [stdout]   20:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     logger::test_data_storage_separator_header
[INFO] [stdout]     logger::test_data_storage_string_header
[INFO] [stdout]     root_locus::test_roots_plot
[INFO] [stdout]     root_locus::test_roots_plot_2order
[INFO] [stdout]     system_identification::sml::test_sml_discrete_errors_in_variables
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 176 passed; 5 failed; 0 ignored; 0 measured; 0 filtered out; finished in 11.12s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--test integration`
[INFO] running `Command { std: "docker" "inspect" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f", kill_on_drop: false }`
[INFO] [stdout] 14519b62faf81b76bf7e1bc9616c2e954996a52ce4c26cc567bef038c85b674f
