Nov 18 03:11:24.309 INFO testing prometheus-0.4.2 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 18 03:11:24.309 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 18 03:11:24.736 INFO [stdout] 301002ff21008febab2c59bd2302f6edf03445924752cc141e1b67e8cba6cddc
Nov 18 03:11:24.739 INFO running `"docker" "start" "-a" "301002ff21008febab2c59bd2302f6edf03445924752cc141e1b67e8cba6cddc"`
Nov 18 03:11:26.534 INFO [stderr] usermod: no changes
Nov 18 03:11:26.675 INFO [stderr]    Compiling prometheus v0.4.2 (/source)
Nov 18 03:11:34.069 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.49s
Nov 18 03:11:34.076 INFO [stderr] su: No module specific data is present
Nov 18 03:11:35.283 INFO running `"docker" "inspect" "301002ff21008febab2c59bd2302f6edf03445924752cc141e1b67e8cba6cddc"`
Nov 18 03:11:35.637 INFO running `"docker" "rm" "-f" "301002ff21008febab2c59bd2302f6edf03445924752cc141e1b67e8cba6cddc"`
Nov 18 03:11:35.853 INFO [stdout] 301002ff21008febab2c59bd2302f6edf03445924752cc141e1b67e8cba6cddc
Nov 18 03:11:35.862 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 18 03:11:36.288 INFO [stdout] d972d2232673b200232769ebe4cf4a1695dcbffc2d967c241a1d67130fb32848
Nov 18 03:11:36.291 INFO running `"docker" "start" "-a" "d972d2232673b200232769ebe4cf4a1695dcbffc2d967c241a1d67130fb32848"`
Nov 18 03:11:37.563 INFO [stderr] usermod: no changes
Nov 18 03:11:37.759 INFO [stderr]    Compiling prometheus v0.4.2 (/source)
Nov 18 03:11:52.481 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.88s
Nov 18 03:11:52.495 INFO [stderr] su: No module specific data is present
Nov 18 03:11:52.872 INFO running `"docker" "inspect" "d972d2232673b200232769ebe4cf4a1695dcbffc2d967c241a1d67130fb32848"`
Nov 18 03:11:53.327 INFO running `"docker" "rm" "-f" "d972d2232673b200232769ebe4cf4a1695dcbffc2d967c241a1d67130fb32848"`
Nov 18 03:11:53.695 INFO [stdout] d972d2232673b200232769ebe4cf4a1695dcbffc2d967c241a1d67130fb32848
Nov 18 03:11:53.705 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 18 03:11:54.081 INFO [stdout] 25830f0490a29be1af882536cfb236cc481774a417b040f9d44602e40fb5458f
Nov 18 03:11:54.081 INFO running `"docker" "start" "-a" "25830f0490a29be1af882536cfb236cc481774a417b040f9d44602e40fb5458f"`
Nov 18 03:11:55.199 INFO [stderr] usermod: no changes
Nov 18 03:11:55.330 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.10s
Nov 18 03:11:55.350 INFO [stderr]      Running /target/debug/deps/prometheus-5ff35a612c45a073
Nov 18 03:11:55.353 INFO [stdout] 
Nov 18 03:11:55.353 INFO [stdout] running 49 tests
Nov 18 03:11:55.356 INFO [stdout] test atomic64::test::test_atomic_i64 ... ok
Nov 18 03:11:55.356 INFO [stdout] test atomic64::test::test_atomic_u64 ... ok
Nov 18 03:11:55.356 INFO [stdout] test atomic64::test::test_atomic_f64 ... ok
Nov 18 03:11:55.356 INFO [stdout] test counter::tests::test_counter_vec_local ... ok
Nov 18 03:11:55.356 INFO [stdout] test counter::tests::test_counter_vec_with_labels ... ok
Nov 18 03:11:55.356 INFO [stdout] test counter::tests::test_counter_vec_with_label_values ... ok
Nov 18 03:11:55.358 INFO [stdout] test counter::tests::test_int_counter ... ok
Nov 18 03:11:55.358 INFO [stdout] test counter::tests::test_int_local_counter ... ok
Nov 18 03:11:55.358 INFO [stdout] test counter::tests::test_int_counter_vec_local ... ok
Nov 18 03:11:55.358 INFO [stdout] test counter::tests::test_local_counter ... ok
Nov 18 03:11:55.358 INFO [stdout] test counter::tests::test_int_counter_vec ... ok
Nov 18 03:11:55.362 INFO [stdout] test desc::tests::test_invalid_const_label_name ... ok
Nov 18 03:11:55.362 INFO [stdout] test desc::tests::test_invalid_variable_label_name ... ok
Nov 18 03:11:55.362 INFO [stdout] test desc::tests::test_invalid_metric_name ... ok
Nov 18 03:11:55.362 INFO [stdout] test counter::tests::test_counter ... ok
Nov 18 03:11:55.363 INFO [stdout] test desc::tests::test_is_valid_label_name ... ok
Nov 18 03:11:55.364 INFO [stdout] test encoder::pb::tests::test_protobuf_encoder ... ok
Nov 18 03:11:55.365 INFO [stdout] test encoder::tests::test_bad_metrics ... ok
Nov 18 03:11:55.365 INFO [stdout] test desc::tests::test_is_valid_metric_name ... ok
Nov 18 03:11:55.365 INFO [stdout] test encoder::text::tests::test_ecape_string ... ok
Nov 18 03:11:55.365 INFO [stdout] test encoder::text::tests::test_text_encoder ... ok
Nov 18 03:11:55.365 INFO [stdout] test gauge::tests::test_gauge ... ok
Nov 18 03:11:55.367 INFO [stdout] test encoder::text::tests::test_text_encoder_histogram ... ok
Nov 18 03:11:55.367 INFO [stdout] test gauge::tests::test_gauge_vec_with_label_values ... ok
Nov 18 03:11:55.367 INFO [stdout] test histogram::tests::test_buckets_functions ... ok
Nov 18 03:11:55.367 INFO [stdout] test gauge::tests::test_gauge_vec_with_labels ... ok
Nov 18 03:11:55.367 INFO [stdout] test histogram::tests::test_buckets_invalidation ... ok
Nov 18 03:11:55.367 INFO [stdout] test histogram::tests::test_histogram_vec_local ... ok
Nov 18 03:11:55.367 INFO [stdout] test histogram::tests::test_duration_to_seconds ... ok
Nov 18 03:11:55.367 INFO [stdout] test histogram::tests::test_histogram_local ... ok
Nov 18 03:11:55.367 INFO [stdout] test histogram::tests::test_histogram_vec_with_opts_buckets ... ok
Nov 18 03:11:55.367 INFO [stdout] test histogram::tests::test_histogram_vec_with_label_values ... ok
Nov 18 03:11:55.367 INFO [stdout] test metrics::tests::test_build_fq_name ... ok
Nov 18 03:11:55.375 INFO [stdout] test metrics::tests::test_label_cmp ... ok
Nov 18 03:11:55.383 INFO [stdout] test registry::tests::test_gather_order ... ok
Nov 18 03:11:55.383 INFO [stdout] test registry::tests::test_default_registry ... ok
Nov 18 03:11:55.383 INFO [stdout] test registry::tests::test_register_multiplecollector ... ok
Nov 18 03:11:55.383 INFO [stdout] test registry::tests::test_prune_empty_metric_family ... ok
Nov 18 03:11:55.383 INFO [stdout] test vec::tests::test_counter_vec_with_label_values ... ok
Nov 18 03:11:55.383 INFO [stdout] test registry::tests::test_registry ... ok
Nov 18 03:11:55.383 INFO [stdout] test vec::tests::test_counter_vec_with_labels ... ok
Nov 18 03:11:55.383 INFO [stdout] test vec::tests::test_gauge_vec_with_labels ... ok
Nov 18 03:11:55.383 INFO [stdout] test vec::tests::test_gauge_vec_with_label_values ... ok
Nov 18 03:11:55.383 INFO [stdout] test vec::tests::test_vec_get_metric_with ... ok
Nov 18 03:11:55.559 INFO [stdout] test counter::tests::test_int_local_counter_negative_inc ... ok
Nov 18 03:11:55.559 INFO [stdout] test counter::tests::test_local_counter_negative_inc ... ok
Nov 18 03:11:55.559 INFO [stdout] test counter::tests::test_counter_negative_inc ... ok
Nov 18 03:11:55.567 INFO [stdout] test counter::tests::test_int_counter_negative_inc ... ok
Nov 18 03:11:55.871 INFO [stdout] test histogram::tests::test_histogram ... ok
Nov 18 03:11:55.871 INFO [stdout] 
Nov 18 03:11:55.872 INFO [stdout] test result: ok. 49 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:11:55.872 INFO [stdout] 
Nov 18 03:11:55.879 INFO [stderr]    Doc-tests prometheus
Nov 18 03:11:56.735 INFO [stdout] 
Nov 18 03:11:56.735 INFO [stdout] running 9 tests
Nov 18 03:12:02.526 INFO [stdout] test src/macros.rs - register_gauge (line 263) ... ok
Nov 18 03:12:05.419 INFO [stdout] test src/macros.rs - register_counter_vec (line 214) ... ok
Nov 18 03:12:06.219 INFO [stdout] test src/macros.rs - register_counter (line 165) ... ok
Nov 18 03:12:06.367 INFO [stdout] test src/macros.rs - opts (line 62) ... ok
Nov 18 03:12:06.368 INFO [stdout] test src/macros.rs - labels (line 18) ... ok
Nov 18 03:12:06.412 INFO [stdout] test src/macros.rs - register_histogram (line 352) ... ok
Nov 18 03:12:07.000 INFO [stdout] test src/macros.rs - register_gauge_vec (line 312) ... ok
Nov 18 03:12:07.007 INFO [stdout] test src/macros.rs - histogram_opts (line 108) ... ok
Nov 18 03:12:07.474 INFO [stdout] test src/macros.rs - register_histogram_vec (line 388) ... ok
Nov 18 03:12:07.474 INFO [stdout] 
Nov 18 03:12:07.474 INFO [stdout] test result: ok. 9 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 03:12:07.474 INFO [stdout] 
Nov 18 03:12:07.503 INFO [stderr] su: No module specific data is present
Nov 18 03:12:07.948 INFO running `"docker" "inspect" "25830f0490a29be1af882536cfb236cc481774a417b040f9d44602e40fb5458f"`
Nov 18 03:12:08.029 INFO running `"docker" "rm" "-f" "25830f0490a29be1af882536cfb236cc481774a417b040f9d44602e40fb5458f"`
Nov 18 03:12:08.137 INFO [stdout] 25830f0490a29be1af882536cfb236cc481774a417b040f9d44602e40fb5458f