Dec 14 14:50:21.444 INFO testing vasp-poscar-0.2.0 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 14:50:21.444 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 14 14:50:21.835 INFO [stdout] 123468a6b03f53c57b10a55c9ecbe2a2f32134e7ec257f59f23f5a153d8bdb13
Dec 14 14:50:21.840 INFO running `"docker" "start" "-a" "123468a6b03f53c57b10a55c9ecbe2a2f32134e7ec257f59f23f5a153d8bdb13"`
Dec 14 14:50:22.851 INFO [stderr] usermod: no changes
Dec 14 14:50:22.983 INFO [stderr]    Compiling vasp-poscar v0.2.0 (/source)
Dec 14 14:50:26.164 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.28s
Dec 14 14:50:26.175 INFO [stderr] su: No module specific data is present
Dec 14 14:50:27.015 INFO running `"docker" "inspect" "123468a6b03f53c57b10a55c9ecbe2a2f32134e7ec257f59f23f5a153d8bdb13"`
Dec 14 14:50:27.297 INFO running `"docker" "rm" "-f" "123468a6b03f53c57b10a55c9ecbe2a2f32134e7ec257f59f23f5a153d8bdb13"`
Dec 14 14:50:27.628 INFO [stdout] 123468a6b03f53c57b10a55c9ecbe2a2f32134e7ec257f59f23f5a153d8bdb13
Dec 14 14:50:27.637 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 14 14:50:28.208 INFO [stdout] 6fdf17cccd98944e28121c29789c632c473f4a3d5e80c51fc1d45dda7ef5f0b0
Dec 14 14:50:28.210 INFO running `"docker" "start" "-a" "6fdf17cccd98944e28121c29789c632c473f4a3d5e80c51fc1d45dda7ef5f0b0"`
Dec 14 14:50:29.855 INFO [stderr] usermod: no changes
Dec 14 14:50:30.091 INFO [stderr]    Compiling serde v1.0.82
Dec 14 14:50:30.098 INFO [stderr]    Compiling indoc-impl v0.2.8
Dec 14 14:50:33.470 INFO [stderr]    Compiling indoc v0.2.8
Dec 14 14:50:44.234 INFO [stderr]    Compiling toml v0.4.10
Dec 14 14:50:44.234 INFO [stderr]    Compiling serde_yaml v0.7.5
Dec 14 14:50:54.350 INFO [stderr]    Compiling version-sync v0.5.0
Dec 14 14:50:57.335 INFO [stderr]    Compiling vasp-poscar v0.2.0 (/source)
Dec 14 14:51:13.591 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 43.70s
Dec 14 14:51:13.612 INFO [stderr] su: No module specific data is present
Dec 14 14:51:14.143 INFO running `"docker" "inspect" "6fdf17cccd98944e28121c29789c632c473f4a3d5e80c51fc1d45dda7ef5f0b0"`
Dec 14 14:51:14.552 INFO running `"docker" "rm" "-f" "6fdf17cccd98944e28121c29789c632c473f4a3d5e80c51fc1d45dda7ef5f0b0"`
Dec 14 14:51:14.899 INFO [stdout] 6fdf17cccd98944e28121c29789c632c473f4a3d5e80c51fc1d45dda7ef5f0b0
Dec 14 14:51:14.899 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 14 14:51:15.446 INFO [stdout] 9f1ca6e9ac258ef9dcd44070ef7629fd49e08261f22082f97ee8e7b77b169db5
Dec 14 14:51:15.452 INFO running `"docker" "start" "-a" "9f1ca6e9ac258ef9dcd44070ef7629fd49e08261f22082f97ee8e7b77b169db5"`
Dec 14 14:51:16.273 INFO [stderr] usermod: no changes
Dec 14 14:51:16.426 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.12s
Dec 14 14:51:16.443 INFO [stderr]      Running /target/debug/deps/vasp_poscar-9668749c153dac49
Dec 14 14:51:16.449 INFO [stdout] 
Dec 14 14:51:16.449 INFO [stdout] running 16 tests
Dec 14 14:51:16.467 INFO [stdout] test builder::tests::test_comment ... ok
Dec 14 14:51:16.467 INFO [stdout] test builder::tests::test_dynamics ... ok
Dec 14 14:51:16.475 INFO [stdout] test builder::tests::test_positions ... ok
Dec 14 14:51:16.479 INFO [stdout] test builder::tests::test_velocities ... ok
Dec 14 14:51:16.479 INFO [stdout] test builder::tests::test_scale ... ok
Dec 14 14:51:16.479 INFO [stdout] test math::tests::test_inv_f64 ... ok
Dec 14 14:51:16.479 INFO [stdout] test math::tests::test_mul_n3_33 ... ok
Dec 14 14:51:16.479 INFO [stdout] test builder::tests::test_group_symbols ... ok
Dec 14 14:51:16.479 INFO [stdout] test builder::tests::test_lattice ... ok
Dec 14 14:51:16.479 INFO [stdout] test builder::tests::test_group_counts ... ok
Dec 14 14:51:16.487 INFO [stdout] test parse::words ... ok
Dec 14 14:51:16.487 INFO [stdout] test types::accessor_tests::smoke_test ... ok
Dec 14 14:51:16.487 INFO [stdout] test types::test_group_iters ... ok
Dec 14 14:51:16.519 INFO [stdout] test builder::tests::panic_no_positions ... ok
Dec 14 14:51:16.527 INFO [stdout] test builder::tests::panic_no_lattice_vectors ... ok
Dec 14 14:51:16.527 INFO [stdout] test builder::tests::panic_no_num_atoms ... ok
Dec 14 14:51:16.527 INFO [stdout] 
Dec 14 14:51:16.527 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:51:16.527 INFO [stdout] 
Dec 14 14:51:16.527 INFO [stderr]      Running /target/debug/deps/parse-24c1f208f87ce8a6
Dec 14 14:51:16.539 INFO [stdout] running 5 tests
Dec 14 14:51:16.539 INFO [stdout]           early-eof.yaml: ..............
Dec 14 14:51:16.542 INFO [stdout]          parse-fail.yaml: ......................
Dec 14 14:51:16.542 INFO [stdout]          whitespace.yaml: .
Dec 14 14:51:16.542 INFO [stdout]   freeform-comments.yaml: ..
Dec 14 14:51:16.542 INFO [stdout]          primitives.yaml: .....
Dec 14 14:51:16.542 INFO [stderr]      Running /target/debug/deps/parse_trailing_lines-2263f9bffb284fec
Dec 14 14:51:16.556 INFO [stdout] 
Dec 14 14:51:16.556 INFO [stdout] running 2 tests
Dec 14 14:51:16.563 INFO [stderr]      Running /target/debug/deps/raw_parse-ee61471943388e24
Dec 14 14:51:16.563 INFO [stdout] test test_permutations_upto ... ok
Dec 14 14:51:16.563 INFO [stdout] test parse_trailing_lines ... ok
Dec 14 14:51:16.563 INFO [stdout] 
Dec 14 14:51:16.563 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:51:16.563 INFO [stdout] 
Dec 14 14:51:16.571 INFO [stdout] 
Dec 14 14:51:16.571 INFO [stdout] running 7 tests
Dec 14 14:51:16.571 INFO [stdout] test scale ... ok
Dec 14 14:51:16.571 INFO [stdout] test positions ... ok
Dec 14 14:51:16.578 INFO [stdout] test lattice ... ok
Dec 14 14:51:16.578 INFO [stdout] test velocities ... ok
Dec 14 14:51:16.587 INFO [stdout] test dynamics ... ok
Dec 14 14:51:16.587 INFO [stderr]      Running /target/debug/deps/raw_write-17b28bfb161b1c59
Dec 14 14:51:16.587 INFO [stdout] test comment ... ok
Dec 14 14:51:16.587 INFO [stdout] test atom_types ... ok
Dec 14 14:51:16.587 INFO [stdout] 
Dec 14 14:51:16.587 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:51:16.587 INFO [stdout] 
Dec 14 14:51:16.596 INFO [stdout] 
Dec 14 14:51:16.597 INFO [stdout] running 7 tests
Dec 14 14:51:16.597 INFO [stdout] test positions ... ok
Dec 14 14:51:16.597 INFO [stdout] test lattice ... ok
Dec 14 14:51:16.597 INFO [stdout] test dynamics ... ok
Dec 14 14:51:16.597 INFO [stdout] test comment ... ok
Dec 14 14:51:16.598 INFO [stdout] test scale ... ok
Dec 14 14:51:16.598 INFO [stderr]      Running /target/debug/deps/validate-c431542c97240eb4
Dec 14 14:51:16.598 INFO [stdout] test atom_types ... ok
Dec 14 14:51:16.598 INFO [stdout] test velocities ... ok
Dec 14 14:51:16.598 INFO [stdout] 
Dec 14 14:51:16.598 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:51:16.598 INFO [stdout] 
Dec 14 14:51:16.615 INFO [stdout] 
Dec 14 14:51:16.615 INFO [stdout] running 6 tests
Dec 14 14:51:16.615 INFO [stdout] test inconsistent_num_groups ... ok
Dec 14 14:51:16.615 INFO [stdout] test inconsistent_num_atoms ... ok
Dec 14 14:51:16.615 INFO [stdout] test comment_newline ... ok
Dec 14 14:51:16.627 INFO [stdout] test no_atoms ... ok
Dec 14 14:51:16.627 INFO [stderr]      Running /target/debug/deps/version_numbers-962a303c42f0c75a
Dec 14 14:51:16.627 INFO [stdout] test symbol_whitespace ... ok
Dec 14 14:51:16.627 INFO [stdout] test bad_scale ... ok
Dec 14 14:51:16.627 INFO [stdout] 
Dec 14 14:51:16.627 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:51:16.627 INFO [stdout] 
Dec 14 14:51:16.634 INFO [stdout] 
Dec 14 14:51:16.634 INFO [stdout] running 2 tests
Dec 14 14:51:16.634 INFO [stdout] test test_readme_deps ... ok
Dec 14 14:51:16.638 INFO [stdout] test test_html_root_url ... ok
Dec 14 14:51:16.638 INFO [stderr]    Doc-tests vasp-poscar
Dec 14 14:51:16.638 INFO [stdout] 
Dec 14 14:51:16.638 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:51:16.638 INFO [stdout] 
Dec 14 14:51:18.517 INFO [stdout] 
Dec 14 14:51:18.517 INFO [stdout] running 7 tests
Dec 14 14:51:27.812 INFO [stdout] test src/types.rs - types::RawPoscar (line 278) ... ok
Dec 14 14:51:28.891 INFO [stdout] test src/builder.rs - builder::Builder (line 54) ... ok
Dec 14 14:51:29.897 INFO [stdout] test src/types.rs - types::RawPoscar (line 307) ... ok
Dec 14 14:51:31.543 INFO [stdout] test src/builder.rs - builder::Zeroed (line 135) ... ok
Dec 14 14:51:32.083 INFO [stdout] test src/types.rs - types::RawPoscar (line 252) ... ok
Dec 14 14:51:32.177 INFO [stdout] test src/builder.rs - builder::Builder (line 28) ... ok
Dec 14 14:51:32.383 INFO [stdout] test src/lib.rs -  (line 16) ... ok
Dec 14 14:51:32.385 INFO [stdout] 
Dec 14 14:51:32.385 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 14:51:32.385 INFO [stdout] 
Dec 14 14:51:32.423 INFO [stderr] su: No module specific data is present
Dec 14 14:51:33.512 INFO running `"docker" "inspect" "9f1ca6e9ac258ef9dcd44070ef7629fd49e08261f22082f97ee8e7b77b169db5"`
Dec 14 14:51:33.919 INFO running `"docker" "rm" "-f" "9f1ca6e9ac258ef9dcd44070ef7629fd49e08261f22082f97ee8e7b77b169db5"`
Dec 14 14:51:34.239 INFO [stdout] 9f1ca6e9ac258ef9dcd44070ef7629fd49e08261f22082f97ee8e7b77b169db5