Dec 14 16:20:46.841 INFO testing toornament-1.1.0 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 14 16:20:46.841 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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:20:47.235 INFO [stdout] 7ef80a21b2c2358cf8c9026efc38f890a2c8901521d4ec30da03b152347969d8
Dec 14 16:20:47.237 INFO running `"docker" "start" "-a" "7ef80a21b2c2358cf8c9026efc38f890a2c8901521d4ec30da03b152347969d8"`
Dec 14 16:20:47.985 INFO [stderr] usermod: no changes
Dec 14 16:20:48.311 INFO [stderr]    Compiling vergen v0.1.1
Dec 14 16:20:48.311 INFO [stderr]    Compiling reqwest v0.8.8
Dec 14 16:20:49.819 INFO [stderr]    Compiling toornament v1.1.0 (/source)
Dec 14 16:21:10.311 INFO [stderr] warning: unused macro definition
Dec 14 16:21:10.311 INFO [stderr]  --> src/macroses.rs:1:1
Dec 14 16:21:10.311 INFO [stderr]   |
Dec 14 16:21:10.311 INFO [stderr] 1 | / macro_rules! format_date {
Dec 14 16:21:10.311 INFO [stderr] 2 | |     ($date:expr) => {
Dec 14 16:21:10.311 INFO [stderr] 3 | |         $date.format("%Y-%m-%d").to_string()
Dec 14 16:21:10.311 INFO [stderr] 4 | |     }
Dec 14 16:21:10.311 INFO [stderr] 5 | | }
Dec 14 16:21:10.311 INFO [stderr]   | |_^
Dec 14 16:21:10.311 INFO [stderr]   |
Dec 14 16:21:10.311 INFO [stderr]   = note: #[warn(unused_macros)] on by default
Dec 14 16:21:10.311 INFO [stderr] 
Dec 14 16:21:10.347 INFO [stderr] warning: doc comment not used by rustdoc
Dec 14 16:21:10.347 INFO [stderr]   --> src/iter/disciplines.rs:76:9
Dec 14 16:21:10.347 INFO [stderr]    |
Dec 14 16:21:10.347 INFO [stderr] 76 |         /// Option::take() returns reference? wtf?
Dec 14 16:21:10.347 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:21:10.347 INFO [stderr]    |
Dec 14 16:21:10.347 INFO [stderr]    = note: #[warn(unused_doc_comments)] on by default
Dec 14 16:21:10.347 INFO [stderr] 
Dec 14 16:21:22.122 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 34.11s
Dec 14 16:21:22.147 INFO [stderr] su: No module specific data is present
Dec 14 16:21:22.865 INFO running `"docker" "inspect" "7ef80a21b2c2358cf8c9026efc38f890a2c8901521d4ec30da03b152347969d8"`
Dec 14 16:21:23.081 INFO running `"docker" "rm" "-f" "7ef80a21b2c2358cf8c9026efc38f890a2c8901521d4ec30da03b152347969d8"`
Dec 14 16:21:23.411 INFO [stdout] 7ef80a21b2c2358cf8c9026efc38f890a2c8901521d4ec30da03b152347969d8
Dec 14 16:21:23.413 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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:21:23.792 INFO [stdout] f117da10169984027f735b87c929ce69ca405ffd46ab9104ae28baecd1c562bb
Dec 14 16:21:23.831 INFO running `"docker" "start" "-a" "f117da10169984027f735b87c929ce69ca405ffd46ab9104ae28baecd1c562bb"`
Dec 14 16:21:24.859 INFO [stderr] usermod: no changes
Dec 14 16:21:25.263 INFO [stderr]    Compiling toornament v1.1.0 (/source)
Dec 14 16:21:33.907 INFO [stderr] warning: unused macro definition
Dec 14 16:21:33.907 INFO [stderr]  --> src/macroses.rs:1:1
Dec 14 16:21:33.907 INFO [stderr]   |
Dec 14 16:21:33.907 INFO [stderr] 1 | / macro_rules! format_date {
Dec 14 16:21:33.907 INFO [stderr] 2 | |     ($date:expr) => {
Dec 14 16:21:33.907 INFO [stderr] 3 | |         $date.format("%Y-%m-%d").to_string()
Dec 14 16:21:33.907 INFO [stderr] 4 | |     }
Dec 14 16:21:33.907 INFO [stderr] 5 | | }
Dec 14 16:21:33.907 INFO [stderr]   | |_^
Dec 14 16:21:33.907 INFO [stderr]   |
Dec 14 16:21:33.907 INFO [stderr]   = note: #[warn(unused_macros)] on by default
Dec 14 16:21:33.907 INFO [stderr] 
Dec 14 16:21:33.950 INFO [stderr] warning: doc comment not used by rustdoc
Dec 14 16:21:33.951 INFO [stderr]   --> src/iter/disciplines.rs:76:9
Dec 14 16:21:33.951 INFO [stderr]    |
Dec 14 16:21:33.951 INFO [stderr] 76 |         /// Option::take() returns reference? wtf?
Dec 14 16:21:33.951 INFO [stderr]    |         ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 16:21:33.951 INFO [stderr]    |
Dec 14 16:21:33.951 INFO [stderr]    = note: #[warn(unused_doc_comments)] on by default
Dec 14 16:21:33.951 INFO [stderr] 
Dec 14 16:21:45.269 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.26s
Dec 14 16:21:45.285 INFO [stderr] su: No module specific data is present
Dec 14 16:21:45.741 INFO running `"docker" "inspect" "f117da10169984027f735b87c929ce69ca405ffd46ab9104ae28baecd1c562bb"`
Dec 14 16:21:45.891 INFO running `"docker" "rm" "-f" "f117da10169984027f735b87c929ce69ca405ffd46ab9104ae28baecd1c562bb"`
Dec 14 16:21:46.021 INFO [stdout] f117da10169984027f735b87c929ce69ca405ffd46ab9104ae28baecd1c562bb
Dec 14 16:21:46.022 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-1/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/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" "-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:21:46.298 INFO [stdout] 40da8ebcfa378d1ac765062bef6cdd149a212a8258fb0f196f5ce9d952365a43
Dec 14 16:21:46.300 INFO running `"docker" "start" "-a" "40da8ebcfa378d1ac765062bef6cdd149a212a8258fb0f196f5ce9d952365a43"`
Dec 14 16:21:46.873 INFO [stderr] usermod: no changes
Dec 14 16:21:47.061 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Dec 14 16:21:47.083 INFO [stderr]      Running /target/debug/deps/toornament-98f0fb7e4d3ab264
Dec 14 16:21:47.096 INFO [stdout] 
Dec 14 16:21:47.096 INFO [stdout] running 13 tests
Dec 14 16:21:47.096 INFO [stdout] test disciplines::tests::test_discipline_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] test disciplines::tests::test_discipline_full_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] test matches::tests::test_parse_match_results ... ok
Dec 14 16:21:47.096 INFO [stdout] test permissions::tests::test_permission_attributes_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] test participants::tests::test_participant_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] test stages::tests::test_stages_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] test tests::test_sync_and_send ... ok
Dec 14 16:21:47.096 INFO [stdout] test tournaments::tests::test_stream_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] test tournaments::tests::test_tournament_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] test videos::tests::test_videos_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] test matches::tests::test_match_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] test endpoints::tests::test_match_filter_to_get_string ... ok
Dec 14 16:21:47.096 INFO [stdout] test disciplines::tests::test_disciplines_parse ... ok
Dec 14 16:21:47.096 INFO [stdout] 
Dec 14 16:21:47.096 INFO [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:21:47.096 INFO [stdout] 
Dec 14 16:21:47.101 INFO [stderr]    Doc-tests toornament
Dec 14 16:21:58.263 INFO [stdout] 
Dec 14 16:21:58.263 INFO [stdout] running 33 tests
Dec 14 16:22:50.717 INFO [stdout] test src/lib.rs - Toornament::delete_tournament_participant (line 1002) ... ok
Dec 14 16:22:54.823 INFO [stdout] test src/lib.rs - Toornament::create_tournament_permission (line 1052) ... ok
Dec 14 16:22:56.475 INFO [stdout] test src/iter/mod.rs - iter (line 25) ... ok
Dec 14 16:22:57.523 INFO [stdout] test src/lib.rs - Toornament::create_tournament_participant (line 881) ... ok
Dec 14 16:22:58.263 INFO [stdout] test src/info.rs - info (line 5) ... test src/info.rs - info (line 5) has been running for over 60 seconds
Dec 14 16:22:58.263 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
Dec 14 16:22:58.279 INFO [stdout] test src/lib.rs -  (line 18) ... test src/lib.rs -  (line 18) has been running for over 60 seconds
Dec 14 16:22:58.290 INFO [stdout] test src/lib.rs - Toornament::delete_tournament (line 461) ... test src/lib.rs - Toornament::delete_tournament (line 461) has been running for over 60 seconds
Dec 14 16:23:01.891 INFO [stdout] test src/lib.rs - Toornament::delete_tournament (line 461) ... ok
Dec 14 16:23:03.992 INFO [stdout] test src/lib.rs -  (line 18) ... ok
Dec 14 16:23:04.148 INFO [stdout] test src/info.rs - info (line 5) ... ok
Dec 14 16:23:07.580 INFO [stdout] test src/iter/mod.rs - iter (line 10) ... ok
Dec 14 16:23:50.733 INFO [stdout] test src/lib.rs - Toornament::delete_tournament_permission (line 1162) ... test src/lib.rs - Toornament::delete_tournament_permission (line 1162) has been running for over 60 seconds
Dec 14 16:23:54.845 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
Dec 14 16:23:56.479 INFO [stdout] test src/lib.rs - Toornament::edit_tournament (line 418) ... test src/lib.rs - Toornament::edit_tournament (line 418) has been running for over 60 seconds
Dec 14 16:23:57.523 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
Dec 14 16:23:58.055 INFO [stdout] test src/lib.rs - Toornament::edit_tournament (line 418) ... ok
Dec 14 16:24:01.347 INFO [stdout] test src/lib.rs - Toornament::delete_tournament_permission (line 1162) ... ok
Dec 14 16:24:01.859 INFO [stdout] test src/lib.rs - Toornament::match_games (line 669) ... ok
Dec 14 16:24:01.891 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
Dec 14 16:24:04.151 INFO [stdout] test src/lib.rs - Toornament::match_result (line 611) ... test src/lib.rs - Toornament::match_result (line 611) has been running for over 60 seconds
Dec 14 16:24:07.585 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
Dec 14 16:24:08.420 INFO [stdout] test src/lib.rs - Toornament::match_game (line 700) ... ok
Dec 14 16:24:15.235 INFO [stdout] test src/lib.rs - Toornament::disciplines (line 336) ... ok
Dec 14 16:24:16.171 INFO [stdout] test src/lib.rs - Toornament::match_game_result (line 776) ... ok
Dec 14 16:24:19.146 INFO [stdout] test src/lib.rs - Toornament::match_result (line 611) ... ok
Dec 14 16:24:28.667 INFO [stdout] test src/lib.rs - Toornament::matches (line 506) ... ok
Dec 14 16:24:58.071 INFO [stdout] test src/lib.rs - Toornament::matches_by_discipline (line 548) ... test src/lib.rs - Toornament::matches_by_discipline (line 548) has been running for over 60 seconds
Dec 14 16:25:01.355 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
Dec 14 16:25:01.867 INFO [stdout] test src/lib.rs - Toornament::set_match_result (line 635) ... test src/lib.rs - Toornament::set_match_result (line 635) has been running for over 60 seconds
Dec 14 16:25:08.423 INFO [stdout] test src/lib.rs - Toornament::tournament_participant (line 938) ... test src/lib.rs - Toornament::tournament_participant (line 938) has been running for over 60 seconds
Dec 14 16:25:15.236 INFO [stdout] test src/lib.rs - Toornament::tournament_participants (line 853) ... test src/lib.rs - Toornament::tournament_participants (line 853) has been running for over 60 seconds
Dec 14 16:25:16.183 INFO [stdout] test src/lib.rs - Toornament::tournament_permission (line 1087) ... test src/lib.rs - Toornament::tournament_permission (line 1087) has been running for over 60 seconds
Dec 14 16:25:18.151 INFO [stdout] test src/lib.rs - Toornament::matches_by_discipline (line 548) ... ok
Dec 14 16:25:19.155 INFO [stdout] test src/lib.rs - Toornament::tournament_permissions (line 1031) ... test src/lib.rs - Toornament::tournament_permissions (line 1031) has been running for over 60 seconds
Dec 14 16:25:19.779 INFO [stdout] test src/lib.rs - Toornament::set_match_result (line 635) ... ok
Dec 14 16:25:23.499 INFO [stdout] test src/lib.rs - Toornament::tournament_participant (line 938) ... ok
Dec 14 16:25:26.507 INFO [stdout] test src/lib.rs - Toornament::my_tournaments (line 484) ... ok
Dec 14 16:25:27.683 INFO [stdout] test src/lib.rs - Toornament::tournament_permission (line 1087) ... ok
Dec 14 16:25:28.674 INFO [stdout] test src/lib.rs - Toornament::tournament_stages (line 1194) ... test src/lib.rs - Toornament::tournament_stages (line 1194) has been running for over 60 seconds
Dec 14 16:25:31.129 INFO [stdout] test src/lib.rs - Toornament::tournament_stages (line 1194) ... ok
Dec 14 16:25:32.781 INFO [stdout] test src/lib.rs - Toornament::tournament_participants (line 853) ... ok
Dec 14 16:25:33.539 INFO [stdout] test src/lib.rs - Toornament::tournament_permissions (line 1031) ... ok
Dec 14 16:26:18.159 INFO [stdout] test src/lib.rs - Toornament::tournament_videos (line 1218) ... test src/lib.rs - Toornament::tournament_videos (line 1218) has been running for over 60 seconds
Dec 14 16:26:19.771 INFO [stdout] test src/lib.rs - Toornament::tournaments (line 375) ... test src/lib.rs - Toornament::tournaments (line 375) has been running for over 60 seconds
Dec 14 16:26:22.626 INFO [stdout] test src/lib.rs - Toornament::tournaments (line 375) ... ok
Dec 14 16:26:23.507 INFO [stdout] test src/lib.rs - Toornament::update_match (line 573) ... test src/lib.rs - Toornament::update_match (line 573) has been running for over 60 seconds
Dec 14 16:26:26.504 INFO [stdout] test src/lib.rs - Toornament::update_match_game (line 736) ... test src/lib.rs - Toornament::update_match_game (line 736) has been running for over 60 seconds
Dec 14 16:26:27.687 INFO [stdout] test src/lib.rs - Toornament::update_match_game_result (line 808) ... test src/lib.rs - Toornament::update_match_game_result (line 808) has been running for over 60 seconds
Dec 14 16:26:27.846 INFO [stdout] test src/lib.rs - Toornament::tournament_videos (line 1218) ... ok
Dec 14 16:26:29.760 INFO [stdout] test src/lib.rs - Toornament::update_match_game (line 736) ... ok
Dec 14 16:26:31.139 INFO [stdout] test src/lib.rs - Toornament::update_tournament_participant (line 965) ... test src/lib.rs - Toornament::update_tournament_participant (line 965) has been running for over 60 seconds
Dec 14 16:26:31.927 INFO [stdout] test src/lib.rs - Toornament::update_match_game_result (line 808) ... ok
Dec 14 16:26:32.079 INFO [stdout] test src/lib.rs - Toornament::update_match (line 573) ... ok
Dec 14 16:26:32.715 INFO [stdout] test src/lib.rs - Toornament::update_tournament_permission_attributes (line 1115) ... ok
Dec 14 16:26:32.783 INFO [stdout] test src/lib.rs - Toornament::update_tournament_participants (line 910) ... test src/lib.rs - Toornament::update_tournament_participants (line 910) has been running for over 60 seconds
Dec 14 16:26:33.013 INFO [stdout] test src/lib.rs - Toornament::update_tournament_participants (line 910) ... ok
Dec 14 16:26:33.351 INFO [stdout] test src/lib.rs - Toornament::update_tournament_participant (line 965) ... ok
Dec 14 16:26:39.958 INFO [stdout] test src/lib.rs - Toornament::with_application (line 271) ... ok
Dec 14 16:26:39.958 INFO [stdout] 
Dec 14 16:26:39.959 INFO [stdout] test result: ok. 33 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 16:26:39.959 INFO [stdout] 
Dec 14 16:26:40.014 INFO [stderr] su: No module specific data is present
Dec 14 16:26:40.843 INFO running `"docker" "inspect" "40da8ebcfa378d1ac765062bef6cdd149a212a8258fb0f196f5ce9d952365a43"`
Dec 14 16:26:41.080 INFO running `"docker" "rm" "-f" "40da8ebcfa378d1ac765062bef6cdd149a212a8258fb0f196f5ce9d952365a43"`
Dec 14 16:26:41.346 INFO [stdout] 40da8ebcfa378d1ac765062bef6cdd149a212a8258fb0f196f5ce9d952365a43