[INFO] fetching crate fbtoggl 0.5.10...
[INFO] testing fbtoggl-0.5.10 against beta-2022-04-10 for beta-1.61-1
[INFO] extracting crate fbtoggl 0.5.10 into /workspace/builds/worker-3/source
[INFO] validating manifest of crates.io crate fbtoggl 0.5.10 on toolchain beta-2022-04-10
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking crates.io crate fbtoggl 0.5.10
[INFO] finished tweaking crates.io crate fbtoggl 0.5.10
[INFO] tweaked toml for crates.io crate fbtoggl 0.5.10 written to /workspace/builds/worker-3/source/Cargo.toml
[INFO] crate crates.io crate fbtoggl 0.5.10 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+beta-2022-04-10" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 97098b513bf5b2e20f5597bcf32d2078e67a913beb42ca2fee134bfd69cf69d4
[INFO] running `Command { std: "docker" "start" "-a" "97098b513bf5b2e20f5597bcf32d2078e67a913beb42ca2fee134bfd69cf69d4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "97098b513bf5b2e20f5597bcf32d2078e67a913beb42ca2fee134bfd69cf69d4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "97098b513bf5b2e20f5597bcf32d2078e67a913beb42ca2fee134bfd69cf69d4", kill_on_drop: false }`
[INFO] [stdout] 97098b513bf5b2e20f5597bcf32d2078e67a913beb42ca2fee134bfd69cf69d4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 93f3b35a6daf217f4959eb32df975f90fae52e43af486639940d188d5ec0e322
[INFO] running `Command { std: "docker" "start" "-a" "93f3b35a6daf217f4959eb32df975f90fae52e43af486639940d188d5ec0e322", kill_on_drop: false }`
[INFO] [stderr]    Compiling memchr v2.4.1
[INFO] [stderr]    Compiling bytes v1.1.0
[INFO] [stderr]    Compiling httparse v1.6.0
[INFO] [stderr]    Compiling maplit v1.0.2
[INFO] [stderr]    Compiling openssl v0.10.38
[INFO] [stderr]    Compiling futures-util v0.3.21
[INFO] [stderr]    Compiling futures-sink v0.3.21
[INFO] [stderr]    Compiling futures-channel v0.3.21
[INFO] [stderr]    Compiling const_fn v0.4.9
[INFO] [stderr]    Compiling ahash v0.4.7
[INFO] [stderr]    Compiling httpdate v1.0.2
[INFO] [stderr]    Compiling async-trait v0.1.52
[INFO] [stderr]    Compiling tower-service v0.3.1
[INFO] [stderr]    Compiling encoding_rs v0.8.30
[INFO] [stderr]    Compiling base64 v0.13.0
[INFO] [stderr]    Compiling heck v0.4.0
[INFO] [stderr]    Compiling similar v2.1.0
[INFO] [stderr]    Compiling ipnet v2.4.0
[INFO] [stderr]    Compiling zeroize v1.5.3
[INFO] [stderr]    Compiling pathdiff v0.2.1
[INFO] [stderr]    Compiling urlencoding v2.1.0
[INFO] [stderr]    Compiling openssl-src v111.17.0+1.1.1m
[INFO] [stderr]    Compiling indexmap v1.8.0
[INFO] [stderr]    Compiling standback v0.2.17
[INFO] [stderr]    Compiling tracing-core v0.1.22
[INFO] [stderr]    Compiling time v0.2.27
[INFO] [stderr]    Compiling nom v6.1.2
[INFO] [stderr]    Compiling yaml-rust v0.4.5
[INFO] [stderr]    Compiling getrandom v0.2.5
[INFO] [stderr]    Compiling socket2 v0.4.4
[INFO] [stderr]    Compiling mio v0.8.0
[INFO] [stderr]    Compiling terminal_size v0.1.17
[INFO] [stderr]    Compiling time v0.1.43
[INFO] [stderr]    Compiling atty v0.2.14
[INFO] [stderr]    Compiling want v0.3.0
[INFO] [stderr]    Compiling dirs-sys v0.3.6
[INFO] [stderr]    Compiling tempfile v3.3.0
[INFO] [stderr]    Compiling proc-macro-error-attr v1.0.4
[INFO] [stderr]    Compiling serde_derive v1.0.136
[INFO] [stderr]    Compiling pest_meta v2.1.3
[INFO] [stderr]    Compiling hashbrown v0.9.1
[INFO] [stderr]    Compiling http v0.2.6
[INFO] [stderr]    Compiling dirs v4.0.0
[INFO] [stderr]    Compiling openssl-sys v0.9.72
[INFO] [stderr]    Compiling textwrap v0.15.0
[INFO] [stderr]    Compiling colored v2.0.0
[INFO] [stderr]    Compiling xdg v2.4.1
[INFO] [stderr]    Compiling rand_core v0.6.3
[INFO] [stderr]    Compiling tracing v0.1.31
[INFO] [stderr]    Compiling time-macros-impl v0.1.2
[INFO] [stderr]    Compiling pest_generator v2.1.3
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling tokio v1.17.0
[INFO] [stderr]    Compiling aho-corasick v0.7.18
[INFO] [stderr]    Compiling os_str_bytes v6.0.0
[INFO] [stderr]    Compiling nom v7.1.0
[INFO] [stderr]    Compiling proc-macro-error v1.0.4
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling clap_derive v3.1.4
[INFO] [stderr]    Compiling pest_derive v2.1.0
[INFO] [stderr]    Compiling http-body v0.4.4
[INFO] [stderr]    Compiling dlv-list v0.2.3
[INFO] [stderr]    Compiling regex v1.5.4
[INFO] [stderr]    Compiling ordered-multimap v0.3.1
[INFO] [stderr]    Compiling time-macros v0.1.1
[INFO] [stderr]    Compiling rust-ini v0.17.0
[INFO] [stderr]    Compiling jackdauer v0.1.1
[INFO] [stderr]    Compiling console v0.15.0
[INFO] [stderr]    Compiling term-table v1.3.2
[INFO] [stderr]    Compiling dialoguer v0.10.0
[INFO] [stderr]    Compiling serde v1.0.136
[INFO] [stderr]    Compiling clap v3.1.6
[INFO] [stderr]    Compiling tokio-util v0.6.9
[INFO] [stderr]    Compiling h2 v0.3.11
[INFO] [stderr]    Compiling serde_json v1.0.79
[INFO] [stderr]    Compiling chrono v0.4.19
[INFO] [stderr]    Compiling serde_urlencoded v0.7.1
[INFO] [stderr]    Compiling toml v0.5.8
[INFO] [stderr]    Compiling json5 v0.4.1
[INFO] [stderr]    Compiling ron v0.7.0
[INFO] [stderr]    Compiling hyper v0.14.17
[INFO] [stderr]    Compiling assert-json-diff v2.0.1
[INFO] [stderr]    Compiling hhmmss v0.1.0
[INFO] [stderr]    Compiling now v0.1.2
[INFO] [stderr]    Compiling htp v0.4.2
[INFO] [stderr]    Compiling config v0.12.0
[INFO] [stderr]    Compiling mockito v0.31.0
[INFO] [stderr]    Compiling native-tls v0.2.8
[INFO] [stderr]    Compiling tokio-native-tls v0.3.0
[INFO] [stderr]    Compiling hyper-tls v0.5.0
[INFO] [stderr]    Compiling reqwest v0.11.9
[INFO] [stderr]    Compiling fbtoggl v0.5.10 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 33.61s
[INFO] running `Command { std: "docker" "inspect" "93f3b35a6daf217f4959eb32df975f90fae52e43af486639940d188d5ec0e322", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "93f3b35a6daf217f4959eb32df975f90fae52e43af486639940d188d5ec0e322", kill_on_drop: false }`
[INFO] [stdout] 93f3b35a6daf217f4959eb32df975f90fae52e43af486639940d188d5ec0e322
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 29b6b496acc4aad1d892e863af994b7ad1dd5a872203598773036a8b3cb7b1ae
[INFO] running `Command { std: "docker" "start" "-a" "29b6b496acc4aad1d892e863af994b7ad1dd5a872203598773036a8b3cb7b1ae", kill_on_drop: false }`
[INFO] [stderr]    Compiling log v0.4.14
[INFO] [stderr]    Compiling diff v0.1.12
[INFO] [stderr]    Compiling ctor v0.1.21
[INFO] [stderr]    Compiling pretty_assertions v1.1.0
[INFO] [stderr]    Compiling mio v0.8.0
[INFO] [stderr]    Compiling want v0.3.0
[INFO] [stderr]    Compiling native-tls v0.2.8
[INFO] [stderr]    Compiling env_logger v0.9.0
[INFO] [stderr]    Compiling mockito v0.31.0
[INFO] [stderr]    Compiling tokio v1.17.0
[INFO] [stderr]    Compiling tokio-util v0.6.9
[INFO] [stderr]    Compiling tokio-native-tls v0.3.0
[INFO] [stderr]    Compiling h2 v0.3.11
[INFO] [stderr]    Compiling hyper v0.14.17
[INFO] [stderr]    Compiling hyper-tls v0.5.0
[INFO] [stderr]    Compiling reqwest v0.11.9
[INFO] [stderr]    Compiling fbtoggl v0.5.10 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 21.68s
[INFO] [stderr]   Executable unittests src/main.rs (/opt/rustwide/target/debug/deps/fbtoggl-5cb80b2db7ef07ed)
[INFO] running `Command { std: "docker" "inspect" "29b6b496acc4aad1d892e863af994b7ad1dd5a872203598773036a8b3cb7b1ae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "29b6b496acc4aad1d892e863af994b7ad1dd5a872203598773036a8b3cb7b1ae", kill_on_drop: false }`
[INFO] [stdout] 29b6b496acc4aad1d892e863af994b7ad1dd5a872203598773036a8b3cb7b1ae
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3/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" "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:b0c94ce3c1162fcb8e57cac5b65ec2f72eabb1eebea4fcc35e269e823f681646" "/opt/rustwide/cargo-home/bin/cargo" "+beta-2022-04-10" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 5c0146c921b78ae4055fcc128a0e47f8eb9c3411f5dcd266b64a7ee090e059a8
[INFO] running `Command { std: "docker" "start" "-a" "5c0146c921b78ae4055fcc128a0e47f8eb9c3411f5dcd266b64a7ee090e059a8", kill_on_drop: false }`
[INFO] [stderr]     Finished test [unoptimized + debuginfo] target(s) in 0.26s
[INFO] [stderr]      Running unittests src/main.rs (/opt/rustwide/target/debug/deps/fbtoggl-5cb80b2db7ef07ed)
[INFO] [stdout] 
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Server is listening at 127.0.0.1:1234
[INFO] [stdout] running 14 tests
[INFO] [stdout] test commands::time_entries_tests::test_calculate_duration ... ok
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /workspaces/12345678/projects
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET /workspaces/12345678/projects
[INFO] [stderr]     
[INFO] [stdout] test client_tests::get_workspace_projects ... ok
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /workspaces/12345678/clients
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stdout] test client_tests::get_workspace_clients ... ok
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET /workspaces/12345678/clients
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stdout] test client_tests::get_me ... ok
[INFO] [stderr]     GET /me
[INFO] [stdout] test client_tests::get_workspaces ... ok
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET /me
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /workspaces
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET /workspaces
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     POST /time_entries/start
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     content-type: application/json
[INFO] [stderr]     content-length: 143
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     {"time_entry":{"billable":false,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","pid":123,"tags":["a","b"]}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stdout] test client_tests::test_start_time_entry ... ok
[INFO] [stderr]     POST /time_entries/start
[INFO] [stderr]     {"time_entry":{"billable":false,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","pid":123,"tags":["a","b"]}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stdout] test client_tests::create_time_entry ... ok
[INFO] [stderr]     POST /time_entries
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     content-type: application/json
[INFO] [stderr]     content-length: 218
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     {"time_entry":{"billable":true,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"Wurst","duration":200,"pid":123456789,"start":"2021-11-21T23:58:09+01:00","tags":["aa","bb"],"wid":123456789}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     POST /time_entries
[INFO] [stderr]     {"time_entry":{"billable":true,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"Wurst","duration":200,"pid":123456789,"start":"2021-11-21T23:58:09+01:00","tags":["aa","bb"],"wid":123456789}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /me
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /workspaces/1234567/projects
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     POST /time_entries
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     content-type: application/json
[INFO] [stderr]     content-length: 210
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     {"time_entry":{"billable":false,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","duration":7200,"pid":123456789,"start":"2021-11-21T23:58:09+01:00","tags":null,"wid":1234567}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /time_entries?start_date=2022-04-13T00%3A00%3A00%2B02%3A00&end_date=2022-04-14T00%3A00%3A00%2B02%3A00
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET ^/time_entries.*$ (regex)
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     POST /time_entries
[INFO] [stderr]     {"time_entry":{"billable":false,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","duration":7200,"pid":123456789,"start":"2021-11-21T23:58:09+01:00","tags":null,"wid":1234567}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET /workspaces/1234567/projects
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET /me
[INFO] [stderr]     
[INFO] [stdout] test commands::time_entries_tests::test_create_workday_with_pause_2_hours ... ok
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     POST /clients
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     content-type: application/json
[INFO] [stderr]     content-length: 46
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     {"client":{"name":"fkbr.org","wid":123456789}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stdout] test client_tests::create_client ... ok
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     POST /clients
[INFO] [stderr]     {"client":{"name":"fkbr.org","wid":123456789}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /time_entries/456
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stdout] test client_tests::test_time_entry_details ... ok
[INFO] [stderr]     GET /time_entries/456
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     DELETE /time_entries/456
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stdout] test client_tests::test_delete_time_entry ... ok
[INFO] [stderr]     DELETE /time_entries/456
[INFO] [stderr]     
[INFO] [stdout] test client_tests::test_stop_time_entry ... ok
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     PUT /time_entries/456/stop
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     content-type: application/json
[INFO] [stderr]     content-length: 126
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     {"time_entry":{"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","pid":123,"tags":["a","b"]}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     PUT /time_entries/456/stop
[INFO] [stderr]     {"time_entry":{"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","pid":123,"tags":["a","b"]}}
[INFO] [stderr]     
[INFO] [stdout] test client_tests::get_time_entries ... ok
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /time_entries?start_date=2021-11-21T00%3A00%3A00%2B01%3A00&end_date=2021-11-22T00%3A00%3A00%2B01%3A00
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET /time_entries?start_date=2021-11-21T00%3A00%3A00%2B01%3A00&end_date=2021-11-22T00%3A00%3A00%2B01%3A00
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /me
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /workspaces/1234567/projects
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     POST /time_entries
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     content-type: application/json
[INFO] [stderr]     content-length: 210
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     {"time_entry":{"billable":true,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","duration":12600,"pid":123456789,"start":"2021-11-21T22:58:09+01:00","tags":null,"wid":1234567}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     POST /time_entries
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     content-type: application/json
[INFO] [stderr]     content-length: 210
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     {"time_entry":{"billable":true,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","duration":12600,"pid":123456789,"start":"2021-11-22T03:28:09+01:00","tags":null,"wid":1234567}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Request received: 
[INFO] [stderr]     GET /time_entries?start_date=2022-04-13T00%3A00%3A00%2B02%3A00&end_date=2022-04-14T00%3A00%3A00%2B02%3A00
[INFO] [stderr]     authorization: Basic Y2I3YmY3ZWZhNmQ2NTIwNDZhYmQyZjdkODRlZTE4YzE6YXBpX3Rva2Vu
[INFO] [stderr]     accept: */*
[INFO] [stderr]     host: 127.0.0.1:1234
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito::server] Mock found
[INFO] [stdout] test commands::time_entries_tests::test_create_workday_with_pause_7_hours ... ok
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stdout] 
[INFO] [stderr]     GET ^/time_entries.*$ (regex)
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.32s
[INFO] [stderr]     
[INFO] [stdout] 
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     POST /time_entries
[INFO] [stderr]     {"time_entry":{"billable":true,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","duration":12600,"pid":123456789,"start":"2021-11-22T03:28:09+01:00","tags":null,"wid":1234567}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     POST /time_entries
[INFO] [stderr]     {"time_entry":{"billable":true,"created_with":"fbtoggl (https://github.com/icepuma/fbtoggl)","description":"fkbr","duration":12600,"pid":123456789,"start":"2021-11-21T22:58:09+01:00","tags":null,"wid":1234567}}
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET /workspaces/1234567/projects
[INFO] [stderr]     
[INFO] [stderr] [2022-04-13T14:02:49Z DEBUG mockito] Mock::drop() called for 
[INFO] [stderr]     GET /me
[INFO] [stderr]     
[INFO] running `Command { std: "docker" "inspect" "5c0146c921b78ae4055fcc128a0e47f8eb9c3411f5dcd266b64a7ee090e059a8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5c0146c921b78ae4055fcc128a0e47f8eb9c3411f5dcd266b64a7ee090e059a8", kill_on_drop: false }`
[INFO] [stdout] 5c0146c921b78ae4055fcc128a0e47f8eb9c3411f5dcd266b64a7ee090e059a8