Dec 05 13:12:43.572 INFO testing naokirin/logian against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 05 13:12:43.572 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 05 13:12:44.023 INFO [stdout] 9379ab7000bd8de7b7a9e9eb16fc8ef489bd3ae243a7ab750af30bdd6dd4e051
Dec 05 13:12:44.029 INFO running `"docker" "start" "-a" "9379ab7000bd8de7b7a9e9eb16fc8ef489bd3ae243a7ab750af30bdd6dd4e051"`
Dec 05 13:12:44.777 INFO [stderr] usermod: no changes
Dec 05 13:12:44.950 INFO [stderr]    Compiling serde v1.0.19
Dec 05 13:12:44.950 INFO [stderr]    Compiling unidecode v0.2.0
Dec 05 13:12:44.952 INFO [stderr]    Compiling pest v0.4.1
Dec 05 13:12:44.952 INFO [stderr]    Compiling humansize v1.0.1
Dec 05 13:12:44.952 INFO [stderr]    Compiling fs_extra v1.0.0
Dec 05 13:12:44.960 INFO [stderr]    Compiling heck v0.3.0
Dec 05 13:12:44.960 INFO [stderr]    Compiling serde_derive v1.0.19
Dec 05 13:12:44.960 INFO [stderr]    Compiling error-chain v0.10.0
Dec 05 13:12:51.924 INFO [stderr]    Compiling slug v0.1.2
Dec 05 13:13:03.040 INFO [stderr]    Compiling serde_json v1.0.6
Dec 05 13:13:03.040 INFO [stderr]    Compiling docopt v0.8.1
Dec 05 13:13:09.199 INFO [stderr]    Compiling tera v0.10.10
Dec 05 13:13:16.634 INFO [stderr]    Compiling logian v0.0.1 (/source)
Dec 05 13:13:25.078 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 40.27s
Dec 05 13:13:25.086 INFO [stderr] su: No module specific data is present
Dec 05 13:13:25.832 INFO running `"docker" "inspect" "9379ab7000bd8de7b7a9e9eb16fc8ef489bd3ae243a7ab750af30bdd6dd4e051"`
Dec 05 13:13:26.186 INFO running `"docker" "rm" "-f" "9379ab7000bd8de7b7a9e9eb16fc8ef489bd3ae243a7ab750af30bdd6dd4e051"`
Dec 05 13:13:26.456 INFO [stdout] 9379ab7000bd8de7b7a9e9eb16fc8ef489bd3ae243a7ab750af30bdd6dd4e051
Dec 05 13:13:26.463 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 05 13:13:26.864 INFO [stdout] 7d5850430a73ce393b50904ae4da2b2073b9d5505fc9b65d3cb5e72196e95b75
Dec 05 13:13:26.866 INFO running `"docker" "start" "-a" "7d5850430a73ce393b50904ae4da2b2073b9d5505fc9b65d3cb5e72196e95b75"`
Dec 05 13:13:28.347 INFO [stderr] usermod: no changes
Dec 05 13:13:28.504 INFO [stderr]    Compiling logian v0.0.1 (/source)
Dec 05 13:13:36.052 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.67s
Dec 05 13:13:36.064 INFO [stderr] su: No module specific data is present
Dec 05 13:13:37.038 INFO running `"docker" "inspect" "7d5850430a73ce393b50904ae4da2b2073b9d5505fc9b65d3cb5e72196e95b75"`
Dec 05 13:13:37.430 INFO running `"docker" "rm" "-f" "7d5850430a73ce393b50904ae4da2b2073b9d5505fc9b65d3cb5e72196e95b75"`
Dec 05 13:13:37.800 INFO [stdout] 7d5850430a73ce393b50904ae4da2b2073b9d5505fc9b65d3cb5e72196e95b75
Dec 05 13:13:37.806 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 05 13:13:38.262 INFO [stdout] 0caaf40b92edaeaaff84ef9da85b7ade970b2f1248d10bdc0c3421fb1753962e
Dec 05 13:13:38.268 INFO running `"docker" "start" "-a" "0caaf40b92edaeaaff84ef9da85b7ade970b2f1248d10bdc0c3421fb1753962e"`
Dec 05 13:13:39.720 INFO [stderr] usermod: no changes
Dec 05 13:13:39.888 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.15s
Dec 05 13:13:39.900 INFO [stderr]      Running /target/debug/deps/logian-f17b628b781ffc43
Dec 05 13:13:39.904 INFO [stdout] 
Dec 05 13:13:39.904 INFO [stdout] running 0 tests
Dec 05 13:13:39.904 INFO [stdout] 
Dec 05 13:13:39.904 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 13:13:39.904 INFO [stdout] 
Dec 05 13:13:39.906 INFO [stderr]      Running /target/debug/deps/logian-1af15e643fb0f120
Dec 05 13:13:39.911 INFO [stdout] 
Dec 05 13:13:39.911 INFO [stdout] running 0 tests
Dec 05 13:13:39.911 INFO [stdout] 
Dec 05 13:13:39.911 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 13:13:39.911 INFO [stdout] 
Dec 05 13:13:39.911 INFO [stdout] 
Dec 05 13:13:39.911 INFO [stdout] running 26 tests
Dec 05 13:13:39.911 INFO [stderr]      Running /target/debug/deps/lib-cf35ecd23c4c1cdb
Dec 05 13:13:39.918 INFO [stdout] test file::test_reader::test_read_no_file ... ok
Dec 05 13:13:39.924 INFO [stdout] test schema::test_generator::test_generate_empty_field_default_log_schema ... ok
Dec 05 13:13:39.924 INFO [stdout] test schema::test_generator::test_generate_fields_default_log_schema ... ok
Dec 05 13:13:39.936 INFO [stdout] test schema::test_generator::test_generate_fields_log_schema ... ok
Dec 05 13:13:39.937 INFO [stdout] test schema::test_generator::test_generate_one_field_log_schema ... ok
Dec 05 13:13:39.946 INFO [stdout] test schema::test_generator::test_generate_empty_field_type_schema ... ok
Dec 05 13:13:39.948 INFO [stdout] test schema::test_generator::test_generate_empty_field_log_schema ... ok
Dec 05 13:13:39.952 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_not_object ... ok
Dec 05 13:13:39.952 INFO [stdout] test schema::test_generator::test_generate_one_field_type_schema ... ok
Dec 05 13:13:39.952 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_undefined_type ... ok
Dec 05 13:13:39.952 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_not_array ... ok
Dec 05 13:13:39.960 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_schema_for_not_array ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_no_string_type_name ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_no_string_type_name ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_type_for_no_string_type_name ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_type_for_undefined_type ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_generator::test_generate_one_field_default_log_schema ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_undefined_type ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_parse_empty_schema ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_parse_log_schema_with_user_defined_type ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_generator::test_generate_fields_type_schema ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_parse_nullable_field ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_parse_mutiple_field_schema ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_parse_one_field_schema ... ok
Dec 05 13:13:39.968 INFO [stdout] test schema::test_parser::test_parse_default_log_schema ... ok
Dec 05 13:13:39.976 INFO [stdout] test schema::test_parser::test_parse_user_defined_type ... ok
Dec 05 13:13:39.976 INFO [stdout] 
Dec 05 13:13:39.976 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 13:13:39.976 INFO [stdout] 
Dec 05 13:13:39.982 INFO [stderr]    Doc-tests logian
Dec 05 13:13:42.008 INFO [stdout] 
Dec 05 13:13:42.008 INFO [stdout] running 0 tests
Dec 05 13:13:42.008 INFO [stdout] 
Dec 05 13:13:42.008 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 05 13:13:42.008 INFO [stdout] 
Dec 05 13:13:42.009 INFO [stderr] su: No module specific data is present
Dec 05 13:13:42.784 INFO running `"docker" "inspect" "0caaf40b92edaeaaff84ef9da85b7ade970b2f1248d10bdc0c3421fb1753962e"`
Dec 05 13:13:43.070 INFO running `"docker" "rm" "-f" "0caaf40b92edaeaaff84ef9da85b7ade970b2f1248d10bdc0c3421fb1753962e"`
Dec 05 13:13:43.402 INFO [stdout] 0caaf40b92edaeaaff84ef9da85b7ade970b2f1248d10bdc0c3421fb1753962e