[INFO] fetching crate optlib 0.4.0...
[INFO] testing optlib-0.4.0 against beta-2023-04-20 for beta-1.70-1
[INFO] extracting crate optlib 0.4.0 into /workspace/builds/worker-6-tc2/source
[INFO] validating manifest of crates.io crate optlib 0.4.0 on toolchain beta-2023-04-20
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+beta-2023-04-20" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate optlib 0.4.0
[INFO] finished tweaking crates.io crate optlib 0.4.0
[INFO] tweaked toml for crates.io crate optlib 0.4.0 written to /workspace/builds/worker-6-tc2/source/Cargo.toml
[INFO] crate crates.io crate optlib 0.4.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" "+beta-2023-04-20" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded num-bigint v0.2.6
[INFO] [stderr]   Downloaded optlib-testfunc v0.1.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-04-20" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 1b314558a1d0bf011f552b0e1b37b977cfcc79f64dce0e712a187891c2bb07da
[INFO] running `Command { std: "docker" "start" "-a" "1b314558a1d0bf011f552b0e1b37b977cfcc79f64dce0e712a187891c2bb07da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "1b314558a1d0bf011f552b0e1b37b977cfcc79f64dce0e712a187891c2bb07da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1b314558a1d0bf011f552b0e1b37b977cfcc79f64dce0e712a187891c2bb07da", kill_on_drop: false }`
[INFO] [stdout] 1b314558a1d0bf011f552b0e1b37b977cfcc79f64dce0e712a187891c2bb07da
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-04-20" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a9f47b5dcbbe7f572d92b2de891ee187f98c7ad4d5d4bbe329490afc2f483b68
[INFO] running `Command { std: "docker" "start" "-a" "a9f47b5dcbbe7f572d92b2de891ee187f98c7ad4d5d4bbe329490afc2f483b68", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling num-traits v0.2.11
[INFO] [stderr]    Compiling num-integer v0.1.42
[INFO] [stderr]    Compiling libc v0.2.66
[INFO] [stderr]    Compiling num-bigint v0.2.6
[INFO] [stderr]    Compiling num-complex v0.2.4
[INFO] [stderr]    Compiling num-rational v0.2.3
[INFO] [stderr]    Compiling num-iter v0.1.40
[INFO] [stderr]    Compiling c2-chacha v0.2.3
[INFO] [stderr]    Compiling getrandom v0.1.14
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_chacha v0.2.1
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling num v0.2.1
[INFO] [stderr]    Compiling optlib v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.27s
[INFO] running `Command { std: "docker" "inspect" "a9f47b5dcbbe7f572d92b2de891ee187f98c7ad4d5d4bbe329490afc2f483b68", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a9f47b5dcbbe7f572d92b2de891ee187f98c7ad4d5d4bbe329490afc2f483b68", kill_on_drop: false }`
[INFO] [stdout] a9f47b5dcbbe7f572d92b2de891ee187f98c7ad4d5d4bbe329490afc2f483b68
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-04-20" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 93b9f2fccf29d240dcdb9c24a9665bf7789a57a0f464d3aa616150c8464f6d36
[INFO] running `Command { std: "docker" "start" "-a" "93b9f2fccf29d240dcdb9c24a9665bf7789a57a0f464d3aa616150c8464f6d36", kill_on_drop: false }`
[INFO] [stderr]    Compiling num_cpus v1.12.0
[INFO] [stderr]    Compiling optlib-testfunc v0.1.0
[INFO] [stderr]    Compiling optlib v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 6.85s
[INFO] running `Command { std: "docker" "inspect" "93b9f2fccf29d240dcdb9c24a9665bf7789a57a0f464d3aa616150c8464f6d36", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "93b9f2fccf29d240dcdb9c24a9665bf7789a57a0f464d3aa616150c8464f6d36", kill_on_drop: false }`
[INFO] [stdout] 93b9f2fccf29d240dcdb9c24a9665bf7789a57a0f464d3aa616150c8464f6d36
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2023-04-20" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 1648458f2a68add6f0a914858bb2a2a5a45e6c6c7f55a64584bac0bff958ce8b
[INFO] running `Command { std: "docker" "start" "-a" "1648458f2a68add6f0a914858bb2a2a5a45e6c6c7f55a64584bac0bff958ce8b", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.03s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/optlib-663ae26ed70f8c2e)
[INFO] [stdout] 
[INFO] [stdout] running 94 tests
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_abs_change ... ok
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_abs_not_change ... ok
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_dimensions_empty ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_min ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_max ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_empty ... ok
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_abs_empty ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::test_population_size ... ok
[INFO] [stdout] test particleswarm::tests::test_find_best_particle_many_01 ... ok
[INFO] [stdout] test particleswarm::tests::test_compare_floats ... ok
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_dimensions_not_change ... ok
[INFO] [stdout] test particleswarm::tests::test_find_best_particle_empty ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_mix ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::test_intervals ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_inside_interval ... ok
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_dimensions_fix ... ok
[INFO] [stdout] test particleswarm::tests::test_particle_move_to_better ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_average_several ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_unite_01 ... ok
[INFO] [stdout] test particleswarm::tests::test_find_best_particle_many_02 ... ok
[INFO] [stdout] test particleswarm::tests::test_find_best_particle_single ... ok
[INFO] [stdout] test particleswarm::tests::test_particle_new ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_average_single_two ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_average_single_one ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_average_single_zero ... ok
[INFO] [stdout] test particleswarm::tests::test_particle_move_to_worse ... ok
[INFO] [stdout] test tools::statistics::tests::convergence_unite_01 ... ok
[INFO] [stdout] test tools::statistics::tests::convergence_unite_02 ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_unite_03 ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_average_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_empty ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_unite_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_several_03 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_single_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_several_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_several_01 ... ok
[INFO] [stdout] test tools::statistics::tests::convergence_unite_04 ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_unite_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_goal_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_several_03 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_goal_none_only ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_several_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_several_04 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_none_only ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_goal_single ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_goal_several ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_single_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_min_iterations_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_min_iterations_several_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_min_iterations_single_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_single ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_min_iterations_single_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_min_iterations_several_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_several_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_vec_float_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_single ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_equal ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_several_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_none_only ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_vec_float_none_only ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_several ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_full_success_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_several_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_vec_float_equal ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_vec_float_single ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_full_success_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_full_success_two_of_three_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_full_success_half ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_full_success_two_of_three_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_none ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_none_many ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_vec_solution_half_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_full_success_fail ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_vec_solution_success_single ... ok
[INFO] [stdout] test tools::statistics::tests::statistics_convergence_unite_empty ... ok
[INFO] [stdout] test tools::statistics::tests::statistics_unite_results_01 ... ok
[INFO] [stdout] test tools::statistics::tests::statistics_unite_results_02 ... ok
[INFO] [stdout] test tools::statistics::tests::statistics_unite_results_03 ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_vec_solution_fail_single ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_vec_solution_half_01 ... ok
[INFO] [stdout] test tools::tests::test_empty ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::empty_intervals - should panic ... ok
[INFO] [stdout] test tools::tests::test_intervals ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::empty_population - should panic ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::invalid_intervals_02 - should panic ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::invalid_intervals_03 - should panic ... ok
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_invalid_size - should panic ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::invalid_intervals_01 - should panic ... ok
[INFO] [stdout] test tools::tests::invalid_intervals_01 - should panic ... ok
[INFO] [stdout] test tools::tests::invalid_intervals_02 - should panic ... ok
[INFO] [stdout] test tools::tests::invalid_intervals_03 - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 94 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/genetic-paraboloid.rs (/opt/rustwide/target/debug/deps/genetic_paraboloid-ce9f19135e9624fc)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/genetic-rastrigin.rs (/opt/rustwide/target/debug/deps/genetic_rastrigin-f6e3fb55d6d7b9df)
[INFO] [stdout] test genetic_paraboloid ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.22s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/genetic-rosenbrock.rs (/opt/rustwide/target/debug/deps/genetic_rosenbrock-9402e2d329d9a18d)
[INFO] [stdout] test genetic_rastrigin ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test genetic_rosenbrock has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "1648458f2a68add6f0a914858bb2a2a5a45e6c6c7f55a64584bac0bff958ce8b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1648458f2a68add6f0a914858bb2a2a5a45e6c6c7f55a64584bac0bff958ce8b", kill_on_drop: false }`
[INFO] [stdout] 1648458f2a68add6f0a914858bb2a2a5a45e6c6c7f55a64584bac0bff958ce8b
