Dec 06 04:51:52.100 INFO testing brocode/fblog against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 06 04:51:52.100 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 04:51:52.630 INFO [stdout] 36cae26f7c81448a1bd9be54ea15a84cc19886ee4e2e0fc5569e82a357f0ebdc
Dec 06 04:51:52.632 INFO running `"docker" "start" "-a" "36cae26f7c81448a1bd9be54ea15a84cc19886ee4e2e0fc5569e82a357f0ebdc"`
Dec 06 04:51:53.734 INFO [stderr] usermod: no changes
Dec 06 04:51:53.886 INFO [stderr]    Compiling lua52-sys v0.1.2
Dec 06 04:51:59.616 INFO [stderr]    Compiling hlua v0.4.1
Dec 06 04:52:01.616 INFO [stderr]    Compiling fblog v1.2.1-alpha.0 (/source)
Dec 06 04:52:05.185 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.42s
Dec 06 04:52:05.191 INFO [stderr] su: No module specific data is present
Dec 06 04:52:06.890 INFO running `"docker" "inspect" "36cae26f7c81448a1bd9be54ea15a84cc19886ee4e2e0fc5569e82a357f0ebdc"`
Dec 06 04:52:07.208 INFO running `"docker" "rm" "-f" "36cae26f7c81448a1bd9be54ea15a84cc19886ee4e2e0fc5569e82a357f0ebdc"`
Dec 06 04:52:07.476 INFO [stdout] 36cae26f7c81448a1bd9be54ea15a84cc19886ee4e2e0fc5569e82a357f0ebdc
Dec 06 04:52:07.478 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 04:52:07.936 INFO [stdout] 925bdc930c31002e83fea7f7df7edca481a2b9bfdb28a54604bf2bf92df24216
Dec 06 04:52:07.939 INFO running `"docker" "start" "-a" "925bdc930c31002e83fea7f7df7edca481a2b9bfdb28a54604bf2bf92df24216"`
Dec 06 04:52:08.409 INFO [stderr] usermod: no changes
Dec 06 04:52:08.480 INFO [stderr]    Compiling fblog v1.2.1-alpha.0 (/source)
Dec 06 04:52:13.036 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.61s
Dec 06 04:52:13.048 INFO [stderr] su: No module specific data is present
Dec 06 04:52:13.939 INFO running `"docker" "inspect" "925bdc930c31002e83fea7f7df7edca481a2b9bfdb28a54604bf2bf92df24216"`
Dec 06 04:52:14.146 INFO running `"docker" "rm" "-f" "925bdc930c31002e83fea7f7df7edca481a2b9bfdb28a54604bf2bf92df24216"`
Dec 06 04:52:14.407 INFO [stdout] 925bdc930c31002e83fea7f7df7edca481a2b9bfdb28a54604bf2bf92df24216
Dec 06 04:52:14.420 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 04:52:14.699 INFO [stdout] d852d922bfcc4f3d4d41306b95391fef71913db4a6caf71486e659a125d48732
Dec 06 04:52:14.702 INFO running `"docker" "start" "-a" "d852d922bfcc4f3d4d41306b95391fef71913db4a6caf71486e659a125d48732"`
Dec 06 04:52:15.245 INFO [stderr] usermod: no changes
Dec 06 04:52:15.311 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.05s
Dec 06 04:52:15.324 INFO [stderr]      Running /target/debug/deps/fblog-e33c0da3295f9418
Dec 06 04:52:15.328 INFO [stdout] 
Dec 06 04:52:15.328 INFO [stdout] running 15 tests
Dec 06 04:52:15.329 INFO [stdout] test filter::tests::deny_all ... ok
Dec 06 04:52:15.329 INFO [stdout] test filter::tests::allow_all ... ok
Dec 06 04:52:15.329 INFO [stdout] test filter::tests::filter_process ... ok
Dec 06 04:52:15.329 INFO [stdout] test filter::tests::filter_contains ... ok
Dec 06 04:52:15.330 INFO [stdout] test filter::tests::filter_regex ... ok
Dec 06 04:52:15.330 INFO [stdout] test filter::tests::unknown_variable ... ok
Dec 06 04:52:15.333 INFO [stdout] test filter::tests::filter_logical_operators ... ok
Dec 06 04:52:15.335 INFO [stdout] test log::tests::write_log_entry_with_additional_field_and_prefix ... ok
Dec 06 04:52:15.336 INFO [stdout] test filter::tests::no_implicit_return ... ok
Dec 06 04:52:15.338 INFO [stdout] test log::tests::write_log_entry_dump_all ... ok
Dec 06 04:52:15.343 INFO [stdout] test inspect::tests::inspect_log_entry ... ok
Dec 06 04:52:15.343 INFO [stdout] test log::tests::write_log_entry_with_exotic_fields ... ok
Dec 06 04:52:15.344 INFO [stdout] test log::tests::write_log_entry_with_additional_field ... ok
Dec 06 04:52:15.347 INFO [stdout] test log::tests::write_log_entry_with_prefix ... ok
Dec 06 04:52:15.350 INFO [stdout] test log::tests::write_log_entry ... ok
Dec 06 04:52:15.351 INFO [stdout] 
Dec 06 04:52:15.351 INFO [stdout] test result: ok. 15 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 06 04:52:15.351 INFO [stdout] 
Dec 06 04:52:15.353 INFO [stderr] su: No module specific data is present
Dec 06 04:52:15.642 INFO running `"docker" "inspect" "d852d922bfcc4f3d4d41306b95391fef71913db4a6caf71486e659a125d48732"`
Dec 06 04:52:15.754 INFO running `"docker" "rm" "-f" "d852d922bfcc4f3d4d41306b95391fef71913db4a6caf71486e659a125d48732"`
Dec 06 04:52:15.878 INFO [stdout] d852d922bfcc4f3d4d41306b95391fef71913db4a6caf71486e659a125d48732