Dec 13 09:22:07.219 INFO testing naokirin/logian against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 13 09:22:07.219 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 09:22:07.507 INFO [stdout] b019f6b9547c6ebe31cabe0f0e58e97ed6c3ce26b37880cfc7cb1598f6d2a8b5
Dec 13 09:22:07.511 INFO running `"docker" "start" "-a" "b019f6b9547c6ebe31cabe0f0e58e97ed6c3ce26b37880cfc7cb1598f6d2a8b5"`
Dec 13 09:22:08.343 INFO [stderr] usermod: no changes
Dec 13 09:22:08.559 INFO [stderr]    Compiling unidecode v0.2.0
Dec 13 09:22:08.559 INFO [stderr]    Compiling serde v1.0.19
Dec 13 09:22:08.563 INFO [stderr]    Compiling pest v0.4.1
Dec 13 09:22:08.563 INFO [stderr]    Compiling humansize v1.0.1
Dec 13 09:22:08.571 INFO [stderr]    Compiling fs_extra v1.0.0
Dec 13 09:22:08.572 INFO [stderr]    Compiling heck v0.3.0
Dec 13 09:22:08.573 INFO [stderr]    Compiling serde_derive_internals v0.17.0
Dec 13 09:22:13.376 INFO [stderr]    Compiling serde_derive v1.0.19
Dec 13 09:22:16.851 INFO [stderr]    Compiling slug v0.1.2
Dec 13 09:22:24.399 INFO [stderr]    Compiling serde_json v1.0.6
Dec 13 09:22:24.399 INFO [stderr]    Compiling docopt v0.8.1
Dec 13 09:22:29.247 INFO [stderr]    Compiling tera v0.10.10
Dec 13 09:22:39.339 INFO [stderr]    Compiling logian v0.0.1 (/source)
Dec 13 09:22:49.165 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 40.79s
Dec 13 09:22:49.173 INFO [stderr] su: No module specific data is present
Dec 13 09:22:50.998 INFO running `"docker" "inspect" "b019f6b9547c6ebe31cabe0f0e58e97ed6c3ce26b37880cfc7cb1598f6d2a8b5"`
Dec 13 09:22:51.483 INFO running `"docker" "rm" "-f" "b019f6b9547c6ebe31cabe0f0e58e97ed6c3ce26b37880cfc7cb1598f6d2a8b5"`
Dec 13 09:22:51.755 INFO [stdout] b019f6b9547c6ebe31cabe0f0e58e97ed6c3ce26b37880cfc7cb1598f6d2a8b5
Dec 13 09:22:51.759 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 09:22:52.328 INFO [stdout] 611c925d74f9700914c8aebce7cd2df0bd4e65884d76857c53d57e910a024aac
Dec 13 09:22:52.332 INFO running `"docker" "start" "-a" "611c925d74f9700914c8aebce7cd2df0bd4e65884d76857c53d57e910a024aac"`
Dec 13 09:22:53.991 INFO [stderr] usermod: no changes
Dec 13 09:22:54.183 INFO [stderr]    Compiling logian v0.0.1 (/source)
Dec 13 09:23:02.070 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.02s
Dec 13 09:23:02.079 INFO [stderr] su: No module specific data is present
Dec 13 09:23:03.743 INFO running `"docker" "inspect" "611c925d74f9700914c8aebce7cd2df0bd4e65884d76857c53d57e910a024aac"`
Dec 13 09:23:04.147 INFO running `"docker" "rm" "-f" "611c925d74f9700914c8aebce7cd2df0bd4e65884d76857c53d57e910a024aac"`
Dec 13 09:23:04.471 INFO [stdout] 611c925d74f9700914c8aebce7cd2df0bd4e65884d76857c53d57e910a024aac
Dec 13 09:23:04.479 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-3/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-3/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 13 09:23:05.039 INFO [stdout] eb22532214bec9d198cdff576cb6b4c3a4cb12fec57893ab8ee853197cea527c
Dec 13 09:23:05.040 INFO running `"docker" "start" "-a" "eb22532214bec9d198cdff576cb6b4c3a4cb12fec57893ab8ee853197cea527c"`
Dec 13 09:23:06.091 INFO [stderr] usermod: no changes
Dec 13 09:23:06.303 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Dec 13 09:23:06.315 INFO [stderr]      Running /target/debug/deps/logian-89287624999bd628
Dec 13 09:23:06.316 INFO [stdout] 
Dec 13 09:23:06.316 INFO [stdout] running 0 tests
Dec 13 09:23:06.319 INFO [stdout] 
Dec 13 09:23:06.319 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 09:23:06.319 INFO [stdout] 
Dec 13 09:23:06.319 INFO [stdout] 
Dec 13 09:23:06.319 INFO [stdout] running 0 tests
Dec 13 09:23:06.319 INFO [stdout] 
Dec 13 09:23:06.319 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 09:23:06.319 INFO [stdout] 
Dec 13 09:23:06.319 INFO [stderr]      Running /target/debug/deps/logian-3081ebdf8397e1d0
Dec 13 09:23:06.319 INFO [stderr]      Running /target/debug/deps/lib-452493d2cbba8122
Dec 13 09:23:06.335 INFO [stdout] 
Dec 13 09:23:06.335 INFO [stdout] running 26 tests
Dec 13 09:23:06.343 INFO [stdout] test file::test_reader::test_read_no_file ... ok
Dec 13 09:23:06.343 INFO [stdout] test schema::test_generator::test_generate_empty_field_default_log_schema ... ok
Dec 13 09:23:06.347 INFO [stdout] test schema::test_generator::test_generate_fields_log_schema ... ok
Dec 13 09:23:06.363 INFO [stdout] test schema::test_generator::test_generate_empty_field_type_schema ... ok
Dec 13 09:23:06.363 INFO [stdout] test schema::test_generator::test_generate_fields_default_log_schema ... ok
Dec 13 09:23:06.363 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_not_object ... ok
Dec 13 09:23:06.363 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_no_string_type_name ... ok
Dec 13 09:23:06.363 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_undefined_type ... ok
Dec 13 09:23:06.377 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_not_array ... ok
Dec 13 09:23:06.377 INFO [stdout] test schema::test_generator::test_generate_empty_field_log_schema ... ok
Dec 13 09:23:06.377 INFO [stdout] test schema::test_generator::test_generate_fields_type_schema ... ok
Dec 13 09:23:06.377 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_schema_for_not_array ... ok
Dec 13 09:23:06.377 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_type_for_no_string_type_name ... ok
Dec 13 09:23:06.377 INFO [stdout] test schema::test_parser::test_parse_default_log_schema ... ok
Dec 13 09:23:06.377 INFO [stdout] test schema::test_parser::test_parse_log_schema_with_user_defined_type ... ok
Dec 13 09:23:06.382 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_type_for_undefined_type ... ok
Dec 13 09:23:06.382 INFO [stdout] test schema::test_generator::test_generate_one_field_type_schema ... ok
Dec 13 09:23:06.382 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_no_string_type_name ... ok
Dec 13 09:23:06.387 INFO [stdout] test schema::test_parser::test_parse_user_defined_type ... ok
Dec 13 09:23:06.387 INFO [stdout] test schema::test_parser::test_parse_one_field_schema ... ok
Dec 13 09:23:06.391 INFO [stdout] test schema::test_parser::test_parse_empty_schema ... ok
Dec 13 09:23:06.391 INFO [stdout] test schema::test_parser::test_parse_nullable_field ... ok
Dec 13 09:23:06.391 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_undefined_type ... ok
Dec 13 09:23:06.403 INFO [stdout] test schema::test_generator::test_generate_one_field_log_schema ... ok
Dec 13 09:23:06.415 INFO [stdout] test schema::test_generator::test_generate_one_field_default_log_schema ... ok
Dec 13 09:23:06.421 INFO [stderr]    Doc-tests logian
Dec 13 09:23:06.421 INFO [stdout] test schema::test_parser::test_parse_mutiple_field_schema ... ok
Dec 13 09:23:06.421 INFO [stdout] 
Dec 13 09:23:06.421 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 09:23:06.421 INFO [stdout] 
Dec 13 09:23:08.623 INFO [stdout] 
Dec 13 09:23:08.623 INFO [stdout] running 0 tests
Dec 13 09:23:08.623 INFO [stdout] 
Dec 13 09:23:08.623 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 09:23:08.623 INFO [stdout] 
Dec 13 09:23:08.631 INFO [stderr] su: No module specific data is present
Dec 13 09:23:09.625 INFO running `"docker" "inspect" "eb22532214bec9d198cdff576cb6b4c3a4cb12fec57893ab8ee853197cea527c"`
Dec 13 09:23:09.896 INFO running `"docker" "rm" "-f" "eb22532214bec9d198cdff576cb6b4c3a4cb12fec57893ab8ee853197cea527c"`
Dec 13 09:23:10.274 INFO [stdout] eb22532214bec9d198cdff576cb6b4c3a4cb12fec57893ab8ee853197cea527c