Nov 16 21:18:20.795 INFO testing lion328/toolsc3k against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 16 21:18:20.796 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 16 21:18:21.239 INFO [stdout] 74e7eadf1a06062f463f4051e3f47cb9b92d9587bce51e9f48144b41a7956082
Nov 16 21:18:21.247 INFO running `"docker" "start" "-a" "74e7eadf1a06062f463f4051e3f47cb9b92d9587bce51e9f48144b41a7956082"`
Nov 16 21:18:22.862 INFO [stderr] usermod: no changes
Nov 16 21:18:23.043 INFO [stderr]    Compiling deflate v0.7.19
Nov 16 21:18:23.046 INFO [stderr]    Compiling syn v0.15.9
Nov 16 21:18:23.048 INFO [stderr]    Compiling jpeg-decoder v0.1.15
Nov 16 21:18:27.904 INFO [stderr]    Compiling png v0.12.0
Nov 16 21:18:40.599 INFO [stderr]    Compiling num-derive v0.2.3
Nov 16 21:18:48.203 INFO [stderr]    Compiling tiff v0.2.1
Nov 16 21:18:49.768 INFO [stderr]    Compiling image v0.20.0
Nov 16 21:19:07.903 INFO [stderr]    Compiling toolsc3k v0.1.0 (/source)
Nov 16 21:19:09.048 INFO [stderr] warning: unused `#[macro_use]` import
Nov 16 21:19:09.049 INFO [stderr]  --> src/main.rs:4:1
Nov 16 21:19:09.049 INFO [stderr]   |
Nov 16 21:19:09.050 INFO [stderr] 4 | #[macro_use]
Nov 16 21:19:09.051 INFO [stderr]   | ^^^^^^^^^^^^
Nov 16 21:19:09.051 INFO [stderr]   |
Nov 16 21:19:09.052 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 16 21:19:09.052 INFO [stderr] 
Nov 16 21:19:09.053 INFO [stderr] warning: unused import: `WriteBytesExt`
Nov 16 21:19:09.054 INFO [stderr]  --> src/format/pak.rs:3:31
Nov 16 21:19:09.054 INFO [stderr]   |
Nov 16 21:19:09.055 INFO [stderr] 3 | use byteorder::{ReadBytesExt, WriteBytesExt, LE};
Nov 16 21:19:09.055 INFO [stderr]   |                               ^^^^^^^^^^^^^
Nov 16 21:19:09.056 INFO [stderr] 
Nov 16 21:19:09.382 INFO [stderr] warning: unused variable: `input`
Nov 16 21:19:09.382 INFO [stderr]    --> src/main.rs:384:20
Nov 16 21:19:09.383 INFO [stderr]     |
Nov 16 21:19:09.384 INFO [stderr] 384 | fn pak_reconstruct(input: &str, output: &str) -> Result<()> {
Nov 16 21:19:09.384 INFO [stderr]     |                    ^^^^^ help: consider using `_input` instead
Nov 16 21:19:09.384 INFO [stderr]     |
Nov 16 21:19:09.384 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Nov 16 21:19:09.384 INFO [stderr] 
Nov 16 21:19:09.384 INFO [stderr] warning: unused variable: `output`
Nov 16 21:19:09.384 INFO [stderr]    --> src/main.rs:384:33
Nov 16 21:19:09.385 INFO [stderr]     |
Nov 16 21:19:09.385 INFO [stderr] 384 | fn pak_reconstruct(input: &str, output: &str) -> Result<()> {
Nov 16 21:19:09.385 INFO [stderr]     |                                 ^^^^^^ help: consider using `_output` instead
Nov 16 21:19:09.385 INFO [stderr] 
Nov 16 21:19:09.490 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:19:09.490 INFO [stderr]    --> src/main.rs:216:9
Nov 16 21:19:09.490 INFO [stderr]     |
Nov 16 21:19:09.491 INFO [stderr] 216 |         writeln!(out, "Record number: {}", i);
Nov 16 21:19:09.491 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:19:09.491 INFO [stderr]     |
Nov 16 21:19:09.491 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Nov 16 21:19:09.491 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:19:09.491 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 16 21:19:09.491 INFO [stderr] 
Nov 16 21:19:09.491 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:19:09.492 INFO [stderr]    --> src/main.rs:217:9
Nov 16 21:19:09.492 INFO [stderr]     |
Nov 16 21:19:09.492 INFO [stderr] 217 |         writeln!(out, "Type ID: 0x{:X?}", r.type_id);
Nov 16 21:19:09.492 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:19:09.492 INFO [stderr]     |
Nov 16 21:19:09.492 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:19:09.492 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 16 21:19:09.492 INFO [stderr] 
Nov 16 21:19:09.492 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:19:09.492 INFO [stderr]    --> src/main.rs:218:9
Nov 16 21:19:09.492 INFO [stderr]     |
Nov 16 21:19:09.492 INFO [stderr] 218 |         writeln!(out, "Group ID: 0x{:X?}", r.group_id);
Nov 16 21:19:09.492 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:19:09.492 INFO [stderr]     |
Nov 16 21:19:09.493 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:19:09.493 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 16 21:19:09.493 INFO [stderr] 
Nov 16 21:19:09.493 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:19:09.493 INFO [stderr]    --> src/main.rs:219:9
Nov 16 21:19:09.493 INFO [stderr]     |
Nov 16 21:19:09.493 INFO [stderr] 219 |         writeln!(out, "Instance ID: 0x{:X?}", r.instance_id);
Nov 16 21:19:09.493 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:19:09.493 INFO [stderr]     |
Nov 16 21:19:09.493 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:19:09.493 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 16 21:19:09.493 INFO [stderr] 
Nov 16 21:19:12.679 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 49.79s
Nov 16 21:19:12.689 INFO [stderr] su: No module specific data is present
Nov 16 21:19:13.728 INFO running `"docker" "inspect" "74e7eadf1a06062f463f4051e3f47cb9b92d9587bce51e9f48144b41a7956082"`
Nov 16 21:19:14.088 INFO running `"docker" "rm" "-f" "74e7eadf1a06062f463f4051e3f47cb9b92d9587bce51e9f48144b41a7956082"`
Nov 16 21:19:14.503 INFO [stdout] 74e7eadf1a06062f463f4051e3f47cb9b92d9587bce51e9f48144b41a7956082
Nov 16 21:19:14.510 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 16 21:19:15.013 INFO [stdout] b996f1748f28e0ebcd208ffa70db7e413f2db734e76f87592b6458dbc50935c3
Nov 16 21:19:15.017 INFO running `"docker" "start" "-a" "b996f1748f28e0ebcd208ffa70db7e413f2db734e76f87592b6458dbc50935c3"`
Nov 16 21:19:16.559 INFO [stderr] usermod: no changes
Nov 16 21:19:16.719 INFO [stderr]    Compiling toolsc3k v0.1.0 (/source)
Nov 16 21:19:17.793 INFO [stderr] warning: unused import: `WriteBytesExt`
Nov 16 21:19:17.793 INFO [stderr]  --> src/format/pak.rs:3:31
Nov 16 21:19:17.793 INFO [stderr]   |
Nov 16 21:19:17.793 INFO [stderr] 3 | use byteorder::{ReadBytesExt, WriteBytesExt, LE};
Nov 16 21:19:17.793 INFO [stderr]   |                               ^^^^^^^^^^^^^
Nov 16 21:19:17.793 INFO [stderr]   |
Nov 16 21:19:17.793 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Nov 16 21:19:17.793 INFO [stderr] 
Nov 16 21:19:18.171 INFO [stderr] warning: unused variable: `input`
Nov 16 21:19:18.171 INFO [stderr]    --> src/main.rs:384:20
Nov 16 21:19:18.171 INFO [stderr]     |
Nov 16 21:19:18.171 INFO [stderr] 384 | fn pak_reconstruct(input: &str, output: &str) -> Result<()> {
Nov 16 21:19:18.171 INFO [stderr]     |                    ^^^^^ help: consider using `_input` instead
Nov 16 21:19:18.171 INFO [stderr]     |
Nov 16 21:19:18.175 INFO [stderr]     = note: #[warn(unused_variables)] on by default
Nov 16 21:19:18.175 INFO [stderr] 
Nov 16 21:19:18.175 INFO [stderr] warning: unused variable: `output`
Nov 16 21:19:18.175 INFO [stderr]    --> src/main.rs:384:33
Nov 16 21:19:18.175 INFO [stderr]     |
Nov 16 21:19:18.175 INFO [stderr] 384 | fn pak_reconstruct(input: &str, output: &str) -> Result<()> {
Nov 16 21:19:18.175 INFO [stderr]     |                                 ^^^^^^ help: consider using `_output` instead
Nov 16 21:19:18.175 INFO [stderr] 
Nov 16 21:19:18.339 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:19:18.339 INFO [stderr]    --> src/main.rs:216:9
Nov 16 21:19:18.339 INFO [stderr]     |
Nov 16 21:19:18.339 INFO [stderr] 216 |         writeln!(out, "Record number: {}", i);
Nov 16 21:19:18.339 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:19:18.339 INFO [stderr]     |
Nov 16 21:19:18.339 INFO [stderr]     = note: #[warn(unused_must_use)] on by default
Nov 16 21:19:18.339 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:19:18.339 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 16 21:19:18.339 INFO [stderr] 
Nov 16 21:19:18.339 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:19:18.339 INFO [stderr]    --> src/main.rs:217:9
Nov 16 21:19:18.339 INFO [stderr]     |
Nov 16 21:19:18.339 INFO [stderr] 217 |         writeln!(out, "Type ID: 0x{:X?}", r.type_id);
Nov 16 21:19:18.339 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:19:18.339 INFO [stderr]     |
Nov 16 21:19:18.339 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:19:18.339 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 16 21:19:18.339 INFO [stderr] 
Nov 16 21:19:18.339 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:19:18.339 INFO [stderr]    --> src/main.rs:218:9
Nov 16 21:19:18.339 INFO [stderr]     |
Nov 16 21:19:18.339 INFO [stderr] 218 |         writeln!(out, "Group ID: 0x{:X?}", r.group_id);
Nov 16 21:19:18.339 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:19:18.339 INFO [stderr]     |
Nov 16 21:19:18.339 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:19:18.339 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 16 21:19:18.339 INFO [stderr] 
Nov 16 21:19:18.339 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:19:18.339 INFO [stderr]    --> src/main.rs:219:9
Nov 16 21:19:18.339 INFO [stderr]     |
Nov 16 21:19:18.339 INFO [stderr] 219 |         writeln!(out, "Instance ID: 0x{:X?}", r.instance_id);
Nov 16 21:19:18.339 INFO [stderr]     |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:19:18.339 INFO [stderr]     |
Nov 16 21:19:18.339 INFO [stderr]     = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:19:18.339 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 16 21:19:18.339 INFO [stderr] 
Nov 16 21:19:20.247 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.67s
Nov 16 21:19:20.255 INFO [stderr] su: No module specific data is present
Nov 16 21:19:20.948 INFO running `"docker" "inspect" "b996f1748f28e0ebcd208ffa70db7e413f2db734e76f87592b6458dbc50935c3"`
Nov 16 21:19:21.255 INFO running `"docker" "rm" "-f" "b996f1748f28e0ebcd208ffa70db7e413f2db734e76f87592b6458dbc50935c3"`
Nov 16 21:19:21.559 INFO [stdout] b996f1748f28e0ebcd208ffa70db7e413f2db734e76f87592b6458dbc50935c3
Nov 16 21:19:21.568 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 16 21:19:21.964 INFO [stdout] f6c25e0f43f516abb0ae4cc9d00ae7266e553e93331ab43ff58185539da5b71b
Nov 16 21:19:21.971 INFO running `"docker" "start" "-a" "f6c25e0f43f516abb0ae4cc9d00ae7266e553e93331ab43ff58185539da5b71b"`
Nov 16 21:19:23.334 INFO [stderr] usermod: no changes
Nov 16 21:19:23.543 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Nov 16 21:19:23.547 INFO [stderr]      Running /target/debug/deps/toolsc3k-f4fec9a1df10bb41
Nov 16 21:19:23.551 INFO [stdout] 
Nov 16 21:19:23.551 INFO [stdout] running 10 tests
Nov 16 21:19:23.579 INFO [stdout] test format::image::tests::from_game_format ... ok
Nov 16 21:19:23.579 INFO [stdout] test format::image::tests::convert ... ok
Nov 16 21:19:23.579 INFO [stdout] test format::image::tests::to_game_format ... ok
Nov 16 21:19:23.579 INFO [stdout] test format::ixf::tests::bad_record_ignore ... ok
Nov 16 21:19:23.587 INFO [stdout] test format::pak::tests::as_single_string ... ok
Nov 16 21:19:23.587 INFO [stdout] test format::ixf::tests::reencode ... ok
Nov 16 21:19:23.587 INFO [stdout] test format::pak::tests::parse ... ok
Nov 16 21:19:23.587 INFO [stdout] test format::ixf::tests::normal ... ok
Nov 16 21:19:23.660 INFO [stdout] test format::ixf::tests::invalid_header ... ok
Nov 16 21:19:23.661 INFO [stdout] test format::ixf::tests::bad_record ... ok
Nov 16 21:19:23.661 INFO [stdout] 
Nov 16 21:19:23.661 INFO [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 21:19:23.661 INFO [stdout] 
Nov 16 21:19:23.665 INFO [stderr] su: No module specific data is present
Nov 16 21:19:24.299 INFO running `"docker" "inspect" "f6c25e0f43f516abb0ae4cc9d00ae7266e553e93331ab43ff58185539da5b71b"`
Nov 16 21:19:24.603 INFO running `"docker" "rm" "-f" "f6c25e0f43f516abb0ae4cc9d00ae7266e553e93331ab43ff58185539da5b71b"`
Nov 16 21:19:24.923 INFO [stdout] f6c25e0f43f516abb0ae4cc9d00ae7266e553e93331ab43ff58185539da5b71b