Nov 17 23:01:11.387 INFO testing shine-graph-0.1.0 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 23:01:11.389 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 23:01:11.831 INFO [stdout] 71cc5a037ac881e7b723cad159d8e8bc8b82d091ecc71111055e0d73f8a3e953
Nov 17 23:01:11.834 INFO running `"docker" "start" "-a" "71cc5a037ac881e7b723cad159d8e8bc8b82d091ecc71111055e0d73f8a3e953"`
Nov 17 23:01:14.131 INFO [stderr] usermod: no changes
Nov 17 23:01:14.243 INFO [stderr]    Compiling shine-graph v0.1.0 (/source)
Nov 17 23:01:14.251 INFO [stderr]    Compiling shine-store v0.2.0
Nov 17 23:01:14.251 INFO [stderr]    Compiling syn v0.15.21
Nov 17 23:01:33.759 INFO [stderr]    Compiling shine-graph-macro v0.1.1
Nov 17 23:01:42.396 INFO [stderr] warning: the feature `tool_lints` has been stable since 1.31.0 and no longer requires an attribute to enable
Nov 17 23:01:42.397 INFO [stderr]  --> src/lib.rs:5:12
Nov 17 23:01:42.397 INFO [stderr]   |
Nov 17 23:01:42.397 INFO [stderr] 5 | #![feature(tool_lints)]
Nov 17 23:01:42.397 INFO [stderr]   |            ^^^^^^^^^^
Nov 17 23:01:42.398 INFO [stderr]   |
Nov 17 23:01:42.398 INFO [stderr]   = note: #[warn(stable_features)] on by default
Nov 17 23:01:42.398 INFO [stderr] 
Nov 17 23:01:42.407 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 17 23:01:42.407 INFO [stderr]    --> src/svec/svector.rs:176:9
Nov 17 23:01:42.407 INFO [stderr]     |
Nov 17 23:01:42.408 INFO [stderr] 176 |         write!(f, "[");
Nov 17 23:01:42.408 INFO [stderr]     |         ^^^^^^^^^^^^^^^
Nov 17 23:01:42.409 INFO [stderr]     |
Nov 17 23:01:42.409 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Nov 17 23:01:42.409 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 17 23:01:42.409 INFO [stderr]     = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Nov 17 23:01:42.410 INFO [stderr] 
Nov 17 23:01:42.410 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 17 23:01:42.410 INFO [stderr]    --> src/svec/svector.rs:181:9
Nov 17 23:01:42.411 INFO [stderr]     |
Nov 17 23:01:42.411 INFO [stderr] 181 |         write!(f, "]");
Nov 17 23:01:42.411 INFO [stderr]     |         ^^^^^^^^^^^^^^^
Nov 17 23:01:42.412 INFO [stderr]     |
Nov 17 23:01:42.412 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 17 23:01:42.412 INFO [stderr]     = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Nov 17 23:01:42.412 INFO [stderr] 
Nov 17 23:01:42.883 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 28.73s
Nov 17 23:01:42.887 INFO [stderr] su: No module specific data is present
Nov 17 23:01:44.018 INFO running `"docker" "inspect" "71cc5a037ac881e7b723cad159d8e8bc8b82d091ecc71111055e0d73f8a3e953"`
Nov 17 23:01:44.369 INFO running `"docker" "rm" "-f" "71cc5a037ac881e7b723cad159d8e8bc8b82d091ecc71111055e0d73f8a3e953"`
Nov 17 23:01:44.758 INFO [stdout] 71cc5a037ac881e7b723cad159d8e8bc8b82d091ecc71111055e0d73f8a3e953
Nov 17 23:01:44.764 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 23:01:45.171 INFO [stdout] dcd0d5f0dd32f9604ed51f2529c63b351401dafe886b4ad1e3bc31472e497455
Nov 17 23:01:45.176 INFO running `"docker" "start" "-a" "dcd0d5f0dd32f9604ed51f2529c63b351401dafe886b4ad1e3bc31472e497455"`
Nov 17 23:01:45.983 INFO [stderr] usermod: no changes
Nov 17 23:01:46.144 INFO [stderr]    Compiling shine-testutils v0.1.0
Nov 17 23:01:47.189 INFO [stderr]    Compiling shine-graph v0.1.0 (/source)
Nov 17 23:01:58.915 INFO [stderr] warning: the feature `tool_lints` has been stable since 1.31.0 and no longer requires an attribute to enable
Nov 17 23:01:58.915 INFO [stderr]  --> src/lib.rs:5:12
Nov 17 23:01:58.915 INFO [stderr]   |
Nov 17 23:01:58.916 INFO [stderr] 5 | #![feature(tool_lints)]
Nov 17 23:01:58.916 INFO [stderr]   |            ^^^^^^^^^^
Nov 17 23:01:58.917 INFO [stderr]   |
Nov 17 23:01:58.917 INFO [stderr]   = note: #[warn(stable_features)] on by default
Nov 17 23:01:58.917 INFO [stderr] 
Nov 17 23:01:59.019 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 17 23:01:59.019 INFO [stderr]    --> src/svec/svector.rs:176:9
Nov 17 23:01:59.019 INFO [stderr]     |
Nov 17 23:01:59.020 INFO [stderr] 176 |         write!(f, "[");
Nov 17 23:01:59.020 INFO [stderr]     |         ^^^^^^^^^^^^^^^
Nov 17 23:01:59.021 INFO [stderr]     |
Nov 17 23:01:59.021 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Nov 17 23:01:59.022 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 17 23:01:59.022 INFO [stderr]     = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Nov 17 23:01:59.023 INFO [stderr] 
Nov 17 23:01:59.023 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 17 23:01:59.024 INFO [stderr]    --> src/svec/svector.rs:181:9
Nov 17 23:01:59.024 INFO [stderr]     |
Nov 17 23:01:59.025 INFO [stderr] 181 |         write!(f, "]");
Nov 17 23:01:59.025 INFO [stderr]     |         ^^^^^^^^^^^^^^^
Nov 17 23:01:59.026 INFO [stderr]     |
Nov 17 23:01:59.026 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 17 23:01:59.027 INFO [stderr]     = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Nov 17 23:01:59.027 INFO [stderr] 
Nov 17 23:02:03.455 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 17.44s
Nov 17 23:02:03.466 INFO [stderr] su: No module specific data is present
Nov 17 23:02:04.967 INFO running `"docker" "inspect" "dcd0d5f0dd32f9604ed51f2529c63b351401dafe886b4ad1e3bc31472e497455"`
Nov 17 23:02:05.321 INFO running `"docker" "rm" "-f" "dcd0d5f0dd32f9604ed51f2529c63b351401dafe886b4ad1e3bc31472e497455"`
Nov 17 23:02:05.675 INFO [stdout] dcd0d5f0dd32f9604ed51f2529c63b351401dafe886b4ad1e3bc31472e497455
Nov 17 23:02:05.685 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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"`
Nov 17 23:02:06.227 INFO [stdout] d614259a995cabbd30ea742ed43f8bff97173fc989028540d9da81eb4efe8b64
Nov 17 23:02:06.229 INFO running `"docker" "start" "-a" "d614259a995cabbd30ea742ed43f8bff97173fc989028540d9da81eb4efe8b64"`
Nov 17 23:02:07.786 INFO [stderr] usermod: no changes
Nov 17 23:02:07.869 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Nov 17 23:02:07.885 INFO [stderr]      Running /target/debug/deps/shine_graph-774d0e28411ba45f
Nov 17 23:02:07.887 INFO [stdout] 
Nov 17 23:02:07.887 INFO [stdout] running 0 tests
Nov 17 23:02:07.887 INFO [stdout] 
Nov 17 23:02:07.887 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:02:07.887 INFO [stdout] 
Nov 17 23:02:07.889 INFO [stderr]      Running /target/debug/deps/bitset-ffc10540714c80e9
Nov 17 23:02:07.891 INFO [stdout] 
Nov 17 23:02:07.891 INFO [stdout] running 6 tests
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: clear - u8
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: clear - u16
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: clear - u32
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: clear - u64
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: clear - u128
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops random - u8
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: set random bits
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate or
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate and
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops random - u16
Nov 17 23:02:07.899 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: set random bits
Nov 17 23:02:07.901 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops - u8
Nov 17 23:02:07.901 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops - u16
Nov 17 23:02:07.901 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops - u32
Nov 17 23:02:07.901 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops - u64
Nov 17 23:02:07.901 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops - u128
Nov 17 23:02:07.903 INFO [stdout] test test_clear ... ok
Nov 17 23:02:07.903 INFO [stdout] test test_ops ... ok
Nov 17 23:02:07.904 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: stress - u8
Nov 17 23:02:07.904 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: set one bit
Nov 17 23:02:07.905 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate or
Nov 17 23:02:07.906 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate and
Nov 17 23:02:07.907 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops random - u32
Nov 17 23:02:07.911 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: set random bits
Nov 17 23:02:07.911 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate or
Nov 17 23:02:07.911 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate and
Nov 17 23:02:07.911 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops random - u64
Nov 17 23:02:07.911 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: set random bits
Nov 17 23:02:07.912 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: simple u8
Nov 17 23:02:07.913 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate or
Nov 17 23:02:07.914 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate and
Nov 17 23:02:07.915 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: ops random - u128
Nov 17 23:02:07.917 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: set random bits
Nov 17 23:02:07.917 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate or
Nov 17 23:02:07.917 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate and
Nov 17 23:02:07.918 INFO [stdout] test test_ops_random ... ok
Nov 17 23:02:07.919 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: random stress - u8
Nov 17 23:02:07.919 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: add bits
Nov 17 23:02:07.948 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: simple u16
Nov 17 23:02:07.971 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: simple u32
Nov 17 23:02:07.971 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate after insertion
Nov 17 23:02:07.987 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: remove half of the bits
Nov 17 23:02:07.987 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: iterate after removal
Nov 17 23:02:07.987 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: random stress - u16
Nov 17 23:02:07.987 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: simple u64
Nov 17 23:02:07.991 INFO [stderr] DEBUG 2018-11-17T23:02:07Z: bitset: add bits
Nov 17 23:02:08.007 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: iterate after insertion
Nov 17 23:02:08.007 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: remove half of the bits
Nov 17 23:02:08.007 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: simple u128
Nov 17 23:02:08.007 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: iterate after removal
Nov 17 23:02:08.007 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: random stress - u32
Nov 17 23:02:08.007 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: add bits
Nov 17 23:02:08.019 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: iterate after insertion
Nov 17 23:02:08.019 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: remove half of the bits
Nov 17 23:02:08.019 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: iterate after removal
Nov 17 23:02:08.019 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: random stress - u64
Nov 17 23:02:08.022 INFO [stdout] test test_simple ... ok
Nov 17 23:02:08.022 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: add bits
Nov 17 23:02:08.031 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: iterate after insertion
Nov 17 23:02:08.031 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: remove half of the bits
Nov 17 23:02:08.031 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: iterate after removal
Nov 17 23:02:08.031 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: random stress - u128
Nov 17 23:02:08.039 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: add bits
Nov 17 23:02:08.043 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: iterate after insertion
Nov 17 23:02:08.043 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: remove half of the bits
Nov 17 23:02:08.043 INFO [stderr] DEBUG 2018-11-17T23:02:08Z: bitset: iterate after removal
Nov 17 23:02:08.043 INFO [stdout] test test_random_stress ... ok
Nov 17 23:02:11.735 INFO [stderr] DEBUG 2018-11-17T23:02:11Z: bitset: set all bits
Nov 17 23:02:15.327 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: stress - u16
Nov 17 23:02:15.327 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: set one bit
Nov 17 23:02:15.371 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: set all bits
Nov 17 23:02:15.423 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: stress - u32
Nov 17 23:02:15.423 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: set one bit
Nov 17 23:02:15.457 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: set all bits
Nov 17 23:02:15.502 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: stress - u64
Nov 17 23:02:15.503 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: set one bit
Nov 17 23:02:15.546 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: set all bits
Nov 17 23:02:15.602 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: stress - u128
Nov 17 23:02:15.602 INFO [stderr] DEBUG 2018-11-17T23:02:15Z: bitset: set one bit
Nov 17 23:02:18.855 INFO [stderr] DEBUG 2018-11-17T23:02:18Z: bitset: set all bits
Nov 17 23:02:22.803 INFO [stdout] test test_stress ... ok
Nov 17 23:02:22.803 INFO [stdout] 
Nov 17 23:02:22.803 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:02:22.804 INFO [stdout] 
Nov 17 23:02:22.804 INFO [stdout] 
Nov 17 23:02:22.804 INFO [stdout] running 1 test
Nov 17 23:02:22.805 INFO [stdout] test test_vec_mat_join ... ok
Nov 17 23:02:22.805 INFO [stdout] 
Nov 17 23:02:22.806 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:02:22.806 INFO [stdout] 
Nov 17 23:02:22.806 INFO [stdout] 
Nov 17 23:02:22.807 INFO [stdout] running 3 tests
Nov 17 23:02:22.807 INFO [stderr]      Running /target/debug/deps/matrixjoin-61392e03e527118e
Nov 17 23:02:22.807 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: row read
Nov 17 23:02:22.808 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: empty row, in capacity
Nov 17 23:02:22.808 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: empty row, outside capacity
Nov 17 23:02:22.808 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: a filled row, continuous
Nov 17 23:02:22.808 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: a filled row, sparse
Nov 17 23:02:22.809 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: row update
Nov 17 23:02:22.809 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: empty row, in capacity
Nov 17 23:02:22.809 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: empty row, outside capacity
Nov 17 23:02:22.810 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: a filled row, continuous
Nov 17 23:02:22.810 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: a filled row, sparse
Nov 17 23:02:22.810 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: vec read, mat read
Nov 17 23:02:22.811 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: vec read, mat update
Nov 17 23:02:22.811 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: vec update, mat read
Nov 17 23:02:22.811 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: vec read, mat read, vec read
Nov 17 23:02:22.811 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: matrixjoin: vec write, mat write
Nov 17 23:02:22.812 INFO [stderr]      Running /target/debug/deps/smat-1c0752b670a486b1
Nov 17 23:02:22.812 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: SparseDMatrix - big
Nov 17 23:02:22.812 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: SparseDMatrix
Nov 17 23:02:22.813 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: pass: 0
Nov 17 23:02:22.813 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: pass: 1
Nov 17 23:02:22.813 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: SparseAMatrix
Nov 17 23:02:22.813 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: pass: 0
Nov 17 23:02:22.814 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: pass: 1
Nov 17 23:02:22.814 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: SparseDMatrix/CSMatrix
Nov 17 23:02:22.814 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: iterate 1st
Nov 17 23:02:22.815 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: iterate mut
Nov 17 23:02:22.815 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: iterate 2nd
Nov 17 23:02:22.815 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: SparseAMatrix/CSMatrix
Nov 17 23:02:22.815 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: iterate 1st
Nov 17 23:02:22.816 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: iterate mut
Nov 17 23:02:22.816 INFO [stderr] DEBUG 2018-11-17T23:02:22Z: smat: iterate 2nd
Nov 17 23:02:22.816 INFO [stdout] test test_simple ... ok
Nov 17 23:02:22.817 INFO [stdout] test test_data_iter ... ok
Nov 17 23:02:28.259 INFO [stdout] test test_stress ... ok
Nov 17 23:02:28.259 INFO [stdout] 
Nov 17 23:02:28.259 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:02:28.259 INFO [stdout] 
Nov 17 23:02:28.259 INFO [stdout] 
Nov 17 23:02:28.259 INFO [stdout] running 3 tests
Nov 17 23:02:28.259 INFO [stderr]      Running /target/debug/deps/svec-1aee25cb2fa8d98b
Nov 17 23:02:28.260 INFO [stdout] test test_data_iter ... ok
Nov 17 23:02:28.260 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: SDVector
Nov 17 23:02:28.261 INFO [stdout] test test_simple ... ok
Nov 17 23:02:28.261 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: iterate 1st
Nov 17 23:02:28.261 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: iterate mut
Nov 17 23:02:28.261 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: iterate 2nd
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: SHVector
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: iterate 1st
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: iterate mut
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: iterate 2nd
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: SDVector
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: pass: 0
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: pass: 1
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: SHVector
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: pass: 0
Nov 17 23:02:28.262 INFO [stderr] DEBUG 2018-11-17T23:02:28Z: svec: pass: 1
Nov 17 23:02:35.729 INFO [stdout] test test_stress ... ok
Nov 17 23:02:35.729 INFO [stdout] 
Nov 17 23:02:35.729 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:02:35.729 INFO [stdout] 
Nov 17 23:02:35.731 INFO [stderr]      Running /target/debug/deps/vectorjoin-7e8384914d36b0b8
Nov 17 23:02:35.735 INFO [stdout] 
Nov 17 23:02:35.735 INFO [stdout] running 1 test
Nov 17 23:02:35.735 INFO [stderr] DEBUG 2018-11-17T23:02:35Z: vectorjoin: read
Nov 17 23:02:35.735 INFO [stderr] DEBUG 2018-11-17T23:02:35Z: vectorjoin: update
Nov 17 23:02:35.735 INFO [stderr] DEBUG 2018-11-17T23:02:35Z: vectorjoin: write
Nov 17 23:02:35.735 INFO [stderr] DEBUG 2018-11-17T23:02:35Z: vectorjoin: (read,update,write)
Nov 17 23:02:35.743 INFO [stderr]    Doc-tests shine-graph
Nov 17 23:02:35.743 INFO [stdout] test test_svec_join ... ok
Nov 17 23:02:35.743 INFO [stdout] 
Nov 17 23:02:35.743 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:02:35.743 INFO [stdout] 
Nov 17 23:02:37.016 INFO [stdout] 
Nov 17 23:02:37.016 INFO [stdout] running 0 tests
Nov 17 23:02:37.016 INFO [stdout] 
Nov 17 23:02:37.016 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 23:02:37.016 INFO [stdout] 
Nov 17 23:02:37.027 INFO [stderr] su: No module specific data is present
Nov 17 23:02:37.328 INFO running `"docker" "inspect" "d614259a995cabbd30ea742ed43f8bff97173fc989028540d9da81eb4efe8b64"`
Nov 17 23:02:37.430 INFO running `"docker" "rm" "-f" "d614259a995cabbd30ea742ed43f8bff97173fc989028540d9da81eb4efe8b64"`
Nov 17 23:02:37.567 INFO [stdout] d614259a995cabbd30ea742ed43f8bff97173fc989028540d9da81eb4efe8b64