Dec 13 08:44:18.897 INFO testing noirotm/fishr against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 08:44:18.897 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 13 08:44:19.259 INFO [stdout] 24ad04f2f7f4af820103cd82cac7b897cfe5c9dfb1de758cfb8ca28695f86a34
Dec 13 08:44:19.264 INFO running `"docker" "start" "-a" "24ad04f2f7f4af820103cd82cac7b897cfe5c9dfb1de758cfb8ca28695f86a34"`
Dec 13 08:44:20.527 INFO [stderr] usermod: no changes
Dec 13 08:44:20.663 INFO [stderr]    Compiling fishr v0.1.0 (/source)
Dec 13 08:44:24.895 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.34s
Dec 13 08:44:24.902 INFO [stderr] su: No module specific data is present
Dec 13 08:44:25.542 INFO running `"docker" "inspect" "24ad04f2f7f4af820103cd82cac7b897cfe5c9dfb1de758cfb8ca28695f86a34"`
Dec 13 08:44:25.634 INFO running `"docker" "rm" "-f" "24ad04f2f7f4af820103cd82cac7b897cfe5c9dfb1de758cfb8ca28695f86a34"`
Dec 13 08:44:25.758 INFO [stdout] 24ad04f2f7f4af820103cd82cac7b897cfe5c9dfb1de758cfb8ca28695f86a34
Dec 13 08:44:25.760 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 13 08:44:25.991 INFO [stdout] 33a59e0087f3b27b08b1e1e1c2331a0145f7f7bd38caab341cfe88fcf317d0e8
Dec 13 08:44:25.993 INFO running `"docker" "start" "-a" "33a59e0087f3b27b08b1e1e1c2331a0145f7f7bd38caab341cfe88fcf317d0e8"`
Dec 13 08:44:26.438 INFO [stderr] usermod: no changes
Dec 13 08:44:26.510 INFO [stderr]    Compiling fishr v0.1.0 (/source)
Dec 13 08:44:31.487 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.01s
Dec 13 08:44:31.487 INFO [stderr] su: No module specific data is present
Dec 13 08:44:31.955 INFO running `"docker" "inspect" "33a59e0087f3b27b08b1e1e1c2331a0145f7f7bd38caab341cfe88fcf317d0e8"`
Dec 13 08:44:32.245 INFO running `"docker" "rm" "-f" "33a59e0087f3b27b08b1e1e1c2331a0145f7f7bd38caab341cfe88fcf317d0e8"`
Dec 13 08:44:32.510 INFO [stdout] 33a59e0087f3b27b08b1e1e1c2331a0145f7f7bd38caab341cfe88fcf317d0e8
Dec 13 08:44:32.517 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +aa49d8ef14939ddec0e34b346b60174a5673d48f-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 13 08:44:33.011 INFO [stdout] 73d871f575acc1f75ec6fb9d4234f2e423f86c80eeede6720740cf569247be47
Dec 13 08:44:33.019 INFO running `"docker" "start" "-a" "73d871f575acc1f75ec6fb9d4234f2e423f86c80eeede6720740cf569247be47"`
Dec 13 08:44:34.085 INFO [stderr] usermod: no changes
Dec 13 08:44:34.191 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.06s
Dec 13 08:44:34.207 INFO [stderr]      Running /target/debug/deps/fish-88f5175ebdf54bbd
Dec 13 08:44:34.219 INFO [stdout] 
Dec 13 08:44:34.219 INFO [stdout] running 39 tests
Dec 13 08:44:34.219 INFO [stdout] test stack::tests::stack::drop_with_empty_stack_fails ... ok
Dec 13 08:44:34.219 INFO [stdout] test stack::tests::stack::dup_works ... ok
Dec 13 08:44:34.219 INFO [stdout] test stack::tests::stack::lshift_works ... ok
Dec 13 08:44:34.219 INFO [stdout] test stack::tests::stack::new_works ... ok
Dec 13 08:44:34.219 INFO [stdout] test stack::tests::stack::push_works ... ok
Dec 13 08:44:34.219 INFO [stdout] test stack::tests::stack::rshift_works ... ok
Dec 13 08:44:34.219 INFO [stdout] test stack::tests::stack::swap2_with_empty_stack_fails ... ok
Dec 13 08:44:34.219 INFO [stdout] test stack::tests::stack::pop_empty_stack_returns_none ... ok
Dec 13 08:44:34.219 INFO [stdout] test stack::tests::stack::pop_works ... ok
Dec 13 08:44:34.221 INFO [stdout] test stack::tests::stack::swap_works ... ok
Dec 13 08:44:34.221 INFO [stdout] test stack::tests::stack::swap2_with_two_elements_fails ... ok
Dec 13 08:44:34.221 INFO [stdout] test stack::tests::stack::swap2_works ... ok
Dec 13 08:44:34.221 INFO [stdout] test stack::tests::stack::drop_works ... ok
Dec 13 08:44:34.223 INFO [stdout] test stack::tests::stack::swap2_with_one_element_fails ... ok
Dec 13 08:44:34.235 INFO [stdout] test stack::tests::stack::switch_empty_register_on_empty_stack_fails ... ok
Dec 13 08:44:34.235 INFO [stdout] test stack::tests::stack::swap_with_one_element_fails ... ok
Dec 13 08:44:34.235 INFO [stdout] test stack::tests::stack::swap_with_empty_stack_fails ... ok
Dec 13 08:44:34.235 INFO [stdout] test stack::tests::stack::dup_with_empty_stack_fails ... ok
Dec 13 08:44:34.235 INFO [stdout] test stack::tests::stack_of_stacks::new_works ... ok
Dec 13 08:44:34.235 INFO [stdout] test stack::tests::stack::switch_register_works ... ok
Dec 13 08:44:34.235 INFO [stdout] test stack::tests::stack_of_stacks::pop_initial_stack_makes_it_empty ... ok
Dec 13 08:44:34.252 INFO [stdout] test stack::tests::stack_of_stacks::push_stack_with_zero_elements_works ... ok
Dec 13 08:44:34.252 INFO [stderr]      Running /target/debug/deps/fishr-31fea101cc363661
Dec 13 08:44:34.252 INFO [stdout] test stack::tests::stack_of_stacks::push_stack_with_too_many_values_fails ... ok
Dec 13 08:44:34.252 INFO [stdout] test stack::tests::stack_of_stacks::pop_stack_with_top_register_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test stack::tests::stack_of_stacks::pop_stack_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test stack::tests::stack_of_stacks::push_stack_with_all_elements_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test stack::tests::stack_of_stacks::pop_stack_with_base_register_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test stack::tests::stack_of_stacks::push_stack_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test tests::push_i64_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test tests::push_str_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test val::tests::val_eq_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test tests::empty_code_box ... ok
Dec 13 08:44:34.252 INFO [stdout] test tests::codebox_with_three_lines ... ok
Dec 13 08:44:34.252 INFO [stdout] test tests::codebox_with_one_line ... ok
Dec 13 08:44:34.252 INFO [stdout] test tests::codebox_with_one_column ... ok
Dec 13 08:44:34.252 INFO [stdout] test tests::codebox_data_is_ok ... ok
Dec 13 08:44:34.252 INFO [stdout] test val::tests::val_to_f64_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test val::tests::val_to_i64_works ... ok
Dec 13 08:44:34.252 INFO [stdout] test val::tests::val_to_u8_works ... ok
Dec 13 08:44:34.252 INFO [stdout] 
Dec 13 08:44:34.252 INFO [stdout] test result: ok. 39 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:34.252 INFO [stdout] 
Dec 13 08:44:34.252 INFO [stdout] 
Dec 13 08:44:34.252 INFO [stdout] running 0 tests
Dec 13 08:44:34.257 INFO [stdout] 
Dec 13 08:44:34.257 INFO [stderr]      Running /target/debug/deps/interpreter_test-9079b5610e8ac486
Dec 13 08:44:34.257 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:34.257 INFO [stdout] 
Dec 13 08:44:34.268 INFO [stdout] 
Dec 13 08:44:34.268 INFO [stdout] running 93 tests
Dec 13 08:44:34.275 INFO [stdout] test conditional_trampoline_with_empty_stack_fails ... ok
Dec 13 08:44:34.275 INFO [stdout] test conditional_trampoline_skips_next_with_zero ... ok
Dec 13 08:44:34.275 INFO [stdout] test conditional_trampoline_executes_next_with_non_zero ... ok
Dec 13 08:44:34.275 INFO [stdout] test addition_works ... ok
Dec 13 08:44:34.275 INFO [stdout] test division_with_empty_stack_fails ... ok
Dec 13 08:44:34.275 INFO [stdout] test division_with_one_element_fails ... ok
Dec 13 08:44:34.275 INFO [stdout] test division_by_zero_fails ... ok
Dec 13 08:44:34.275 INFO [stdout] test char_output_with_empty_stack_fails ... ok
Dec 13 08:44:34.279 INFO [stdout] test char_output_works ... ok
Dec 13 08:44:34.279 INFO [stdout] test addition_with_one_element_fails ... ok
Dec 13 08:44:34.279 INFO [stdout] test drop_with_empty_stack_fails ... ok
Dec 13 08:44:34.279 INFO [stdout] test division_works ... ok
Dec 13 08:44:34.279 INFO [stdout] test addition_with_empty_stack_fails ... ok
Dec 13 08:44:34.279 INFO [stdout] test double_quotes_work ... ok
Dec 13 08:44:34.279 INFO [stdout] test equal_with_empty_stack_fails ... ok
Dec 13 08:44:34.279 INFO [stdout] test equal_with_one_element_fails ... ok
Dec 13 08:44:34.279 INFO [stdout] test equal_works ... ok
Dec 13 08:44:34.279 INFO [stdout] test drop_works ... ok
Dec 13 08:44:34.279 INFO [stdout] test dup_with_empty_stack_fails ... ok
Dec 13 08:44:34.279 INFO [stdout] test greater_than_with_empty_stack_fails ... ok
Dec 13 08:44:34.279 INFO [stdout] test greater_than_with_one_element_fails ... ok
Dec 13 08:44:34.279 INFO [stdout] test greater_than_works ... ok
Dec 13 08:44:34.279 INFO [stdout] test end_works ... ok
Dec 13 08:44:34.279 INFO [stdout] test input_works ... ok
Dec 13 08:44:34.279 INFO [stdout] test invalid_code_does_not_run ... ok
Dec 13 08:44:34.287 INFO [stdout] test jump_too_far_wraps_to_zero ... ok
Dec 13 08:44:34.287 INFO [stdout] test dup_works ... ok
Dec 13 08:44:34.287 INFO [stdout] test jump_to_negative_position_fails ... ok
Dec 13 08:44:34.287 INFO [stdout] test jump_with_empty_stack_fails ... ok
Dec 13 08:44:34.287 INFO [stdout] test empty_code_does_not_run ... ok
Dec 13 08:44:34.295 INFO [stdout] test jump_with_one_element_fails ... ok
Dec 13 08:44:34.295 INFO [stdout] test jump_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test less_than_with_empty_stack_fails ... ok
Dec 13 08:44:34.295 INFO [stdout] test len_with_empty_stack_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test len_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test literal_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test lshift_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test mirror_down_to_up_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test mirror_multi_down_to_up_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test less_than_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test mirror_multi_left_to_right_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test mirror_multi_right_to_left_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test mirror_multi_up_to_down_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test mirror_right_to_down_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test mirror_right_to_up_works ... ok
Dec 13 08:44:34.295 INFO [stdout] test mirror_right_to_left_works ... ok
Dec 13 08:44:34.318 INFO [stdout] test move_right_works ... ok
Dec 13 08:44:34.318 INFO [stdout] test modulo_by_zero_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test modulo_with_empty_stack_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test modulo_with_one_element_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test modulo_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test less_than_with_one_element_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test move_down_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test move_left_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test multiplication_with_one_element_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test multiplication_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test new_stack_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test new_empty_stack_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test new_stack_with_negative_elements_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test new_stack_with_too_many_elements_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test num_output_float_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test multiplication_with_empty_stack_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test num_output_int_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test num_output_with_empty_stack_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test move_up_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test read_memory_outside_codebox_pushes_zero ... ok
Dec 13 08:44:34.327 INFO [stdout] test remove_last_stack_empties_it ... ok
Dec 13 08:44:34.327 INFO [stdout] test read_memory_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test read_memory_with_space_pushes_zero ... ok
Dec 13 08:44:34.327 INFO [stdout] test reverse_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test remove_stack_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test single_quotes_work ... ok
Dec 13 08:44:34.327 INFO [stdout] test skip_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test substraction_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test swap2_with_empty_stack_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test substraction_with_one_element_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test swap2_with_one_element_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test rshift_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test substraction_with_empty_stack_fails ... ok
Dec 13 08:44:34.327 INFO [stdout] test swap2_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test switch_register_from_empty_works ... ok
Dec 13 08:44:34.327 INFO [stdout] test swap2_with_two_elements_fails ... ok
Dec 13 08:44:34.335 INFO [stdout] test write_memory_with_current_value_is_nop ... ok
Dec 13 08:44:34.335 INFO [stdout] test switch_register_from_full_works ... ok
Dec 13 08:44:34.335 INFO [stdout] test write_memory_with_negative_coordinates_works ... ok
Dec 13 08:44:34.335 INFO [stdout] test swap_with_empty_stack_fails ... ok
Dec 13 08:44:34.335 INFO [stdout] test swap_works ... ok
Dec 13 08:44:34.335 INFO [stdout] test swap_with_one_element_fails ... ok
Dec 13 08:44:34.335 INFO [stdout] test switch_register_with_empty_stack_fails ... ok
Dec 13 08:44:34.335 INFO [stdout] test write_memory_with_empty_stack_fails ... ok
Dec 13 08:44:34.338 INFO [stdout] test write_memory_works ... ok
Dec 13 08:44:34.338 INFO [stderr]      Running /target/debug/deps/math_test-a6e8f4b528fc0162
Dec 13 08:44:34.338 INFO [stdout] test read_memory_with_one_element_fails ... ok
Dec 13 08:44:34.338 INFO [stdout] test read_memory_with_empty_stack_fails ... ok
Dec 13 08:44:34.338 INFO [stdout] 
Dec 13 08:44:34.338 INFO [stdout] test result: ok. 93 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:34.338 INFO [stdout] 
Dec 13 08:44:34.347 INFO [stdout] 
Dec 13 08:44:34.347 INFO [stdout] running 10 tests
Dec 13 08:44:34.347 INFO [stdout] test add_float_and_int_yields_float ... ok
Dec 13 08:44:34.347 INFO [stdout] test add_int_and_float_yields_float ... ok
Dec 13 08:44:34.347 INFO [stdout] test mul_float_and_int_yields_float ... ok
Dec 13 08:44:34.347 INFO [stdout] test mul_int_and_float_yields_float ... ok
Dec 13 08:44:34.347 INFO [stdout] test sub_float_and_int_yields_float ... ok
Dec 13 08:44:34.347 INFO [stdout] test sub_int_and_float_yields_float ... ok
Dec 13 08:44:34.347 INFO [stdout] test sub_floats_yields_float ... ok
Dec 13 08:44:34.347 INFO [stdout] test add_floats_yields_float ... ok
Dec 13 08:44:34.347 INFO [stdout] test mul_floats_yields_float ... ok
Dec 13 08:44:34.351 INFO [stdout] test mod_negative_value_works ... ok
Dec 13 08:44:34.351 INFO [stderr]    Doc-tests fish
Dec 13 08:44:34.351 INFO [stdout] 
Dec 13 08:44:34.351 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:34.351 INFO [stdout] 
Dec 13 08:44:34.999 INFO [stdout] 
Dec 13 08:44:34.999 INFO [stdout] running 0 tests
Dec 13 08:44:34.999 INFO [stdout] 
Dec 13 08:44:34.999 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:34.999 INFO [stdout] 
Dec 13 08:44:35.051 INFO [stderr] su: No module specific data is present
Dec 13 08:44:35.497 INFO running `"docker" "inspect" "73d871f575acc1f75ec6fb9d4234f2e423f86c80eeede6720740cf569247be47"`
Dec 13 08:44:35.595 INFO running `"docker" "rm" "-f" "73d871f575acc1f75ec6fb9d4234f2e423f86c80eeede6720740cf569247be47"`
Dec 13 08:44:35.718 INFO [stdout] 73d871f575acc1f75ec6fb9d4234f2e423f86c80eeede6720740cf569247be47