[INFO] fetching crate tracing-timing 0.5.0... [INFO] testing tracing-timing-0.5.0 against master#99e3aef02079e9c10583638520cd0c134dc3a01d for pr-85530 [INFO] extracting crate tracing-timing 0.5.0 into /workspace/builds/worker-3/source [INFO] validating manifest of crates.io crate tracing-timing 0.5.0 on toolchain 99e3aef02079e9c10583638520cd0c134dc3a01d [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] started tweaking crates.io crate tracing-timing 0.5.0 [INFO] finished tweaking crates.io crate tracing-timing 0.5.0 [INFO] tweaked toml for crates.io crate tracing-timing 0.5.0 written to /workspace/builds/worker-3/source/Cargo.toml [INFO] crate crates.io crate tracing-timing 0.5.0 already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] 29b663f7a898ec15f456d8cb1c785766b5a91f716074f8ff1064d2993783ff18 [INFO] running `Command { std: "docker" "start" "-a" "29b663f7a898ec15f456d8cb1c785766b5a91f716074f8ff1064d2993783ff18", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "29b663f7a898ec15f456d8cb1c785766b5a91f716074f8ff1064d2993783ff18", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "29b663f7a898ec15f456d8cb1c785766b5a91f716074f8ff1064d2993783ff18", kill_on_drop: false }` [INFO] [stdout] 29b663f7a898ec15f456d8cb1c785766b5a91f716074f8ff1064d2993783ff18 [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] 073c854977c829b01231d2c2468567c550c26064ae8f40c4313a09767775f8ab [INFO] running `Command { std: "docker" "start" "-a" "073c854977c829b01231d2c2468567c550c26064ae8f40c4313a09767775f8ab", kill_on_drop: false }` [INFO] [stderr] Compiling spin v0.5.2 [INFO] [stderr] Compiling cfg-if v1.0.0 [INFO] [stderr] Compiling libc v0.2.65 [INFO] [stderr] Compiling libm v0.2.1 [INFO] [stderr] Compiling byteorder v1.3.2 [INFO] [stderr] Compiling ryu v1.0.2 [INFO] [stderr] Compiling cfg-if v0.1.10 [INFO] [stderr] Compiling radium v0.5.3 [INFO] [stderr] Compiling serde v1.0.103 [INFO] [stderr] Compiling log v0.4.8 [INFO] [stderr] Compiling regex-syntax v0.6.12 [INFO] [stderr] Compiling lexical-core v0.7.6 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling utf8-ranges v1.0.4 [INFO] [stderr] Compiling funty v1.1.0 [INFO] [stderr] Compiling tap v1.0.1 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling static_assertions v1.1.0 [INFO] [stderr] Compiling adler32 v1.0.4 [INFO] [stderr] Compiling wyz v0.2.0 [INFO] [stderr] Compiling doc-comment v0.3.1 [INFO] [stderr] Compiling itoa v0.4.4 [INFO] [stderr] Compiling atomic-shim v0.1.0 [INFO] [stderr] Compiling base64 v0.13.0 [INFO] [stderr] Compiling ansi_term v0.12.1 [INFO] [stderr] Compiling slab v0.4.2 [INFO] [stderr] Compiling crossbeam-utils v0.8.4 [INFO] [stderr] Compiling num-traits v0.2.10 [INFO] [stderr] Compiling memoffset v0.6.3 [INFO] [stderr] Compiling num-integer v0.1.41 [INFO] [stderr] Compiling indexmap v1.3.0 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling miniz_oxide v0.3.5 [INFO] [stderr] Compiling crc32fast v1.2.0 [INFO] [stderr] Compiling tracing-core v0.1.7 [INFO] [stderr] Compiling thread_local v0.3.6 [INFO] [stderr] Compiling sharded-slab v0.0.9 [INFO] [stderr] Compiling raw-cpuid v9.0.0 [INFO] [stderr] Compiling nom v6.1.2 [INFO] [stderr] Compiling tracing-log v0.1.1 [INFO] [stderr] Compiling bitvec v0.19.5 [INFO] [stderr] Compiling fxhash v0.2.1 [INFO] [stderr] Compiling crossbeam-channel v0.5.1 [INFO] [stderr] Compiling crossbeam-epoch v0.9.4 [INFO] [stderr] Compiling crossbeam-queue v0.3.1 [INFO] [stderr] Compiling time v0.1.42 [INFO] [stderr] Compiling flate2 v1.0.13 [INFO] [stderr] Compiling quanta v0.7.2 [INFO] [stderr] Compiling crossbeam-deque v0.8.0 [INFO] [stderr] Compiling chrono v0.4.10 [INFO] [stderr] Compiling crossbeam v0.8.0 [INFO] [stderr] Compiling regex-automata v0.1.8 [INFO] [stderr] Compiling regex v1.3.1 [INFO] [stderr] Compiling matchers v0.0.1 [INFO] [stderr] Compiling serde_json v1.0.42 [INFO] [stderr] Compiling tracing-serde v0.1.2 [INFO] [stderr] Compiling hdrhistogram v7.3.0 [INFO] [stderr] Compiling tracing-subscriber v0.2.9 [INFO] [stderr] Compiling tracing-timing v0.5.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 25.01s [INFO] running `Command { std: "docker" "inspect" "073c854977c829b01231d2c2468567c550c26064ae8f40c4313a09767775f8ab", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "073c854977c829b01231d2c2468567c550c26064ae8f40c4313a09767775f8ab", kill_on_drop: false }` [INFO] [stdout] 073c854977c829b01231d2c2468567c550c26064ae8f40c4313a09767775f8ab [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] a6414775473abb3630b07bf0029781e77bf7942c96d0f659af495a3c38bf1d8d [INFO] running `Command { std: "docker" "start" "-a" "a6414775473abb3630b07bf0029781e77bf7942c96d0f659af495a3c38bf1d8d", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.26 [INFO] [stderr] Compiling getrandom v0.2.2 [INFO] [stderr] Compiling unicode-xid v0.2.0 [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling rand_core v0.6.2 [INFO] [stderr] Compiling rand_chacha v0.3.0 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling rand v0.8.3 [INFO] [stderr] Compiling syn v1.0.72 [INFO] [stderr] Compiling rand_distr v0.4.0 [INFO] [stderr] Compiling tracing-attributes v0.1.5 [INFO] [stderr] Compiling tracing v0.1.10 [INFO] [stderr] Compiling tracing-timing v0.5.0 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 31.02s [INFO] running `Command { std: "docker" "inspect" "a6414775473abb3630b07bf0029781e77bf7942c96d0f659af495a3c38bf1d8d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "a6414775473abb3630b07bf0029781e77bf7942c96d0f659af495a3c38bf1d8d", kill_on_drop: false }` [INFO] [stdout] a6414775473abb3630b07bf0029781e77bf7942c96d0f659af495a3c38bf1d8d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:20528e8c29e4536546f0102ce88568b16ea7538393a33fcca951030f7af10457" "/opt/rustwide/cargo-home/bin/cargo" "+99e3aef02079e9c10583638520cd0c134dc3a01d" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 7700f06d1485ac68adf73bdb5223e31460c18fd338548a3d94b18367956e1741 [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] running `Command { std: "docker" "start" "-a" "7700f06d1485ac68adf73bdb5223e31460c18fd338548a3d94b18367956e1741", kill_on_drop: false }` [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 0.10s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/tracing_timing-ecea0200af72eed5) [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; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/layer.rs (/opt/rustwide/target/debug/deps/layer-cdea7c8f4022c1b5) [INFO] [stdout] [INFO] [stdout] running 23 tests [INFO] [stdout] test explicit_event_parent ... ok [INFO] [stdout] test nested_bubble ... ok [INFO] [stdout] test by_field_typed ... ok [INFO] [stdout] test nested_diff ... ok [INFO] [stdout] test nested_no_bubble ... ok [INFO] [stdout] test nested ... ok [INFO] [stdout] test by_field ... ok [INFO] [stdout] test dupe_span ... ok [INFO] [stdout] test by_closure ... ok [INFO] [stdout] test downcaster ... ok [INFO] [stdout] test free_standing_event ... ok [INFO] [stdout] test same_event_two_threads ... ok [INFO] [stdout] test by_name ... ok [INFO] [stdout] test explicit_span_parent ... ok [INFO] [stdout] test by_default ... ok [INFO] [stdout] test event_order ... ok [INFO] [stdout] test tracks_current_span ... ok [INFO] [stdout] test tracks_current_span_deep ... ok [INFO] [stdout] test by_target ... ok [INFO] [stdout] test custom_time ... ok [INFO] [stdout] test span_close_event ... ok [INFO] [stdout] test informed_histogram_constructor ... ok [INFO] [stdout] test samples ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.47s [INFO] [stdout] [INFO] [stderr] Running tests/subscriber.rs (/opt/rustwide/target/debug/deps/subscriber-4afa1b9d3981fcf9) [INFO] [stdout] [INFO] [stdout] running 23 tests [INFO] [stdout] test downcaster ... ok [INFO] [stdout] test informed_histogram_constructor ... ok [INFO] [stdout] test explicit_event_parent ... ok [INFO] [stdout] test by_field_typed ... ok [INFO] [stdout] test free_standing_event ... ok [INFO] [stdout] test by_closure ... ok [INFO] [stdout] test tracks_current_span ... ok [INFO] [stdout] test by_field ... ok [INFO] [stdout] test nested_bubble ... ok [INFO] [stdout] test same_event_two_threads ... ok [INFO] [stdout] test by_name ... ok [INFO] [stdout] test dupe_span ... ok [INFO] [stdout] test span_close_event ... ok [INFO] [stdout] test nested_no_bubble ... ok [INFO] [stdout] test tracks_current_span_deep ... ok [INFO] [stdout] test event_order ... ok [INFO] [stdout] test nested ... ok [INFO] [stdout] test custom_time ... ok [INFO] [stdout] test nested_diff ... ok [INFO] [stdout] test by_default ... ok [INFO] [stdout] test by_target ... ok [INFO] [stdout] test explicit_span_parent ... ok [INFO] [stdout] test samples ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.97s [INFO] [stdout] [INFO] [stderr] Doc-tests tracing-timing [INFO] [stdout] [INFO] [stdout] running 12 tests [INFO] [stdout] test src/lib.rs - (line 130) ... ok [INFO] [stderr] error: test failed, to rerun pass '--doc' [INFO] [stderr] [INFO] [stderr] Caused by: [INFO] [stderr] process didn't exit successfully: `rustdoc --edition=2018 --crate-type lib --crate-name tracing_timing --test /opt/rustwide/workdir/src/lib.rs -L dependency=/opt/rustwide/target/debug/deps -L dependency=/opt/rustwide/target/debug/deps --extern crossbeam=/opt/rustwide/target/debug/deps/libcrossbeam-25ecdefae6df641a.rlib --extern doc_comment=/opt/rustwide/target/debug/deps/libdoc_comment-1cd070a51c2297a2.rlib --extern fxhash=/opt/rustwide/target/debug/deps/libfxhash-94642d8b924956a9.rlib --extern hdrhistogram=/opt/rustwide/target/debug/deps/libhdrhistogram-6de1d24f637808dd.rlib --extern indexmap=/opt/rustwide/target/debug/deps/libindexmap-e7a215335831b103.rlib --extern quanta=/opt/rustwide/target/debug/deps/libquanta-0e6ff99b43189961.rlib --extern rand=/opt/rustwide/target/debug/deps/librand-e1df0f39c8069a77.rlib --extern rand_distr=/opt/rustwide/target/debug/deps/librand_distr-42950b452c995251.rlib --extern slab=/opt/rustwide/target/debug/deps/libslab-66c74742abc4bd48.rlib --extern tracing=/opt/rustwide/target/debug/deps/libtracing-d3fe0dcbf40a3aa4.rlib --extern tracing_core=/opt/rustwide/target/debug/deps/libtracing_core-2e7214911b255b3b.rlib --extern tracing_subscriber=/opt/rustwide/target/debug/deps/libtracing_subscriber-8cd943eea7b12978.rlib --extern tracing_timing=/opt/rustwide/target/debug/deps/libtracing_timing-b3ca725a4768b8da.rlib -C embed-bitcode=no --cfg 'feature="default"' --cfg 'feature="layer"' --cfg 'feature="tracing-subscriber"' --error-format human` (signal: 9, SIGKILL: kill) [INFO] running `Command { std: "docker" "inspect" "7700f06d1485ac68adf73bdb5223e31460c18fd338548a3d94b18367956e1741", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "7700f06d1485ac68adf73bdb5223e31460c18fd338548a3d94b18367956e1741", kill_on_drop: false }` [INFO] [stdout] 7700f06d1485ac68adf73bdb5223e31460c18fd338548a3d94b18367956e1741