Nov 16 16:02:41.295 INFO testing rcoh/angle-grinder against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 16:02:41.295 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 16:02:41.531 INFO [stdout] 2b56a0c00236dd91dcfbd04a39d488c81ecd2a4c8b9fee47952ce02c7daa8c7d
Nov 16 16:02:41.536 INFO running `"docker" "start" "-a" "2b56a0c00236dd91dcfbd04a39d488c81ecd2a4c8b9fee47952ce02c7daa8c7d"`
Nov 16 16:02:41.957 INFO [stderr] usermod: no changes
Nov 16 16:02:42.178 INFO [stderr]    Compiling memoffset v0.1.0
Nov 16 16:02:42.178 INFO [stderr]    Compiling quantiles v0.7.1
Nov 16 16:02:42.178 INFO [stderr]    Compiling regex-syntax v0.2.6
Nov 16 16:02:42.181 INFO [stderr]    Compiling itertools v0.7.6
Nov 16 16:02:42.181 INFO [stderr]    Compiling nom v4.0.0-beta3
Nov 16 16:02:42.182 INFO [stderr]    Compiling parking_lot_core v0.2.13
Nov 16 16:02:42.182 INFO [stderr]    Compiling backtrace-sys v0.1.16
Nov 16 16:02:42.182 INFO [stderr]    Compiling rayon-core v1.4.0
Nov 16 16:02:42.615 INFO [stderr]    Compiling structopt-derive v0.2.6
Nov 16 16:02:42.615 INFO [stderr]    Compiling env_logger v0.5.6
Nov 16 16:02:46.441 INFO [stderr]    Compiling terminal_size v0.1.7
Nov 16 16:02:46.552 INFO [stderr]    Compiling backtrace v0.3.5
Nov 16 16:02:47.511 INFO [stderr]    Compiling crossbeam-epoch v0.2.0
Nov 16 16:02:53.597 INFO [stderr]    Compiling parking_lot v0.4.8
Nov 16 16:02:53.603 INFO [stderr]    Compiling failure v0.1.1
Nov 16 16:02:53.755 INFO [stderr]    Compiling rayon v0.9.0
Nov 16 16:02:54.579 INFO [stderr]    Compiling structopt v0.2.6
Nov 16 16:02:55.114 INFO [stderr]    Compiling crossbeam-channel v0.1.2
Nov 16 16:02:58.275 INFO [stderr]    Compiling quicli v0.2.0
Nov 16 16:02:59.503 INFO [stderr]    Compiling ag v0.7.4 (/source)
Nov 16 16:03:12.347 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 30.37s
Nov 16 16:03:12.368 INFO [stderr] su: No module specific data is present
Nov 16 16:03:12.897 INFO running `"docker" "inspect" "2b56a0c00236dd91dcfbd04a39d488c81ecd2a4c8b9fee47952ce02c7daa8c7d"`
Nov 16 16:03:13.239 INFO running `"docker" "rm" "-f" "2b56a0c00236dd91dcfbd04a39d488c81ecd2a4c8b9fee47952ce02c7daa8c7d"`
Nov 16 16:03:13.611 INFO [stdout] 2b56a0c00236dd91dcfbd04a39d488c81ecd2a4c8b9fee47952ce02c7daa8c7d
Nov 16 16:03:13.618 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 16:03:13.983 INFO [stdout] 85a5c915d5b207e7fcae440aa2b2c69cb68b4cbaf3d1e4dc6f1799f1bf5030b7
Nov 16 16:03:13.988 INFO running `"docker" "start" "-a" "85a5c915d5b207e7fcae440aa2b2c69cb68b4cbaf3d1e4dc6f1799f1bf5030b7"`
Nov 16 16:03:15.987 INFO [stderr] usermod: no changes
Nov 16 16:03:16.247 INFO [stderr]    Compiling pulldown-cmark v0.1.2
Nov 16 16:03:16.247 INFO [stderr]    Compiling bytecount v0.2.0
Nov 16 16:03:16.247 INFO [stderr]    Compiling difference v1.0.0
Nov 16 16:03:16.247 INFO [stderr]    Compiling environment v0.1.1
Nov 16 16:03:16.247 INFO [stderr]    Compiling toml v0.4.6
Nov 16 16:03:16.247 INFO [stderr]    Compiling semver v0.8.0
Nov 16 16:03:16.267 INFO [stderr]    Compiling error-chain v0.11.0
Nov 16 16:03:16.267 INFO [stderr]    Compiling tempdir v0.3.6
Nov 16 16:03:21.971 INFO [stderr]    Compiling cargo_metadata v0.3.3
Nov 16 16:03:29.475 INFO [stderr]    Compiling skeptic v0.13.2
Nov 16 16:03:33.360 INFO [stderr]    Compiling assert_cli v0.5.4
Nov 16 16:03:38.111 INFO [stderr]    Compiling ag v0.7.4 (/source)
Nov 16 16:03:52.964 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 36.96s
Nov 16 16:03:52.980 INFO [stderr] su: No module specific data is present
Nov 16 16:03:54.463 INFO running `"docker" "inspect" "85a5c915d5b207e7fcae440aa2b2c69cb68b4cbaf3d1e4dc6f1799f1bf5030b7"`
Nov 16 16:03:54.723 INFO running `"docker" "rm" "-f" "85a5c915d5b207e7fcae440aa2b2c69cb68b4cbaf3d1e4dc6f1799f1bf5030b7"`
Nov 16 16:03:54.999 INFO [stdout] 85a5c915d5b207e7fcae440aa2b2c69cb68b4cbaf3d1e4dc6f1799f1bf5030b7
Nov 16 16:03:55.010 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/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 +2e026d6e5d7621634147ad4c8074f1d964dbb1be-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 16:03:55.475 INFO [stdout] 2f4338da1aa506a0bd4aeaf38ca71a2902f5b1082999abaeb4025837d4e658ba
Nov 16 16:03:55.479 INFO running `"docker" "start" "-a" "2f4338da1aa506a0bd4aeaf38ca71a2902f5b1082999abaeb4025837d4e658ba"`
Nov 16 16:03:56.704 INFO [stderr] usermod: no changes
Nov 16 16:03:56.987 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.23s
Nov 16 16:03:56.990 INFO [stderr]      Running /target/debug/deps/ag-c8e45966fb9e0d2d
Nov 16 16:03:56.995 INFO [stdout] 
Nov 16 16:03:56.995 INFO [stdout] running 31 tests
Nov 16 16:03:56.995 INFO [stdout] test data::tests::agg ... ok
Nov 16 16:03:56.995 INFO [stdout] test lang::tests::parse_agg_operator ... ok
Nov 16 16:03:56.995 INFO [stdout] test data::tests::record_put_get ... ok
Nov 16 16:03:56.995 INFO [stdout] test lang::tests::parse_expr ... ok
Nov 16 16:03:56.995 INFO [stdout] test data::tests::ordering ... ok
Nov 16 16:03:56.997 INFO [stdout] test data::tests::from_string ... ok
Nov 16 16:03:56.997 INFO [stdout] test lang::tests::parse_expr_value ... ok
Nov 16 16:03:56.997 INFO [stdout] test lang::tests::parse_ident ... ok
Nov 16 16:03:56.998 INFO [stdout] test lang::tests::parse_parses ... ok
Nov 16 16:03:56.998 INFO [stdout] test lang::tests::parse_operator ... ok
Nov 16 16:03:56.999 INFO [stdout] test lang::tests::parse_expr_ident ... ok
Nov 16 16:03:56.999 INFO [stdout] test lang::tests::parse_var_list ... ok
Nov 16 16:03:56.999 INFO [stdout] test lang::tests::query_no_operators ... ok
Nov 16 16:03:56.999 INFO [stdout] test lang::tests::parse_quoted_string ... ok
Nov 16 16:03:56.999 INFO [stdout] test lang::tests::parse_percentile ... ok
Nov 16 16:03:57.007 INFO [stdout] test operator::tests::count_groups ... ok
Nov 16 16:03:57.007 INFO [stdout] test lang::tests::query_operators ... ok
Nov 16 16:03:57.007 INFO [stdout] test operator::tests::count_no_groups ... ok
Nov 16 16:03:57.007 INFO [stdout] test operator::tests::fields_except ... ok
Nov 16 16:03:57.007 INFO [stdout] test operator::tests::fields_only ... ok
Nov 16 16:03:57.007 INFO [stdout] test operator::tests::json ... ok
Nov 16 16:03:57.007 INFO [stdout] test operator::tests::multi_grouper ... ok
Nov 16 16:03:57.007 INFO [stdout] test operator::tests::parse_from_field ... ok
Nov 16 16:03:57.007 INFO [stdout] test operator::tests::sort_raw ... ok
Nov 16 16:03:57.023 INFO [stdout] test operator::tests::test_agg_adapter ... ok
Nov 16 16:03:57.023 INFO [stdout] test operator::tests::parse ... ok
Nov 16 16:03:57.023 INFO [stdout] test render::tests::pretty_print_aggregate ... ok
Nov 16 16:03:57.023 INFO [stdout] test render::tests::pretty_print_record_too_long ... ok
Nov 16 16:03:57.023 INFO [stdout] test render::tests::pretty_print_record ... ok
Nov 16 16:03:57.027 INFO [stdout] test operator::tests::sort_aggregate ... ok
Nov 16 16:03:57.146 INFO [stdout] test data::tests::panic_on_invalid_row ... ok
Nov 16 16:03:57.147 INFO [stdout] 
Nov 16 16:03:57.147 INFO [stdout] test result: ok. 31 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 16:03:57.147 INFO [stdout] 
Nov 16 16:03:57.171 INFO [stdout] 
Nov 16 16:03:57.172 INFO [stderr]      Running /target/debug/deps/agrind-aa1e55cbf9a17a25
Nov 16 16:03:57.172 INFO [stdout] running 0 tests
Nov 16 16:03:57.172 INFO [stderr]      Running /target/debug/deps/code_blocks-bc0ac0c62885f07a
Nov 16 16:03:57.173 INFO [stdout] 
Nov 16 16:03:57.173 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 16:03:57.173 INFO [stdout] 
Nov 16 16:03:57.180 INFO [stdout] 
Nov 16 16:03:57.180 INFO [stdout] running 0 tests
Nov 16 16:03:57.180 INFO [stdout] 
Nov 16 16:03:57.181 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 16:03:57.181 INFO [stdout] 
Nov 16 16:03:57.191 INFO [stdout] 
Nov 16 16:03:57.191 INFO [stderr]      Running /target/debug/deps/integration-6252c5538e10d35c
Nov 16 16:03:57.192 INFO [stdout] running 13 tests
Nov 16 16:03:57.447 INFO [stdout] test integration::no_args ... ok
Nov 16 16:03:57.527 INFO [stdout] test integration::count_distinct_operator ... ok
Nov 16 16:03:57.951 INFO [stdout] test integration::json_from ... ok
Nov 16 16:03:58.151 INFO [stdout] test integration::basic_count ... ok
Nov 16 16:03:58.171 INFO [stdout] test integration::validate_readme_examples ... ok
Nov 16 16:03:58.343 INFO [stdout] test integration::sort_order ... ok
Nov 16 16:03:58.479 INFO [stdout] test integration::fields ... ok
Nov 16 16:03:58.573 INFO [stdout] test integration::file_input ... ok
Nov 16 16:03:58.655 INFO [stdout] test integration::parse_failure ... ok
Nov 16 16:03:58.711 INFO [stdout] test integration::aggregate_of_aggregate ... ok
Nov 16 16:03:58.871 INFO [stdout] test integration::sum_operator ... ok
Nov 16 16:03:58.951 INFO [stdout] test integration::test_where_typecheck ... ok
Nov 16 16:03:59.539 INFO [stderr]    Doc-tests ag
Nov 16 16:03:59.539 INFO [stdout] test integration::where_operator ... ok
Nov 16 16:03:59.539 INFO [stdout] 
Nov 16 16:03:59.539 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 16:03:59.539 INFO [stdout] 
Nov 16 16:04:01.139 INFO [stdout] 
Nov 16 16:04:01.139 INFO [stdout] running 0 tests
Nov 16 16:04:01.147 INFO [stdout] 
Nov 16 16:04:01.147 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 16:04:01.147 INFO [stdout] 
Nov 16 16:04:01.159 INFO [stderr] su: No module specific data is present
Nov 16 16:04:02.355 INFO running `"docker" "inspect" "2f4338da1aa506a0bd4aeaf38ca71a2902f5b1082999abaeb4025837d4e658ba"`
Nov 16 16:04:02.709 INFO running `"docker" "rm" "-f" "2f4338da1aa506a0bd4aeaf38ca71a2902f5b1082999abaeb4025837d4e658ba"`
Nov 16 16:04:03.059 INFO [stdout] 2f4338da1aa506a0bd4aeaf38ca71a2902f5b1082999abaeb4025837d4e658ba