Oct 14 11:10:09.300 INFO testing michaelmior/eson against try#40d4795669493f1965de7c44029c69552134fe1f for rustdoc-test-static-cling-1
Oct 14 11:10:09.300 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-2/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-2/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 14 11:10:09.845 INFO blam! dfe09d77602a32f0a259c0dbfe4dcdc2aa6409dc795fa3356a2e2189b7c4adfe
Oct 14 11:10:09.847 INFO running `"docker" "start" "-a" "dfe09d77602a32f0a259c0dbfe4dcdc2aa6409dc795fa3356a2e2189b7c4adfe"`
Oct 14 11:10:11.267 INFO kablam! usermod: no changes
Oct 14 11:10:11.403 INFO kablam!    Compiling libc v0.2.26
Oct 14 11:10:11.403 INFO kablam!    Compiling either v1.1.0
Oct 14 11:10:11.403 INFO kablam!    Compiling permutation v0.2.5
Oct 14 11:10:11.403 INFO kablam!    Compiling defaultmap v0.3.0
Oct 14 11:10:11.403 INFO kablam!    Compiling group-by v1.0.0
Oct 14 11:10:11.403 INFO kablam!    Compiling argparse v0.2.1
Oct 14 11:10:11.403 INFO kablam!    Compiling float-ord v0.1.2
Oct 14 11:10:11.403 INFO kablam!    Compiling ordermap v0.2.11
Oct 14 11:10:12.260 INFO kablam!    Compiling peg v0.5.4
Oct 14 11:10:12.335 INFO kablam!    Compiling string-intern v0.1.7
Oct 14 11:10:12.435 INFO kablam!    Compiling itertools v0.6.1
Oct 14 11:10:16.775 INFO kablam!    Compiling thread-id v3.2.0
Oct 14 11:10:17.279 INFO kablam!    Compiling simple-logging v1.0.1
Oct 14 11:10:21.824 INFO kablam!    Compiling eson v0.1.0 (/source)
Oct 14 11:10:32.064 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 20.77s
Oct 14 11:10:32.068 INFO kablam! su: No module specific data is present
Oct 14 11:10:34.023 INFO running `"docker" "rm" "-f" "dfe09d77602a32f0a259c0dbfe4dcdc2aa6409dc795fa3356a2e2189b7c4adfe"`
Oct 14 11:10:34.339 INFO blam! dfe09d77602a32f0a259c0dbfe4dcdc2aa6409dc795fa3356a2e2189b7c4adfe
Oct 14 11:10:34.347 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-2/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-2/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 14 11:10:34.819 INFO blam! cee2ade6c139d193b6d5ea33d155f65002dfa3ce1b0f04a172462ac901508b54
Oct 14 11:10:34.835 INFO running `"docker" "start" "-a" "cee2ade6c139d193b6d5ea33d155f65002dfa3ce1b0f04a172462ac901508b54"`
Oct 14 11:10:36.490 INFO kablam! usermod: no changes
Oct 14 11:10:36.571 INFO kablam!    Compiling collect-mac v0.1.0
Oct 14 11:10:36.851 INFO kablam!    Compiling eson v0.1.0 (/source)
Oct 14 11:10:49.623 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 13.10s
Oct 14 11:10:49.627 INFO kablam! su: No module specific data is present
Oct 14 11:10:50.932 INFO running `"docker" "rm" "-f" "cee2ade6c139d193b6d5ea33d155f65002dfa3ce1b0f04a172462ac901508b54"`
Oct 14 11:10:51.225 INFO blam! cee2ade6c139d193b6d5ea33d155f65002dfa3ce1b0f04a172462ac901508b54
Oct 14 11:10:51.244 INFO running `"docker" "create" "-v" "/mnt/big/crater/./work/local/target-dirs/rustdoc-test-static-cling-1/worker-2/try#40d4795669493f1965de7c44029c69552134fe1f:/target:rw,Z" "-v" "/mnt/big/crater/./work/local/test-source/worker-2/rustdoc-test-static-cling-1/try#40d4795669493f1965de7c44029c69552134fe1f:/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 +40d4795669493f1965de7c44029c69552134fe1f-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"`
Oct 14 11:10:51.744 INFO blam! a736b16dfdcb9e0c161062a8a0abd44a16fb60662dd6f87827c9890c63e3272e
Oct 14 11:10:51.747 INFO running `"docker" "start" "-a" "a736b16dfdcb9e0c161062a8a0abd44a16fb60662dd6f87827c9890c63e3272e"`
Oct 14 11:10:53.295 INFO kablam! usermod: no changes
Oct 14 11:10:53.435 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 0.08s
Oct 14 11:10:53.441 INFO kablam!      Running /target/debug/deps/eson-5746c896ae6dfeb4
Oct 14 11:10:53.444 INFO blam! 
Oct 14 11:10:53.445 INFO blam! running 52 tests
Oct 14 11:10:53.451 INFO blam! test dependencies::tests::ind_closure_transitive ... ok
Oct 14 11:10:53.451 INFO blam! test dependencies::tests::fd_fmt ... ok
Oct 14 11:10:53.452 INFO blam! test dependencies::tests::fd_trivial ... ok
Oct 14 11:10:53.452 INFO blam! test dependencies::tests::ind_fmt ... ok
Oct 14 11:10:53.452 INFO blam! test dependencies::tests::ind_closure_transitive_reverse ... ok
Oct 14 11:10:53.453 INFO blam! test dependencies::tests::fd_closure ... ok
Oct 14 11:10:53.453 INFO blam! test dependencies::tests::ind_reverse ... ok
Oct 14 11:10:53.453 INFO blam! test dependencies::tests::ind_fmt_same_rhs ... ok
Oct 14 11:10:53.454 INFO blam! test dependencies::tests::ind_is_subset ... ok
Oct 14 11:10:53.454 INFO blam! test dependencies::tests::ind_is_subset_no ... ok
Oct 14 11:10:53.454 INFO blam! test dependencies::tests::ind_is_subset_self ... ok
Oct 14 11:10:53.455 INFO blam! test model::tests::retain_fk_inds_yes ... ok
Oct 14 11:10:53.455 INFO blam! test model::tests::minimize_fds ... ok
Oct 14 11:10:53.455 INFO blam! test model::tests::schema_add_ind_subset ... ok
Oct 14 11:10:53.455 INFO blam! test model::tests::schema_contains_ind ... ok
Oct 14 11:10:53.456 INFO blam! test model::tests::retain_fk_inds_no ... ok
Oct 14 11:10:53.456 INFO blam! test model::tests::prune_fds ... ok
Oct 14 11:10:53.456 INFO blam! test model::tests::schema_copy_inds_partial ... ok
Oct 14 11:10:53.464 INFO blam! test model::tests::schema_copy_inds ... ok
Oct 14 11:10:53.464 INFO blam! test model::tests::schema_prune_inds_yes ... ok
Oct 14 11:10:53.465 INFO blam! test model::tests::schema_prune_inds_fields_one_side ... ok
Oct 14 11:10:53.465 INFO blam! test model::tests::schema_prune_inds_no ... ok
Oct 14 11:10:53.466 INFO blam! test dependencies::tests::fd_reverse ... ok
Oct 14 11:10:53.466 INFO blam! test model::tests::schema_prune_inds_fields ... ok
Oct 14 11:10:53.466 INFO blam! test dependencies::tests::ind_closure_fd ... ok
Oct 14 11:10:53.467 INFO blam! test model::tests::schema_contains_ind_subset ... ok
Oct 14 11:10:53.467 INFO blam! test model::tests::table_add_pk_fd ... ok
Oct 14 11:10:53.467 INFO blam! test model::tests::table_contains_fd_no ... ok
Oct 14 11:10:53.467 INFO blam! test model::tests::table_format_string ... ok
Oct 14 11:10:53.468 INFO blam! test model::tests::table_is_bcnf_yes ... ok
Oct 14 11:10:53.468 INFO blam! test model::tests::table_contains_fd ... ok
Oct 14 11:10:53.469 INFO blam! test model::tests::table_copy_fds ... ok
Oct 14 11:10:53.469 INFO blam! test model::tests::table_is_bcnf_no ... ok
Oct 14 11:10:53.469 INFO blam! test model::tests::table_is_superkey_no ... ok
Oct 14 11:10:53.471 INFO blam! test model::tests::table_is_superkey_yes ... ok
Oct 14 11:10:53.471 INFO blam! test model::tests::table_no_violating_fd ... ok
Oct 14 11:10:53.472 INFO blam! test model::tests::table_set_primary_key_length ... ok
Oct 14 11:10:53.472 INFO blam! test model::tests::table_key_fields ... ok
Oct 14 11:10:53.472 INFO blam! test model::tests::table_set_primary_key_no_stats ... ok
Oct 14 11:10:53.472 INFO blam! test model::tests::table_set_primary_key_position ... ok
Oct 14 11:10:53.473 INFO blam! test model::tests::table_set_primary_key_value ... ok
Oct 14 11:10:53.473 INFO blam! test model::tests::table_violating_fd_length ... ok
Oct 14 11:10:53.473 INFO blam! test model::tests::table_violating_fd_no_stats ... ok
Oct 14 11:10:53.474 INFO blam! test model::tests::table_violating_fd_position ... ok
Oct 14 11:10:53.474 INFO blam! test model::tests::table_violating_fd_value ... ok
Oct 14 11:10:53.499 INFO blam! test normalize::test::normalize ... ok
Oct 14 11:10:53.499 INFO blam! test model::tests::tables_equal_by_name ... ok
Oct 14 11:10:53.500 INFO blam! test normalize::test::normalize_change_keys ... ok
Oct 14 11:10:53.500 INFO blam! test normalize::test::subsume_fields ... ok
Oct 14 11:10:53.500 INFO blam! test normalize::test::subsume_merge ... ok
Oct 14 11:10:53.500 INFO blam! test normalize::test::subsume_table ... ok
Oct 14 11:10:53.567 INFO blam! test model::tests::table_set_primary_key_invalid ... ok
Oct 14 11:10:53.567 INFO blam! 
Oct 14 11:10:53.568 INFO blam! test result: ok. 52 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Oct 14 11:10:53.568 INFO blam! 
Oct 14 11:10:53.569 INFO kablam! su: No module specific data is present
Oct 14 11:10:54.139 INFO running `"docker" "rm" "-f" "a736b16dfdcb9e0c161062a8a0abd44a16fb60662dd6f87827c9890c63e3272e"`
Oct 14 11:10:54.403 INFO blam! a736b16dfdcb9e0c161062a8a0abd44a16fb60662dd6f87827c9890c63e3272e