[INFO] fetching crate ew 0.4.0...
[INFO] testing ew-0.4.0 against 1.55.0 for beta-1.56-1
[INFO] extracting crate ew 0.4.0 into /workspace/builds/worker-1/source
[INFO] validating manifest of crates.io crate ew 0.4.0 on toolchain 1.55.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.55.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate ew 0.4.0
[INFO] finished tweaking crates.io crate ew 0.4.0
[INFO] tweaked toml for crates.io crate ew 0.4.0 written to /workspace/builds/worker-1/source/Cargo.toml
[INFO] crate crates.io crate ew 0.4.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.55.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] d525e52229ba0daf4848c20b6277836fb73dfefb459e5bd8a79ae45c4131406a
[INFO] running `Command { std: "docker" "start" "-a" "d525e52229ba0daf4848c20b6277836fb73dfefb459e5bd8a79ae45c4131406a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "d525e52229ba0daf4848c20b6277836fb73dfefb459e5bd8a79ae45c4131406a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d525e52229ba0daf4848c20b6277836fb73dfefb459e5bd8a79ae45c4131406a", kill_on_drop: false }`
[INFO] [stdout] d525e52229ba0daf4848c20b6277836fb73dfefb459e5bd8a79ae45c4131406a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 00f0d9af618dc4b02127807be1cc3080f5e0b4d54be33f362900f65746376d45
[INFO] running `Command { std: "docker" "start" "-a" "00f0d9af618dc4b02127807be1cc3080f5e0b4d54be33f362900f65746376d45", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.89
[INFO] [stderr]    Compiling num-bigint v0.2.6
[INFO] [stderr]    Compiling num-rational v0.2.4
[INFO] [stderr]    Compiling num-iter v0.1.42
[INFO] [stderr]    Compiling num-complex v0.2.4
[INFO] [stderr]    Compiling num-integer v0.1.44
[INFO] [stderr]    Compiling getrandom v0.1.16
[INFO] [stderr]    Compiling rand_core v0.5.1
[INFO] [stderr]    Compiling rand_chacha v0.2.2
[INFO] [stderr]    Compiling rand v0.7.3
[INFO] [stderr]    Compiling num v0.2.1
[INFO] [stderr]    Compiling ew v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.66s
[INFO] running `Command { std: "docker" "inspect" "00f0d9af618dc4b02127807be1cc3080f5e0b4d54be33f362900f65746376d45", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "00f0d9af618dc4b02127807be1cc3080f5e0b4d54be33f362900f65746376d45", kill_on_drop: false }`
[INFO] [stdout] 00f0d9af618dc4b02127807be1cc3080f5e0b4d54be33f362900f65746376d45
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 9481d803d6e978448e335d498cc1e7c375e7f5ec6b79a1753b3db36701d47b2d
[INFO] running `Command { std: "docker" "start" "-a" "9481d803d6e978448e335d498cc1e7c375e7f5ec6b79a1753b3db36701d47b2d", kill_on_drop: false }`
[INFO] [stderr]    Compiling num_cpus v1.13.0
[INFO] [stderr]    Compiling ew-testfunc v0.1.0
[INFO] [stderr]    Compiling ew v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 9.28s
[INFO] running `Command { std: "docker" "inspect" "9481d803d6e978448e335d498cc1e7c375e7f5ec6b79a1753b3db36701d47b2d", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9481d803d6e978448e335d498cc1e7c375e7f5ec6b79a1753b3db36701d47b2d", kill_on_drop: false }`
[INFO] [stdout] 9481d803d6e978448e335d498cc1e7c375e7f5ec6b79a1753b3db36701d47b2d
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-1/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" "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:a89201d6b5b9fd45c15d5952ece0a0129e7e80cb26ec023fd59cf09bc26f1604" "/opt/rustwide/cargo-home/bin/cargo" "+1.55.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] cc985521835525af2c714219cf6c7711ea4befdadb53cc262e19fbdf9030ecb9
[INFO] running `Command { std: "docker" "start" "-a" "cc985521835525af2c714219cf6c7711ea4befdadb53cc262e19fbdf9030ecb9", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.02s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/ew-31540eaa5b11cf27)
[INFO] [stdout] 
[INFO] [stdout] running 94 tests
[INFO] [stdout] test genetic::creation::vec_float::tests::test_population_size ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_max ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_empty ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_inside_interval ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_min ... ok
[INFO] [stdout] test particleswarm::postmove::tests::test_mix ... ok
[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_abs_empty ... ok
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_dimensions_empty ... ok
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_dimensions_fix ... ok
[INFO] [stdout] test particleswarm::postvelocitycalc::tests::test_max_velocity_dimensions_not_change ... ok
[INFO] [stdout] test particleswarm::tests::test_compare_floats ... ok
[INFO] [stdout] test particleswarm::tests::test_find_best_particle_empty ... 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_find_best_particle_many_01 ... ok
[INFO] [stdout] test particleswarm::tests::test_particle_move_to_better ... ok
[INFO] [stdout] test particleswarm::tests::test_particle_new ... ok
[INFO] [stdout] test particleswarm::tests::test_particle_move_to_worse ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_average_empty ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_average_several ... 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_zero ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_unite_01 ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_average_single_one ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_unite_02 ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_unite_empty ... ok
[INFO] [stdout] test tools::statistics::tests::call_count_data_unite_03 ... ok
[INFO] [stdout] test tools::statistics::tests::convergence_unite_04 ... ok
[INFO] [stdout] test tools::statistics::tests::convergence_unite_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_empty ... ok
[INFO] [stdout] test tools::statistics::tests::convergence_unite_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_several_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_goal_none_only ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_several_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_goal_single ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_single_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_none_only ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_goal_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_goal_several ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_several_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_single_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_convergence_several_03 ... 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_03 ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_several_04 ... ok
[INFO] [stdout] test tools::statistics::tests::get_min_iterations_several_01 ... 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_min_iterations_single_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_empty ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_none_only ... ok
[INFO] [stdout] test tools::statistics::tests::get_average_vec_float_single ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::test_intervals ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_equal ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_several ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_single ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_several_02 ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_goal_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_vec_float_equal ... ok
[INFO] [stdout] test tools::statistics::tests::get_standard_deviation_vec_float_none_only ... 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_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_goal_full_success_half ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_goal_empty ... 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_01 ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_vec_solution_fail_single ... 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_vec_solution_success_single ... ok
[INFO] [stdout] test tools::statistics::tests::get_success_rate_vec_solution_half_02 ... 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::tests::test_empty ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::invalid_intervals_01 - should panic ... ok
[INFO] [stdout] test genetic::creation::vec_float::tests::empty_intervals - should panic ... 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 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] test tools::tests::test_intervals ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 94 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/genetic-paraboloid.rs (/opt/rustwide/target/debug/deps/genetic_paraboloid-fc5f7bd0d4a2564b)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/genetic-rastrigin.rs (/opt/rustwide/target/debug/deps/genetic_rastrigin-687a2f854946a29e)
[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 3.96s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]      Running tests/genetic-rosenbrock.rs (/opt/rustwide/target/debug/deps/genetic_rosenbrock-76c7b8120927597f)
[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.21s
[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" "cc985521835525af2c714219cf6c7711ea4befdadb53cc262e19fbdf9030ecb9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cc985521835525af2c714219cf6c7711ea4befdadb53cc262e19fbdf9030ecb9", kill_on_drop: false }`
[INFO] [stdout] cc985521835525af2c714219cf6c7711ea4befdadb53cc262e19fbdf9030ecb9