[INFO] fetching crate pipecolor 0.4.2...
[INFO] testing pipecolor-0.4.2 against try#eafdee2dfae8c2233b74f98b123308be7ccefcc6 for pr-79296
[INFO] extracting crate pipecolor 0.4.2 into /workspace/builds/worker-7/source
[INFO] validating manifest of crates.io crate pipecolor 0.4.2 on toolchain eafdee2dfae8c2233b74f98b123308be7ccefcc6
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "read-manifest" "--manifest-path" "Cargo.toml", 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-7/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: "/workspace/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "fetch" "--locked" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded toml v0.4.10
[INFO] [stderr]   Downloaded ucd-util v0.1.5
[INFO] [stderr]   Downloaded termion v1.5.3
[INFO] [stderr]   Downloaded proc-macro2 v1.0.6
[INFO] [stderr]   Downloaded blake2b_simd v0.5.9
[INFO] [stderr]   Downloaded failure_derive v0.1.6
[INFO] [stderr]   Downloaded itoa v0.4.4
[INFO] [stderr]   Downloaded nix v0.9.0
[INFO] [stderr]   Downloaded synstructure v0.12.3
[INFO] [stderr]   Downloaded serde v1.0.102
[INFO] [stderr]   Downloaded backtrace v0.3.40
[INFO] [stderr]   Downloaded nix v0.10.0
[INFO] [stderr]   Downloaded failure v0.1.6
[INFO] [stderr]   Downloaded syn v1.0.8
[INFO] [stderr]   Downloaded arrayref v0.3.5
[INFO] [stderr]   Downloaded winapi-util v0.1.2
[INFO] [stderr]   Downloaded walkdir v2.2.9
[INFO] [stderr]   Downloaded structopt-derive v0.2.18
[INFO] [stderr]   Downloaded structopt v0.2.18
[INFO] [stderr]   Downloaded unicode-width v0.1.6
[INFO] [stderr]   Downloaded timeout-readwrite v0.1.0
[INFO] [stderr]   Downloaded tempdir v0.3.7
[INFO] [stderr]   Downloaded skeptic v0.13.4
[INFO] [stderr]   Downloaded same-file v1.0.5
[INFO] [stderr]   Downloaded libc v0.2.65
[INFO] [stderr]   Downloaded constant_time_eq v0.1.4
[INFO] [stderr]   Downloaded rust-argon2 v0.5.1
[INFO] [stderr]   Downloaded bytecount v0.4.0
[INFO] [stderr]   Downloaded error-chain v0.12.1
[INFO] [stderr]   Downloaded cc v1.0.47
[INFO] [stderr]   Downloaded pulldown-cmark v0.2.0
[INFO] [stderr]   Downloaded serde_derive v1.0.102
[INFO] [stderr]   Downloaded serde_json v1.0.41
[INFO] [stderr]   Downloaded proc-reader v0.4.0
[INFO] [stderr]   Downloaded remove_dir_all v0.5.2
[INFO] [stderr]   Downloaded error-chain v0.11.0
[INFO] [stderr]   Downloaded cargo_metadata v0.6.4
[INFO] [stderr]   Downloaded redox_users v0.3.1
[INFO] [stderr]   Downloaded memchr v2.2.1
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/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" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "metadata" "--no-deps" "--format-version=1", 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] f1234d8acbc505279eed0d62470e78e8f4c245bfc013479dad6ffb5fee57bb6f
[INFO] running `Command { std: "docker" "start" "-a" "f1234d8acbc505279eed0d62470e78e8f4c245bfc013479dad6ffb5fee57bb6f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f1234d8acbc505279eed0d62470e78e8f4c245bfc013479dad6ffb5fee57bb6f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f1234d8acbc505279eed0d62470e78e8f4c245bfc013479dad6ffb5fee57bb6f", kill_on_drop: false }`
[INFO] [stdout] f1234d8acbc505279eed0d62470e78e8f4c245bfc013479dad6ffb5fee57bb6f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/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" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] dfccf6edff26faafec9e02053ac38c85f18dddbf35875d4e1b3619992dbe8b64
[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" "dfccf6edff26faafec9e02053ac38c85f18dddbf35875d4e1b3619992dbe8b64", 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 bitflags v1.2.1
[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 version_check v0.1.5
[INFO] [stderr]    Compiling ryu v1.0.2
[INFO] [stderr]    Compiling semver-parser v0.7.0
[INFO] [stderr]    Compiling itoa v0.4.4
[INFO] [stderr]    Compiling proc-macro2 v0.4.30
[INFO] [stderr]    Compiling remove_dir_all v0.5.2
[INFO] [stderr]    Compiling same-file v1.0.5
[INFO] [stderr]    Compiling unicode-xid v0.1.0
[INFO] [stderr]    Compiling memchr v2.2.1
[INFO] [stderr]    Compiling bytecount v0.4.0
[INFO] [stderr]    Compiling syn v0.15.44
[INFO] [stderr]    Compiling unicode-segmentation v1.6.0
[INFO] [stderr]    Compiling lazy_static v1.4.0
[INFO] [stderr]    Compiling regex v0.2.11
[INFO] [stderr]    Compiling ansi_term v0.11.0
[INFO] [stderr]    Compiling ucd-util v0.1.5
[INFO] [stderr]    Compiling strsim v0.8.0
[INFO] [stderr]    Compiling utf8-ranges v1.0.4
[INFO] [stderr]    Compiling walkdir v2.2.9
[INFO] [stderr]    Compiling thread_local v0.3.6
[INFO] [stderr]    Compiling regex-syntax v0.5.6
[INFO] [stderr]    Compiling error-chain v0.12.1
[INFO] [stderr]    Compiling heck v0.3.1
[INFO] [stderr]    Compiling pulldown-cmark v0.2.0
[INFO] [stderr]    Compiling backtrace-sys v0.1.32
[INFO] [stderr]    Compiling quote v0.6.13
[INFO] [stderr]    Compiling aho-corasick v0.6.10
[INFO] [stderr]    Compiling rand v0.4.6
[INFO] [stderr]    Compiling iovec v0.1.4
[INFO] [stderr]    Compiling atty v0.2.13
[INFO] [stderr]    Compiling nix v0.9.0
[INFO] [stderr]    Compiling dirs-sys v0.3.4
[INFO] [stderr]    Compiling termion v1.5.3
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling bytes v0.4.12
[INFO] [stderr]    Compiling quote v1.0.2
[INFO] [stderr]    Compiling dirs v2.0.2
[INFO] [stderr]    Compiling backtrace v0.3.40
[INFO] [stderr]    Compiling nix v0.10.0
[INFO] [stderr]    Compiling tempdir v0.3.7
[INFO] [stderr]    Compiling error-chain v0.11.0
[INFO] [stderr]    Compiling timeout-readwrite v0.1.0
[INFO] [stderr]    Compiling serde_json v1.0.41
[INFO] [stderr]    Compiling semver v0.9.0
[INFO] [stderr]    Compiling toml v0.4.10
[INFO] [stderr]    Compiling structopt-derive v0.2.18
[INFO] [stderr]    Compiling structopt v0.2.18
[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 associated function `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 a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated associated function `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: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 2 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 43s
[INFO] running `Command { std: "docker" "inspect" "dfccf6edff26faafec9e02053ac38c85f18dddbf35875d4e1b3619992dbe8b64", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "dfccf6edff26faafec9e02053ac38c85f18dddbf35875d4e1b3619992dbe8b64", kill_on_drop: false }`
[INFO] [stdout] dfccf6edff26faafec9e02053ac38c85f18dddbf35875d4e1b3619992dbe8b64
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/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" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] a652df3cc42381671288acbadc50c5fa1004cb65e3d76ec70022aaef1e630663
[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" "a652df3cc42381671288acbadc50c5fa1004cb65e3d76ec70022aaef1e630663", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]    Compiling pipecolor v0.4.2 (/opt/rustwide/workdir)
[INFO] [stdout] warning: use of deprecated associated function `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 a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: use of deprecated associated function `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: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] warning: 2 warnings emitted
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 4.91s
[INFO] running `Command { std: "docker" "inspect" "a652df3cc42381671288acbadc50c5fa1004cb65e3d76ec70022aaef1e630663", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a652df3cc42381671288acbadc50c5fa1004cb65e3d76ec70022aaef1e630663", kill_on_drop: false }`
[INFO] [stdout] a652df3cc42381671288acbadc50c5fa1004cb65e3d76ec70022aaef1e630663
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7/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" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "rustops/crates-build-env@sha256:6eabd152ff4036248d66efda456a36cb33d24b7291b33f25f75140726c88da35" "/opt/rustwide/cargo-home/bin/cargo" "+eafdee2dfae8c2233b74f98b123308be7ccefcc6" "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] 2670a57092a019389b759634ee74b154930b62420956ee7279bdaba46525832c
[INFO] running `Command { std: "docker" "start" "-a" "2670a57092a019389b759634ee74b154930b62420956ee7279bdaba46525832c", kill_on_drop: false }`
[INFO] [stderr] warning: use of deprecated associated function `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 a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: use of deprecated associated function `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: this warning originates in a macro (in Nightly builds, run with -Z macro-backtrace for more info)
[INFO] [stderr] 
[INFO] [stderr] warning: 2 warnings emitted
[INFO] [stderr] 
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/pipecolor-34d9f7cef1f73f0c
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[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] 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] test tests::test_run ... 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] 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] 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_verbose ... ok
[INFO] [stdout] test colorize::tests::test_colorize ... ok
[INFO] [stdout] test tests::test_read_config_fail ... ok
[INFO] [stdout] test colorize::tests::test_colorize_fail ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "2670a57092a019389b759634ee74b154930b62420956ee7279bdaba46525832c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2670a57092a019389b759634ee74b154930b62420956ee7279bdaba46525832c", kill_on_drop: false }`
[INFO] [stdout] 2670a57092a019389b759634ee74b154930b62420956ee7279bdaba46525832c