[INFO] fetching crate ms-pdb-msf 0.1.4...
[INFO] testing ms-pdb-msf-0.1.4 against master#cdb45c87e2cd43495379f7e867e3cc15dcee9f93 for pr-145838-1
[INFO] extracting crate ms-pdb-msf 0.1.4 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate ms-pdb-msf 0.1.4
[INFO] finished tweaking crates.io crate ms-pdb-msf 0.1.4
[INFO] tweaked toml for crates.io crate ms-pdb-msf 0.1.4 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate ms-pdb-msf 0.1.4 on toolchain cdb45c87e2cd43495379f7e867e3cc15dcee9f93
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate ms-pdb-msf 0.1.4 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded dbg-ranges v0.1.1
[INFO] [stderr]   Downloaded sync_file v0.2.9
[INFO] [stderr]   Downloaded pow2 v0.1.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 35c8db5b17899754466fd9fa177160674c7c56042a23f99b0969e1c3026b33e3
[INFO] running `Command { std: "docker" "start" "-a" "35c8db5b17899754466fd9fa177160674c7c56042a23f99b0969e1c3026b33e3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "35c8db5b17899754466fd9fa177160674c7c56042a23f99b0969e1c3026b33e3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "35c8db5b17899754466fd9fa177160674c7c56042a23f99b0969e1c3026b33e3", kill_on_drop: false }`
[INFO] [stdout] 35c8db5b17899754466fd9fa177160674c7c56042a23f99b0969e1c3026b33e3
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6a43780c11735f052d3b2b2b1d22ce1eac23fa38a2809f9542b0bc4d32b2471f
[INFO] running `Command { std: "docker" "start" "-a" "6a43780c11735f052d3b2b2b1d22ce1eac23fa38a2809f9542b0bc4d32b2471f", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.93
[INFO] [stderr]    Compiling unicode-ident v1.0.16
[INFO] [stderr]    Compiling radium v0.7.0
[INFO] [stderr]    Compiling tap v1.0.1
[INFO] [stderr]    Compiling anyhow v1.0.95
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling zerocopy v0.8.14
[INFO] [stderr]    Compiling funty v2.0.0
[INFO] [stderr]    Compiling static_assertions v1.1.0
[INFO] [stderr]    Compiling sync_file v0.2.9
[INFO] [stderr]    Compiling uuid v1.12.1
[INFO] [stderr]    Compiling tracing-core v0.1.33
[INFO] [stderr]    Compiling wyz v0.5.1
[INFO] [stderr]    Compiling zerocopy v0.7.35
[INFO] [stderr]    Compiling quote v1.0.38
[INFO] [stderr]    Compiling syn v2.0.96
[INFO] [stderr]    Compiling bitvec v1.0.1
[INFO] [stderr]    Compiling zerocopy-derive v0.8.14
[INFO] [stderr]    Compiling tracing-attributes v0.1.28
[INFO] [stderr]    Compiling zerocopy-derive v0.7.35
[INFO] [stderr]    Compiling pow2 v0.1.1
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling ms-pdb-msf v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 12.35s
[INFO] running `Command { std: "docker" "inspect" "6a43780c11735f052d3b2b2b1d22ce1eac23fa38a2809f9542b0bc4d32b2471f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6a43780c11735f052d3b2b2b1d22ce1eac23fa38a2809f9542b0bc4d32b2471f", kill_on_drop: false }`
[INFO] [stdout] 6a43780c11735f052d3b2b2b1d22ce1eac23fa38a2809f9542b0bc4d32b2471f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 57832d75c128f006383ec0e0836b19c404d88cd30533b258d96df8a7a2cfbf52
[INFO] running `Command { std: "docker" "start" "-a" "57832d75c128f006383ec0e0836b19c404d88cd30533b258d96df8a7a2cfbf52", kill_on_drop: false }`
[INFO] [stderr]    Compiling cfg_aliases v0.1.1
[INFO] [stderr]    Compiling syn v1.0.109
[INFO] [stderr]    Compiling libc v0.2.169
[INFO] [stderr]    Compiling log v0.4.25
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling pretty-hex v0.4.1
[INFO] [stderr]    Compiling dbg-ranges v0.1.1
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling static_init_macro v1.0.4
[INFO] [stderr]    Compiling static_init v1.0.3
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling tracing-subscriber v0.3.19
[INFO] [stderr]    Compiling ms-pdb-msf v0.1.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 8.65s
[INFO] running `Command { std: "docker" "inspect" "57832d75c128f006383ec0e0836b19c404d88cd30533b258d96df8a7a2cfbf52", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "57832d75c128f006383ec0e0836b19c404d88cd30533b258d96df8a7a2cfbf52", kill_on_drop: false }`
[INFO] [stdout] 57832d75c128f006383ec0e0836b19c404d88cd30533b258d96df8a7a2cfbf52
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/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=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+cdb45c87e2cd43495379f7e867e3cc15dcee9f93" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] aa3c131e8ee83b512164996c8e183220e8d167e736430ff6bfab1959686472aa
[INFO] running `Command { std: "docker" "start" "-a" "aa3c131e8ee83b512164996c8e183220e8d167e736430ff6bfab1959686472aa", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ms_pdb_msf-63082f080a206e24)
[INFO] [stdout] 
[INFO] [stdout] running 53 tests
[INFO] [stdout] test pages::test_page_mapper_nil ... ok
[INFO] [stdout] test pages::test_page_mapper_basic ... ok
[INFO] [stdout] test tests::page_size ... ok
[INFO] [stdout] test tests::msf_write_multi_streams ... ok
[INFO] [stdout] test tests::read_stream_dir_stream ... ok
[INFO] [stdout] test tests::read_nil_stream ... ok
[INFO] [stdout] test tests::read_stream_to_vec_mut_modified ... ok
[INFO] [stdout] test tests::read_stream_to_vec_mut_committed ... ok
[INFO] [stdout] test show_magics ... ok
[INFO] [stdout] test tests::stream_writer_flush ... ok
[INFO] [stdout] test tests::read_stream_to_box ... ok
[INFO] [stdout] test tests::empty_pdb ... ok
[INFO] [stdout] test tests::commit_no_writes ... ok
[INFO] [stdout] test tests::single_commit ... ok
[INFO] [stdout] test tests::stream_writer_set_contents_modifying_extending ... ok
[INFO] [stdout] test tests::commit_on_read_only ... ok
[INFO] [stdout] test tests::simple_multiple_streams ... ok
[INFO] [stdout] test tests::test_overwrite_aligned_start_single_page ... ok
[INFO] [stdout] test tests::read_stream_out_of_range ... ok
[INFO] [stdout] test tests::stream_writer_random_write_at ... ok
[INFO] [stdout] test tests::stream_writer_random_read_at ... ok
[INFO] [stdout] test tests::stream_writer_write_at ... ok
[INFO] [stdout] test tests::stream_writer_set_contents_new ... ok
[INFO] [stdout] test tests::test_overwrite_case_unaligned_extend_within_page ... ok
[INFO] [stdout] test tests::test_overwrite_case_unaligned_end ... ok
[INFO] [stdout] test tests::test_overwrite_unaligned_start_single_page ... ok
[INFO] [stdout] test tests::test_overwrite_case_zzz_1 ... ok
[INFO] [stdout] test tests::stream_writer_write_at_empty ... ok
[INFO] [stdout] test tests::test_overwrite_case_unaligned_extend_across_pages ... ok
[INFO] [stdout] test tests::test_write_hello_world ... ok
[INFO] [stdout] test tests::test_overwrite_case_zzz_2 ... ok
[INFO] [stdout] test tests::test_write_empty_stream ... ok
[INFO] [stdout] test tests::test_overwrite_case_zzz_3 ... ok
[INFO] [stdout] test tests::test_write_empty_buffer ... ok
[INFO] [stdout] test tests::test_zero_extend_unaligned_start_1 ... ok
[INFO] [stdout] test tests::multiple_commit ... ok
[INFO] [stdout] test tests::one_stream_hello_world ... ok
[INFO] [stdout] test tests::mix_and_match ... ok
[INFO] [stdout] test tests::test_zero_extend_unaligned_start_single_page ... ok
[INFO] [stdout] test tests::stream_writer_set_contents_modifying_shrinking ... ok
[INFO] [stdout] test tests::test_zero_extend_aligned_start_unaligned_end ... ok
[INFO] [stdout] test tests::test_overwrite_case_c ... ok
[INFO] [stdout] test write::test_find_longest_page_run ... ok
[INFO] [stdout] test tests::test_zero_extend_unaligned_start_cross_pages_unaligned_end ... ok
[INFO] [stdout] test tests::test_write_x ... ok
[INFO] [stdout] test tests::test_overwrite_case_many_pages ... ok
[INFO] [stdout] test tests::test_zero_extend_unaligned_start_cross_page_many ... ok
[INFO] [stdout] test tests::test_zero_extend_aligned_start_pages_unaligned_end ... ok
[INFO] [stdout] test tests::test_zero_extend_unaligned_start_cross_pages_aligned_end ... ok
[INFO] [stdout] test tests::test_write_simple ... ok
[INFO] [stdout] test tests::test_write_many_pieces ... ok
[INFO] [stdout] test tests::stream_writer_extend_large ... ok
[INFO] [stdout] test tests::many_commits ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 53 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.47s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "aa3c131e8ee83b512164996c8e183220e8d167e736430ff6bfab1959686472aa", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "aa3c131e8ee83b512164996c8e183220e8d167e736430ff6bfab1959686472aa", kill_on_drop: false }`
[INFO] [stdout] aa3c131e8ee83b512164996c8e183220e8d167e736430ff6bfab1959686472aa