Nov 18 14:33:11.881 INFO testing fblog-1.0.1 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 14:33:11.881 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 18 14:33:12.429 INFO [stdout] 0eacd509a50569cc8387a67f2345e9252cdda15adcb26e92031a2779d6813b07
Nov 18 14:33:12.430 INFO running `"docker" "start" "-a" "0eacd509a50569cc8387a67f2345e9252cdda15adcb26e92031a2779d6813b07"`
Nov 18 14:33:13.379 INFO [stderr] usermod: no changes
Nov 18 14:33:13.571 INFO [stderr]    Compiling lua52-sys v0.1.2
Nov 18 14:33:19.375 INFO [stderr]    Compiling hlua v0.4.1
Nov 18 14:33:21.523 INFO [stderr]    Compiling fblog v1.0.1 (/source)
Nov 18 14:33:25.252 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.84s
Nov 18 14:33:25.259 INFO [stderr] su: No module specific data is present
Nov 18 14:33:26.207 INFO running `"docker" "inspect" "0eacd509a50569cc8387a67f2345e9252cdda15adcb26e92031a2779d6813b07"`
Nov 18 14:33:26.504 INFO running `"docker" "rm" "-f" "0eacd509a50569cc8387a67f2345e9252cdda15adcb26e92031a2779d6813b07"`
Nov 18 14:33:26.911 INFO [stdout] 0eacd509a50569cc8387a67f2345e9252cdda15adcb26e92031a2779d6813b07
Nov 18 14:33:26.918 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 18 14:33:27.271 INFO [stdout] bc605ec124eeab062fa3ad268deb37b62e4254786174c1900763cf6c8690b663
Nov 18 14:33:27.279 INFO running `"docker" "start" "-a" "bc605ec124eeab062fa3ad268deb37b62e4254786174c1900763cf6c8690b663"`
Nov 18 14:33:28.529 INFO [stderr] usermod: no changes
Nov 18 14:33:28.627 INFO [stderr]    Compiling fblog v1.0.1 (/source)
Nov 18 14:33:33.628 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 5.07s
Nov 18 14:33:33.635 INFO [stderr] su: No module specific data is present
Nov 18 14:33:34.323 INFO running `"docker" "inspect" "bc605ec124eeab062fa3ad268deb37b62e4254786174c1900763cf6c8690b663"`
Nov 18 14:33:34.571 INFO running `"docker" "rm" "-f" "bc605ec124eeab062fa3ad268deb37b62e4254786174c1900763cf6c8690b663"`
Nov 18 14:33:34.827 INFO [stdout] bc605ec124eeab062fa3ad268deb37b62e4254786174c1900763cf6c8690b663
Nov 18 14:33:34.834 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 18 14:33:35.271 INFO [stdout] 16b0f1cf07df935119ebc15948bdc6772635a1688a743c5e98d9d4d819822243
Nov 18 14:33:35.273 INFO running `"docker" "start" "-a" "16b0f1cf07df935119ebc15948bdc6772635a1688a743c5e98d9d4d819822243"`
Nov 18 14:33:36.323 INFO [stderr] usermod: no changes
Nov 18 14:33:36.434 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
Nov 18 14:33:36.444 INFO [stderr]      Running /target/debug/deps/fblog-3f06efa0973bfd43
Nov 18 14:33:36.447 INFO [stdout] 
Nov 18 14:33:36.447 INFO [stdout] running 13 tests
Nov 18 14:33:36.456 INFO [stdout] test filter::tests::allow_all ... ok
Nov 18 14:33:36.458 INFO [stdout] test filter::tests::deny_all ... ok
Nov 18 14:33:36.458 INFO [stdout] test filter::tests::filter_contains ... ok
Nov 18 14:33:36.479 INFO [stdout] test log::tests::write_log_entry ... ok
Nov 18 14:33:36.479 INFO [stdout] test log::tests::write_log_entry_dump_all ... ok
Nov 18 14:33:36.482 INFO [stdout] test filter::tests::filter_process ... ok
Nov 18 14:33:36.483 INFO [stdout] test filter::tests::filter_logical_operators ... ok
Nov 18 14:33:36.484 INFO [stdout] test filter::tests::filter_regex ... ok
Nov 18 14:33:36.485 INFO [stdout] test filter::tests::unknown_variable ... ok
Nov 18 14:33:36.485 INFO [stdout] test filter::tests::no_implicit_return ... ok
Nov 18 14:33:36.503 INFO [stdout] test log::tests::write_log_entry_with_additional_field ... ok
Nov 18 14:33:36.503 INFO [stdout] test log::tests::write_log_entry_with_exotic_fields ... ok
Nov 18 14:33:36.503 INFO [stdout] test inspect::tests::inspect_log_entry ... ok
Nov 18 14:33:36.503 INFO [stdout] 
Nov 18 14:33:36.503 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 14:33:36.503 INFO [stdout] 
Nov 18 14:33:36.507 INFO [stderr] su: No module specific data is present
Nov 18 14:33:36.991 INFO running `"docker" "inspect" "16b0f1cf07df935119ebc15948bdc6772635a1688a743c5e98d9d4d819822243"`
Nov 18 14:33:37.282 INFO running `"docker" "rm" "-f" "16b0f1cf07df935119ebc15948bdc6772635a1688a743c5e98d9d4d819822243"`
Nov 18 14:33:37.596 INFO [stdout] 16b0f1cf07df935119ebc15948bdc6772635a1688a743c5e98d9d4d819822243