Dec 13 08:44:19.376 INFO testing noirotm/fishr against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 08:44:19.376 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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.900 INFO [stdout] 1ec29b5b7b34952fe3322190ee99e67caf751c890668bf073b64483f43d42d5d
Dec 13 08:44:19.904 INFO running `"docker" "start" "-a" "1ec29b5b7b34952fe3322190ee99e67caf751c890668bf073b64483f43d42d5d"`
Dec 13 08:44:21.115 INFO [stderr] usermod: no changes
Dec 13 08:44:21.251 INFO [stderr]    Compiling fishr v0.1.0 (/source)
Dec 13 08:44:25.433 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.28s
Dec 13 08:44:25.438 INFO [stderr] su: No module specific data is present
Dec 13 08:44:25.835 INFO running `"docker" "inspect" "1ec29b5b7b34952fe3322190ee99e67caf751c890668bf073b64483f43d42d5d"`
Dec 13 08:44:25.979 INFO running `"docker" "rm" "-f" "1ec29b5b7b34952fe3322190ee99e67caf751c890668bf073b64483f43d42d5d"`
Dec 13 08:44:26.092 INFO [stdout] 1ec29b5b7b34952fe3322190ee99e67caf751c890668bf073b64483f43d42d5d
Dec 13 08:44:26.094 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:26.335 INFO [stdout] 5781e5b3894cb37ae7c7338ce49e5bda6c72b07cd4922cd6cab7e2928edd4f4b
Dec 13 08:44:26.337 INFO running `"docker" "start" "-a" "5781e5b3894cb37ae7c7338ce49e5bda6c72b07cd4922cd6cab7e2928edd4f4b"`
Dec 13 08:44:27.795 INFO [stderr] usermod: no changes
Dec 13 08:44:27.873 INFO [stderr]    Compiling fishr v0.1.0 (/source)
Dec 13 08:44:32.347 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.52s
Dec 13 08:44:32.347 INFO [stderr] su: No module specific data is present
Dec 13 08:44:33.124 INFO running `"docker" "inspect" "5781e5b3894cb37ae7c7338ce49e5bda6c72b07cd4922cd6cab7e2928edd4f4b"`
Dec 13 08:44:33.499 INFO running `"docker" "rm" "-f" "5781e5b3894cb37ae7c7338ce49e5bda6c72b07cd4922cd6cab7e2928edd4f4b"`
Dec 13 08:44:33.827 INFO [stdout] 5781e5b3894cb37ae7c7338ce49e5bda6c72b07cd4922cd6cab7e2928edd4f4b
Dec 13 08:44:33.835 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:34.247 INFO [stdout] f6517eebc8b5e0e8cc4bf9a1aac8640f68b4fc7b54d51ad9bc2dba303c650be2
Dec 13 08:44:34.248 INFO running `"docker" "start" "-a" "f6517eebc8b5e0e8cc4bf9a1aac8640f68b4fc7b54d51ad9bc2dba303c650be2"`
Dec 13 08:44:35.219 INFO [stderr] usermod: no changes
Dec 13 08:44:35.253 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 13 08:44:35.265 INFO [stderr]      Running /target/debug/deps/fish-ea93052f062f5d6b
Dec 13 08:44:35.267 INFO [stdout] 
Dec 13 08:44:35.267 INFO [stdout] running 39 tests
Dec 13 08:44:35.271 INFO [stdout] test stack::tests::stack::drop_with_empty_stack_fails ... ok
Dec 13 08:44:35.271 INFO [stdout] test stack::tests::stack::dup_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::dup_with_empty_stack_fails ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::drop_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::lshift_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::swap2_with_two_elements_fails ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::swap2_with_one_element_fails ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::rshift_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::swap2_with_empty_stack_fails ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::push_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::pop_empty_stack_returns_none ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::swap2_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::new_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::swap_with_empty_stack_fails ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::swap_with_one_element_fails ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::swap_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::switch_empty_register_on_empty_stack_fails ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack::switch_register_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack_of_stacks::new_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack_of_stacks::pop_initial_stack_makes_it_empty ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack_of_stacks::pop_stack_with_base_register_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack_of_stacks::pop_stack_with_top_register_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack_of_stacks::pop_stack_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test tests::codebox_with_one_column ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack_of_stacks::push_stack_with_all_elements_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack_of_stacks::push_stack_with_too_many_values_fails ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack_of_stacks::push_stack_with_zero_elements_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test stack::tests::stack_of_stacks::push_stack_works ... ok
Dec 13 08:44:35.273 INFO [stdout] test tests::codebox_data_is_ok ... ok
Dec 13 08:44:35.273 INFO [stdout] test tests::codebox_with_one_line ... ok
Dec 13 08:44:35.274 INFO [stdout] test tests::codebox_with_three_lines ... ok
Dec 13 08:44:35.274 INFO [stdout] test tests::empty_code_box ... ok
Dec 13 08:44:35.274 INFO [stdout] test tests::push_i64_works ... ok
Dec 13 08:44:35.274 INFO [stdout] test tests::push_str_works ... ok
Dec 13 08:44:35.274 INFO [stdout] test val::tests::val_eq_works ... ok
Dec 13 08:44:35.274 INFO [stdout] test val::tests::val_to_f64_works ... ok
Dec 13 08:44:35.274 INFO [stdout] test val::tests::val_to_i64_works ... ok
Dec 13 08:44:35.274 INFO [stdout] test val::tests::val_to_u8_works ... ok
Dec 13 08:44:35.279 INFO [stdout] test stack::tests::stack::pop_works ... ok
Dec 13 08:44:35.280 INFO [stdout] 
Dec 13 08:44:35.280 INFO [stdout] test result: ok. 39 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:35.280 INFO [stdout] 
Dec 13 08:44:35.280 INFO [stderr]      Running /target/debug/deps/fishr-2c9bdfdcc2150e6b
Dec 13 08:44:35.284 INFO [stderr]      Running /target/debug/deps/interpreter_test-0d0f2ddeac718557
Dec 13 08:44:35.284 INFO [stdout] 
Dec 13 08:44:35.284 INFO [stdout] running 0 tests
Dec 13 08:44:35.284 INFO [stdout] 
Dec 13 08:44:35.284 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:35.284 INFO [stdout] 
Dec 13 08:44:35.286 INFO [stdout] 
Dec 13 08:44:35.286 INFO [stdout] running 93 tests
Dec 13 08:44:35.287 INFO [stdout] test addition_works ... ok
Dec 13 08:44:35.287 INFO [stdout] test addition_with_empty_stack_fails ... ok
Dec 13 08:44:35.287 INFO [stdout] test char_output_with_empty_stack_fails ... ok
Dec 13 08:44:35.288 INFO [stdout] test char_output_works ... ok
Dec 13 08:44:35.288 INFO [stdout] test conditional_trampoline_with_empty_stack_fails ... ok
Dec 13 08:44:35.288 INFO [stdout] test addition_with_one_element_fails ... ok
Dec 13 08:44:35.289 INFO [stdout] test conditional_trampoline_skips_next_with_zero ... ok
Dec 13 08:44:35.289 INFO [stdout] test division_with_empty_stack_fails ... ok
Dec 13 08:44:35.289 INFO [stdout] test conditional_trampoline_executes_next_with_non_zero ... ok
Dec 13 08:44:35.289 INFO [stdout] test division_by_zero_fails ... ok
Dec 13 08:44:35.290 INFO [stdout] test division_with_one_element_fails ... ok
Dec 13 08:44:35.290 INFO [stdout] test drop_works ... ok
Dec 13 08:44:35.290 INFO [stdout] test double_quotes_work ... ok
Dec 13 08:44:35.290 INFO [stdout] test end_works ... ok
Dec 13 08:44:35.290 INFO [stdout] test division_works ... ok
Dec 13 08:44:35.290 INFO [stdout] test drop_with_empty_stack_fails ... ok
Dec 13 08:44:35.291 INFO [stdout] test dup_with_empty_stack_fails ... ok
Dec 13 08:44:35.291 INFO [stdout] test greater_than_with_empty_stack_fails ... ok
Dec 13 08:44:35.291 INFO [stdout] test equal_with_empty_stack_fails ... ok
Dec 13 08:44:35.291 INFO [stdout] test empty_code_does_not_run ... ok
Dec 13 08:44:35.292 INFO [stdout] test invalid_code_does_not_run ... ok
Dec 13 08:44:35.292 INFO [stdout] test jump_to_negative_position_fails ... ok
Dec 13 08:44:35.292 INFO [stdout] test jump_with_empty_stack_fails ... ok
Dec 13 08:44:35.292 INFO [stdout] test equal_works ... ok
Dec 13 08:44:35.292 INFO [stdout] test equal_with_one_element_fails ... ok
Dec 13 08:44:35.293 INFO [stdout] test greater_than_with_one_element_fails ... ok
Dec 13 08:44:35.293 INFO [stdout] test jump_too_far_wraps_to_zero ... ok
Dec 13 08:44:35.293 INFO [stdout] test jump_works ... ok
Dec 13 08:44:35.293 INFO [stdout] test jump_with_one_element_fails ... ok
Dec 13 08:44:35.294 INFO [stdout] test greater_than_works ... ok
Dec 13 08:44:35.294 INFO [stdout] test dup_works ... ok
Dec 13 08:44:35.294 INFO [stdout] test input_works ... ok
Dec 13 08:44:35.294 INFO [stdout] test less_than_works ... ok
Dec 13 08:44:35.294 INFO [stdout] test lshift_works ... ok
Dec 13 08:44:35.295 INFO [stdout] test len_with_empty_stack_works ... ok
Dec 13 08:44:35.295 INFO [stdout] test mirror_multi_left_to_right_works ... ok
Dec 13 08:44:35.295 INFO [stdout] test len_works ... ok
Dec 13 08:44:35.295 INFO [stdout] test less_than_with_empty_stack_fails ... ok
Dec 13 08:44:35.296 INFO [stdout] test mirror_multi_down_to_up_works ... ok
Dec 13 08:44:35.296 INFO [stdout] test mirror_multi_right_to_left_works ... ok
Dec 13 08:44:35.296 INFO [stdout] test mirror_right_to_left_works ... ok
Dec 13 08:44:35.296 INFO [stdout] test mirror_right_to_down_works ... ok
Dec 13 08:44:35.296 INFO [stdout] test mirror_multi_up_to_down_works ... ok
Dec 13 08:44:35.296 INFO [stdout] test less_than_with_one_element_fails ... ok
Dec 13 08:44:35.296 INFO [stdout] test mirror_down_to_up_works ... ok
Dec 13 08:44:35.296 INFO [stdout] test mirror_right_to_up_works ... ok
Dec 13 08:44:35.297 INFO [stdout] test literal_works ... ok
Dec 13 08:44:35.297 INFO [stdout] test move_down_works ... ok
Dec 13 08:44:35.297 INFO [stdout] test modulo_with_empty_stack_fails ... ok
Dec 13 08:44:35.298 INFO [stdout] test move_left_works ... ok
Dec 13 08:44:35.298 INFO [stdout] test modulo_with_one_element_fails ... ok
Dec 13 08:44:35.299 INFO [stdout] test modulo_works ... ok
Dec 13 08:44:35.299 INFO [stdout] test multiplication_with_one_element_fails ... ok
Dec 13 08:44:35.299 INFO [stdout] test multiplication_with_empty_stack_fails ... ok
Dec 13 08:44:35.299 INFO [stdout] test new_stack_with_negative_elements_fails ... ok
Dec 13 08:44:35.299 INFO [stdout] test modulo_by_zero_fails ... ok
Dec 13 08:44:35.299 INFO [stdout] test new_stack_with_too_many_elements_fails ... ok
Dec 13 08:44:35.301 INFO [stdout] test move_up_works ... ok
Dec 13 08:44:35.301 INFO [stdout] test move_right_works ... ok
Dec 13 08:44:35.301 INFO [stdout] test read_memory_outside_codebox_pushes_zero ... ok
Dec 13 08:44:35.301 INFO [stdout] test read_memory_with_one_element_fails ... ok
Dec 13 08:44:35.301 INFO [stdout] test read_memory_with_empty_stack_fails ... ok
Dec 13 08:44:35.301 INFO [stdout] test read_memory_works ... ok
Dec 13 08:44:35.301 INFO [stdout] test read_memory_with_space_pushes_zero ... ok
Dec 13 08:44:35.301 INFO [stdout] test remove_last_stack_empties_it ... ok
Dec 13 08:44:35.301 INFO [stdout] test remove_stack_works ... ok
Dec 13 08:44:35.301 INFO [stdout] test num_output_float_works ... ok
Dec 13 08:44:35.301 INFO [stdout] test rshift_works ... ok
Dec 13 08:44:35.301 INFO [stdout] test num_output_with_empty_stack_fails ... ok
Dec 13 08:44:35.301 INFO [stdout] test reverse_works ... ok
Dec 13 08:44:35.302 INFO [stdout] test substraction_with_one_element_fails ... ok
Dec 13 08:44:35.302 INFO [stdout] test single_quotes_work ... ok
Dec 13 08:44:35.302 INFO [stdout] test substraction_with_empty_stack_fails ... ok
Dec 13 08:44:35.302 INFO [stdout] test num_output_int_works ... ok
Dec 13 08:44:35.302 INFO [stdout] test skip_works ... ok
Dec 13 08:44:35.302 INFO [stdout] test substraction_works ... ok
Dec 13 08:44:35.302 INFO [stdout] test swap2_with_two_elements_fails ... ok
Dec 13 08:44:35.303 INFO [stdout] test swap_with_one_element_fails ... ok
Dec 13 08:44:35.303 INFO [stdout] test new_stack_works ... ok
Dec 13 08:44:35.303 INFO [stdout] test swap2_works ... ok
Dec 13 08:44:35.303 INFO [stdout] test swap_with_empty_stack_fails ... ok
Dec 13 08:44:35.303 INFO [stdout] test swap2_with_empty_stack_fails ... ok
Dec 13 08:44:35.303 INFO [stdout] test swap_works ... ok
Dec 13 08:44:35.303 INFO [stdout] test swap2_with_one_element_fails ... ok
Dec 13 08:44:35.303 INFO [stdout] test write_memory_with_current_value_is_nop ... ok
Dec 13 08:44:35.303 INFO [stdout] test multiplication_works ... ok
Dec 13 08:44:35.304 INFO [stdout] test write_memory_with_negative_coordinates_works ... ok
Dec 13 08:44:35.304 INFO [stdout] test switch_register_with_empty_stack_fails ... ok
Dec 13 08:44:35.304 INFO [stdout] test switch_register_from_full_works ... ok
Dec 13 08:44:35.304 INFO [stdout] test switch_register_from_empty_works ... ok
Dec 13 08:44:35.304 INFO [stdout] test write_memory_with_empty_stack_fails ... ok
Dec 13 08:44:35.304 INFO [stdout] test new_empty_stack_works ... ok
Dec 13 08:44:35.305 INFO [stdout] test write_memory_works ... ok
Dec 13 08:44:35.305 INFO [stderr]      Running /target/debug/deps/math_test-75416441a9c6a4ab
Dec 13 08:44:35.305 INFO [stdout] 
Dec 13 08:44:35.305 INFO [stdout] test result: ok. 93 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:35.305 INFO [stdout] 
Dec 13 08:44:35.306 INFO [stdout] 
Dec 13 08:44:35.306 INFO [stdout] running 10 tests
Dec 13 08:44:35.308 INFO [stdout] test add_float_and_int_yields_float ... ok
Dec 13 08:44:35.308 INFO [stdout] test add_int_and_float_yields_float ... ok
Dec 13 08:44:35.309 INFO [stdout] test mul_int_and_float_yields_float ... ok
Dec 13 08:44:35.309 INFO [stdout] test mul_floats_yields_float ... ok
Dec 13 08:44:35.309 INFO [stdout] test sub_floats_yields_float ... ok
Dec 13 08:44:35.309 INFO [stdout] test sub_float_and_int_yields_float ... ok
Dec 13 08:44:35.309 INFO [stdout] test mod_negative_value_works ... ok
Dec 13 08:44:35.309 INFO [stdout] test mul_float_and_int_yields_float ... ok
Dec 13 08:44:35.310 INFO [stdout] test add_floats_yields_float ... ok
Dec 13 08:44:35.314 INFO [stdout] test sub_int_and_float_yields_float ... ok
Dec 13 08:44:35.314 INFO [stdout] 
Dec 13 08:44:35.315 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:35.315 INFO [stdout] 
Dec 13 08:44:35.315 INFO [stderr]    Doc-tests fish
Dec 13 08:44:35.825 INFO [stdout] 
Dec 13 08:44:35.825 INFO [stdout] running 0 tests
Dec 13 08:44:35.825 INFO [stdout] 
Dec 13 08:44:35.825 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 08:44:35.825 INFO [stdout] 
Dec 13 08:44:35.830 INFO [stderr] su: No module specific data is present
Dec 13 08:44:36.086 INFO running `"docker" "inspect" "f6517eebc8b5e0e8cc4bf9a1aac8640f68b4fc7b54d51ad9bc2dba303c650be2"`
Dec 13 08:44:36.155 INFO running `"docker" "rm" "-f" "f6517eebc8b5e0e8cc4bf9a1aac8640f68b4fc7b54d51ad9bc2dba303c650be2"`
Dec 13 08:44:36.278 INFO [stdout] f6517eebc8b5e0e8cc4bf9a1aac8640f68b4fc7b54d51ad9bc2dba303c650be2