Nov 17 19:02:13.875 INFO testing vasp-poscar-0.2.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 19:02:13.875 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 19:02:14.259 INFO [stdout] ae8c7247d7d44bc47299257e0c0aa1f18c74fd792cf46ac5484a607030488ab6
Nov 17 19:02:14.263 INFO running `"docker" "start" "-a" "ae8c7247d7d44bc47299257e0c0aa1f18c74fd792cf46ac5484a607030488ab6"`
Nov 17 19:02:15.927 INFO [stderr] usermod: no changes
Nov 17 19:02:16.091 INFO [stderr]    Compiling vasp-poscar v0.2.0 (/source)
Nov 17 19:02:18.897 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2.93s
Nov 17 19:02:18.919 INFO [stderr] su: No module specific data is present
Nov 17 19:02:19.437 INFO running `"docker" "inspect" "ae8c7247d7d44bc47299257e0c0aa1f18c74fd792cf46ac5484a607030488ab6"`
Nov 17 19:02:19.575 INFO running `"docker" "rm" "-f" "ae8c7247d7d44bc47299257e0c0aa1f18c74fd792cf46ac5484a607030488ab6"`
Nov 17 19:02:19.798 INFO [stdout] ae8c7247d7d44bc47299257e0c0aa1f18c74fd792cf46ac5484a607030488ab6
Nov 17 19:02:19.800 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 19:02:20.276 INFO [stdout] 61f216c70978f5c9c1afd124f813bc3a7d40a65dc3b5088b20a52e3e77b9a4a0
Nov 17 19:02:20.287 INFO running `"docker" "start" "-a" "61f216c70978f5c9c1afd124f813bc3a7d40a65dc3b5088b20a52e3e77b9a4a0"`
Nov 17 19:02:21.295 INFO [stderr] usermod: no changes
Nov 17 19:02:21.515 INFO [stderr]    Compiling toml v0.4.8
Nov 17 19:02:21.515 INFO [stderr]    Compiling serde_yaml v0.7.5
Nov 17 19:02:28.762 INFO [stderr]    Compiling version-sync v0.5.0
Nov 17 19:02:31.356 INFO [stderr]    Compiling vasp-poscar v0.2.0 (/source)
Nov 17 19:02:49.647 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 28.32s
Nov 17 19:02:49.651 INFO [stderr] su: No module specific data is present
Nov 17 19:02:50.149 INFO running `"docker" "inspect" "61f216c70978f5c9c1afd124f813bc3a7d40a65dc3b5088b20a52e3e77b9a4a0"`
Nov 17 19:02:50.487 INFO running `"docker" "rm" "-f" "61f216c70978f5c9c1afd124f813bc3a7d40a65dc3b5088b20a52e3e77b9a4a0"`
Nov 17 19:02:50.747 INFO [stdout] 61f216c70978f5c9c1afd124f813bc3a7d40a65dc3b5088b20a52e3e77b9a4a0
Nov 17 19:02:50.756 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 19:02:51.256 INFO [stdout] 08c5911988784e420581e23e036a354c868cd7b191bdbe73b2787421b376977b
Nov 17 19:02:51.258 INFO running `"docker" "start" "-a" "08c5911988784e420581e23e036a354c868cd7b191bdbe73b2787421b376977b"`
Nov 17 19:02:52.763 INFO [stderr] usermod: no changes
Nov 17 19:02:52.883 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.09s
Nov 17 19:02:52.899 INFO [stderr]      Running /target/debug/deps/vasp_poscar-2a37f85f076f42ce
Nov 17 19:02:52.911 INFO [stdout] 
Nov 17 19:02:52.911 INFO [stdout] running 16 tests
Nov 17 19:02:52.912 INFO [stdout] test builder::tests::test_lattice ... ok
Nov 17 19:02:52.912 INFO [stdout] test builder::tests::test_group_symbols ... ok
Nov 17 19:02:52.912 INFO [stdout] test builder::tests::test_group_counts ... ok
Nov 17 19:02:52.913 INFO [stdout] test builder::tests::test_scale ... ok
Nov 17 19:02:52.913 INFO [stdout] test builder::tests::test_positions ... ok
Nov 17 19:02:52.913 INFO [stdout] test builder::tests::test_dynamics ... ok
Nov 17 19:02:52.914 INFO [stdout] test math::tests::test_inv_f64 ... ok
Nov 17 19:02:52.914 INFO [stdout] test math::tests::test_mul_n3_33 ... ok
Nov 17 19:02:52.914 INFO [stdout] test parse::words ... ok
Nov 17 19:02:52.915 INFO [stdout] test builder::tests::test_comment ... ok
Nov 17 19:02:52.915 INFO [stdout] test builder::tests::test_velocities ... ok
Nov 17 19:02:52.915 INFO [stdout] test types::accessor_tests::smoke_test ... ok
Nov 17 19:02:52.916 INFO [stdout] test types::test_group_iters ... ok
Nov 17 19:02:53.086 INFO [stdout] test builder::tests::panic_no_num_atoms ... ok
Nov 17 19:02:53.087 INFO [stderr]      Running /target/debug/deps/parse-1eba532e13dde8b2
Nov 17 19:02:53.087 INFO [stdout] test builder::tests::panic_no_positions ... ok
Nov 17 19:02:53.087 INFO [stdout] test builder::tests::panic_no_lattice_vectors ... ok
Nov 17 19:02:53.088 INFO [stdout] 
Nov 17 19:02:53.088 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:02:53.088 INFO [stdout] 
Nov 17 19:02:53.107 INFO [stdout] running 5 tests
Nov 17 19:02:53.107 INFO [stdout]           early-eof.yaml: ..............
Nov 17 19:02:53.122 INFO [stdout]          parse-fail.yaml: ......................
Nov 17 19:02:53.122 INFO [stdout]          whitespace.yaml: .
Nov 17 19:02:53.122 INFO [stdout]   freeform-comments.yaml: ..
Nov 17 19:02:53.122 INFO [stdout]          primitives.yaml: .....
Nov 17 19:02:53.128 INFO [stderr]      Running /target/debug/deps/parse_trailing_lines-72d602f6b8c00ece
Nov 17 19:02:53.138 INFO [stdout] 
Nov 17 19:02:53.139 INFO [stdout] running 2 tests
Nov 17 19:02:53.139 INFO [stdout] test test_permutations_upto ... ok
Nov 17 19:02:53.143 INFO [stdout] test parse_trailing_lines ... ok
Nov 17 19:02:53.143 INFO [stdout] 
Nov 17 19:02:53.144 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:02:53.144 INFO [stdout] 
Nov 17 19:02:53.158 INFO [stdout] 
Nov 17 19:02:53.159 INFO [stderr]      Running /target/debug/deps/raw_parse-d0347214cc710bc5
Nov 17 19:02:53.159 INFO [stdout] running 7 tests
Nov 17 19:02:53.165 INFO [stdout] test scale ... ok
Nov 17 19:02:53.166 INFO [stdout] test velocities ... ok
Nov 17 19:02:53.166 INFO [stdout] test positions ... ok
Nov 17 19:02:53.167 INFO [stdout] test lattice ... ok
Nov 17 19:02:53.167 INFO [stdout] test dynamics ... ok
Nov 17 19:02:53.167 INFO [stdout] test comment ... ok
Nov 17 19:02:53.168 INFO [stdout] test atom_types ... ok
Nov 17 19:02:53.169 INFO [stdout] 
Nov 17 19:02:53.169 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:02:53.169 INFO [stdout] 
Nov 17 19:02:53.171 INFO [stderr]      Running /target/debug/deps/raw_write-64bf940bbfa06f83
Nov 17 19:02:53.175 INFO [stdout] 
Nov 17 19:02:53.175 INFO [stdout] running 7 tests
Nov 17 19:02:53.183 INFO [stdout] test atom_types ... ok
Nov 17 19:02:53.183 INFO [stdout] test dynamics ... ok
Nov 17 19:02:53.183 INFO [stdout] test lattice ... ok
Nov 17 19:02:53.183 INFO [stdout] test scale ... ok
Nov 17 19:02:53.183 INFO [stdout] test positions ... ok
Nov 17 19:02:53.183 INFO [stdout] test velocities ... ok
Nov 17 19:02:53.187 INFO [stdout] test comment ... ok
Nov 17 19:02:53.187 INFO [stdout] 
Nov 17 19:02:53.187 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:02:53.187 INFO [stdout] 
Nov 17 19:02:53.187 INFO [stderr]      Running /target/debug/deps/validate-dff15bfe9981f68b
Nov 17 19:02:53.202 INFO [stdout] 
Nov 17 19:02:53.202 INFO [stdout] running 6 tests
Nov 17 19:02:53.207 INFO [stdout] test comment_newline ... ok
Nov 17 19:02:53.207 INFO [stdout] test inconsistent_num_groups ... ok
Nov 17 19:02:53.207 INFO [stdout] test bad_scale ... ok
Nov 17 19:02:53.207 INFO [stdout] test inconsistent_num_atoms ... ok
Nov 17 19:02:53.207 INFO [stdout] test no_atoms ... ok
Nov 17 19:02:53.207 INFO [stdout] test symbol_whitespace ... ok
Nov 17 19:02:53.207 INFO [stdout] 
Nov 17 19:02:53.207 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:02:53.207 INFO [stdout] 
Nov 17 19:02:53.207 INFO [stdout] 
Nov 17 19:02:53.207 INFO [stdout] running 2 tests
Nov 17 19:02:53.207 INFO [stderr]      Running /target/debug/deps/version_numbers-4f75d44e5766ac00
Nov 17 19:02:53.241 INFO [stdout] test test_readme_deps ... ok
Nov 17 19:02:53.266 INFO [stdout] test test_html_root_url ... ok
Nov 17 19:02:53.266 INFO [stderr]    Doc-tests vasp-poscar
Nov 17 19:02:53.266 INFO [stdout] 
Nov 17 19:02:53.266 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:02:53.266 INFO [stdout] 
Nov 17 19:02:54.795 INFO [stdout] 
Nov 17 19:02:54.795 INFO [stdout] running 7 tests
Nov 17 19:03:01.023 INFO [stdout] test src/lib.rs -  (line 16) ... ok
Nov 17 19:03:01.504 INFO [stdout] test src/builder.rs - builder::Builder (line 28) ... ok
Nov 17 19:03:01.979 INFO [stdout] test src/types.rs - types::RawPoscar (line 278) ... ok
Nov 17 19:03:02.139 INFO [stdout] test src/builder.rs - builder::Builder (line 54) ... ok
Nov 17 19:03:02.539 INFO [stdout] test src/types.rs - types::RawPoscar (line 307) ... ok
Nov 17 19:03:02.913 INFO [stdout] test src/types.rs - types::RawPoscar (line 252) ... ok
Nov 17 19:03:03.141 INFO [stdout] test src/builder.rs - builder::Zeroed (line 135) ... ok
Nov 17 19:03:03.141 INFO [stdout] 
Nov 17 19:03:03.142 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 19:03:03.142 INFO [stdout] 
Nov 17 19:03:03.191 INFO [stderr] su: No module specific data is present
Nov 17 19:03:04.129 INFO running `"docker" "inspect" "08c5911988784e420581e23e036a354c868cd7b191bdbe73b2787421b376977b"`
Nov 17 19:03:04.411 INFO running `"docker" "rm" "-f" "08c5911988784e420581e23e036a354c868cd7b191bdbe73b2787421b376977b"`
Nov 17 19:03:04.715 INFO [stdout] 08c5911988784e420581e23e036a354c868cd7b191bdbe73b2787421b376977b