[INFO] fetching crate proc-macro2 1.0.47...
[INFO] testing proc-macro2-1.0.47 against try#8dae881ac166f8debe04e17604ebbe2ab47083fd+target=i686-unknown-linux-musl for musl_upgrade_test
[INFO] extracting crate proc-macro2 1.0.47 into /workspace/builds/worker-5/source
[INFO] validating manifest of crates.io crate proc-macro2 1.0.47 on toolchain 8dae881ac166f8debe04e17604ebbe2ab47083fd
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8dae881ac166f8debe04e17604ebbe2ab47083fd" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate proc-macro2 1.0.47
[INFO] finished tweaking crates.io crate proc-macro2 1.0.47
[INFO] tweaked toml for crates.io crate proc-macro2 1.0.47 written to /workspace/builds/worker-5/source/Cargo.toml
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8dae881ac166f8debe04e17604ebbe2ab47083fd" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update", kill_on_drop: false }`
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+8dae881ac166f8debe04e17604ebbe2ab47083fd" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+8dae881ac166f8debe04e17604ebbe2ab47083fd" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] dff9e86d1b412158298989f88251b64357048e5e24a803ec94cd7112c0b89a9c
[INFO] running `Command { std: "docker" "start" "-a" "dff9e86d1b412158298989f88251b64357048e5e24a803ec94cd7112c0b89a9c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "dff9e86d1b412158298989f88251b64357048e5e24a803ec94cd7112c0b89a9c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dff9e86d1b412158298989f88251b64357048e5e24a803ec94cd7112c0b89a9c", kill_on_drop: false }`
[INFO] [stdout] dff9e86d1b412158298989f88251b64357048e5e24a803ec94cd7112c0b89a9c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+8dae881ac166f8debe04e17604ebbe2ab47083fd" "build" "--frozen" "--message-format=json" "--target" "i686-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 8a276b837c01bd31d403a9d71663526a3aa28bfa4455dd97bdaec43f426455a4
[INFO] running `Command { std: "docker" "start" "-a" "8a276b837c01bd31d403a9d71663526a3aa28bfa4455dd97bdaec43f426455a4", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.47 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling unicode-ident v1.0.5
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.50s
[INFO] running `Command { std: "docker" "inspect" "8a276b837c01bd31d403a9d71663526a3aa28bfa4455dd97bdaec43f426455a4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8a276b837c01bd31d403a9d71663526a3aa28bfa4455dd97bdaec43f426455a4", kill_on_drop: false }`
[INFO] [stdout] 8a276b837c01bd31d403a9d71663526a3aa28bfa4455dd97bdaec43f426455a4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+8dae881ac166f8debe04e17604ebbe2ab47083fd" "test" "--frozen" "--no-run" "--message-format=json" "--target" "i686-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 76232bea2c29b2e9ca33fc4193adea970b148353bc4130423966c115a82aa717
[INFO] running `Command { std: "docker" "start" "-a" "76232bea2c29b2e9ca33fc4193adea970b148353bc4130423966c115a82aa717", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.47
[INFO] [stderr]    Compiling quote v1.0.21
[INFO] [stderr]    Compiling proc-macro2 v1.0.47 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 2.51s
[INFO] running `Command { std: "docker" "inspect" "76232bea2c29b2e9ca33fc4193adea970b148353bc4130423966c115a82aa717", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "76232bea2c29b2e9ca33fc4193adea970b148353bc4130423966c115a82aa717", kill_on_drop: false }`
[INFO] [stdout] 76232bea2c29b2e9ca33fc4193adea970b148353bc4130423966c115a82aa717
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5/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:bb5b0feb4f87116a4ea905b7ff5bf5b85913db05e9f0fbc1abdd3168928d9075" "/opt/rustwide/cargo-home/bin/cargo" "+8dae881ac166f8debe04e17604ebbe2ab47083fd" "test" "--frozen" "--target" "i686-unknown-linux-musl", kill_on_drop: false }`
[INFO] [stdout] 836a38cd9e3d8d55c5e41cfed2bacad5797ea86d4589ae96d26dca1a3ecf6805
[INFO] running `Command { std: "docker" "start" "-a" "836a38cd9e3d8d55c5e41cfed2bacad5797ea86d4589ae96d26dca1a3ecf6805", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/proc_macro2-65392bbaf84806e1)
[INFO] [stdout] 
[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] [stderr]      Running tests/comments.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/comments-07581f6677b8ca7d)
[INFO] [stdout] 
[INFO] [stdout] running 4 tests
[INFO] [stderr]      Running tests/features.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/features-3f7a78b6884e178b)
[INFO] [stdout] test closed_immediately ... ok
[INFO] [stdout] test carriage_return ... ok
[INFO] [stdout] test incomplete ... ok
[INFO] [stdout] test lit ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test make_sure_no_proc_macro ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/marker.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/marker-5c7ec2537677bdd3)
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test Delimiter ... ok
[INFO] [stdout] test Group ... ok
[INFO] [stdout] test Ident ... ok
[INFO] [stdout] test LexError ... ok
[INFO] [stdout] test Literal ... ok
[INFO] [stdout] test Punct ... ok
[INFO] [stdout] test Spacing ... ok
[INFO] [stdout] test Span ... ok
[INFO] [stdout] test TokenStream ... ok
[INFO] [stdout] test TokenTree ... ok
[INFO] [stdout] test unwind_safe::Delimiter ... ok
[INFO] [stdout] test unwind_safe::Group ... ok
[INFO] [stdout] test unwind_safe::Ident ... ok
[INFO] [stdout] test unwind_safe::LexError ... ok
[INFO] [stdout] test unwind_safe::Literal ... ok
[INFO] [stdout] test unwind_safe::Punct ... ok
[INFO] [stdout] test unwind_safe::Spacing ... ok
[INFO] [stdout] test unwind_safe::Span ... ok
[INFO] [stdout] test unwind_safe::TokenStream ... ok
[INFO] [stdout] test unwind_safe::TokenTree ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/test-31608451418cc4c8)
[INFO] [stdout] 
[INFO] [stdout] running 34 tests
[INFO] [stdout] test default_tokenstream_is_empty ... ok
[INFO] [stdout] test byte_order_mark ... ok
[INFO] [stdout] test fail ... ok
[INFO] [stdout] test joint_last_token ... ok
[INFO] [stdout] test idents ... ok
[INFO] [stdout] test literal_byte_string ... ok
[INFO] [stdout] test literal_character ... ok
[INFO] [stdout] test literal_float ... ok
[INFO] [stdout] test literal_integer ... ok
[INFO] [stdout] test literal_iter_negative ... ok
[INFO] [stdout] test literal_parse ... ok
[INFO] [stdout] test literal_raw_string ... ok
[INFO] [stdout] test literal_string ... ok
[INFO] [stdout] test literal_suffix ... ok
[INFO] [stdout] test no_panic ... ok
[INFO] [stdout] test punct_before_comment ... ok
[INFO] [stdout] test raw_identifier ... ok
[INFO] [stdout] test raw_idents ... ok
[INFO] [stdout] test test_debug_ident ... ok
[INFO] [stdout] test test_debug_tokenstream ... ok
[INFO] [stdout] test roundtrip ... ok
[INFO] [stdout] test tokenstream_size_hint ... ok
[INFO] [stdout] test tuple_indexing ... ok
[INFO] [stdout] test ident_empty - should panic ... ok
[INFO] [stdout] test ident_invalid - should panic ... ok
[INFO] [stdout] test ident_number - should panic ... ok
[INFO] [stdout] test ident_raw_reserved - should panic ... ok
[INFO] [stdout] test ident_raw_underscore - should panic ... ok
[INFO] [stdout] test lifetime_empty - should panic ... ok
[INFO] [stdout] test lifetime_invalid ... ok
[INFO] [stdout] test lifetime_number - should panic ... ok
[INFO] [stdout] test raw_ident_empty - should panic ... ok
[INFO] [stdout] test raw_ident_invalid - should panic ... ok
[INFO] [stdout] test raw_ident_number - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 34 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/test_fmt.rs (/opt/rustwide/target/i686-unknown-linux-musl/debug/deps/test_fmt-f56ec0d55684cde5)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test test_fmt_group ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "836a38cd9e3d8d55c5e41cfed2bacad5797ea86d4589ae96d26dca1a3ecf6805", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "836a38cd9e3d8d55c5e41cfed2bacad5797ea86d4589ae96d26dca1a3ecf6805", kill_on_drop: false }`
[INFO] [stdout] 836a38cd9e3d8d55c5e41cfed2bacad5797ea86d4589ae96d26dca1a3ecf6805