[INFO] cloning repository https://github.com/dalance/pipecolor [INFO] running `"git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/dalance/pipecolor" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdalance%2Fpipecolor"` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdalance%2Fpipecolor'... [INFO] running `"git" "rev-parse" "HEAD"` [INFO] [stdout] 73769239cf1728c5812529f1fc98444addc8f57b [INFO] testing dalance/pipecolor against 1.44.0 for beta-1.45-1 [INFO] running `"git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fdalance%2Fpipecolor" "/workspace/builds/worker-0/source"` [INFO] [stderr] Cloning into '/workspace/builds/worker-0/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/dalance/pipecolor on toolchain 1.44.0 [INFO] running `"/workspace/cargo-home/bin/cargo" "+1.44.0" "read-manifest" "--manifest-path" "Cargo.toml"` [INFO] started tweaking git repo https://github.com/dalance/pipecolor [INFO] finished tweaking git repo https://github.com/dalance/pipecolor [INFO] tweaked toml for git repo https://github.com/dalance/pipecolor written to /workspace/builds/worker-0/source/Cargo.toml [INFO] crate git repo https://github.com/dalance/pipecolor already has a lockfile, it will not be regenerated [INFO] running `"/workspace/cargo-home/bin/cargo" "+1.44.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"` [INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.44.0" "build" "--frozen"` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] 55ab960fa327d795009a17f3d46fb668378377d9703376e27635253eafa6cd84 [INFO] running `"docker" "start" "-a" "55ab960fa327d795009a17f3d46fb668378377d9703376e27635253eafa6cd84"` [INFO] [stderr] sudo: setrlimit(RLIMIT_CORE): Operation not permitted [INFO] [stderr] Compiling libc v0.2.65 [INFO] [stderr] Compiling cc v1.0.47 [INFO] [stderr] Compiling bitflags v1.2.1 [INFO] [stderr] Compiling proc-macro2 v1.0.6 [INFO] [stderr] Compiling serde v1.0.102 [INFO] [stderr] Compiling syn v1.0.8 [INFO] [stderr] Compiling ryu v1.0.2 [INFO] [stderr] Compiling syn v0.15.44 [INFO] [stderr] Compiling memchr v2.2.1 [INFO] [stderr] Compiling unicode-width v0.1.6 [INFO] [stderr] Compiling unicode-segmentation v1.6.0 [INFO] [stderr] Compiling bitflags v0.9.1 [INFO] [stderr] Compiling lazy_static v1.4.0 [INFO] [stderr] Compiling regex v0.2.11 [INFO] [stderr] Compiling ucd-util v0.1.5 [INFO] [stderr] Compiling numtoa v0.1.0 [INFO] [stderr] Compiling utf8-ranges v1.0.4 [INFO] [stderr] Compiling error-chain v0.12.1 [INFO] [stderr] Compiling thread_local v0.3.6 [INFO] [stderr] Compiling textwrap v0.11.0 [INFO] [stderr] Compiling regex-syntax v0.5.6 [INFO] [stderr] Compiling quote v0.6.13 [INFO] [stderr] Compiling pulldown-cmark v0.2.0 [INFO] [stderr] Compiling heck v0.3.1 [INFO] [stderr] Compiling aho-corasick v0.6.10 [INFO] [stderr] Compiling backtrace-sys v0.1.32 [INFO] [stderr] Compiling quote v1.0.2 [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 dirs v2.0.2 [INFO] [stderr] Compiling nix v0.10.0 [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 structopt-derive v0.2.18 [INFO] [stderr] Compiling timeout-readwrite v0.1.0 [INFO] [stderr] Compiling structopt v0.2.18 [INFO] [stderr] Compiling serde_derive v1.0.102 [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 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.3-pre (/opt/rustwide/workdir) [INFO] [stderr] warning: use of deprecated item '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 item '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 dev [unoptimized + debuginfo] target(s) in 1m 58s [INFO] running `"docker" "inspect" "55ab960fa327d795009a17f3d46fb668378377d9703376e27635253eafa6cd84"` [INFO] running `"docker" "rm" "-f" "55ab960fa327d795009a17f3d46fb668378377d9703376e27635253eafa6cd84"` [INFO] [stdout] 55ab960fa327d795009a17f3d46fb668378377d9703376e27635253eafa6cd84 [INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.44.0" "test" "--frozen" "--no-run"` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] 196d1207f5fdd8b120e1166c5a77b53bb7936e58f0bfc3d40239c66ab8243d76 [INFO] running `"docker" "start" "-a" "196d1207f5fdd8b120e1166c5a77b53bb7936e58f0bfc3d40239c66ab8243d76"` [INFO] [stderr] sudo: setrlimit(RLIMIT_CORE): Operation not permitted [INFO] [stderr] Compiling pipecolor v0.4.3-pre (/opt/rustwide/workdir) [INFO] [stderr] warning: use of deprecated item '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 item '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 5.21s [INFO] running `"docker" "inspect" "196d1207f5fdd8b120e1166c5a77b53bb7936e58f0bfc3d40239c66ab8243d76"` [INFO] running `"docker" "rm" "-f" "196d1207f5fdd8b120e1166c5a77b53bb7936e58f0bfc3d40239c66ab8243d76"` [INFO] [stdout] 196d1207f5fdd8b120e1166c5a77b53bb7936e58f0bfc3d40239c66ab8243d76 [INFO] running `"docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0/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" "MAP_USER_ID=0" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.44.0" "test" "--frozen"` [INFO] [stderr] WARNING: Your kernel does not support swap limit capabilities or the cgroup is not mounted. Memory limited without swap. [INFO] [stdout] c122be37e1f1e230153b766411e10b034404d4ca8d92615c2de318bc56844013 [INFO] running `"docker" "start" "-a" "c122be37e1f1e230153b766411e10b034404d4ca8d92615c2de318bc56844013"` [INFO] [stderr] sudo: setrlimit(RLIMIT_CORE): Operation not permitted [INFO] [stderr] warning: use of deprecated item '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 item '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.18s [INFO] [stderr] Running /opt/rustwide/target/debug/deps/pipecolor-d3b33d2b4a900d2d [INFO] [stdout] [INFO] [stdout] running 6 tests [INFO] [stdout] test tests::test_read_config_fail ... 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] 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=, 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=, 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=, 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] 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] 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 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] test tests::test_mode ... 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 `"docker" "inspect" "c122be37e1f1e230153b766411e10b034404d4ca8d92615c2de318bc56844013"` [INFO] running `"docker" "rm" "-f" "c122be37e1f1e230153b766411e10b034404d4ca8d92615c2de318bc56844013"` [INFO] [stdout] c122be37e1f1e230153b766411e10b034404d4ca8d92615c2de318bc56844013