Dec 14 16:13:42.687 INFO testing trace-macro-1.1.1 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 16:13:42.687 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 14 16:13:42.904 INFO [stdout] ab0ad621499c4fc14ee6257e25584bb788e5881830b731fdf4802aee61ef781e
Dec 14 16:13:42.907 INFO running `"docker" "start" "-a" "ab0ad621499c4fc14ee6257e25584bb788e5881830b731fdf4802aee61ef781e"`
Dec 14 16:13:43.898 INFO [stderr] usermod: no changes
Dec 14 16:13:43.940 INFO [stderr]    Compiling trace-macro v1.1.1 (/source)
Dec 14 16:13:44.425 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.51s
Dec 14 16:13:44.435 INFO [stderr] su: No module specific data is present
Dec 14 16:13:45.047 INFO running `"docker" "inspect" "ab0ad621499c4fc14ee6257e25584bb788e5881830b731fdf4802aee61ef781e"`
Dec 14 16:13:45.299 INFO running `"docker" "rm" "-f" "ab0ad621499c4fc14ee6257e25584bb788e5881830b731fdf4802aee61ef781e"`
Dec 14 16:13:45.589 INFO [stdout] ab0ad621499c4fc14ee6257e25584bb788e5881830b731fdf4802aee61ef781e
Dec 14 16:13:45.597 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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"`
Dec 14 16:13:46.040 INFO [stdout] b494230218adf3b83c30140d150835a0527338bdf9ac8620588e764da9d7f298
Dec 14 16:13:46.044 INFO running `"docker" "start" "-a" "b494230218adf3b83c30140d150835a0527338bdf9ac8620588e764da9d7f298"`
Dec 14 16:13:47.336 INFO [stderr] usermod: no changes
Dec 14 16:13:47.399 INFO [stderr]    Compiling trace-macro v1.1.1 (/source)
Dec 14 16:13:48.049 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.049 INFO [stderr]  --> tests/dummy.rs:8:5
Dec 14 16:13:48.049 INFO [stderr]   |
Dec 14 16:13:48.049 INFO [stderr] 8 |     ENTER!(a, b);
Dec 14 16:13:48.049 INFO [stderr]   |     ^^^^^^^^^^^^^
Dec 14 16:13:48.049 INFO [stderr]   |
Dec 14 16:13:48.049 INFO [stderr]   = note: #[warn(deprecated)] on by default
Dec 14 16:13:48.049 INFO [stderr]   = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.049 INFO [stderr] 
Dec 14 16:13:48.049 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.049 INFO [stderr]  --> tests/dummy.rs:9:5
Dec 14 16:13:48.049 INFO [stderr]   |
Dec 14 16:13:48.049 INFO [stderr] 9 |     TRACE!("This", "is", "dummy", "test");
Dec 14 16:13:48.049 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.049 INFO [stderr]   |
Dec 14 16:13:48.049 INFO [stderr]   = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.049 INFO [stderr] 
Dec 14 16:13:48.049 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.049 INFO [stderr]   --> tests/dummy.rs:10:5
Dec 14 16:13:48.049 INFO [stderr]    |
Dec 14 16:13:48.049 INFO [stderr] 10 |     TRACE!(sep=>"+", "This", "is", "dummy", "test");
Dec 14 16:13:48.049 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.049 INFO [stderr]    |
Dec 14 16:13:48.049 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.049 INFO [stderr] 
Dec 14 16:13:48.050 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.050 INFO [stderr]   --> tests/dummy.rs:11:5
Dec 14 16:13:48.050 INFO [stderr]    |
Dec 14 16:13:48.059 INFO [stderr] 11 |     INFO!("This", "is", "dummy", "test");
Dec 14 16:13:48.059 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.059 INFO [stderr]    |
Dec 14 16:13:48.059 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.059 INFO [stderr] 
Dec 14 16:13:48.059 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.059 INFO [stderr]   --> tests/dummy.rs:15:5
Dec 14 16:13:48.059 INFO [stderr]    |
Dec 14 16:13:48.059 INFO [stderr] 15 |     TRACE!(type=>"INFO", "lolka", 666);
Dec 14 16:13:48.059 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.059 INFO [stderr]    |
Dec 14 16:13:48.059 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.059 INFO [stderr] 
Dec 14 16:13:48.062 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.063 INFO [stderr]   --> tests/dummy.rs:17:5
Dec 14 16:13:48.063 INFO [stderr]    |
Dec 14 16:13:48.063 INFO [stderr] 17 |     TRACE!(type=>"INFO", sep=>"_", "lolka", 2);
Dec 14 16:13:48.063 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.063 INFO [stderr]    |
Dec 14 16:13:48.063 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.063 INFO [stderr] 
Dec 14 16:13:48.084 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.084 INFO [stderr]   --> tests/dummy.rs:24:5
Dec 14 16:13:48.084 INFO [stderr]    |
Dec 14 16:13:48.085 INFO [stderr] 24 |     DEBUG_TRACE!(type=>"INFO", "lolka", 666);
Dec 14 16:13:48.085 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.085 INFO [stderr]    |
Dec 14 16:13:48.085 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.085 INFO [stderr] 
Dec 14 16:13:48.089 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.089 INFO [stderr]   --> tests/dummy.rs:26:5
Dec 14 16:13:48.089 INFO [stderr]    |
Dec 14 16:13:48.089 INFO [stderr] 26 |     DEBUG_TRACE!(type=>"INFO", sep=>"_", "lolka", 2);
Dec 14 16:13:48.089 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.089 INFO [stderr]    |
Dec 14 16:13:48.089 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.089 INFO [stderr] 
Dec 14 16:13:48.092 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.092 INFO [stderr]   --> tests/dummy.rs:27:5
Dec 14 16:13:48.092 INFO [stderr]    |
Dec 14 16:13:48.092 INFO [stderr] 27 |     DEBUG_TRACE!(type=>"INFO", sep=>"_", "lolka", (1..22));
Dec 14 16:13:48.092 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.092 INFO [stderr]    |
Dec 14 16:13:48.092 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.092 INFO [stderr] 
Dec 14 16:13:48.108 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.108 INFO [stderr]   --> tests/dummy.rs:32:5
Dec 14 16:13:48.108 INFO [stderr]    |
Dec 14 16:13:48.108 INFO [stderr] 32 |     enter!(a, b);
Dec 14 16:13:48.108 INFO [stderr]    |     ^^^^^^^^^^^^^
Dec 14 16:13:48.108 INFO [stderr]    |
Dec 14 16:13:48.108 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.108 INFO [stderr] 
Dec 14 16:13:48.151 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.151 INFO [stderr]   --> tests/dummy.rs:38:16
Dec 14 16:13:48.151 INFO [stderr]    |
Dec 14 16:13:48.151 INFO [stderr] 38 |     assert_eq!(connect_args!(1, 2, 3), "1 2 3".to_string());
Dec 14 16:13:48.151 INFO [stderr]    |                ^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.151 INFO [stderr]    |
Dec 14 16:13:48.151 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.151 INFO [stderr] 
Dec 14 16:13:48.157 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.157 INFO [stderr]   --> tests/dummy.rs:39:16
Dec 14 16:13:48.157 INFO [stderr]    |
Dec 14 16:13:48.157 INFO [stderr] 39 |     assert_eq!(connect_args!(sep=>"-", 1, 2, 3), "1-2-3".to_string());
Dec 14 16:13:48.159 INFO [stderr]    |                ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.159 INFO [stderr]    |
Dec 14 16:13:48.159 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.159 INFO [stderr] 
Dec 14 16:13:48.164 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.164 INFO [stderr]   --> tests/dummy.rs:40:16
Dec 14 16:13:48.164 INFO [stderr]    |
Dec 14 16:13:48.164 INFO [stderr] 40 |     assert_eq!(connect_args!(sep=>"+", 1, 2, 666), "1+2+666".to_string());
Dec 14 16:13:48.164 INFO [stderr]    |                ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.164 INFO [stderr]    |
Dec 14 16:13:48.164 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.164 INFO [stderr] 
Dec 14 16:13:48.168 INFO [stderr] warning: use of deprecated item 'std::slice::SliceConcatExt::connect': renamed to join
Dec 14 16:13:48.168 INFO [stderr]   --> tests/dummy.rs:42:16
Dec 14 16:13:48.168 INFO [stderr]    |
Dec 14 16:13:48.168 INFO [stderr] 42 |     assert_eq!(connect_args!(formatter=>"{:?}", sep=>"+", 1, 2, "KIK"), "1+2+\"KIK\"".to_string());
Dec 14 16:13:48.168 INFO [stderr]    |                ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:13:48.168 INFO [stderr]    |
Dec 14 16:13:48.168 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Dec 14 16:13:48.168 INFO [stderr] 
Dec 14 16:13:48.800 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.43s
Dec 14 16:13:48.804 INFO [stderr] su: No module specific data is present
Dec 14 16:13:49.100 INFO running `"docker" "inspect" "b494230218adf3b83c30140d150835a0527338bdf9ac8620588e764da9d7f298"`
Dec 14 16:13:49.189 INFO running `"docker" "rm" "-f" "b494230218adf3b83c30140d150835a0527338bdf9ac8620588e764da9d7f298"`
Dec 14 16:13:49.244 INFO [stdout] b494230218adf3b83c30140d150835a0527338bdf9ac8620588e764da9d7f298