Nov 16 18:33:04.712 INFO testing naokirin/logian against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 16 18:33:04.712 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 18:33:04.991 INFO [stdout] 00f643affcb970b2f81176136afdefc6ba00b7042fa754dba4af9df4612e0fa2
Nov 16 18:33:04.994 INFO running `"docker" "start" "-a" "00f643affcb970b2f81176136afdefc6ba00b7042fa754dba4af9df4612e0fa2"`
Nov 16 18:33:05.495 INFO [stderr] usermod: no changes
Nov 16 18:33:05.623 INFO [stderr]    Compiling unidecode v0.2.0
Nov 16 18:33:05.623 INFO [stderr]    Compiling humansize v1.0.1
Nov 16 18:33:05.623 INFO [stderr]    Compiling fs_extra v1.0.0
Nov 16 18:33:05.625 INFO [stderr]    Compiling docopt v0.8.1
Nov 16 18:33:11.019 INFO [stderr]    Compiling slug v0.1.2
Nov 16 18:33:12.099 INFO [stderr]    Compiling tera v0.10.10
Nov 16 18:33:23.108 INFO [stderr]    Compiling logian v0.0.1 (/source)
Nov 16 18:33:32.942 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 27.43s
Nov 16 18:33:32.950 INFO [stderr] su: No module specific data is present
Nov 16 18:33:34.687 INFO running `"docker" "inspect" "00f643affcb970b2f81176136afdefc6ba00b7042fa754dba4af9df4612e0fa2"`
Nov 16 18:33:35.049 INFO running `"docker" "rm" "-f" "00f643affcb970b2f81176136afdefc6ba00b7042fa754dba4af9df4612e0fa2"`
Nov 16 18:33:35.387 INFO [stdout] 00f643affcb970b2f81176136afdefc6ba00b7042fa754dba4af9df4612e0fa2
Nov 16 18:33:35.397 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 18:33:35.919 INFO [stdout] 631769a7feda7455fd89d2c4bdbf983964a2e1ea35928fc3973a78429870e1ac
Nov 16 18:33:35.922 INFO running `"docker" "start" "-a" "631769a7feda7455fd89d2c4bdbf983964a2e1ea35928fc3973a78429870e1ac"`
Nov 16 18:33:38.469 INFO [stderr] usermod: no changes
Nov 16 18:33:38.597 INFO [stderr]    Compiling logian v0.0.1 (/source)
Nov 16 18:33:46.527 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.03s
Nov 16 18:33:46.540 INFO [stderr] su: No module specific data is present
Nov 16 18:33:48.405 INFO running `"docker" "inspect" "631769a7feda7455fd89d2c4bdbf983964a2e1ea35928fc3973a78429870e1ac"`
Nov 16 18:33:48.797 INFO running `"docker" "rm" "-f" "631769a7feda7455fd89d2c4bdbf983964a2e1ea35928fc3973a78429870e1ac"`
Nov 16 18:33:49.111 INFO [stdout] 631769a7feda7455fd89d2c4bdbf983964a2e1ea35928fc3973a78429870e1ac
Nov 16 18:33:49.118 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-3/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/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 18:33:49.586 INFO [stdout] be9fbfabf44dac4677c3238ee2e238421edf81ef1c2e0db0c4bb20ee24039801
Nov 16 18:33:49.588 INFO running `"docker" "start" "-a" "be9fbfabf44dac4677c3238ee2e238421edf81ef1c2e0db0c4bb20ee24039801"`
Nov 16 18:33:51.839 INFO [stderr] usermod: no changes
Nov 16 18:33:51.987 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.13s
Nov 16 18:33:51.995 INFO [stdout] 
Nov 16 18:33:51.995 INFO [stdout] running 0 tests
Nov 16 18:33:51.995 INFO [stdout] 
Nov 16 18:33:51.995 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 18:33:51.995 INFO [stdout] 
Nov 16 18:33:51.996 INFO [stderr]      Running /target/debug/deps/logian-9baafc9a4f80df9e
Nov 16 18:33:51.996 INFO [stderr]      Running /target/debug/deps/logian-39a8b79973f8787e
Nov 16 18:33:51.999 INFO [stdout] 
Nov 16 18:33:51.999 INFO [stdout] running 0 tests
Nov 16 18:33:51.999 INFO [stdout] 
Nov 16 18:33:51.999 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 18:33:51.999 INFO [stdout] 
Nov 16 18:33:52.000 INFO [stderr]      Running /target/debug/deps/lib-741dbd19aff714ea
Nov 16 18:33:52.023 INFO [stdout] 
Nov 16 18:33:52.023 INFO [stdout] running 26 tests
Nov 16 18:33:52.024 INFO [stdout] test file::test_reader::test_read_no_file ... ok
Nov 16 18:33:52.042 INFO [stdout] test schema::test_generator::test_generate_empty_field_type_schema ... ok
Nov 16 18:33:52.045 INFO [stdout] test schema::test_generator::test_generate_empty_field_log_schema ... ok
Nov 16 18:33:52.045 INFO [stdout] test schema::test_generator::test_generate_empty_field_default_log_schema ... ok
Nov 16 18:33:52.045 INFO [stdout] test schema::test_generator::test_generate_fields_type_schema ... ok
Nov 16 18:33:52.048 INFO [stdout] test schema::test_generator::test_generate_fields_default_log_schema ... ok
Nov 16 18:33:52.062 INFO [stdout] test schema::test_generator::test_generate_one_field_default_log_schema ... ok
Nov 16 18:33:52.065 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_not_object ... ok
Nov 16 18:33:52.065 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_undefined_type ... ok
Nov 16 18:33:52.072 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_no_string_type_name ... ok
Nov 16 18:33:52.072 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_not_array ... ok
Nov 16 18:33:52.072 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_undefined_type ... ok
Nov 16 18:33:52.072 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_no_string_type_name ... ok
Nov 16 18:33:52.072 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_type_for_no_string_type_name ... ok
Nov 16 18:33:52.083 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_type_for_undefined_type ... ok
Nov 16 18:33:52.084 INFO [stdout] test schema::test_parser::test_parse_default_log_schema ... ok
Nov 16 18:33:52.084 INFO [stdout] test schema::test_parser::test_parse_empty_schema ... ok
Nov 16 18:33:52.084 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_schema_for_not_array ... ok
Nov 16 18:33:52.084 INFO [stdout] test schema::test_generator::test_generate_fields_log_schema ... ok
Nov 16 18:33:52.087 INFO [stdout] test schema::test_parser::test_parse_mutiple_field_schema ... ok
Nov 16 18:33:52.091 INFO [stdout] test schema::test_parser::test_parse_one_field_schema ... ok
Nov 16 18:33:52.091 INFO [stdout] test schema::test_parser::test_parse_nullable_field ... ok
Nov 16 18:33:52.091 INFO [stdout] test schema::test_parser::test_parse_user_defined_type ... ok
Nov 16 18:33:52.099 INFO [stdout] test schema::test_parser::test_parse_log_schema_with_user_defined_type ... ok
Nov 16 18:33:52.103 INFO [stdout] test schema::test_generator::test_generate_one_field_log_schema ... ok
Nov 16 18:33:52.104 INFO [stdout] test schema::test_generator::test_generate_one_field_type_schema ... ok
Nov 16 18:33:52.104 INFO [stdout] 
Nov 16 18:33:52.104 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 18:33:52.104 INFO [stdout] 
Nov 16 18:33:52.105 INFO [stderr]    Doc-tests logian
Nov 16 18:33:53.770 INFO [stdout] 
Nov 16 18:33:53.770 INFO [stdout] running 0 tests
Nov 16 18:33:53.771 INFO [stdout] 
Nov 16 18:33:53.772 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 18:33:53.772 INFO [stdout] 
Nov 16 18:33:53.783 INFO [stderr] su: No module specific data is present
Nov 16 18:33:55.451 INFO running `"docker" "inspect" "be9fbfabf44dac4677c3238ee2e238421edf81ef1c2e0db0c4bb20ee24039801"`
Nov 16 18:33:55.833 INFO running `"docker" "rm" "-f" "be9fbfabf44dac4677c3238ee2e238421edf81ef1c2e0db0c4bb20ee24039801"`
Nov 16 18:33:56.227 INFO [stdout] be9fbfabf44dac4677c3238ee2e238421edf81ef1c2e0db0c4bb20ee24039801