Dec 06 18:12:08.691 INFO testing vasp-poscar-0.2.0 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 18:12:08.691 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 06 18:12:09.088 INFO [stdout] fe91459454b192366753b41137094b928e8c36a144f1f17427032604aca5589e
Dec 06 18:12:09.094 INFO running `"docker" "start" "-a" "fe91459454b192366753b41137094b928e8c36a144f1f17427032604aca5589e"`
Dec 06 18:12:10.294 INFO [stderr] usermod: no changes
Dec 06 18:12:10.412 INFO [stderr]    Compiling vasp-poscar v0.2.0 (/source)
Dec 06 18:12:13.664 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.35s
Dec 06 18:12:13.671 INFO [stderr] su: No module specific data is present
Dec 06 18:12:14.468 INFO running `"docker" "inspect" "fe91459454b192366753b41137094b928e8c36a144f1f17427032604aca5589e"`
Dec 06 18:12:14.698 INFO running `"docker" "rm" "-f" "fe91459454b192366753b41137094b928e8c36a144f1f17427032604aca5589e"`
Dec 06 18:12:14.929 INFO [stdout] fe91459454b192366753b41137094b928e8c36a144f1f17427032604aca5589e
Dec 06 18:12:14.934 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 06 18:12:15.484 INFO [stdout] ff2308214501a8da99327befd6428aa383576bbfca9ac3dd2021fe545913aa5c
Dec 06 18:12:15.490 INFO running `"docker" "start" "-a" "ff2308214501a8da99327befd6428aa383576bbfca9ac3dd2021fe545913aa5c"`
Dec 06 18:12:16.824 INFO [stderr] usermod: no changes
Dec 06 18:12:16.954 INFO [stderr]    Compiling unindent v0.1.3
Dec 06 18:12:16.957 INFO [stderr]    Compiling serde_yaml v0.7.5
Dec 06 18:12:16.957 INFO [stderr]    Compiling version-sync v0.5.0
Dec 06 18:12:18.516 INFO [stderr]    Compiling indoc-impl v0.2.8
Dec 06 18:12:22.860 INFO [stderr]    Compiling indoc v0.2.8
Dec 06 18:12:23.717 INFO [stderr]    Compiling vasp-poscar v0.2.0 (/source)
Dec 06 18:12:39.524 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 22.68s
Dec 06 18:12:39.532 INFO [stderr] su: No module specific data is present
Dec 06 18:12:40.140 INFO running `"docker" "inspect" "ff2308214501a8da99327befd6428aa383576bbfca9ac3dd2021fe545913aa5c"`
Dec 06 18:12:40.454 INFO running `"docker" "rm" "-f" "ff2308214501a8da99327befd6428aa383576bbfca9ac3dd2021fe545913aa5c"`
Dec 06 18:12:40.750 INFO [stdout] ff2308214501a8da99327befd6428aa383576bbfca9ac3dd2021fe545913aa5c
Dec 06 18:12:40.755 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-7/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 06 18:12:41.111 INFO [stdout] d11aa7ed2ebcd1b0572f665a1934d2499fe6af1d62a9e6a339326e591ffaa274
Dec 06 18:12:41.114 INFO running `"docker" "start" "-a" "d11aa7ed2ebcd1b0572f665a1934d2499fe6af1d62a9e6a339326e591ffaa274"`
Dec 06 18:12:42.320 INFO [stderr] usermod: no changes
Dec 06 18:12:42.450 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Dec 06 18:12:42.476 INFO [stderr]      Running /target/debug/deps/vasp_poscar-b60dc7406e15cd65
Dec 06 18:12:42.476 INFO [stdout] 
Dec 06 18:12:42.476 INFO [stdout] running 16 tests
Dec 06 18:12:42.477 INFO [stdout] test builder::tests::test_group_counts ... ok
Dec 06 18:12:42.484 INFO [stdout] test builder::tests::test_comment ... ok
Dec 06 18:12:42.484 INFO [stdout] test builder::tests::test_group_symbols ... ok
Dec 06 18:12:42.484 INFO [stdout] test builder::tests::test_dynamics ... ok
Dec 06 18:12:42.500 INFO [stdout] test builder::tests::test_positions ... ok
Dec 06 18:12:42.500 INFO [stdout] test builder::tests::test_scale ... ok
Dec 06 18:12:42.500 INFO [stdout] test math::tests::test_inv_f64 ... ok
Dec 06 18:12:42.500 INFO [stdout] test builder::tests::test_velocities ... ok
Dec 06 18:12:42.500 INFO [stdout] test builder::tests::test_lattice ... ok
Dec 06 18:12:42.500 INFO [stdout] test types::test_group_iters ... ok
Dec 06 18:12:42.500 INFO [stdout] test types::accessor_tests::smoke_test ... ok
Dec 06 18:12:42.508 INFO [stdout] test math::tests::test_mul_n3_33 ... ok
Dec 06 18:12:42.508 INFO [stdout] test parse::words ... ok
Dec 06 18:12:42.540 INFO [stderr]      Running /target/debug/deps/parse-dc555441d68f117d
Dec 06 18:12:42.540 INFO [stdout] test builder::tests::panic_no_positions ... ok
Dec 06 18:12:42.540 INFO [stdout] test builder::tests::panic_no_num_atoms ... ok
Dec 06 18:12:42.540 INFO [stdout] test builder::tests::panic_no_lattice_vectors ... ok
Dec 06 18:12:42.540 INFO [stdout] 
Dec 06 18:12:42.540 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:12:42.540 INFO [stdout] 
Dec 06 18:12:42.564 INFO [stdout] running 5 tests
Dec 06 18:12:42.564 INFO [stdout]          primitives.yaml: .....
Dec 06 18:12:42.569 INFO [stdout]          parse-fail.yaml: ......................
Dec 06 18:12:42.569 INFO [stdout]   freeform-comments.yaml: ..
Dec 06 18:12:42.569 INFO [stdout]          whitespace.yaml: .
Dec 06 18:12:42.572 INFO [stdout]           early-eof.yaml: ..............
Dec 06 18:12:42.572 INFO [stderr]      Running /target/debug/deps/parse_trailing_lines-545b0d848ff2cfe1
Dec 06 18:12:42.577 INFO [stdout] 
Dec 06 18:12:42.577 INFO [stdout] running 2 tests
Dec 06 18:12:42.580 INFO [stderr]      Running /target/debug/deps/raw_parse-6b287e3f014ffba8
Dec 06 18:12:42.580 INFO [stdout] test test_permutations_upto ... ok
Dec 06 18:12:42.580 INFO [stdout] test parse_trailing_lines ... ok
Dec 06 18:12:42.580 INFO [stdout] 
Dec 06 18:12:42.580 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:12:42.580 INFO [stdout] 
Dec 06 18:12:42.581 INFO [stdout] 
Dec 06 18:12:42.582 INFO [stdout] running 7 tests
Dec 06 18:12:42.594 INFO [stdout] test dynamics ... ok
Dec 06 18:12:42.594 INFO [stdout] test atom_types ... ok
Dec 06 18:12:42.594 INFO [stdout] test lattice ... ok
Dec 06 18:12:42.595 INFO [stdout] test comment ... ok
Dec 06 18:12:42.595 INFO [stdout] test positions ... ok
Dec 06 18:12:42.596 INFO [stdout] test velocities ... ok
Dec 06 18:12:42.596 INFO [stdout] test scale ... ok
Dec 06 18:12:42.596 INFO [stdout] 
Dec 06 18:12:42.596 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:12:42.596 INFO [stdout] 
Dec 06 18:12:42.600 INFO [stderr]      Running /target/debug/deps/raw_write-38c24906026d4c25
Dec 06 18:12:42.612 INFO [stdout] 
Dec 06 18:12:42.612 INFO [stdout] running 7 tests
Dec 06 18:12:42.620 INFO [stdout] test lattice ... ok
Dec 06 18:12:42.620 INFO [stdout] test dynamics ... ok
Dec 06 18:12:42.620 INFO [stdout] test comment ... ok
Dec 06 18:12:42.620 INFO [stdout] test atom_types ... ok
Dec 06 18:12:42.628 INFO [stdout] test positions ... ok
Dec 06 18:12:42.628 INFO [stdout] test velocities ... ok
Dec 06 18:12:42.628 INFO [stdout] test scale ... ok
Dec 06 18:12:42.628 INFO [stdout] 
Dec 06 18:12:42.628 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:12:42.628 INFO [stdout] 
Dec 06 18:12:42.628 INFO [stderr]      Running /target/debug/deps/validate-d50170d95efc8dca
Dec 06 18:12:42.632 INFO [stdout] 
Dec 06 18:12:42.632 INFO [stdout] running 6 tests
Dec 06 18:12:42.632 INFO [stdout] test no_atoms ... ok
Dec 06 18:12:42.632 INFO [stdout] test inconsistent_num_groups ... ok
Dec 06 18:12:42.632 INFO [stdout] test inconsistent_num_atoms ... ok
Dec 06 18:12:42.632 INFO [stdout] test symbol_whitespace ... ok
Dec 06 18:12:42.633 INFO [stdout] test comment_newline ... ok
Dec 06 18:12:42.633 INFO [stdout] test bad_scale ... ok
Dec 06 18:12:42.633 INFO [stdout] 
Dec 06 18:12:42.633 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:12:42.633 INFO [stdout] 
Dec 06 18:12:42.636 INFO [stderr]      Running /target/debug/deps/version_numbers-78cd7f4769a8ec7c
Dec 06 18:12:42.638 INFO [stdout] 
Dec 06 18:12:42.638 INFO [stdout] running 2 tests
Dec 06 18:12:42.640 INFO [stdout] test test_readme_deps ... ok
Dec 06 18:12:42.664 INFO [stdout] test test_html_root_url ... ok
Dec 06 18:12:42.664 INFO [stdout] 
Dec 06 18:12:42.664 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:12:42.664 INFO [stdout] 
Dec 06 18:12:42.672 INFO [stderr]    Doc-tests vasp-poscar
Dec 06 18:12:44.543 INFO [stdout] 
Dec 06 18:12:44.543 INFO [stdout] running 7 tests
Dec 06 18:12:52.743 INFO [stdout] test src/builder.rs - builder::Zeroed (line 135) ... ok
Dec 06 18:12:52.759 INFO [stdout] test src/types.rs - types::RawPoscar (line 307) ... ok
Dec 06 18:12:53.214 INFO [stdout] test src/types.rs - types::RawPoscar (line 278) ... ok
Dec 06 18:12:53.300 INFO [stdout] test src/builder.rs - builder::Builder (line 54) ... ok
Dec 06 18:12:54.489 INFO [stdout] test src/builder.rs - builder::Builder (line 28) ... ok
Dec 06 18:12:55.084 INFO [stdout] test src/types.rs - types::RawPoscar (line 252) ... ok
Dec 06 18:12:55.456 INFO [stdout] test src/lib.rs -  (line 16) ... ok
Dec 06 18:12:55.456 INFO [stdout] 
Dec 06 18:12:55.456 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 18:12:55.456 INFO [stdout] 
Dec 06 18:12:55.493 INFO [stderr] su: No module specific data is present
Dec 06 18:12:56.292 INFO running `"docker" "inspect" "d11aa7ed2ebcd1b0572f665a1934d2499fe6af1d62a9e6a339326e591ffaa274"`
Dec 06 18:12:56.645 INFO running `"docker" "rm" "-f" "d11aa7ed2ebcd1b0572f665a1934d2499fe6af1d62a9e6a339326e591ffaa274"`
Dec 06 18:12:56.837 INFO [stdout] d11aa7ed2ebcd1b0572f665a1934d2499fe6af1d62a9e6a339326e591ffaa274