Dec 07 08:11:02.997 INFO testing log-once-0.2.0 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 08:11:02.997 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 07 08:11:03.295 INFO [stdout] 4921cb5c776caeab9f8c9d68bcf5844a21d2507e078becb19496e94520b750ba
Dec 07 08:11:03.298 INFO running `"docker" "start" "-a" "4921cb5c776caeab9f8c9d68bcf5844a21d2507e078becb19496e94520b750ba"`
Dec 07 08:11:03.692 INFO [stderr] usermod: no changes
Dec 07 08:11:03.730 INFO [stderr]    Compiling log-once v0.2.0 (/source)
Dec 07 08:11:04.460 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.74s
Dec 07 08:11:04.460 INFO [stderr] su: No module specific data is present
Dec 07 08:11:04.846 INFO running `"docker" "inspect" "4921cb5c776caeab9f8c9d68bcf5844a21d2507e078becb19496e94520b750ba"`
Dec 07 08:11:04.955 INFO running `"docker" "rm" "-f" "4921cb5c776caeab9f8c9d68bcf5844a21d2507e078becb19496e94520b750ba"`
Dec 07 08:11:05.079 INFO [stdout] 4921cb5c776caeab9f8c9d68bcf5844a21d2507e078becb19496e94520b750ba
Dec 07 08:11:05.083 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 07 08:11:05.333 INFO [stdout] a8e5206ccf765987b8c621a2d9b51bc464fa2f4cc5e2d36a0684707ffcaa24d7
Dec 07 08:11:05.335 INFO running `"docker" "start" "-a" "a8e5206ccf765987b8c621a2d9b51bc464fa2f4cc5e2d36a0684707ffcaa24d7"`
Dec 07 08:11:05.909 INFO [stderr] usermod: no changes
Dec 07 08:11:05.956 INFO [stderr]    Compiling log-once v0.2.0 (/source)
Dec 07 08:11:10.618 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.68s
Dec 07 08:11:10.623 INFO [stderr] su: No module specific data is present
Dec 07 08:11:10.902 INFO running `"docker" "inspect" "a8e5206ccf765987b8c621a2d9b51bc464fa2f4cc5e2d36a0684707ffcaa24d7"`
Dec 07 08:11:11.013 INFO running `"docker" "rm" "-f" "a8e5206ccf765987b8c621a2d9b51bc464fa2f4cc5e2d36a0684707ffcaa24d7"`
Dec 07 08:11:11.096 INFO [stdout] a8e5206ccf765987b8c621a2d9b51bc464fa2f4cc5e2d36a0684707ffcaa24d7
Dec 07 08:11:11.098 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-6/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 07 08:11:11.348 INFO [stdout] 4e503e1770fd506dcb61c2f3c8c7e58b9a96a3499d732e996c13c5164143d175
Dec 07 08:11:11.348 INFO running `"docker" "start" "-a" "4e503e1770fd506dcb61c2f3c8c7e58b9a96a3499d732e996c13c5164143d175"`
Dec 07 08:11:11.951 INFO [stderr] usermod: no changes
Dec 07 08:11:11.982 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
Dec 07 08:11:11.993 INFO [stderr]      Running /target/debug/deps/log_once-fbdf02303151a860
Dec 07 08:11:11.995 INFO [stdout] 
Dec 07 08:11:11.995 INFO [stdout] running 1 test
Dec 07 08:11:11.995 INFO [stdout] test tests::called_once ... ok
Dec 07 08:11:11.995 INFO [stdout] 
Dec 07 08:11:11.995 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:11:11.995 INFO [stdout] 
Dec 07 08:11:11.996 INFO [stderr]      Running /target/debug/deps/debug-2629e101b0edf83d
Dec 07 08:11:11.997 INFO [stdout] 
Dec 07 08:11:11.997 INFO [stdout] running 1 test
Dec 07 08:11:12.001 INFO [stdout] test debug ... ok
Dec 07 08:11:12.001 INFO [stderr]      Running /target/debug/deps/error-2bea6a9dfd3dc635
Dec 07 08:11:12.001 INFO [stdout] 
Dec 07 08:11:12.001 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:11:12.001 INFO [stdout] 
Dec 07 08:11:12.006 INFO [stdout] 
Dec 07 08:11:12.006 INFO [stdout] running 1 test
Dec 07 08:11:12.012 INFO [stdout] test error ... ok
Dec 07 08:11:12.012 INFO [stdout] 
Dec 07 08:11:12.012 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:11:12.012 INFO [stdout] 
Dec 07 08:11:12.013 INFO [stderr]      Running /target/debug/deps/info-103fb9db404e823a
Dec 07 08:11:12.016 INFO [stderr]      Running /target/debug/deps/trace-fb4d308bf3008043
Dec 07 08:11:12.016 INFO [stdout] 
Dec 07 08:11:12.016 INFO [stdout] running 1 test
Dec 07 08:11:12.016 INFO [stdout] test info ... ok
Dec 07 08:11:12.016 INFO [stdout] 
Dec 07 08:11:12.016 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:11:12.016 INFO [stdout] 
Dec 07 08:11:12.016 INFO [stdout] 
Dec 07 08:11:12.016 INFO [stdout] running 1 test
Dec 07 08:11:12.016 INFO [stdout] test trace ... ok
Dec 07 08:11:12.016 INFO [stdout] 
Dec 07 08:11:12.016 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:11:12.016 INFO [stdout] 
Dec 07 08:11:12.016 INFO [stderr]      Running /target/debug/deps/warn-d5b7e5451d715dbe
Dec 07 08:11:12.024 INFO [stderr]    Doc-tests log-once
Dec 07 08:11:12.024 INFO [stdout] 
Dec 07 08:11:12.024 INFO [stdout] running 1 test
Dec 07 08:11:12.024 INFO [stdout] test warn ... ok
Dec 07 08:11:12.024 INFO [stdout] 
Dec 07 08:11:12.024 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:11:12.024 INFO [stdout] 
Dec 07 08:11:12.868 INFO [stdout] 
Dec 07 08:11:12.869 INFO [stdout] running 1 test
Dec 07 08:11:14.060 INFO [stdout] test src/lib.rs -  (line 22) ... ok
Dec 07 08:11:14.060 INFO [stdout] 
Dec 07 08:11:14.060 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 08:11:14.060 INFO [stdout] 
Dec 07 08:11:14.075 INFO [stderr] su: No module specific data is present
Dec 07 08:11:14.716 INFO running `"docker" "inspect" "4e503e1770fd506dcb61c2f3c8c7e58b9a96a3499d732e996c13c5164143d175"`
Dec 07 08:11:14.834 INFO running `"docker" "rm" "-f" "4e503e1770fd506dcb61c2f3c8c7e58b9a96a3499d732e996c13c5164143d175"`
Dec 07 08:11:14.965 INFO [stdout] 4e503e1770fd506dcb61c2f3c8c7e58b9a96a3499d732e996c13c5164143d175