Nov 17 20:08:19.902 INFO testing toornament-1.1.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 20:08:19.902 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 17 20:08:20.137 INFO [stdout] e1b1e5fdbf927dbb86d399f1a382755919190bffef68f3b2f3380dd2ca6a9f1d
Nov 17 20:08:20.140 INFO running `"docker" "start" "-a" "e1b1e5fdbf927dbb86d399f1a382755919190bffef68f3b2f3380dd2ca6a9f1d"`
Nov 17 20:08:20.551 INFO [stderr] usermod: no changes
Nov 17 20:08:20.843 INFO [stderr]    Compiling toornament v1.1.0 (/source)
Nov 17 20:08:20.846 INFO [stderr]    Compiling reqwest v0.8.8
Nov 17 20:08:36.709 INFO [stderr] warning: unused macro definition
Nov 17 20:08:36.709 INFO [stderr]  --> src/macroses.rs:1:1
Nov 17 20:08:36.709 INFO [stderr]   |
Nov 17 20:08:36.709 INFO [stderr] 1 | / macro_rules! format_date {
Nov 17 20:08:36.709 INFO [stderr] 2 | |     ($date:expr) => {
Nov 17 20:08:36.709 INFO [stderr] 3 | |         $date.format("%Y-%m-%d").to_string()
Nov 17 20:08:36.709 INFO [stderr] 4 | |     }
Nov 17 20:08:36.709 INFO [stderr] 5 | | }
Nov 17 20:08:36.709 INFO [stderr]   | |_^
Nov 17 20:08:36.709 INFO [stderr]   |
Nov 17 20:08:36.709 INFO [stderr]   = note: #[warn(unused_macros)] on by default
Nov 17 20:08:36.709 INFO [stderr] 
Nov 17 20:08:36.729 INFO [stderr] warning: doc comment not used by rustdoc
Nov 17 20:08:36.730 INFO [stderr]   --> src/iter/disciplines.rs:76:9
Nov 17 20:08:36.730 INFO [stderr]    |
Nov 17 20:08:36.730 INFO [stderr] 76 |         /// Option::take() returns reference? wtf?
Nov 17 20:08:36.730 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 17 20:08:36.730 INFO [stderr]    |
Nov 17 20:08:36.730 INFO [stderr]    = note: #[warn(unused_doc_comments)] on by default
Nov 17 20:08:36.730 INFO [stderr] 
Nov 17 20:08:43.926 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 23.34s
Nov 17 20:08:43.940 INFO [stderr] su: No module specific data is present
Nov 17 20:08:44.201 INFO running `"docker" "inspect" "e1b1e5fdbf927dbb86d399f1a382755919190bffef68f3b2f3380dd2ca6a9f1d"`
Nov 17 20:08:44.264 INFO running `"docker" "rm" "-f" "e1b1e5fdbf927dbb86d399f1a382755919190bffef68f3b2f3380dd2ca6a9f1d"`
Nov 17 20:08:44.435 INFO [stdout] e1b1e5fdbf927dbb86d399f1a382755919190bffef68f3b2f3380dd2ca6a9f1d
Nov 17 20:08:44.441 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 17 20:08:44.795 INFO [stdout] 6c141faa0eb899af059e20d37173c93ab6312903d23260cdd06e21a9687fc3e6
Nov 17 20:08:44.800 INFO running `"docker" "start" "-a" "6c141faa0eb899af059e20d37173c93ab6312903d23260cdd06e21a9687fc3e6"`
Nov 17 20:08:45.779 INFO [stderr] usermod: no changes
Nov 17 20:08:46.027 INFO [stderr]    Compiling toornament v1.1.0 (/source)
Nov 17 20:08:52.267 INFO [stderr] warning: unused macro definition
Nov 17 20:08:52.268 INFO [stderr]  --> src/macroses.rs:1:1
Nov 17 20:08:52.268 INFO [stderr]   |
Nov 17 20:08:52.269 INFO [stderr] 1 | / macro_rules! format_date {
Nov 17 20:08:52.269 INFO [stderr] 2 | |     ($date:expr) => {
Nov 17 20:08:52.269 INFO [stderr] 3 | |         $date.format("%Y-%m-%d").to_string()
Nov 17 20:08:52.269 INFO [stderr] 4 | |     }
Nov 17 20:08:52.270 INFO [stderr] 5 | | }
Nov 17 20:08:52.270 INFO [stderr]   | |_^
Nov 17 20:08:52.270 INFO [stderr]   |
Nov 17 20:08:52.271 INFO [stderr]   = note: #[warn(unused_macros)] on by default
Nov 17 20:08:52.271 INFO [stderr] 
Nov 17 20:08:52.308 INFO [stderr] warning: doc comment not used by rustdoc
Nov 17 20:08:52.308 INFO [stderr]   --> src/iter/disciplines.rs:76:9
Nov 17 20:08:52.309 INFO [stderr]    |
Nov 17 20:08:52.309 INFO [stderr] 76 |         /// Option::take() returns reference? wtf?
Nov 17 20:08:52.309 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 17 20:08:52.310 INFO [stderr]    |
Nov 17 20:08:52.310 INFO [stderr]    = note: #[warn(unused_doc_comments)] on by default
Nov 17 20:08:52.310 INFO [stderr] 
Nov 17 20:09:02.027 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.23s
Nov 17 20:09:02.042 INFO [stderr] su: No module specific data is present
Nov 17 20:09:02.299 INFO running `"docker" "inspect" "6c141faa0eb899af059e20d37173c93ab6312903d23260cdd06e21a9687fc3e6"`
Nov 17 20:09:02.411 INFO running `"docker" "rm" "-f" "6c141faa0eb899af059e20d37173c93ab6312903d23260cdd06e21a9687fc3e6"`
Nov 17 20:09:02.528 INFO [stdout] 6c141faa0eb899af059e20d37173c93ab6312903d23260cdd06e21a9687fc3e6
Nov 17 20:09:02.533 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-1/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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 17 20:09:02.705 INFO [stdout] 95afa768b77a6e626dd8938ef554d156aede72b07f959cfdd290d9edca68027f
Nov 17 20:09:02.707 INFO running `"docker" "start" "-a" "95afa768b77a6e626dd8938ef554d156aede72b07f959cfdd290d9edca68027f"`
Nov 17 20:09:03.223 INFO [stderr] usermod: no changes
Nov 17 20:09:03.558 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.31s
Nov 17 20:09:03.568 INFO [stderr]      Running /target/debug/deps/toornament-a4ae9a9349158075
Nov 17 20:09:03.576 INFO [stdout] 
Nov 17 20:09:03.576 INFO [stdout] running 13 tests
Nov 17 20:09:03.611 INFO [stdout] test disciplines::tests::test_discipline_parse ... ok
Nov 17 20:09:03.631 INFO [stdout] test disciplines::tests::test_discipline_full_parse ... ok
Nov 17 20:09:03.639 INFO [stdout] test disciplines::tests::test_disciplines_parse ... ok
Nov 17 20:09:03.639 INFO [stdout] test endpoints::tests::test_match_filter_to_get_string ... ok
Nov 17 20:09:03.639 INFO [stdout] test permissions::tests::test_permission_attributes_parse ... ok
Nov 17 20:09:03.639 INFO [stdout] test matches::tests::test_parse_match_results ... ok
Nov 17 20:09:03.640 INFO [stdout] test matches::tests::test_match_parse ... ok
Nov 17 20:09:03.640 INFO [stdout] test participants::tests::test_participant_parse ... ok
Nov 17 20:09:03.640 INFO [stdout] test tournaments::tests::test_stream_parse ... ok
Nov 17 20:09:03.647 INFO [stdout] test tests::test_sync_and_send ... ok
Nov 17 20:09:03.647 INFO [stdout] test stages::tests::test_stages_parse ... ok
Nov 17 20:09:03.647 INFO [stdout] test videos::tests::test_videos_parse ... ok
Nov 17 20:09:03.655 INFO [stdout] test tournaments::tests::test_tournament_parse ... ok
Nov 17 20:09:03.655 INFO [stdout] 
Nov 17 20:09:03.655 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 20:09:03.655 INFO [stdout] 
Nov 17 20:09:03.665 INFO [stderr]    Doc-tests toornament
Nov 17 20:09:13.527 INFO [stdout] 
Nov 17 20:09:13.527 INFO [stdout] running 33 tests
Nov 17 20:10:05.899 INFO [stdout] test src/lib.rs - Toornament::delete_tournament (line 461) ... ok
Nov 17 20:10:12.267 INFO [stdout] test src/lib.rs - Toornament::create_tournament_participant (line 881) ... ok
Nov 17 20:10:12.979 INFO [stdout] test src/lib.rs - Toornament::create_tournament_permission (line 1052) ... ok
Nov 17 20:10:13.180 INFO [stdout] test src/lib.rs - Toornament::delete_tournament_participant (line 1002) ... ok
Nov 17 20:10:13.539 INFO [stdout] test src/iter/mod.rs - iter (line 10) ... test src/iter/mod.rs - iter (line 10) has been running for over 60 seconds
Nov 17 20:10:13.540 INFO [stdout] test src/iter/mod.rs - iter (line 25) ... test src/iter/mod.rs - iter (line 25) has been running for over 60 seconds
Nov 17 20:10:13.540 INFO [stdout] test src/info.rs - info (line 5) ... test src/info.rs - info (line 5) has been running for over 60 seconds
Nov 17 20:10:13.551 INFO [stdout] test src/lib.rs -  (line 18) ... test src/lib.rs -  (line 18) has been running for over 60 seconds
Nov 17 20:10:16.027 INFO [stdout] test src/iter/mod.rs - iter (line 25) ... ok
Nov 17 20:10:16.308 INFO [stdout] test src/lib.rs -  (line 18) ... ok
Nov 17 20:10:16.547 INFO [stdout] test src/iter/mod.rs - iter (line 10) ... ok
Nov 17 20:10:18.207 INFO [stdout] test src/info.rs - info (line 5) ... ok
Nov 17 20:11:03.511 INFO [stdout] test src/lib.rs - Toornament::delete_tournament_permission (line 1162) ... ok
Nov 17 20:11:08.532 INFO [stdout] test src/lib.rs - Toornament::edit_tournament (line 418) ... ok
Nov 17 20:11:12.266 INFO [stdout] test src/lib.rs - Toornament::disciplines (line 336) ... test src/lib.rs - Toornament::disciplines (line 336) has been running for over 60 seconds
Nov 17 20:11:13.184 INFO [stdout] test src/lib.rs - Toornament::match_game (line 700) ... test src/lib.rs - Toornament::match_game (line 700) has been running for over 60 seconds
Nov 17 20:11:13.809 INFO [stdout] test src/lib.rs - Toornament::match_game (line 700) ... ok
Nov 17 20:11:14.719 INFO [stdout] test src/lib.rs - Toornament::match_result (line 611) ... ok
Nov 17 20:11:16.021 INFO [stdout] test src/lib.rs - Toornament::match_game_result (line 776) ... test src/lib.rs - Toornament::match_game_result (line 776) has been running for over 60 seconds
Nov 17 20:11:16.306 INFO [stdout] test src/lib.rs - Toornament::match_games (line 669) ... test src/lib.rs - Toornament::match_games (line 669) has been running for over 60 seconds
Nov 17 20:11:17.923 INFO [stdout] test src/lib.rs - Toornament::disciplines (line 336) ... ok
Nov 17 20:11:18.203 INFO [stdout] test src/lib.rs - Toornament::matches (line 506) ... test src/lib.rs - Toornament::matches (line 506) has been running for over 60 seconds
Nov 17 20:11:19.023 INFO [stdout] test src/lib.rs - Toornament::match_game_result (line 776) ... ok
Nov 17 20:11:20.275 INFO [stdout] test src/lib.rs - Toornament::matches (line 506) ... ok
Nov 17 20:11:20.372 INFO [stdout] test src/lib.rs - Toornament::match_games (line 669) ... ok
Nov 17 20:12:00.375 INFO [stdout] test src/lib.rs - Toornament::matches_by_discipline (line 548) ... ok
Nov 17 20:12:05.919 INFO [stdout] test src/lib.rs - Toornament::set_match_result (line 635) ... ok
Nov 17 20:12:08.359 INFO [stdout] test src/lib.rs - Toornament::tournament_participants (line 853) ... ok
Nov 17 20:12:08.533 INFO [stdout] test src/lib.rs - Toornament::my_tournaments (line 484) ... test src/lib.rs - Toornament::my_tournaments (line 484) has been running for over 60 seconds
Nov 17 20:12:10.407 INFO [stdout] test src/lib.rs - Toornament::my_tournaments (line 484) ... ok
Nov 17 20:12:11.056 INFO [stdout] test src/lib.rs - Toornament::tournament_participant (line 938) ... ok
Nov 17 20:12:11.727 INFO [stdout] test src/lib.rs - Toornament::tournament_permission (line 1087) ... ok
Nov 17 20:12:12.496 INFO [stdout] test src/lib.rs - Toornament::tournament_stages (line 1194) ... ok
Nov 17 20:12:14.708 INFO [stdout] test src/lib.rs - Toornament::tournament_permissions (line 1031) ... ok
Nov 17 20:12:46.804 INFO [stdout] test src/lib.rs - Toornament::tournament_videos (line 1218) ... ok
Nov 17 20:12:56.991 INFO [stdout] test src/lib.rs - Toornament::update_match_game (line 736) ... ok
Nov 17 20:12:59.461 INFO [stdout] test src/lib.rs - Toornament::tournaments (line 375) ... ok
Nov 17 20:12:59.473 INFO [stdout] test src/lib.rs - Toornament::update_match (line 573) ... ok
Nov 17 20:13:02.340 INFO [stdout] test src/lib.rs - Toornament::update_tournament_participant (line 965) ... ok
Nov 17 20:13:02.351 INFO [stdout] test src/lib.rs - Toornament::update_tournament_participants (line 910) ... ok
Nov 17 20:13:02.667 INFO [stdout] test src/lib.rs - Toornament::update_match_game_result (line 808) ... ok
Nov 17 20:13:02.799 INFO [stdout] test src/lib.rs - Toornament::update_tournament_permission_attributes (line 1115) ... ok
Nov 17 20:13:08.133 INFO [stdout] test src/lib.rs - Toornament::with_application (line 271) ... ok
Nov 17 20:13:08.133 INFO [stdout] 
Nov 17 20:13:08.134 INFO [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 20:13:08.134 INFO [stdout] 
Nov 17 20:13:08.184 INFO [stderr] su: No module specific data is present
Nov 17 20:13:09.011 INFO running `"docker" "inspect" "95afa768b77a6e626dd8938ef554d156aede72b07f959cfdd290d9edca68027f"`
Nov 17 20:13:09.341 INFO running `"docker" "rm" "-f" "95afa768b77a6e626dd8938ef554d156aede72b07f959cfdd290d9edca68027f"`
Nov 17 20:13:09.615 INFO [stdout] 95afa768b77a6e626dd8938ef554d156aede72b07f959cfdd290d9edca68027f