Dec 07 09:38:52.088 INFO testing joinkit-0.2.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 09:38:52.089 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 09:38:52.633 INFO [stdout] 4c1fa20e7a50ac1e93d7ec23a9ba80985fb864e97624cb4b9d593ba66676b365
Dec 07 09:38:52.635 INFO running `"docker" "start" "-a" "4c1fa20e7a50ac1e93d7ec23a9ba80985fb864e97624cb4b9d593ba66676b365"`
Dec 07 09:38:54.587 INFO [stderr] usermod: no changes
Dec 07 09:38:54.711 INFO [stderr]    Compiling joinkit v0.2.0 (/source)
Dec 07 09:38:56.072 INFO [stderr] warning: unused `#[macro_use]` import
Dec 07 09:38:56.072 INFO [stderr]   --> src/lib.rs:27:1
Dec 07 09:38:56.072 INFO [stderr]    |
Dec 07 09:38:56.072 INFO [stderr] 27 | #[macro_use]
Dec 07 09:38:56.072 INFO [stderr]    | ^^^^^^^^^^^^
Dec 07 09:38:56.072 INFO [stderr]    |
Dec 07 09:38:56.072 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Dec 07 09:38:56.072 INFO [stderr] 
Dec 07 09:38:56.280 INFO [stderr] warning: unused import: `itertools::Itertools`
Dec 07 09:38:56.280 INFO [stderr]  --> src/util.rs:3:5
Dec 07 09:38:56.280 INFO [stderr]   |
Dec 07 09:38:56.280 INFO [stderr] 3 | use itertools::Itertools;
Dec 07 09:38:56.280 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^
Dec 07 09:38:56.280 INFO [stderr] 
Dec 07 09:38:56.280 INFO [stderr] warning: unused import: `BufRead`
Dec 07 09:38:56.280 INFO [stderr]  --> src/util.rs:5:15
Dec 07 09:38:56.280 INFO [stderr]   |
Dec 07 09:38:56.280 INFO [stderr] 5 | use std::io::{BufRead, Write, BufWriter,};
Dec 07 09:38:56.280 INFO [stderr]   |               ^^^^^^^
Dec 07 09:38:56.280 INFO [stderr] 
Dec 07 09:39:02.528 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.91s
Dec 07 09:39:02.536 INFO [stderr] su: No module specific data is present
Dec 07 09:39:03.224 INFO running `"docker" "inspect" "4c1fa20e7a50ac1e93d7ec23a9ba80985fb864e97624cb4b9d593ba66676b365"`
Dec 07 09:39:03.618 INFO running `"docker" "rm" "-f" "4c1fa20e7a50ac1e93d7ec23a9ba80985fb864e97624cb4b9d593ba66676b365"`
Dec 07 09:39:03.998 INFO [stdout] 4c1fa20e7a50ac1e93d7ec23a9ba80985fb864e97624cb4b9d593ba66676b365
Dec 07 09:39:04.002 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 09:39:04.420 INFO [stdout] 21e6bfdfc5ee099d68d235a05aba5cc08f68775fbd145e66f4fb69b8f874b8fa
Dec 07 09:39:04.428 INFO running `"docker" "start" "-a" "21e6bfdfc5ee099d68d235a05aba5cc08f68775fbd145e66f4fb69b8f874b8fa"`
Dec 07 09:39:05.888 INFO [stderr] usermod: no changes
Dec 07 09:39:06.004 INFO [stderr]    Compiling joinkit v0.2.0 (/source)
Dec 07 09:39:11.972 INFO [stderr] warning: unused `#[macro_use]` import
Dec 07 09:39:11.972 INFO [stderr]   --> src/lib.rs:27:1
Dec 07 09:39:11.972 INFO [stderr]    |
Dec 07 09:39:11.972 INFO [stderr] 27 | #[macro_use]
Dec 07 09:39:11.972 INFO [stderr]    | ^^^^^^^^^^^^
Dec 07 09:39:11.972 INFO [stderr]    |
Dec 07 09:39:11.972 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Dec 07 09:39:11.972 INFO [stderr] 
Dec 07 09:39:13.060 INFO [stderr] warning: unused import: `itertools::Itertools`
Dec 07 09:39:13.060 INFO [stderr]  --> src/util.rs:3:5
Dec 07 09:39:13.060 INFO [stderr]   |
Dec 07 09:39:13.060 INFO [stderr] 3 | use itertools::Itertools;
Dec 07 09:39:13.060 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^
Dec 07 09:39:13.060 INFO [stderr] 
Dec 07 09:39:13.061 INFO [stderr] warning: unused import: `BufRead`
Dec 07 09:39:13.061 INFO [stderr]  --> src/util.rs:5:15
Dec 07 09:39:13.061 INFO [stderr]   |
Dec 07 09:39:13.061 INFO [stderr] 5 | use std::io::{BufRead, Write, BufWriter,};
Dec 07 09:39:13.061 INFO [stderr]   |               ^^^^^^^
Dec 07 09:39:13.061 INFO [stderr] 
Dec 07 09:39:16.976 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.05s
Dec 07 09:39:16.981 INFO [stderr] su: No module specific data is present
Dec 07 09:39:18.114 INFO running `"docker" "inspect" "21e6bfdfc5ee099d68d235a05aba5cc08f68775fbd145e66f4fb69b8f874b8fa"`
Dec 07 09:39:18.490 INFO running `"docker" "rm" "-f" "21e6bfdfc5ee099d68d235a05aba5cc08f68775fbd145e66f4fb69b8f874b8fa"`
Dec 07 09:39:18.908 INFO [stdout] 21e6bfdfc5ee099d68d235a05aba5cc08f68775fbd145e66f4fb69b8f874b8fa
Dec 07 09:39:18.914 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-3/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 09:39:19.557 INFO [stdout] a65c46943c975e1e4dc940adbf3b3427152ade9f2395d2a3df4967c2d34c3b13
Dec 07 09:39:19.562 INFO running `"docker" "start" "-a" "a65c46943c975e1e4dc940adbf3b3427152ade9f2395d2a3df4967c2d34c3b13"`
Dec 07 09:39:20.980 INFO [stderr] usermod: no changes
Dec 07 09:39:21.092 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
Dec 07 09:39:21.101 INFO [stderr]      Running /target/debug/deps/joinkit-5d044f33c981a229
Dec 07 09:39:21.112 INFO [stderr]      Running /target/debug/deps/hjoin-539a6f13caa453c5
Dec 07 09:39:21.112 INFO [stdout] 
Dec 07 09:39:21.112 INFO [stderr]      Running /target/debug/deps/mjoin-1a59589ac5339e8d
Dec 07 09:39:21.112 INFO [stdout] running 0 tests
Dec 07 09:39:21.112 INFO [stdout] 
Dec 07 09:39:21.112 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:39:21.112 INFO [stdout] 
Dec 07 09:39:21.112 INFO [stdout] 
Dec 07 09:39:21.112 INFO [stdout] running 0 tests
Dec 07 09:39:21.112 INFO [stdout] 
Dec 07 09:39:21.112 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:39:21.112 INFO [stdout] 
Dec 07 09:39:21.112 INFO [stdout] 
Dec 07 09:39:21.112 INFO [stderr]      Running /target/debug/deps/hash_join-842d2cae8e1a4a36
Dec 07 09:39:21.112 INFO [stdout] running 0 tests
Dec 07 09:39:21.112 INFO [stdout] 
Dec 07 09:39:21.112 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:39:21.112 INFO [stdout] 
Dec 07 09:39:21.118 INFO [stdout] 
Dec 07 09:39:21.118 INFO [stdout] running 12 tests
Dec 07 09:39:21.118 INFO [stdout] test left_excl_fused_inv ... ok
Dec 07 09:39:21.118 INFO [stdout] test left_outer_fused ... ok
Dec 07 09:39:21.118 INFO [stdout] test left_outer_fused_inv ... ok
Dec 07 09:39:21.118 INFO [stdout] test left_excl_fused ... ok
Dec 07 09:39:21.118 INFO [stdout] test inner_fused_inv ... ok
Dec 07 09:39:21.118 INFO [stdout] test inner_fused ... ok
Dec 07 09:39:21.118 INFO [stdout] test full_outer_fused_inv ... ok
Dec 07 09:39:21.119 INFO [stdout] test full_outer_fused ... ok
Dec 07 09:39:21.119 INFO [stdout] test right_excl_fused ... ok
Dec 07 09:39:21.119 INFO [stdout] test right_excl_fused_inv ... ok
Dec 07 09:39:21.119 INFO [stdout] test right_outer_fused ... ok
Dec 07 09:39:21.119 INFO [stdout] test right_outer_fused_inv ... ok
Dec 07 09:39:21.119 INFO [stdout] 
Dec 07 09:39:21.119 INFO [stdout] test result: ok. 12 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:39:21.119 INFO [stdout] 
Dec 07 09:39:21.121 INFO [stdout] 
Dec 07 09:39:21.121 INFO [stderr]      Running /target/debug/deps/merge_join-b275abf755ffdbfc
Dec 07 09:39:21.121 INFO [stdout] running 8 tests
Dec 07 09:39:21.121 INFO [stdout] test left_outer_fused ... ok
Dec 07 09:39:21.122 INFO [stdout] test left_outer_fused_inv ... ok
Dec 07 09:39:21.124 INFO [stdout] test left_excl_fused_inv ... ok
Dec 07 09:39:21.124 INFO [stdout] test left_excl_fused ... ok
Dec 07 09:39:21.125 INFO [stdout] test inner_fused_inv ... ok
Dec 07 09:39:21.125 INFO [stdout] test inner_fused ... ok
Dec 07 09:39:21.125 INFO [stdout] test full_outer_fused_inv ... ok
Dec 07 09:39:21.125 INFO [stdout] test full_outer_fused ... ok
Dec 07 09:39:21.125 INFO [stdout] 
Dec 07 09:39:21.126 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:39:21.126 INFO [stdout] 
Dec 07 09:39:21.128 INFO [stdout] 
Dec 07 09:39:21.128 INFO [stderr]      Running /target/debug/deps/util-f2f1d7e82559d411
Dec 07 09:39:21.128 INFO [stdout] running 4 tests
Dec 07 09:39:21.128 INFO [stdout] test extract_key_single_ne ... ok
Dec 07 09:39:21.128 INFO [stdout] test extract_key_single_eq ... ok
Dec 07 09:39:21.128 INFO [stdout] test extract_key_multiple_ne ... ok
Dec 07 09:39:21.129 INFO [stdout] test extract_key_multiple_eq ... ok
Dec 07 09:39:21.129 INFO [stdout] 
Dec 07 09:39:21.129 INFO [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:39:21.129 INFO [stdout] 
Dec 07 09:39:21.132 INFO [stderr]    Doc-tests joinkit
Dec 07 09:39:23.137 INFO [stdout] 
Dec 07 09:39:23.137 INFO [stdout] running 15 tests
Dec 07 09:39:34.532 INFO [stdout] test src/lib.rs - Joinkit::hash_join_full_outer (line 403) ... ok
Dec 07 09:39:34.919 INFO [stdout] test src/lib.rs - Joinkit::hash_join_left_excl (line 245) ... ok
Dec 07 09:39:36.504 INFO [stdout] test src/lib.rs - Joinkit::hash_join_inner (line 209) ... ok
Dec 07 09:39:38.348 INFO [stdout] test src/lib.rs -  (line 20) ... ok
Dec 07 09:39:38.624 INFO [stdout] test src/lib.rs - Joinkit::merge_join_full_outer_by (line 165) ... ok
Dec 07 09:39:39.596 INFO [stdout] test src/lib.rs - Joinkit::hash_join_right_outer (line 361) ... ok
Dec 07 09:39:40.316 INFO [stdout] test src/lib.rs - Joinkit::hash_join_right_excl (line 322) ... ok
Dec 07 09:39:42.585 INFO [stdout] test src/lib.rs - Joinkit::hash_join_left_outer (line 284) ... ok
Dec 07 09:39:47.568 INFO [stdout] test src/lib.rs - Joinkit::merge_join_left_outer_by (line 131) ... ok
Dec 07 09:39:48.460 INFO [stdout] test src/util.rs - util::extract_key (line 143) ... ok
Dec 07 09:39:48.468 INFO [stdout] test src/lib.rs - Joinkit::merge_join_left_excl_by (line 99) ... ok
Dec 07 09:39:48.860 INFO [stdout] test src/lib.rs - Joinkit::merge_join_inner_by (line 68) ... ok
Dec 07 09:39:49.030 INFO [stdout] test src/util.rs - util::fields_to_idx (line 58) ... ok
Dec 07 09:39:49.291 INFO [stdout] test src/util.rs - util::extract_key_value (line 208) ... ok
Dec 07 09:39:49.808 INFO [stdout] test src/util.rs - util::num_fields (line 236) ... ok
Dec 07 09:39:49.808 INFO [stdout] 
Dec 07 09:39:49.808 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:39:49.808 INFO [stdout] 
Dec 07 09:39:49.840 INFO [stderr] su: No module specific data is present
Dec 07 09:39:50.702 INFO running `"docker" "inspect" "a65c46943c975e1e4dc940adbf3b3427152ade9f2395d2a3df4967c2d34c3b13"`
Dec 07 09:39:50.872 INFO running `"docker" "rm" "-f" "a65c46943c975e1e4dc940adbf3b3427152ade9f2395d2a3df4967c2d34c3b13"`
Dec 07 09:39:51.128 INFO [stdout] a65c46943c975e1e4dc940adbf3b3427152ade9f2395d2a3df4967c2d34c3b13