Nov 17 20:12:13.180 INFO testing tokio_kcp-0.7.1 against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 17 20:12:13.181 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 17 20:12:13.524 INFO [stdout] 4d042173cea4eb3aea5dabb5f9268175f01abeac273c44a907e2c73ee63734e8
Nov 17 20:12:13.529 INFO running `"docker" "start" "-a" "4d042173cea4eb3aea5dabb5f9268175f01abeac273c44a907e2c73ee63734e8"`
Nov 17 20:12:14.927 INFO [stderr] usermod: no changes
Nov 17 20:12:15.135 INFO [stderr]    Compiling priority-queue v0.3.2
Nov 17 20:12:15.135 INFO [stderr]    Compiling kcp v0.4.10
Nov 17 20:12:16.711 INFO [stderr]    Compiling tokio_kcp v0.7.1 (/source)
Nov 17 20:12:23.700 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.74s
Nov 17 20:12:23.713 INFO [stderr] su: No module specific data is present
Nov 17 20:12:24.706 INFO running `"docker" "inspect" "4d042173cea4eb3aea5dabb5f9268175f01abeac273c44a907e2c73ee63734e8"`
Nov 17 20:12:25.045 INFO running `"docker" "rm" "-f" "4d042173cea4eb3aea5dabb5f9268175f01abeac273c44a907e2c73ee63734e8"`
Nov 17 20:12:25.320 INFO [stdout] 4d042173cea4eb3aea5dabb5f9268175f01abeac273c44a907e2c73ee63734e8
Nov 17 20:12:25.327 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 17 20:12:25.892 INFO [stdout] 606982d6567c3410dcffba2e47a52c079adb28450c03e72817fa2da4981c4d41
Nov 17 20:12:25.894 INFO running `"docker" "start" "-a" "606982d6567c3410dcffba2e47a52c079adb28450c03e72817fa2da4981c4d41"`
Nov 17 20:12:27.063 INFO [stderr] usermod: no changes
Nov 17 20:12:27.302 INFO [stderr]    Compiling tokio_kcp v0.7.1 (/source)
Nov 17 20:12:38.341 INFO [stderr] warning: use of deprecated item 'bytes::BufMut::put_u32': use put_u32_be or put_u32_le
Nov 17 20:12:38.341 INFO [stderr]   --> tests/echo.rs:43:17
Nov 17 20:12:38.341 INFO [stderr]    |
Nov 17 20:12:38.341 INFO [stderr] 43 |             buf.put_u32::<LittleEndian>(self.count as u32);
Nov 17 20:12:38.341 INFO [stderr]    |                 ^^^^^^^
Nov 17 20:12:38.341 INFO [stderr]    |
Nov 17 20:12:38.341 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 20:12:38.341 INFO [stderr] 
Nov 17 20:12:38.491 INFO [stderr] warning: use of deprecated item 'bytes::Buf::get_u32': use get_u32_be or get_u32_le
Nov 17 20:12:38.492 INFO [stderr]   --> tests/echo.rs:86:27
Nov 17 20:12:38.492 INFO [stderr]    |
Nov 17 20:12:38.492 INFO [stderr] 86 |             let cnt = cur.get_u32::<LittleEndian>();
Nov 17 20:12:38.492 INFO [stderr]    |                           ^^^^^^^
Nov 17 20:12:38.523 INFO [stderr] 
Nov 17 20:12:39.717 INFO [stderr] warning: use of deprecated item 'bytes::BufMut::put_u32': use put_u32_be or put_u32_le
Nov 17 20:12:39.717 INFO [stderr]   --> tests/echo_bench.rs:74:17
Nov 17 20:12:39.717 INFO [stderr]    |
Nov 17 20:12:39.717 INFO [stderr] 74 |             buf.put_u32::<LittleEndian>(self.index as u32);
Nov 17 20:12:39.717 INFO [stderr]    |                 ^^^^^^^
Nov 17 20:12:39.717 INFO [stderr]    |
Nov 17 20:12:39.717 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 20:12:39.717 INFO [stderr] 
Nov 17 20:12:39.723 INFO [stderr] warning: use of deprecated item 'bytes::BufMut::put_u32': use put_u32_be or put_u32_le
Nov 17 20:12:39.723 INFO [stderr]   --> tests/echo_bench.rs:75:17
Nov 17 20:12:39.723 INFO [stderr]    |
Nov 17 20:12:39.723 INFO [stderr] 75 |             buf.put_u32::<LittleEndian>(cur);
Nov 17 20:12:39.723 INFO [stderr]    |                 ^^^^^^^
Nov 17 20:12:39.723 INFO [stderr] 
Nov 17 20:12:39.779 INFO [stderr] warning: use of deprecated item 'bytes::Buf::get_u32': use get_u32_be or get_u32_le
Nov 17 20:12:39.779 INFO [stderr]    --> tests/echo_bench.rs:136:26
Nov 17 20:12:39.779 INFO [stderr]     |
Nov 17 20:12:39.779 INFO [stderr] 136 |             let sn = cur.get_u32::<LittleEndian>();
Nov 17 20:12:39.779 INFO [stderr]     |                          ^^^^^^^
Nov 17 20:12:39.779 INFO [stderr] 
Nov 17 20:12:39.779 INFO [stderr] warning: use of deprecated item 'bytes::Buf::get_u32': use get_u32_be or get_u32_le
Nov 17 20:12:39.779 INFO [stderr]    --> tests/echo_bench.rs:137:26
Nov 17 20:12:39.779 INFO [stderr]     |
Nov 17 20:12:39.779 INFO [stderr] 137 |             let ts = cur.get_u32::<LittleEndian>();
Nov 17 20:12:39.779 INFO [stderr]     |                          ^^^^^^^
Nov 17 20:12:39.779 INFO [stderr] 
Nov 17 20:12:41.343 INFO [stderr] warning: use of deprecated item 'bytes::BufMut::put_u32': use put_u32_be or put_u32_le
Nov 17 20:12:41.343 INFO [stderr]   --> examples/bench_client.rs:74:17
Nov 17 20:12:41.343 INFO [stderr]    |
Nov 17 20:12:41.343 INFO [stderr] 74 |             buf.put_u32::<LittleEndian>(self.index as u32);
Nov 17 20:12:41.343 INFO [stderr]    |                 ^^^^^^^
Nov 17 20:12:41.343 INFO [stderr]    |
Nov 17 20:12:41.343 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 20:12:41.343 INFO [stderr] 
Nov 17 20:12:41.343 INFO [stderr] warning: use of deprecated item 'bytes::BufMut::put_u32': use put_u32_be or put_u32_le
Nov 17 20:12:41.343 INFO [stderr]   --> examples/bench_client.rs:75:17
Nov 17 20:12:41.343 INFO [stderr]    |
Nov 17 20:12:41.343 INFO [stderr] 75 |             buf.put_u32::<LittleEndian>(cur);
Nov 17 20:12:41.343 INFO [stderr]    |                 ^^^^^^^
Nov 17 20:12:41.343 INFO [stderr] 
Nov 17 20:12:41.347 INFO [stderr] warning: use of deprecated item 'bytes::Buf::get_u32': use get_u32_be or get_u32_le
Nov 17 20:12:41.347 INFO [stderr]    --> examples/bench_client.rs:138:26
Nov 17 20:12:41.347 INFO [stderr]     |
Nov 17 20:12:41.347 INFO [stderr] 138 |             let sn = cur.get_u32::<LittleEndian>();
Nov 17 20:12:41.347 INFO [stderr]     |                          ^^^^^^^
Nov 17 20:12:41.347 INFO [stderr] 
Nov 17 20:12:41.347 INFO [stderr] warning: use of deprecated item 'bytes::Buf::get_u32': use get_u32_be or get_u32_le
Nov 17 20:12:41.347 INFO [stderr]    --> examples/bench_client.rs:139:26
Nov 17 20:12:41.347 INFO [stderr]     |
Nov 17 20:12:41.347 INFO [stderr] 139 |             let ts = cur.get_u32::<LittleEndian>();
Nov 17 20:12:41.347 INFO [stderr]     |                          ^^^^^^^
Nov 17 20:12:41.347 INFO [stderr] 
Nov 17 20:12:43.995 INFO [stderr] warning: use of deprecated item 'tokio_io::AsyncRead::framed': Use tokio_codec::Decoder::framed instead
Nov 17 20:12:43.995 INFO [stderr]   --> examples/client.rs:55:37
Nov 17 20:12:43.995 INFO [stderr]    |
Nov 17 20:12:43.995 INFO [stderr] 55 |         let (sink, stream) = stream.framed(Bytes).split();
Nov 17 20:12:43.995 INFO [stderr]    |                                     ^^^^^^
Nov 17 20:12:43.995 INFO [stderr]    |
Nov 17 20:12:43.995 INFO [stderr]    = note: #[warn(deprecated)] on by default
Nov 17 20:12:43.995 INFO [stderr] 
Nov 17 20:12:54.890 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 27.79s
Nov 17 20:12:54.925 INFO [stderr] su: No module specific data is present
Nov 17 20:12:56.263 INFO running `"docker" "inspect" "606982d6567c3410dcffba2e47a52c079adb28450c03e72817fa2da4981c4d41"`
Nov 17 20:12:56.623 INFO running `"docker" "rm" "-f" "606982d6567c3410dcffba2e47a52c079adb28450c03e72817fa2da4981c4d41"`
Nov 17 20:12:56.899 INFO [stdout] 606982d6567c3410dcffba2e47a52c079adb28450c03e72817fa2da4981c4d41
Nov 17 20:12:56.909 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/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 17 20:12:57.472 INFO [stdout] 5fb76f6e864265bcdf7ef2af24ac0060f5f626f2e8c74fba39c8dde483a2c99c
Nov 17 20:12:57.474 INFO running `"docker" "start" "-a" "5fb76f6e864265bcdf7ef2af24ac0060f5f626f2e8c74fba39c8dde483a2c99c"`
Nov 17 20:12:59.034 INFO [stderr] usermod: no changes
Nov 17 20:12:59.207 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Nov 17 20:12:59.218 INFO [stderr]      Running /target/debug/deps/tokio_kcp-c7b61ed9f77e36a8
Nov 17 20:12:59.223 INFO [stdout] 
Nov 17 20:12:59.223 INFO [stdout] running 0 tests
Nov 17 20:12:59.224 INFO [stdout] 
Nov 17 20:12:59.224 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 20:12:59.224 INFO [stdout] 
Nov 17 20:12:59.225 INFO [stderr]      Running /target/debug/deps/echo-74aab77db93ee4fe
Nov 17 20:12:59.229 INFO [stdout] 
Nov 17 20:12:59.229 INFO [stdout] running 1 test
Nov 17 20:12:59.336 INFO [stdout] test echo ... ok
Nov 17 20:12:59.336 INFO [stdout] 
Nov 17 20:12:59.336 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 20:12:59.337 INFO [stdout] 
Nov 17 20:12:59.338 INFO [stderr]      Running /target/debug/deps/echo_bench-3c18e204fa41f51f
Nov 17 20:12:59.340 INFO [stdout] 
Nov 17 20:12:59.340 INFO [stdout] running 3 tests
Nov 17 20:13:19.351 INFO [stdout] test echo_bench_fast ... ok
Nov 17 20:13:19.352 INFO [stdout] test echo_bench_normal ... ok
Nov 17 20:13:19.352 INFO [stdout] test echo_bench_default ... ok
Nov 17 20:13:19.352 INFO [stdout] 
Nov 17 20:13:19.352 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 20:13:19.352 INFO [stdout] 
Nov 17 20:13:19.355 INFO [stderr]    Doc-tests tokio_kcp
Nov 17 20:13:24.801 INFO [stdout] 
Nov 17 20:13:24.801 INFO [stdout] running 0 tests
Nov 17 20:13:24.801 INFO [stdout] 
Nov 17 20:13:24.801 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 20:13:24.802 INFO [stdout] 
Nov 17 20:13:24.811 INFO [stderr] su: No module specific data is present
Nov 17 20:13:25.714 INFO running `"docker" "inspect" "5fb76f6e864265bcdf7ef2af24ac0060f5f626f2e8c74fba39c8dde483a2c99c"`
Nov 17 20:13:26.031 INFO running `"docker" "rm" "-f" "5fb76f6e864265bcdf7ef2af24ac0060f5f626f2e8c74fba39c8dde483a2c99c"`
Nov 17 20:13:26.337 INFO [stdout] 5fb76f6e864265bcdf7ef2af24ac0060f5f626f2e8c74fba39c8dde483a2c99c