[INFO] fetching crate pipecolor 0.4.2...
[INFO] testing pipecolor-0.4.2 against 1.69.0 for beta-1.70-1
[INFO] extracting crate pipecolor 0.4.2 into /workspace/builds/worker-4-tc1/source
[INFO] validating manifest of crates.io crate pipecolor 0.4.2 on toolchain 1.69.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.69.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate pipecolor 0.4.2
[INFO] finished tweaking crates.io crate pipecolor 0.4.2
[INFO] tweaked toml for crates.io crate pipecolor 0.4.2 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] crate crates.io crate pipecolor 0.4.2 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" "+1.69.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded cc v1.0.47
[INFO] [stderr]   Downloaded blake2b_simd v0.5.9
[INFO] [stderr]   Downloaded nix v0.10.0
[INFO] [stderr]   Downloaded ucd-util v0.1.5
[INFO] [stderr]   Downloaded timeout-readwrite v0.1.0
[INFO] [stderr]   Downloaded proc-reader v0.4.0
[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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] def7ac59d1d6161cfee47a65c1d2027a3a2be67e1826c3d32029e41f4a6b1345
[INFO] running `Command { std: "docker" "start" "-a" "def7ac59d1d6161cfee47a65c1d2027a3a2be67e1826c3d32029e41f4a6b1345", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "def7ac59d1d6161cfee47a65c1d2027a3a2be67e1826c3d32029e41f4a6b1345", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "def7ac59d1d6161cfee47a65c1d2027a3a2be67e1826c3d32029e41f4a6b1345", kill_on_drop: false }`
[INFO] [stdout] def7ac59d1d6161cfee47a65c1d2027a3a2be67e1826c3d32029e41f4a6b1345
[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=warn" "-e" "RUSTDOCFLAGS=--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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 132cb9667470047100179a9ffe0347a9aa6d4ec0f73e0c80963f2d7bc95a2430
[INFO] running `Command { std: "docker" "start" "-a" "132cb9667470047100179a9ffe0347a9aa6d4ec0f73e0c80963f2d7bc95a2430", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.65
[INFO] [stderr]    Compiling cfg-if v0.1.10
[INFO] [stderr]    Compiling cc v1.0.47
[INFO] [stderr]    Compiling proc-macro2 v1.0.6
[INFO] [stderr]    Compiling serde v1.0.102
[INFO] [stderr]    Compiling unicode-xid v0.2.0
[INFO] [stderr]    Compiling rustc-demangle v0.1.16
[INFO] [stderr]    Compiling syn v1.0.8
[INFO] [stderr]    Compiling ryu v1.0.2
[INFO] [stderr]    Compiling semver-parser v0.7.0
[INFO] [stderr]    Compiling pulldown-cmark v0.2.0
[INFO] [stderr]    Compiling proc-macro2 v0.4.30
[INFO] [stderr]    Compiling itoa v0.4.4
[INFO] [stderr]    Compiling same-file v1.0.5
[INFO] [stderr]    Compiling error-chain v0.12.1
[INFO] [stderr]    Compiling byteorder v1.3.2
[INFO] [stderr]    Compiling remove_dir_all v0.5.2
[INFO] [stderr]    Compiling memchr v2.2.1
[INFO] [stderr]    Compiling walkdir v2.2.9
[INFO] [stderr]    Compiling bytecount v0.4.0
[INFO] [stderr]    Compiling glob v0.2.11
[INFO] [stderr]    Compiling void v1.0.2
[INFO] [stderr]    Compiling unicode-segmentation v1.6.0
[INFO] [stderr]    Compiling unicode-width v0.1.6
[INFO] [stderr]    Compiling nix v0.10.0
[INFO] [stderr]    Compiling ucd-util v0.1.5
[INFO] [stderr]    Compiling textwrap v0.11.0
[INFO] [stderr]    Compiling vec_map v0.8.1
[INFO] [stderr]    Compiling bitflags v0.9.1
[INFO] [stderr]    Compiling regex v0.2.11
[INFO] [stderr]    Compiling thread_local v0.3.6
[INFO] [stderr]    Compiling regex-syntax v0.5.6
[INFO] [stderr]    Compiling numtoa v0.1.0
[INFO] [stderr]    Compiling utf8-ranges v1.0.4
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling quote v0.6.13
[INFO] [stderr]    Compiling quote v1.0.2
[INFO] [stderr]    Compiling rand v0.4.6
[INFO] [stderr]    Compiling iovec v0.1.4
[INFO] [stderr]    Compiling backtrace-sys v0.1.32
[INFO] [stderr]    Compiling atty v0.2.13
[INFO] [stderr]    Compiling dirs-sys v0.3.4
[INFO] [stderr]    Compiling nix v0.9.0
[INFO] [stderr]    Compiling aho-corasick v0.6.10
[INFO] [stderr]    Compiling termion v1.5.3
[INFO] [stderr]    Compiling bytes v0.4.12
[INFO] [stderr]    Compiling syn v0.15.44
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling dirs v2.0.2
[INFO] [stderr]    Compiling tempdir v0.3.7
[INFO] [stderr]    Compiling backtrace v0.3.40
[INFO] [stderr]    Compiling error-chain v0.11.0
[INFO] [stderr]    Compiling timeout-readwrite v0.1.0
[INFO] [stderr]    Compiling structopt-derive v0.2.18
[INFO] [stderr]    Compiling structopt v0.2.18
[INFO] [stderr]    Compiling semver v0.9.0
[INFO] [stderr]    Compiling serde_json v1.0.41
[INFO] [stderr]    Compiling toml v0.4.10
[INFO] [stderr]    Compiling serde_derive v1.0.102
[INFO] [stderr]    Compiling cargo_metadata v0.6.4
[INFO] [stderr]    Compiling skeptic v0.13.4
[INFO] [stderr]    Compiling proc-reader v0.4.0
[INFO] [stderr]    Compiling pipecolor v0.4.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated method `std::error::Error::description`: use the Display impl or to_string()
[INFO] [stdout]   --> src/main.rs:88:1
[INFO] [stdout]    |
[INFO] [stdout] 88 | / error_chain! {
[INFO] [stdout] 89 | |     links {
[INFO] [stdout] 90 | |         Colorize(crate::colorize::Error, crate::colorize::ErrorKind);
[INFO] [stdout] 91 | |     }
[INFO] [stdout] ...  |
[INFO] [stdout] 95 | |     }
[INFO] [stdout] 96 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(deprecated)]` on by default
[INFO] [stdout]    = note: this warning originates in the macro `impl_error_chain_processed` which comes from the expansion of the macro `error_chain` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.54s
[INFO] running `Command { std: "docker" "inspect" "132cb9667470047100179a9ffe0347a9aa6d4ec0f73e0c80963f2d7bc95a2430", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "132cb9667470047100179a9ffe0347a9aa6d4ec0f73e0c80963f2d7bc95a2430", kill_on_drop: false }`
[INFO] [stdout] 132cb9667470047100179a9ffe0347a9aa6d4ec0f73e0c80963f2d7bc95a2430
[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=warn" "-e" "RUSTDOCFLAGS=--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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1cc577c8951ca0776e2f5098d63b320be49c2f8d7f7500f3cd6ac9c86c8374d2
[INFO] running `Command { std: "docker" "start" "-a" "1cc577c8951ca0776e2f5098d63b320be49c2f8d7f7500f3cd6ac9c86c8374d2", kill_on_drop: false }`
[INFO] [stderr]    Compiling pipecolor v0.4.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated method `std::error::Error::description`: use the Display impl or to_string()
[INFO] [stdout]   --> src/main.rs:88:1
[INFO] [stdout]    |
[INFO] [stdout] 88 | / error_chain! {
[INFO] [stdout] 89 | |     links {
[INFO] [stdout] 90 | |         Colorize(crate::colorize::Error, crate::colorize::ErrorKind);
[INFO] [stdout] 91 | |     }
[INFO] [stdout] ...  |
[INFO] [stdout] 95 | |     }
[INFO] [stdout] 96 | | }
[INFO] [stdout]    | |_^
[INFO] [stdout]    |
[INFO] [stdout]    = note: `#[warn(deprecated)]` on by default
[INFO] [stdout]    = note: this warning originates in the macro `impl_error_chain_processed` which comes from the expansion of the macro `error_chain` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 1 warning emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 1.70s
[INFO] running `Command { std: "docker" "inspect" "1cc577c8951ca0776e2f5098d63b320be49c2f8d7f7500f3cd6ac9c86c8374d2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1cc577c8951ca0776e2f5098d63b320be49c2f8d7f7500f3cd6ac9c86c8374d2", kill_on_drop: false }`
[INFO] [stdout] 1cc577c8951ca0776e2f5098d63b320be49c2f8d7f7500f3cd6ac9c86c8374d2
[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=warn" "-e" "RUSTDOCFLAGS=--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:5ff2268d62e97bff2cde7d5815dd6ed5b47097566f13b8d0ca110b04b60e07ed" "/opt/rustwide/cargo-home/bin/cargo" "+1.69.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 7cb0e8a507f08a4dd7f512a7cd5b51d8e9de2a84634d60cd1055ab8ad66ddae1
[INFO] running `Command { std: "docker" "start" "-a" "7cb0e8a507f08a4dd7f512a7cd5b51d8e9de2a84634d60cd1055ab8ad66ddae1", kill_on_drop: false }`
[INFO] [stderr] warning: use of deprecated method `std::error::Error::description`: use the Display impl or to_string()
[INFO] [stderr]   --> src/main.rs:88:1
[INFO] [stderr]    |
[INFO] [stderr] 88 | / error_chain! {
[INFO] [stderr] 89 | |     links {
[INFO] [stderr] 90 | |         Colorize(crate::colorize::Error, crate::colorize::ErrorKind);
[INFO] [stderr] 91 | |     }
[INFO] [stderr] ...  |
[INFO] [stderr] 95 | |     }
[INFO] [stderr] 96 | | }
[INFO] [stderr]    | |_^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(deprecated)]` on by default
[INFO] [stderr]    = note: this warning originates in the macro `impl_error_chain_processed` which comes from the expansion of the macro `error_chain` (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: `pipecolor` (bin "pipecolor" test) generated 1 warning
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/pipecolor-a6ce064582539506)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test tests::test_read_config_fail ... ok
[INFO] [stdout] [38;5;7m[38;5;10mxxx.xxx.xx.xxx[38;5;7m - - [[38;5;12m25/Mar/2018:04:20:54 +0900[38;5;7m] "[38;5;14mGET[38;5;7m /index.html HTTP/1.1" 302 278 "-" "[38;5;2mMozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)[38;5;7m"[39m
[INFO] [stdout] [38;5;7m[38;5;10mxxx.xx.xx.xx[38;5;7m - - [[38;5;12m25/Mar/2018:04:23:20 +0900[38;5;7m] "[38;5;13mHEAD[38;5;7m / HTTP/1.1" 302 - "https://xxx.xxx" "[38;5;2mMozilla/5.0 (compatible; MSIE 9.0; Windows NT 6.1; WOW64; Trident/5.0)[38;5;7m"[39m
[INFO] [stdout] [38;5;7m[38;5;10mxxx.xxx.xx.xx[38;5;7m - - [[38;5;12m25/Mar/2018:12:14:55 +0900[38;5;7m] "[38;5;11mPOST[38;5;7m /xxx.php HTTP/1.1" 302 281 "-" "[38;5;2mMozilla/5.0 (Windows NT 6.1; rv:34.0) Gecko/20100101 Firefox/34.0[38;5;7m"[39m
[INFO] [stdout] [38;5;7m[38;5;10mxx.xxx.xxx.xxx[38;5;7m - - [[38;5;12m25/Mar/2018:14:12:13 +0900[38;5;7m] "[38;5;14mGET[38;5;7m / HTTP/1.1" 302 278 "-" "[38;5;2mMozilla/5.0 (Macintosh; Intel Mac OS X 10_12_0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36[38;5;7m"[39m
[INFO] [stdout] [38;5;7m[38;5;10mxxx.xxx.xx.xxx[38;5;7m - - [[38;5;12m25/Mar/2018:14:13:04 +0900[38;5;7m] "[38;5;14mGET[38;5;7m /index.html HTTP/1.1" 302 278 "-" "[38;5;2mMozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)[38;5;7m"[39m
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:04:20:54 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] [38;5;7m[38;5;10mxxx.xxx.xx.xxx[38;5;7m - - [[38;5;12m25/Mar/2018:14:13:04 +0900[38;5;7m] "[38;5;14mGET[38;5;7m /index.html HTTP/1.1" 302 278 "-" "[38;5;2mMozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)[38;5;7m"[39m
[INFO] [stdout] xxx.xx.xx.xx - - [25/Mar/2018:04:23:20 +0900] "HEAD / HTTP/1.1" 302 - "https://xxx.xxx" "Mozilla/5.0 (compatible; MSIE 9.0; Windows NT 6.1; WOW64; Trident/5.0)"
[INFO] [stdout] xxx.xxx.xx.xx - - [25/Mar/2018:12:14:55 +0900] "POST /xxx.php HTTP/1.1" 302 281 "-" "Mozilla/5.0 (Windows NT 6.1; rv:34.0) Gecko/20100101 Firefox/34.0"
[INFO] [stdout] xx.xxx.xxx.xxx - - [25/Mar/2018:14:12:13 +0900] "GET / HTTP/1.1" 302 278 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_12_0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:13:04 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:13:04 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:15:59 +0900] "GET /en/index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (iPad; CPU OS 11_2_6 like Mac OS X) AppleWebKit/604.5.6 (KHTML, like Gecko) Version/11.0 Mobile/15D100 Safari/604.1"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:18:36 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:18:36 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:24:05 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] Mar 25 04:17:30 xxx postfix/smtpd[19644]: connect from example.com[xxx.xxx.xx.xxx]
[INFO] [stdout] Mar 25 04:17:30 xxx postfix/smtpd[19644]: SSL_accept error from example.com[xxx.xxx.xx.xxx]: -1
[INFO] [stdout] Mar 25 04:17:30 xxx postfix/smtpd[19644]: lost connection after STARTTLS from example.com[xxx.xxx.xx.xxx]
[INFO] [stdout] Mar 25 04:17:30 xxx postfix/smtpd[19644]: disconnect from example.com[xxx.xxx.xx.xxx]
[INFO] [stdout] Mar 25 04:17:31 xxx dovecot: imap-login: Disconnected: rip=xxx.xxx.xx.xxx, lip=xxx.xx.xxx.xxx
[INFO] [stdout] Mar 25 04:17:45 xxx postfix/smtpd[19644]: connect from example.com[xxx.xxx.xx.xxx]
[INFO] [stdout] Mar 25 04:17:45 xxx postfix/smtpd[19644]: SSL_accept error from example.com[xxx.xxx.xx.xxx]: -1
[INFO] [stdout] Mar 25 04:17:45 xxx postfix/smtpd[19644]: lost connection after STARTTLS from example.com[xxx.xxx.xx.xxx]
[INFO] [stdout] Mar 25 04:17:45 xxx postfix/smtpd[19644]: disconnect from example.com[xxx.xxx.xx.xxx]
[INFO] [stdout] Mar 25 04:17:46 xxx dovecot: imap-login: Login: user=<xxx>, method=PLAIN, rip=xxx.xxx.xx.xx, lip=xxx.xx.xxx.xxx, TLS
[INFO] [stdout] Mar 25 04:17:46 xxx dovecot: imap-login: Disconnected: rip=xxx.xxx.xx.xxx, lip=xxx.xx.xxx.xxx
[INFO] [stdout] Mar 25 04:17:46 xxx dovecot: IMAP(xxx): Connection closed
[INFO] [stdout] Mar 25 04:18:00 xxx postfix/smtpd[19644]: connect from example.com[xxx.xxx.xx.xxx]
[INFO] [stdout] Mar 25 04:18:00 xxx postfix/smtpd[19644]: SSL_accept error from example.com[xxx.xxx.xx.xxx]: -1
[INFO] [stdout] Mar 25 04:18:00 xxx postfix/smtpd[19644]: lost connection after STARTTLS from example.com[xxx.xxx.xx.xxx]
[INFO] [stdout] Mar 25 04:18:00 xxx postfix/smtpd[19644]: disconnect from example.com[xxx.xxx.xx.xxx]
[INFO] [stdout] Mar 25 04:18:01 xxx dovecot: imap-login: Disconnected: rip=xxx.xxx.xx.xxx, lip=xxx.xx.xxx.xxx
[INFO] [stdout] Mar 25 04:18:04 xxx dovecot: pop3-login: Login: user=<xxx>, method=PLAIN, rip=xxx.xx.xxx.xx, lip=xxx.xx.xxx.xxx
[INFO] [stdout] Mar 25 04:18:04 xxx dovecot: pop3-login: Login: user=<xxx>, method=PLAIN, rip=xxx.xxx.xx.xxx, lip=xxx.xx.xxx.xxx, TLS
[INFO] [stdout] Mar 25 04:18:04 xxx dovecot: POP3(xxx): Disconnected: Logged out top=0/0, retr=0/0, del=0/582, size=97911928
[INFO] [stdout] [38;5;7m[38;5;10mxxx.xxx.xx.xxx[38;5;7m - - [[38;5;12m25/Mar/2018:14:15:59 +0900[38;5;7m] "[38;5;14mGET[38;5;7m /en/index.html HTTP/1.1" 302 278 "-" "[38;5;2mMozilla/5.0 (iPad; CPU OS 11_2_6 like Mac OS X) AppleWebKit/604.5.6 (KHTML, like Gecko) Version/11.0 Mobile/15D100 Safari/604.1[38;5;7m"[39m
[INFO] [stdout] [38;5;7m[38;5;10mxxx.xxx.xx.xxx[38;5;7m - - [[38;5;12m25/Mar/2018:14:18:36 +0900[38;5;7m] "[38;5;14mGET[38;5;7m /index.html HTTP/1.1" 302 278 "-" "[38;5;2mMozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)[38;5;7m"[39m
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:04:20:54 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xx.xx.xx - - [25/Mar/2018:04:23:20 +0900] "HEAD / HTTP/1.1" 302 - "https://xxx.xxx" "Mozilla/5.0 (compatible; MSIE 9.0; Windows NT 6.1; WOW64; Trident/5.0)"
[INFO] [stdout] xxx.xxx.xx.xx - - [25/Mar/2018:12:14:55 +0900] "POST /xxx.php HTTP/1.1" 302 281 "-" "Mozilla/5.0 (Windows NT 6.1; rv:34.0) Gecko/20100101 Firefox/34.0"
[INFO] [stdout] xx.xxx.xxx.xxx - - [25/Mar/2018:14:12:13 +0900] "GET / HTTP/1.1" 302 278 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_12_0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:13:04 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:13:04 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:15:59 +0900] "GET /en/index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (iPad; CPU OS 11_2_6 like Mac OS X) AppleWebKit/604.5.6 (KHTML, like Gecko) Version/11.0 Mobile/15D100 Safari/604.1"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:18:36 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:18:36 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:24:05 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] test tests::test_run ... ok
[INFO] [stdout] [38;5;7m[38;5;10mxxx.xxx.xx.xxx[38;5;7m - - [[38;5;12m25/Mar/2018:14:18:36 +0900[38;5;7m] "[38;5;14mGET[38;5;7m /index.html HTTP/1.1" 302 278 "-" "[38;5;2mMozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)[38;5;7m"[39m
[INFO] [stdout] test tests::test_verbose ... ok
[INFO] [stdout] [38;5;7m[38;5;10mxxx.xxx.xx.xxx[38;5;7m - - [[38;5;12m25/Mar/2018:14:24:05 +0900[38;5;7m] "[38;5;14mGET[38;5;7m /index.html HTTP/1.1" 302 278 "-" "[38;5;2mMozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)[38;5;7m"[39m
[INFO] [stdout] test colorize::tests::test_colorize ... ok
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:04:20:54 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xx.xx.xx - - [25/Mar/2018:04:23:20 +0900] "HEAD / HTTP/1.1" 302 - "https://xxx.xxx" "Mozilla/5.0 (compatible; MSIE 9.0; Windows NT 6.1; WOW64; Trident/5.0)"
[INFO] [stdout] xxx.xxx.xx.xx - - [25/Mar/2018:12:14:55 +0900] "POST /xxx.php HTTP/1.1" 302 281 "-" "Mozilla/5.0 (Windows NT 6.1; rv:34.0) Gecko/20100101 Firefox/34.0"
[INFO] [stdout] xx.xxx.xxx.xxx - - [25/Mar/2018:14:12:13 +0900] "GET / HTTP/1.1" 302 278 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_12_0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:13:04 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:13:04 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:15:59 +0900] "GET /en/index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (iPad; CPU OS 11_2_6 like Mac OS X) AppleWebKit/604.5.6 (KHTML, like Gecko) Version/11.0 Mobile/15D100 Safari/604.1"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:18:36 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:18:36 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:24:05 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:04:20:54 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xx.xx.xx - - [25/Mar/2018:04:23:20 +0900] "HEAD / HTTP/1.1" 302 - "https://xxx.xxx" "Mozilla/5.0 (compatible; MSIE 9.0; Windows NT 6.1; WOW64; Trident/5.0)"
[INFO] [stdout] xxx.xxx.xx.xx - - [25/Mar/2018:12:14:55 +0900] "POST /xxx.php HTTP/1.1" 302 281 "-" "Mozilla/5.0 (Windows NT 6.1; rv:34.0) Gecko/20100101 Firefox/34.0"
[INFO] [stdout] xx.xxx.xxx.xxx - - [25/Mar/2018:14:12:13 +0900] "GET / HTTP/1.1" 302 278 "-" "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_12_0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/53.0.2785.143 Safari/537.36"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:13:04 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:13:04 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:15:59 +0900] "GET /en/index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (iPad; CPU OS 11_2_6 like Mac OS X) AppleWebKit/604.5.6 (KHTML, like Gecko) Version/11.0 Mobile/15D100 Safari/604.1"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:18:36 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:18:36 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] xxx.xxx.xx.xxx - - [25/Mar/2018:14:24:05 +0900] "GET /index.html HTTP/1.1" 302 278 "-" "Mozilla/5.0 (compatible; MSIE 10.0; Windows NT 6.1; Trident/6.0)"
[INFO] [stdout] test tests::test_mode ... ok
[INFO] [stdout] test colorize::tests::test_colorize_fail ... FAILED
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- colorize::tests::test_colorize_fail stdout ----
[INFO] [stdout] thread 'colorize::tests::test_colorize_fail' panicked at 'assertion failed: `(left == right)`
[INFO] [stdout]   left: `"Err(Error(Msg(\"failed to parse color name 'xxx'\"),"`,
[INFO] [stdout]  right: `"Err(Error(Msg(\"failed to parse color name \\'xxx\\'\""`', src/colorize.rs:246:9
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0:     0x55cb56ffe7fa - std::backtrace_rs::backtrace::libunwind::trace::ha9053a9a07ca49cb
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/../../backtrace/src/backtrace/libunwind.rs:93:5
[INFO] [stdout]    1:     0x55cb56ffe7fa - std::backtrace_rs::backtrace::trace_unsynchronized::h9c2852a457ad564e
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/../../backtrace/src/backtrace/mod.rs:66:5
[INFO] [stdout]    2:     0x55cb56ffe7fa - std::sys_common::backtrace::_print_fmt::h457936fbfaa0070f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:65:5
[INFO] [stdout]    3:     0x55cb56ffe7fa - <std::sys_common::backtrace::_print::DisplayBacktrace as core::fmt::Display>::fmt::h5779d7bf7f70cb0c
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:44:22
[INFO] [stdout]    4:     0x55cb5702366e - core::fmt::write::h5a4baaff1bcd3eb5
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/fmt/mod.rs:1232:17
[INFO] [stdout]    5:     0x55cb56ffb7e5 - std::io::Write::write_fmt::h478f79c628ef31d1
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/io/mod.rs:1684:15
[INFO] [stdout]    6:     0x55cb56ffe5c5 - std::sys_common::backtrace::_print::h5fcdc36060f177e8
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:47:5
[INFO] [stdout]    7:     0x55cb56ffe5c5 - std::sys_common::backtrace::print::h54ca9458b876c8bf
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:34:9
[INFO] [stdout]    8:     0x55cb5700038f - std::panicking::default_hook::{{closure}}::hbe471161c7664ed6
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:271:22
[INFO] [stdout]    9:     0x55cb5700004f - std::panicking::default_hook::ha3500da57aa4ac4f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:287:9
[INFO] [stdout]   10:     0x55cb56d22757 - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::hdf1b89dd137ece34
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:2001:9
[INFO] [stdout]   11:     0x55cb56d22757 - test::test_main::{{closure}}::h9081a79f20e75698
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:135:21
[INFO] [stdout]   12:     0x55cb57000abd - <alloc::boxed::Box<F,A> as core::ops::function::Fn<Args>>::call::h6507bddc3eebb4a5
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:2001:9
[INFO] [stdout]   13:     0x55cb57000abd - std::panicking::rust_panic_with_hook::h50c09d000dc561d2
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:696:13
[INFO] [stdout]   14:     0x55cb57000839 - std::panicking::begin_panic_handler::{{closure}}::h9e2b2176e00e0d9c
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:583:13
[INFO] [stdout]   15:     0x55cb56ffec66 - std::sys_common::backtrace::__rust_end_short_backtrace::h5739b8e512c09d02
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:150:18
[INFO] [stdout]   16:     0x55cb57000542 - rust_begin_unwind
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:579:5
[INFO] [stdout]   17:     0x55cb56c8a4d3 - core::panicking::panic_fmt::hf33a1475b4dc5c3e
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/panicking.rs:64:14
[INFO] [stdout]   18:     0x55cb56c8a7af - core::panicking::assert_failed_inner::haf9816227b20b6f2
[INFO] [stdout]   19:     0x55cb56caedca - core::panicking::assert_failed::hf4a571cf7f7b606d
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/panicking.rs:211:5
[INFO] [stdout]   20:     0x55cb56cc13c8 - pipecolor::colorize::tests::test_colorize_fail::h38c2d3a00c42ac47
[INFO] [stdout]                                at /opt/rustwide/workdir/src/colorize.rs:246:9
[INFO] [stdout]   21:     0x55cb56cc1137 - pipecolor::colorize::tests::test_colorize_fail::{{closure}}::h71ee90c4b08942b2
[INFO] [stdout]                                at /opt/rustwide/workdir/src/colorize.rs:243:29
[INFO] [stdout]   22:     0x55cb56cb6a35 - core::ops::function::FnOnce::call_once::h24778ff94d2535ab
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   23:     0x55cb56d27b3f - core::ops::function::FnOnce::call_once::h7d969581be7d0075
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   24:     0x55cb56d27b3f - test::__rust_begin_short_backtrace::hca25a52684e56655
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:656:18
[INFO] [stdout]   25:     0x55cb56cf915c - test::run_test::{{closure}}::ha8ac744c4af1a4bb
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:647:30
[INFO] [stdout]   26:     0x55cb56cf915c - core::ops::function::FnOnce::call_once{{vtable.shim}}::h7b411a9ed45bdecf
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   27:     0x55cb56d26b06 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::hd05328869a8ed200
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:1987:9
[INFO] [stdout]   28:     0x55cb56d26b06 - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h0c601ce20bd5b2be
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   29:     0x55cb56d26b06 - std::panicking::try::do_call::ha4be5c164fe30854
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:487:40
[INFO] [stdout]   30:     0x55cb56d26b06 - std::panicking::try::h604546f3609af05f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:451:19
[INFO] [stdout]   31:     0x55cb56d26b06 - std::panic::catch_unwind::h5bfa8afe44c9c2f9
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panic.rs:140:14
[INFO] [stdout]   32:     0x55cb56d26b06 - test::run_test_in_process::hd50dee55dd63e6aa
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:679:27
[INFO] [stdout]   33:     0x55cb56d26b06 - test::run_test::run_test_inner::{{closure}}::h4aa0f433aa85cea8
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:573:39
[INFO] [stdout]   34:     0x55cb56cf37d1 - test::run_test::run_test_inner::{{closure}}::had56431adf24b4d6
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/test/src/lib.rs:600:37
[INFO] [stdout]   35:     0x55cb56cf37d1 - std::sys_common::backtrace::__rust_begin_short_backtrace::ha8d9890e0c73bf13
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys_common/backtrace.rs:134:18
[INFO] [stdout]   36:     0x55cb56cf91eb - std::thread::Builder::spawn_unchecked_::{{closure}}::{{closure}}::h251832bcb4a95327
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/thread/mod.rs:560:17
[INFO] [stdout]   37:     0x55cb56cf91eb - <core::panic::unwind_safe::AssertUnwindSafe<F> as core::ops::function::FnOnce<()>>::call_once::h8fdff598fa414831
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/panic/unwind_safe.rs:271:9
[INFO] [stdout]   38:     0x55cb56cf91eb - std::panicking::try::do_call::h455dd2f7764a950f
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:487:40
[INFO] [stdout]   39:     0x55cb56cf91eb - std::panicking::try::had6f23b7b73ae72a
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panicking.rs:451:19
[INFO] [stdout]   40:     0x55cb56cf91eb - std::panic::catch_unwind::ha6a5ca3915b4dad0
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/panic.rs:140:14
[INFO] [stdout]   41:     0x55cb56cf91eb - std::thread::Builder::spawn_unchecked_::{{closure}}::h883b72ef75da6231
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/thread/mod.rs:559:30
[INFO] [stdout]   42:     0x55cb56cf91eb - core::ops::function::FnOnce::call_once{{vtable.shim}}::hb7dff73dc8bd2ccb
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/core/src/ops/function.rs:250:5
[INFO] [stdout]   43:     0x55cb57004e63 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h39990b24eedef2ab
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:1987:9
[INFO] [stdout]   44:     0x55cb57004e63 - <alloc::boxed::Box<F,A> as core::ops::function::FnOnce<Args>>::call_once::h01a027258444143b
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/alloc/src/boxed.rs:1987:9
[INFO] [stdout]   45:     0x55cb57004e63 - std::sys::unix::thread::Thread::new::thread_start::ha4f1cdd9c25884ba
[INFO] [stdout]                                at /rustc/84c898d65adf2f39a5a98507f1fe0ce10a2b8dbc/library/std/src/sys/unix/thread.rs:108:17
[INFO] [stdout]   46:     0x7f6d78cffb43 - <unknown>
[INFO] [stdout]   47:     0x7f6d78d90bb4 - __clone
[INFO] [stdout]   48:                0x0 - <unknown>
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     colorize::tests::test_colorize_fail
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 5 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.25s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--bin pipecolor`
[INFO] running `Command { std: "docker" "inspect" "7cb0e8a507f08a4dd7f512a7cd5b51d8e9de2a84634d60cd1055ab8ad66ddae1", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7cb0e8a507f08a4dd7f512a7cd5b51d8e9de2a84634d60cd1055ab8ad66ddae1", kill_on_drop: false }`
[INFO] [stdout] 7cb0e8a507f08a4dd7f512a7cd5b51d8e9de2a84634d60cd1055ab8ad66ddae1
