Nov 18 14:37:24.489 INFO testing faktory-0.10.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982 Nov 18 14:37:24.491 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 14:37:24.870 INFO [stdout] d51f6775e0934485c93d24a0632fa44e4f73820007e8fe8a0ccb6d472ec5ee46 Nov 18 14:37:24.877 INFO running `"docker" "start" "-a" "d51f6775e0934485c93d24a0632fa44e4f73820007e8fe8a0ccb6d472ec5ee46"` Nov 18 14:37:25.726 INFO [stderr] usermod: no changes Nov 18 14:37:25.927 INFO [stderr] Compiling atomic-option v0.1.2 Nov 18 14:37:26.504 INFO [stderr] Compiling faktory v0.10.0 (/source) Nov 18 14:37:30.663 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 4.88s Nov 18 14:37:30.664 INFO [stderr] su: No module specific data is present Nov 18 14:37:31.279 INFO running `"docker" "inspect" "d51f6775e0934485c93d24a0632fa44e4f73820007e8fe8a0ccb6d472ec5ee46"` Nov 18 14:37:31.537 INFO running `"docker" "rm" "-f" "d51f6775e0934485c93d24a0632fa44e4f73820007e8fe8a0ccb6d472ec5ee46"` Nov 18 14:37:31.951 INFO [stdout] d51f6775e0934485c93d24a0632fa44e4f73820007e8fe8a0ccb6d472ec5ee46 Nov 18 14:37:31.958 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 14:37:32.387 INFO [stdout] 8bb1c285dcdf2508498e2635a7a6b7cefce355a7e98ac67121f7e7d4e5bc3ba0 Nov 18 14:37:32.391 INFO running `"docker" "start" "-a" "8bb1c285dcdf2508498e2635a7a6b7cefce355a7e98ac67121f7e7d4e5bc3ba0"` Nov 18 14:37:33.618 INFO [stderr] usermod: no changes Nov 18 14:37:33.815 INFO [stderr] Compiling mockstream v0.0.3 Nov 18 14:37:34.819 INFO [stderr] Compiling faktory v0.10.0 (/source) Nov 18 14:37:43.535 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 9.89s Nov 18 14:37:43.547 INFO [stderr] su: No module specific data is present Nov 18 14:37:43.898 INFO running `"docker" "inspect" "8bb1c285dcdf2508498e2635a7a6b7cefce355a7e98ac67121f7e7d4e5bc3ba0"` Nov 18 14:37:43.991 INFO running `"docker" "rm" "-f" "8bb1c285dcdf2508498e2635a7a6b7cefce355a7e98ac67121f7e7d4e5bc3ba0"` Nov 18 14:37:44.143 INFO [stdout] 8bb1c285dcdf2508498e2635a7a6b7cefce355a7e98ac67121f7e7d4e5bc3ba0 Nov 18 14:37:44.147 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-7/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 14:37:44.303 INFO [stdout] 34d35f7548367e4eb23175b92895a3ddbe20a2e0c8666c1fb54420bcfd856eb0 Nov 18 14:37:44.307 INFO running `"docker" "start" "-a" "34d35f7548367e4eb23175b92895a3ddbe20a2e0c8666c1fb54420bcfd856eb0"` Nov 18 14:37:44.809 INFO [stderr] usermod: no changes Nov 18 14:37:44.971 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.12s Nov 18 14:37:44.987 INFO [stderr] Running /target/debug/deps/faktory-45c9a646d5bdae6d Nov 18 14:37:44.991 INFO [stdout] Nov 18 14:37:44.991 INFO [stdout] running 28 tests Nov 18 14:37:45.019 INFO [stdout] test consumer::tests::it_works ... ignored Nov 18 14:37:45.020 INFO [stdout] test producer::tests::it_works ... ignored Nov 18 14:37:45.020 INFO [stdout] test proto::single::resp::test::it_decodes_blob_json ... ok Nov 18 14:37:45.020 INFO [stdout] test proto::single::resp::test::it_decodes_json_empty ... ok Nov 18 14:37:45.021 INFO [stdout] test proto::single::resp::test::it_decodes_json_nill ... ok Nov 18 14:37:45.021 INFO [stdout] test proto::single::resp::test::it_decodes_json_ok_blob ... ok Nov 18 14:37:45.021 INFO [stdout] test proto::single::resp::test::it_decodes_json_ok_string ... ok Nov 18 14:37:45.022 INFO [stdout] test proto::single::resp::test::it_decodes_string_json ... ok Nov 18 14:37:45.022 INFO [stdout] test proto::single::resp::test::it_parses_empty_bulk ... ok Nov 18 14:37:45.022 INFO [stdout] test proto::single::resp::test::it_parses_nills ... ok Nov 18 14:37:45.026 INFO [stdout] test proto::single::resp::test::it_parses_non_empty_bulk ... ok Nov 18 14:37:45.026 INFO [stdout] test proto::single::resp::test::it_parses_numbers ... ok Nov 18 14:37:45.026 INFO [stdout] test proto::single::resp::test::it_parses_simple_strings ... ok Nov 18 14:37:45.067 INFO [stdout] test proto::single::resp::test::it_errors_on_bad_json_blob ... ok Nov 18 14:37:45.067 INFO [stdout] test proto::single::resp::test::it_errors_on_bad_json_string ... ok Nov 18 14:37:45.068 INFO [stdout] test proto::tests::it_works ... ignored Nov 18 14:37:45.068 INFO [stdout] test proto::single::resp::test::it_errors_on_bad_sizes ... ok Nov 18 14:37:45.068 INFO [stdout] test proto::single::resp::test::it_errors_on_unknown_resp_type ... ok Nov 18 14:37:45.069 INFO [stdout] test proto::single::resp::test::it_errors_on_bad_numbers ... ok Nov 18 14:37:45.069 INFO [stdout] test proto::tests::correct_env_parsing ... ok Nov 18 14:37:45.069 INFO [stdout] test proto::single::resp::test::json_error_on_number ... ok Nov 18 14:37:45.069 INFO [stdout] test proto::tests::url_can_take_password_and_port ... ok Nov 18 14:37:45.069 INFO [stdout] test proto::tests::url_port_default ... ok Nov 18 14:37:45.070 INFO [stdout] test proto::single::resp::test::it_parses_errors ... ok Nov 18 14:37:45.070 INFO [stdout] test proto::tests::url_requires_tcp ... ok Nov 18 14:37:45.070 INFO [stdout] test proto::tests::url_requires_host ... ok Nov 18 14:37:45.079 INFO [stdout] test proto::tests::url_doesnt_require_port ... ok Nov 18 14:37:45.123 INFO [stdout] test proto::single::resp::test::it_cant_do_arrays ... ok Nov 18 14:37:45.123 INFO [stdout] Nov 18 14:37:45.123 INFO [stdout] test result: ok. 25 passed; 0 failed; 3 ignored; 0 measured; 0 filtered out Nov 18 14:37:45.123 INFO [stdout] Nov 18 14:37:45.123 INFO [stdout] Nov 18 14:37:45.123 INFO [stdout] running 8 tests Nov 18 14:37:45.123 INFO [stderr] Running /target/debug/deps/consumer-2964c0ada1ee6310 Nov 18 14:37:45.137 INFO [stdout] test hello ... ok Nov 18 14:37:45.137 INFO [stdout] test dequeue_first_empty ... ok Nov 18 14:37:45.171 INFO [stdout] test hello_pwd ... ok Nov 18 14:37:45.191 INFO [stdout] test dequeue ... ok Nov 18 14:37:50.195 INFO [stdout] test terminate ... ok Nov 18 14:37:55.205 INFO [stdout] test no_first_job ... ok Nov 18 14:37:55.207 INFO [stdout] test well_behaved ... ok Nov 18 14:37:55.212 INFO [stdout] test well_behaved_many ... ok Nov 18 14:37:55.212 INFO [stdout] Nov 18 14:37:55.213 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 18 14:37:55.213 INFO [stdout] Nov 18 14:37:55.214 INFO [stderr] Running /target/debug/deps/producer-b8b522f59b22648d Nov 18 14:37:55.216 INFO [stdout] Nov 18 14:37:55.216 INFO [stdout] running 3 tests Nov 18 14:37:55.227 INFO [stdout] test enqueue ... ok Nov 18 14:37:55.227 INFO [stdout] test hello ... ok Nov 18 14:37:55.254 INFO [stdout] test hello_pwd ... ok Nov 18 14:37:55.254 INFO [stderr] Doc-tests faktory Nov 18 14:37:55.254 INFO [stdout] Nov 18 14:37:55.254 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 18 14:37:55.254 INFO [stdout] Nov 18 14:37:58.796 INFO [stdout] Nov 18 14:37:58.796 INFO [stdout] running 6 tests Nov 18 14:38:08.226 INFO [stdout] test src/lib.rs - (line 44) ... ok Nov 18 14:38:09.203 INFO [stdout] test src/producer/mod.rs - producer::Producer (line 55) ... ok Nov 18 14:38:09.347 INFO [stdout] test src/producer/mod.rs - producer::Producer (line 62) ... ok Nov 18 14:38:10.195 INFO [stdout] test src/producer/mod.rs - producer::Producer (line 48) ... ok Nov 18 14:38:10.369 INFO [stdout] test src/lib.rs - (line 36) ... ok Nov 18 14:38:10.440 INFO [stdout] test src/consumer/mod.rs - consumer::Consumer (line 98) ... ok Nov 18 14:38:10.440 INFO [stdout] Nov 18 14:38:10.440 INFO [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Nov 18 14:38:10.440 INFO [stdout] Nov 18 14:38:10.454 INFO [stderr] su: No module specific data is present Nov 18 14:38:10.895 INFO running `"docker" "inspect" "34d35f7548367e4eb23175b92895a3ddbe20a2e0c8666c1fb54420bcfd856eb0"` Nov 18 14:38:10.981 INFO running `"docker" "rm" "-f" "34d35f7548367e4eb23175b92895a3ddbe20a2e0c8666c1fb54420bcfd856eb0"` Nov 18 14:38:11.069 INFO [stdout] 34d35f7548367e4eb23175b92895a3ddbe20a2e0c8666c1fb54420bcfd856eb0