Dec 13 09:22:09.710 INFO testing naokirin/logian against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 13 09:22:09.711 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:10.311 INFO [stdout] 0ee71c974da6723bf091783f7fb660a85ec9389db99f8888266e08736ce6d6a1
Dec 13 09:22:10.327 INFO running `"docker" "start" "-a" "0ee71c974da6723bf091783f7fb660a85ec9389db99f8888266e08736ce6d6a1"`
Dec 13 09:22:11.601 INFO [stderr] usermod: no changes
Dec 13 09:22:11.960 INFO [stderr]    Compiling serde v1.0.19
Dec 13 09:22:11.967 INFO [stderr]    Compiling heck v0.3.0
Dec 13 09:22:11.967 INFO [stderr]    Compiling serde_derive v1.0.19
Dec 13 09:22:25.027 INFO [stderr]    Compiling serde_json v1.0.6
Dec 13 09:22:25.027 INFO [stderr]    Compiling docopt v0.8.1
Dec 13 09:22:31.275 INFO [stderr]    Compiling tera v0.10.10
Dec 13 09:22:40.699 INFO [stderr]    Compiling logian v0.0.1 (/source)
Dec 13 09:22:51.087 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 39.45s
Dec 13 09:22:51.096 INFO [stderr] su: No module specific data is present
Dec 13 09:22:52.583 INFO running `"docker" "inspect" "0ee71c974da6723bf091783f7fb660a85ec9389db99f8888266e08736ce6d6a1"`
Dec 13 09:22:52.903 INFO running `"docker" "rm" "-f" "0ee71c974da6723bf091783f7fb660a85ec9389db99f8888266e08736ce6d6a1"`
Dec 13 09:22:53.247 INFO [stdout] 0ee71c974da6723bf091783f7fb660a85ec9389db99f8888266e08736ce6d6a1
Dec 13 09:22:53.253 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:53.783 INFO [stdout] b9bbe515859f9fe681fa92818e84301d365b8ec649fb43405a838cc6ed4c734c
Dec 13 09:22:53.787 INFO running `"docker" "start" "-a" "b9bbe515859f9fe681fa92818e84301d365b8ec649fb43405a838cc6ed4c734c"`
Dec 13 09:22:55.203 INFO [stderr] usermod: no changes
Dec 13 09:22:55.404 INFO [stderr]    Compiling logian v0.0.1 (/source)
Dec 13 09:23:03.119 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.89s
Dec 13 09:23:03.127 INFO [stderr] su: No module specific data is present
Dec 13 09:23:03.921 INFO running `"docker" "inspect" "b9bbe515859f9fe681fa92818e84301d365b8ec649fb43405a838cc6ed4c734c"`
Dec 13 09:23:04.172 INFO running `"docker" "rm" "-f" "b9bbe515859f9fe681fa92818e84301d365b8ec649fb43405a838cc6ed4c734c"`
Dec 13 09:23:04.446 INFO [stdout] b9bbe515859f9fe681fa92818e84301d365b8ec649fb43405a838cc6ed4c734c
Dec 13 09:23:04.453 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-0/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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:04.995 INFO [stdout] 391ce7537419171c064b6f1265570dd0676fec92e55ec9d9e2c2feb75bea3e12
Dec 13 09:23:04.996 INFO running `"docker" "start" "-a" "391ce7537419171c064b6f1265570dd0676fec92e55ec9d9e2c2feb75bea3e12"`
Dec 13 09:23:06.179 INFO [stderr] usermod: no changes
Dec 13 09:23:06.377 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.18s
Dec 13 09:23:06.387 INFO [stderr]      Running /target/debug/deps/logian-a59d76feb2c06cf6
Dec 13 09:23:06.391 INFO [stdout] 
Dec 13 09:23:06.391 INFO [stdout] running 0 tests
Dec 13 09:23:06.391 INFO [stdout] 
Dec 13 09:23:06.391 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 09:23:06.391 INFO [stdout] 
Dec 13 09:23:06.399 INFO [stderr]      Running /target/debug/deps/logian-14d2c45f804162ea
Dec 13 09:23:06.399 INFO [stderr]      Running /target/debug/deps/lib-6c6433fedc228249
Dec 13 09:23:06.399 INFO [stdout] 
Dec 13 09:23:06.399 INFO [stdout] running 0 tests
Dec 13 09:23:06.399 INFO [stdout] 
Dec 13 09:23:06.399 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 09:23:06.399 INFO [stdout] 
Dec 13 09:23:06.399 INFO [stdout] 
Dec 13 09:23:06.399 INFO [stdout] running 26 tests
Dec 13 09:23:06.415 INFO [stdout] test file::test_reader::test_read_no_file ... ok
Dec 13 09:23:06.431 INFO [stdout] test schema::test_generator::test_generate_one_field_log_schema ... ok
Dec 13 09:23:06.431 INFO [stdout] test schema::test_generator::test_generate_empty_field_type_schema ... ok
Dec 13 09:23:06.459 INFO [stdout] test schema::test_generator::test_generate_fields_type_schema ... ok
Dec 13 09:23:06.459 INFO [stdout] test schema::test_generator::test_generate_one_field_type_schema ... ok
Dec 13 09:23:06.483 INFO [stdout] test schema::test_generator::test_generate_fields_log_schema ... ok
Dec 13 09:23:06.483 INFO [stdout] test schema::test_generator::test_generate_one_field_default_log_schema ... ok
Dec 13 09:23:06.483 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_not_object ... ok
Dec 13 09:23:06.483 INFO [stdout] test schema::test_generator::test_generate_fields_default_log_schema ... ok
Dec 13 09:23:06.483 INFO [stdout] test schema::test_generator::test_generate_empty_field_default_log_schema ... ok
Dec 13 09:23:06.483 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_no_string_type_name ... ok
Dec 13 09:23:06.483 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_type_for_no_string_type_name ... ok
Dec 13 09:23:06.483 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_no_string_type_name ... ok
Dec 13 09:23:06.495 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_not_array ... ok
Dec 13 09:23:06.495 INFO [stdout] test schema::test_parser::test_parse_default_log_schema ... ok
Dec 13 09:23:06.495 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_type_for_undefined_type ... ok
Dec 13 09:23:06.495 INFO [stdout] test schema::test_parser::test_error_to_parse_log_schema_for_undefined_type ... ok
Dec 13 09:23:06.495 INFO [stdout] test schema::test_parser::test_error_to_parse_user_defined_schema_for_not_array ... ok
Dec 13 09:23:06.495 INFO [stdout] test schema::test_parser::test_error_to_parse_default_log_schema_for_undefined_type ... ok
Dec 13 09:23:06.495 INFO [stdout] test schema::test_parser::test_parse_nullable_field ... ok
Dec 13 09:23:06.503 INFO [stdout] test schema::test_generator::test_generate_empty_field_log_schema ... ok
Dec 13 09:23:06.503 INFO [stdout] test schema::test_parser::test_parse_empty_schema ... ok
Dec 13 09:23:06.503 INFO [stdout] test schema::test_parser::test_parse_mutiple_field_schema ... ok
Dec 13 09:23:06.503 INFO [stdout] test schema::test_parser::test_parse_log_schema_with_user_defined_type ... ok
Dec 13 09:23:06.503 INFO [stdout] test schema::test_parser::test_parse_user_defined_type ... ok
Dec 13 09:23:06.511 INFO [stdout] test schema::test_parser::test_parse_one_field_schema ... ok
Dec 13 09:23:06.511 INFO [stdout] 
Dec 13 09:23:06.511 INFO [stdout] test result: ok. 26 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 09:23:06.511 INFO [stdout] 
Dec 13 09:23:06.523 INFO [stderr]    Doc-tests logian
Dec 13 09:23:08.552 INFO [stdout] 
Dec 13 09:23:08.552 INFO [stdout] running 0 tests
Dec 13 09:23:08.552 INFO [stdout] 
Dec 13 09:23:08.552 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 13 09:23:08.552 INFO [stdout] 
Dec 13 09:23:08.567 INFO [stderr] su: No module specific data is present
Dec 13 09:23:09.321 INFO running `"docker" "inspect" "391ce7537419171c064b6f1265570dd0676fec92e55ec9d9e2c2feb75bea3e12"`
Dec 13 09:23:09.657 INFO running `"docker" "rm" "-f" "391ce7537419171c064b6f1265570dd0676fec92e55ec9d9e2c2feb75bea3e12"`
Dec 13 09:23:09.978 INFO [stdout] 391ce7537419171c064b6f1265570dd0676fec92e55ec9d9e2c2feb75bea3e12