[INFO] fetching crate subplotlib 0.1.1...
[INFO] testing subplotlib-0.1.1 against 1.60.0 for beta-1.61-1
[INFO] extracting crate subplotlib 0.1.1 into /workspace/builds/worker-2/source
[INFO] validating manifest of crates.io crate subplotlib 0.1.1 on toolchain 1.60.0
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate subplotlib 0.1.1
[INFO] finished tweaking crates.io crate subplotlib 0.1.1
[INFO] tweaked toml for crates.io crate subplotlib 0.1.1 written to /workspace/builds/worker-2/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+1.60.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded remove_dir_all v0.7.0
[INFO] [stderr]   Downloaded state v0.5.2
[INFO] [stderr]   Downloaded shell-words v1.1.0
[INFO] [stderr]   Downloaded generator v0.7.0
[INFO] [stderr]   Downloaded loom v0.5.4
[INFO] [stderr]   Downloaded subplotlib-derive v0.1.0
[INFO] [stderr]   Downloaded unescape v0.1.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 3b566286cc6ca3334e20cd9d868e80e8b1cc9016f1e4a44316fed0e9daae60ad
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "3b566286cc6ca3334e20cd9d868e80e8b1cc9016f1e4a44316fed0e9daae60ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3b566286cc6ca3334e20cd9d868e80e8b1cc9016f1e4a44316fed0e9daae60ad", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3b566286cc6ca3334e20cd9d868e80e8b1cc9016f1e4a44316fed0e9daae60ad", kill_on_drop: false }`
[INFO] [stdout] 3b566286cc6ca3334e20cd9d868e80e8b1cc9016f1e4a44316fed0e9daae60ad
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 867bc1da31fd43affaf8db556f3515a1ee67580bb5bcef2f9dc2fc4784741da1
[INFO] running `Command { std: "docker" "start" "-a" "867bc1da31fd43affaf8db556f3515a1ee67580bb5bcef2f9dc2fc4784741da1", kill_on_drop: false }`
[INFO] [stderr]    Compiling unescape v0.1.0
[INFO] [stderr]    Compiling shell-words v1.1.0
[INFO] [stderr]    Compiling state v0.5.2
[INFO] [stderr]    Compiling remove_dir_all v0.7.0
[INFO] [stderr]    Compiling fs2 v0.4.3
[INFO] [stderr]    Compiling fehler-macros v1.0.0
[INFO] [stderr]    Compiling fehler v1.0.0
[INFO] [stderr]    Compiling subplotlib-derive v0.1.0
[INFO] [stderr]    Compiling subplotlib v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 16.95s
[INFO] running `Command { std: "docker" "inspect" "867bc1da31fd43affaf8db556f3515a1ee67580bb5bcef2f9dc2fc4784741da1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "867bc1da31fd43affaf8db556f3515a1ee67580bb5bcef2f9dc2fc4784741da1", kill_on_drop: false }`
[INFO] [stdout] 867bc1da31fd43affaf8db556f3515a1ee67580bb5bcef2f9dc2fc4784741da1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ec62b01b4b7120d6a5bb3498ee17a91f19d7fc2dd774beca2795b20a6e298fba
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] running `Command { std: "docker" "start" "-a" "ec62b01b4b7120d6a5bb3498ee17a91f19d7fc2dd774beca2795b20a6e298fba", kill_on_drop: false }`
[INFO] [stderr]    Compiling subplotlib v0.1.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 7.37s
[INFO] running `Command { std: "docker" "inspect" "ec62b01b4b7120d6a5bb3498ee17a91f19d7fc2dd774beca2795b20a6e298fba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ec62b01b4b7120d6a5bb3498ee17a91f19d7fc2dd774beca2795b20a6e298fba", kill_on_drop: false }`
[INFO] [stdout] ec62b01b4b7120d6a5bb3498ee17a91f19d7fc2dd774beca2795b20a6e298fba
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:eaef2f80f755933c374d2ae5edccceec0c1312ceb8a4e0b6404e8ab76561e1e5" "/opt/rustwide/cargo-home/bin/cargo" "+1.60.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap.
[INFO] [stdout] 9ed70305145eb3b87002711f4569a6c4c6e2788e2ef17dd68c2f23d5e997f401
[INFO] running `Command { std: "docker" "start" "-a" "9ed70305145eb3b87002711f4569a6c4c6e2788e2ef17dd68c2f23d5e997f401", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running unittests (/opt/rustwide/target/debug/deps/subplotlib-110fac67e4c43de1)
[INFO] [stdout] 
[INFO] [stderr]      Running tests/files.rs (/opt/rustwide/target/debug/deps/files-a3d04314ee044603)
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stdout] test directories ... ok
[INFO] [stderr]      Running tests/runcmd.rs (/opt/rustwide/target/debug/deps/runcmd-e30ba50b9785afd1)
[INFO] [stdout] test file_contents ... ok
[INFO] [stdout] test create_on_disk_files_from_embedded_files ... ok
[INFO] [stdout] test file_metadata ... ok
[INFO] [stdout] test file_modification_time ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 16 tests
[INFO] [stdout] test check_stderr_doesn_t_contain_sub_string ... ok
[INFO] [stdout] test check_stdout_doesn_t_match_regular_expression ... ok
[INFO] [stdout] test check_stderr_doesn_t_match_regular_expressions ... ok
[INFO] [stdout] test check_stdout_is_exactly_as_wanted ... ok
[INFO] [stdout] test failed_execution_in_a_sub_directory ... ok
[INFO] [stdout] test check_stderr_is_exactly_as_wanted ... ok
[INFO] [stdout] test check_stdout_using_regular_expressions ... ok
[INFO] [stdout] test check_stdout_doesn_t_contain_sub_string ... ok
[INFO] [stdout] test successful_execution_in_a_sub_directory ... ok
[INFO] [stdout] test failed_execution ... ok
[INFO] [stdout] test check_stderr_using_sub_string_search ... ok
[INFO] [stdout] test check_stdout_is_not_exactly_something ... ok
[INFO] [stdout] test successful_execution ... ok
[INFO] [stdout] test check_stdout_using_sub_string_search ... ok
[INFO] [stdout] test check_stderr_using_regular_expressions ... ok
[INFO] [stdout] test check_stderr_is_not_exactly_something ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test fundamentals ... ok
[INFO] [stderr]      Running tests/subplotlib.rs (/opt/rustwide/target/debug/deps/subplotlib-c70d0bc315243b78)
[INFO] [stdout] test embedded_files ... ok
[INFO] [stdout] test data_directory ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests subplotlib
[INFO] [stdout] 
[INFO] [stdout] running 53 tests
[INFO] [stdout] test src/steplibrary/datadir.rs - steplibrary::datadir::datadir_has_enough_space::call (line 112) ... ignored
[INFO] [stdout] test src/steplibrary/datadir.rs - steplibrary::datadir::datadir_has_enough_space_megabytes::call (line 124) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::create_from_embedded::call (line 51) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::create_from_embedded_with_other_name::call (line 64) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::create_from_text::call (line 100) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::file_contains::call (line 181) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::file_does_not_exist::call (line 153) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::file_exists::call (line 138) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::file_match::call (line 200) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::file_matches_regex::call (line 190) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::has_different_metadata::call (line 236) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::has_remembered_metadata::call (line 211) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::make_directory::call (line 283) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::mtime_is_ancient::call (line 272) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::mtime_is_recent::call (line 261) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::only_these_exist::call (line 168) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::path_does_not_exist::call (line 305) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::path_exists::call (line 294) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::path_is_empty::call (line 318) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::path_is_not_empty::call (line 329) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::remember_metadata::call (line 105) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::remove_directory::call (line 288) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::touch::call (line 123) ... ignored
[INFO] [stdout] test src/steplibrary/files.rs - steplibrary::files::touch_with_timestamp::call (line 83) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::exit_code_is::call (line 186) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::exit_code_is_nonzero::call (line 209) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::exit_code_is_not::call (line 196) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::exit_code_is_zero::call (line 203) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::helper_script::call (line 80) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::helper_srcdir_path::call (line 87) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::run::call (line 92) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::run_in::call (line 100) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stderr_contains::call (line 291) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stderr_doesnt_contain::call (line 298) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stderr_doesnt_match_regex::call (line 326) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stderr_is::call (line 263) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stderr_isnt::call (line 270) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stderr_matches_regex::call (line 319) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stdout_contains::call (line 277) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stdout_doesnt_contain::call (line 284) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stdout_doesnt_match_regex::call (line 312) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stdout_is::call (line 249) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stdout_isnt::call (line 256) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::stdout_matches_regex::call (line 305) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::try_to_run::call (line 108) ... ignored
[INFO] [stdout] test src/steplibrary/runcmd.rs - steplibrary::runcmd::try_to_run_in::call (line 115) ... ignored
[INFO] [stdout] test src/prelude.rs - prelude::throws (line 39) ... ok
[INFO] [stdout] test src/prelude.rs - prelude::throws (line 26) ... ok
[INFO] [stdout] test src/prelude.rs - prelude::step (line 100) ... ok
[INFO] [stdout] test src/steplibrary.rs - steplibrary (line 10) ... ok
[INFO] [stdout] test src/prelude.rs - prelude (line 6) ... ok
[INFO] [stdout] test src/prelude.rs - prelude::step (line 73) ... ok
[INFO] [stdout] test src/file.rs - file::SubplotDataFile (line 19) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 7 passed; 0 failed; 46 ignored; 0 measured; 0 filtered out; finished in 2.66s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "9ed70305145eb3b87002711f4569a6c4c6e2788e2ef17dd68c2f23d5e997f401", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9ed70305145eb3b87002711f4569a6c4c6e2788e2ef17dd68c2f23d5e997f401", kill_on_drop: false }`
[INFO] [stdout] 9ed70305145eb3b87002711f4569a6c4c6e2788e2ef17dd68c2f23d5e997f401