[INFO] crate tracing-timing 0.2.12 is already in cache [INFO] extracting crate tracing-timing 0.2.12 into work/ex/beta-1.38-1/sources/1.37.0/reg/tracing-timing/0.2.12 [INFO] extracting crate tracing-timing 0.2.12 into work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/tracing-timing/0.2.12 [INFO] validating manifest of tracing-timing-0.2.12 on toolchain 1.37.0 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] validating manifest of tracing-timing-0.2.12 on toolchain beta-2019-08-13 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] started frobbing tracing-timing-0.2.12 [INFO] finished frobbing tracing-timing-0.2.12 [INFO] frobbed toml for tracing-timing-0.2.12 written to work/ex/beta-1.38-1/sources/1.37.0/reg/tracing-timing/0.2.12/Cargo.toml [INFO] started frobbing tracing-timing-0.2.12 [INFO] finished frobbing tracing-timing-0.2.12 [INFO] frobbed toml for tracing-timing-0.2.12 written to work/ex/beta-1.38-1/sources/beta-2019-08-13/reg/tracing-timing/0.2.12/Cargo.toml [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"` [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+1.37.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] [stderr] Downloading crates ... [INFO] [stderr] Downloaded tracing v0.1.6 [INFO] [stderr] Downloaded tracing-attributes v0.1.2 [INFO] running `"/mnt/big/crater/work/local/cargo-home/bin/cargo" "+beta-2019-08-13" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] testing tracing-timing-0.2.12 against 1.37.0 for beta-1.38-1 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-3/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/reg/tracing-timing/0.2.12:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.37.0" "build" "--frozen"` [INFO] [stdout] 24ec6333b97580d97a69c84ce6b4a673ac158d37d76611bd186f63ac56e47aed [INFO] running `"docker" "start" "-a" "24ec6333b97580d97a69c84ce6b4a673ac158d37d76611bd186f63ac56e47aed"` [INFO] [stderr] Compiling quanta v0.3.1 [INFO] [stderr] Compiling hdrhistogram v6.3.4 [INFO] [stderr] Compiling crossbeam v0.7.2 [INFO] [stderr] Compiling tracing-timing v0.2.12 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 3.27s [INFO] running `"docker" "inspect" "24ec6333b97580d97a69c84ce6b4a673ac158d37d76611bd186f63ac56e47aed"` [INFO] running `"docker" "rm" "-f" "24ec6333b97580d97a69c84ce6b4a673ac158d37d76611bd186f63ac56e47aed"` [INFO] [stdout] 24ec6333b97580d97a69c84ce6b4a673ac158d37d76611bd186f63ac56e47aed [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-3/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/reg/tracing-timing/0.2.12:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.37.0" "test" "--frozen" "--no-run"` [INFO] [stdout] 344d9118a43e61a9ce27caa21149684256fdfd5265fd434af7794f00deea4127 [INFO] running `"docker" "start" "-a" "344d9118a43e61a9ce27caa21149684256fdfd5265fd434af7794f00deea4127"` [INFO] [stderr] Compiling syn v1.0.3 [INFO] [stderr] Compiling c2-chacha v0.2.2 [INFO] [stderr] Compiling rand_chacha v0.2.1 [INFO] [stderr] Compiling rand v0.7.0 [INFO] [stderr] Compiling rand_distr v0.2.1 [INFO] [stderr] Compiling tracing-attributes v0.1.2 [INFO] [stderr] Compiling tracing v0.1.6 [INFO] [stderr] Compiling tracing-timing v0.2.12 (/opt/crater/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 26.73s [INFO] running `"docker" "inspect" "344d9118a43e61a9ce27caa21149684256fdfd5265fd434af7794f00deea4127"` [INFO] running `"docker" "rm" "-f" "344d9118a43e61a9ce27caa21149684256fdfd5265fd434af7794f00deea4127"` [INFO] [stdout] 344d9118a43e61a9ce27caa21149684256fdfd5265fd434af7794f00deea4127 [INFO] running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.38-1/worker-3/1.37.0:/opt/crater/target:rw,Z" "-v" "/mnt/big/crater/work/ex/beta-1.38-1/sources/1.37.0/reg/tracing-timing/0.2.12:/opt/crater/workdir:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/opt/crater/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/opt/crater/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/opt/crater/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/crater/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/crater/cargo-home" "-e" "RUSTUP_HOME=/opt/crater/rustup-home" "-w" "/opt/crater/workdir" "-m" "1536M" "--network" "none" "rustops/crates-build-env" "/opt/crater/cargo-home/bin/cargo" "+1.37.0" "test" "--frozen"` [INFO] [stdout] 400a7ce15fbe4c4ad364f876166955c4576c447929477fe2b401e85c19f66228 [INFO] running `"docker" "start" "-a" "400a7ce15fbe4c4ad364f876166955c4576c447929477fe2b401e85c19f66228"` [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.08s [INFO] [stderr] Running /opt/crater/target/debug/deps/tracing_timing-ee6d0b09717208f4 [INFO] [stderr] Running /opt/crater/target/debug/deps/lib-3ea9ed79f55cf801 [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 20 tests [INFO] [stdout] test downcaster ... ok [INFO] [stdout] test by_name ... ok [INFO] [stdout] test by_target ... ok [INFO] [stdout] test by_default ... ok [INFO] [stdout] test by_closure ... ok [INFO] [stdout] test event_order ... ok [INFO] [stdout] test by_field_typed ... ok [INFO] [stdout] test explicit_event_parent ... ok [INFO] [stdout] test by_field ... ok [INFO] [stdout] test explicit_span_parent ... ok [INFO] [stdout] test dupe_span ... ok [INFO] [stdout] test same_event_two_threads ... ok [INFO] [stdout] test tracks_current_span_deep ... ok [INFO] [stdout] test tracks_current_span ... ok [INFO] [stdout] test custom_time ... ok [INFO] [stdout] test free_standing_event ... ok [INFO] [stdout] test nested ... ok [INFO] [stdout] test informed_histogram_constructor ... ok [INFO] [stdout] test nested_diff ... ok [INFO] [stdout] test samples ... ok [INFO] [stderr] Doc-tests tracing-timing [INFO] [stdout] [INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] [stdout] [INFO] [stdout] running 7 tests [INFO] [stdout] test src/builder.rs - builder::Builder::build_informed (line 77) ... ok [INFO] [stdout] test src/builder.rs - builder::Builder (line 10) ... ok [INFO] [stdout] test src/lib.rs - EventGroup (line 206) ... ok [INFO] [stdout] test src/lib.rs - SpanGroup (line 178) ... ok [INFO] [stdout] test src/lib.rs - TimingSubscriber::downcaster (line 662) ... ok [INFO] [stdout] test src/lib.rs - (line 6) ... ok [INFO] [stdout] test src/lib.rs - (line 69) ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out [INFO] [stdout] [INFO] running `"docker" "inspect" "400a7ce15fbe4c4ad364f876166955c4576c447929477fe2b401e85c19f66228"` [INFO] running `"docker" "rm" "-f" "400a7ce15fbe4c4ad364f876166955c4576c447929477fe2b401e85c19f66228"` [INFO] [stdout] 400a7ce15fbe4c4ad364f876166955c4576c447929477fe2b401e85c19f66228