[INFO] cloning repository https://github.com/eHealthExperts/k2-creek [INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/eHealthExperts/k2-creek" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FeHealthExperts%2Fk2-creek", kill_on_drop: false }` [INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FeHealthExperts%2Fk2-creek'... [INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }` [INFO] [stdout] c27e946703479fd3fb37af77b3c18777316218d6 [INFO] testing eHealthExperts/k2-creek against master#432e145bd5a974c5b6f4dd9b352891bd7502b69d for pr-87041 [INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FeHealthExperts%2Fk2-creek" "/workspace/builds/worker-4/source", kill_on_drop: false }` [INFO] [stderr] Cloning into '/workspace/builds/worker-4/source'... [INFO] [stderr] done. [INFO] validating manifest of git repo https://github.com/eHealthExperts/k2-creek on toolchain 432e145bd5a974c5b6f4dd9b352891bd7502b69d [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }` [INFO] removed /workspace/builds/worker-4/source/.cargo/config [INFO] removed /workspace/builds/worker-4/source/rust-toolchain [INFO] started tweaking git repo https://github.com/eHealthExperts/k2-creek [INFO] finished tweaking git repo https://github.com/eHealthExperts/k2-creek [INFO] tweaked toml for git repo https://github.com/eHealthExperts/k2-creek written to /workspace/builds/worker-4/source/Cargo.toml [INFO] crate git repo https://github.com/eHealthExperts/k2-creek already has a lockfile, it will not be regenerated [INFO] running `Command { std: "/workspace/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }` [INFO] [stdout] 4ec2b64cef4db2983ca135197df44d4dc8674d1adf673fb4436be79d6aadb95d [INFO] running `Command { std: "docker" "start" "-a" "4ec2b64cef4db2983ca135197df44d4dc8674d1adf673fb4436be79d6aadb95d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "inspect" "4ec2b64cef4db2983ca135197df44d4dc8674d1adf673fb4436be79d6aadb95d", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4ec2b64cef4db2983ca135197df44d4dc8674d1adf673fb4436be79d6aadb95d", kill_on_drop: false }` [INFO] [stdout] 4ec2b64cef4db2983ca135197df44d4dc8674d1adf673fb4436be79d6aadb95d [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "build" "--frozen" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] f0a04bf8750d270871d4ba0d7582df7734a9e8a44a01ee07557b9f11f784025f [INFO] running `Command { std: "docker" "start" "-a" "f0a04bf8750d270871d4ba0d7582df7734a9e8a44a01ee07557b9f11f784025f", kill_on_drop: false }` [INFO] [stderr] Compiling proc-macro2 v1.0.27 [INFO] [stderr] Compiling unicode-xid v0.2.2 [INFO] [stderr] Compiling version_check v0.9.3 [INFO] [stderr] Compiling pin-project-lite v0.2.6 [INFO] [stderr] Compiling encoding_index_tests v0.1.4 [INFO] [stderr] Compiling lexical-core v0.7.6 [INFO] [stderr] Compiling strsim v0.10.0 [INFO] [stderr] Compiling static_assertions v1.1.0 [INFO] [stderr] Compiling ident_case v1.0.1 [INFO] [stderr] Compiling arrayvec v0.5.2 [INFO] [stderr] Compiling native-tls v0.2.7 [INFO] [stderr] Compiling radium v0.5.3 [INFO] [stderr] Compiling openssl-probe v0.1.4 [INFO] [stderr] Compiling httpdate v1.0.1 [INFO] [stderr] Compiling tower-service v0.3.1 [INFO] [stderr] Compiling funty v1.1.0 [INFO] [stderr] Compiling tap v1.0.1 [INFO] [stderr] Compiling wyz v0.2.0 [INFO] [stderr] Compiling rustversion v1.0.5 [INFO] [stderr] Compiling utf8parse v0.2.0 [INFO] [stderr] Compiling k2-creek v1.0.1 (/opt/rustwide/workdir) [INFO] [stderr] Compiling ipnet v2.3.1 [INFO] [stderr] Compiling rust-ini v0.13.0 [INFO] [stderr] Compiling yasna v0.4.0 [INFO] [stderr] Compiling tokio v1.7.1 [INFO] [stderr] Compiling openssl-sys v0.9.64 [INFO] [stderr] Compiling ring v0.16.20 [INFO] [stderr] Compiling futures-macro v0.3.15 [INFO] [stderr] Compiling futures-util v0.3.15 [INFO] [stderr] Compiling indexmap v1.6.2 [INFO] [stderr] Compiling tracing-core v0.1.18 [INFO] [stderr] Compiling unicode-bidi v0.3.5 [INFO] [stderr] Compiling form_urlencoded v1.0.1 [INFO] [stderr] Compiling nix v0.18.0 [INFO] [stderr] Compiling encoding-index-korean v1.20141219.5 [INFO] [stderr] Compiling encoding-index-simpchinese v1.20141219.5 [INFO] [stderr] Compiling encoding-index-singlebyte v1.20141219.5 [INFO] [stderr] Compiling encoding-index-tradchinese v1.20141219.5 [INFO] [stderr] Compiling encoding-index-japanese v1.20141219.5 [INFO] [stderr] Compiling http-body v0.4.2 [INFO] [stderr] Compiling encoding_rs v0.8.28 [INFO] [stderr] Compiling num_cpus v1.13.0 [INFO] [stderr] Compiling socket2 v0.4.0 [INFO] [stderr] Compiling dirs-sys-next v0.1.2 [INFO] [stderr] Compiling atty v0.2.14 [INFO] [stderr] Compiling regex v1.4.6 [INFO] [stderr] Compiling idna v0.2.3 [INFO] [stderr] Compiling tracing v0.1.26 [INFO] [stderr] Compiling dirs-next v1.0.2 [INFO] [stderr] Compiling clap v2.33.3 [INFO] [stderr] Compiling bitvec v0.19.5 [INFO] [stderr] Compiling value-bag v1.0.0-alpha.7 [INFO] [stderr] Compiling nom v5.1.2 [INFO] [stderr] Compiling nom v6.2.0 [INFO] [stderr] Compiling encoding v0.2.33 [INFO] [stderr] Compiling quote v1.0.9 [INFO] [stderr] Compiling openssl v0.10.35 [INFO] [stderr] Compiling syn v1.0.73 [INFO] [stderr] Compiling webpki v0.21.4 [INFO] [stderr] Compiling sct v0.6.1 [INFO] [stderr] Compiling webpki-roots v0.21.1 [INFO] [stderr] Compiling rusticata-macros v3.0.1 [INFO] [stderr] Compiling darling_core v0.13.0 [INFO] [stderr] Compiling ctor v0.1.20 [INFO] [stderr] Compiling serde_derive v1.0.126 [INFO] [stderr] Compiling thiserror-impl v1.0.25 [INFO] [stderr] Compiling enum-iterator-derive v0.6.0 [INFO] [stderr] Compiling darling_macro v0.13.0 [INFO] [stderr] Compiling enum-iterator v0.6.0 [INFO] [stderr] Compiling log v0.4.14 [INFO] [stderr] Compiling mio v0.7.13 [INFO] [stderr] Compiling want v0.3.0 [INFO] [stderr] Compiling rustls v0.19.1 [INFO] [stderr] Compiling rustyline v6.3.0 [INFO] [stderr] Compiling env_logger v0.8.4 [INFO] [stderr] Compiling darling v0.13.0 [INFO] [stderr] Compiling serde_with_macros v1.4.2 [INFO] [stderr] Compiling thiserror v1.0.25 [INFO] [stderr] Compiling promptly v0.3.0 [INFO] [stderr] Compiling serde v1.0.126 [INFO] [stderr] Compiling tokio-util v0.6.7 [INFO] [stderr] Compiling tokio-native-tls v0.3.0 [INFO] [stderr] Compiling tokio-rustls v0.22.0 [INFO] [stderr] Compiling h2 v0.3.3 [INFO] [stderr] Compiling serde_json v1.0.64 [INFO] [stderr] Compiling url v2.2.2 [INFO] [stderr] Compiling serde_urlencoded v0.7.0 [INFO] [stderr] Compiling serde_with v1.9.4 [INFO] [stderr] Compiling config v0.11.0 [INFO] [stderr] Compiling serde-xml-rs v0.4.1 [INFO] [stderr] Compiling hyper v0.14.9 [INFO] [stderr] Compiling hyper-tls v0.5.0 [INFO] [stderr] Compiling hyper-rustls v0.22.1 [INFO] [stderr] Compiling reqwest v0.11.3 [INFO] [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1m 18s [INFO] running `Command { std: "docker" "inspect" "f0a04bf8750d270871d4ba0d7582df7734a9e8a44a01ee07557b9f11f784025f", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "f0a04bf8750d270871d4ba0d7582df7734a9e8a44a01ee07557b9f11f784025f", kill_on_drop: false }` [INFO] [stdout] f0a04bf8750d270871d4ba0d7582df7734a9e8a44a01ee07557b9f11f784025f [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }` [INFO] [stdout] 62a9690a98f87c06503971a99f23498404737f4f355e345c09f1b33c8135fb5c [INFO] running `Command { std: "docker" "start" "-a" "62a9690a98f87c06503971a99f23498404737f4f355e345c09f1b33c8135fb5c", kill_on_drop: false }` [INFO] [stderr] Compiling ppv-lite86 v0.2.10 [INFO] [stderr] Compiling predicates-core v1.0.2 [INFO] [stderr] Compiling difference v2.0.0 [INFO] [stderr] Compiling normalize-line-endings v0.3.0 [INFO] [stderr] Compiling doc-comment v0.3.3 [INFO] [stderr] Compiling scopeguard v1.1.0 [INFO] [stderr] Compiling treeline v0.1.0 [INFO] [stderr] Compiling smallvec v1.6.1 [INFO] [stderr] Compiling http-types v2.11.1 [INFO] [stderr] Compiling data-encoding v2.3.2 [INFO] [stderr] Compiling infer v0.2.3 [INFO] [stderr] Compiling regex-automata v0.1.10 [INFO] [stderr] Compiling futures-timer v3.0.2 [INFO] [stderr] Compiling remove_dir_all v0.5.3 [INFO] [stderr] Compiling fragile v1.0.0 [INFO] [stderr] Compiling downcast v0.10.0 [INFO] [stderr] Compiling num-traits v0.2.14 [INFO] [stderr] Compiling instant v0.1.9 [INFO] [stderr] Compiling crossbeam-queue v0.3.2 [INFO] [stderr] Compiling crossbeam-utils v0.8.5 [INFO] [stderr] Compiling futures-lite v1.12.0 [INFO] [stderr] Compiling getrandom v0.1.16 [INFO] [stderr] Compiling getrandom v0.2.3 [INFO] [stderr] Compiling wait-timeout v0.2.0 [INFO] [stderr] Compiling async-trait v0.1.50 [INFO] [stderr] Compiling mockall_derive v0.9.1 [INFO] [stderr] Compiling serial_test_derive v0.5.1 [INFO] [stderr] Compiling async-attributes v1.1.2 [INFO] [stderr] Compiling futures-executor v0.3.15 [INFO] [stderr] Compiling config v0.10.1 [INFO] [stderr] Compiling polling v2.1.0 [INFO] [stderr] Compiling kv-log-macro v1.0.7 [INFO] [stderr] Compiling lock_api v0.4.4 [INFO] [stderr] Compiling rand_core v0.6.3 [INFO] [stderr] Compiling bstr v0.2.15 [INFO] [stderr] Compiling rand_core v0.5.1 [INFO] [stderr] Compiling futures v0.3.15 [INFO] [stderr] Compiling predicates-tree v1.0.2 [INFO] [stderr] Compiling parking_lot_core v0.8.3 [INFO] [stderr] Compiling serde_qs v0.7.2 [INFO] [stderr] Compiling rand_chacha v0.2.2 [INFO] [stderr] Compiling rand_chacha v0.3.1 [INFO] [stderr] Compiling rand v0.8.4 [INFO] [stderr] Compiling parking_lot v0.11.1 [INFO] [stderr] Compiling rand v0.7.3 [INFO] [stderr] Compiling async-executor v1.4.1 [INFO] [stderr] Compiling async-io v1.4.1 [INFO] [stderr] Compiling blocking v1.0.2 [INFO] [stderr] Compiling tempfile v3.2.0 [INFO] [stderr] Compiling float-cmp v0.8.0 [INFO] [stderr] Compiling predicates v1.0.8 [INFO] [stderr] Compiling serial_test v0.5.1 [INFO] [stderr] Compiling async-global-executor v2.0.2 [INFO] [stderr] Compiling async-std v1.9.0 [INFO] [stderr] Compiling assert_cmd v1.0.5 [INFO] [stderr] Compiling deadpool v0.7.0 [INFO] [stderr] Compiling wiremock v0.5.3 [INFO] [stderr] Compiling mockall v0.9.1 [INFO] [stderr] Compiling k2-creek v1.0.1 (/opt/rustwide/workdir) [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 32.63s [INFO] running `Command { std: "docker" "inspect" "62a9690a98f87c06503971a99f23498404737f4f355e345c09f1b33c8135fb5c", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "62a9690a98f87c06503971a99f23498404737f4f355e345c09f1b33c8135fb5c", kill_on_drop: false }` [INFO] [stdout] 62a9690a98f87c06503971a99f23498404737f4f355e345c09f1b33c8135fb5c [INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4/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" "ghcr.io/rust-lang/crates-build-env/linux@sha256:34b6a614d2c27851fe6cbf88fbd1137609cefab8b10d0615aaeb6fd47975d74e" "/opt/rustwide/cargo-home/bin/cargo" "+432e145bd5a974c5b6f4dd9b352891bd7502b69d" "test" "--frozen", kill_on_drop: false }` [INFO] [stdout] 4d499fda7798478d4909f3d71e49fbce9463a0c29dced59d22e70908b5bcb1b6 [INFO] running `Command { std: "docker" "start" "-a" "4d499fda7798478d4909f3d71e49fbce9463a0c29dced59d22e70908b5bcb1b6", kill_on_drop: false }` [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Blocking waiting for file lock on package cache [INFO] [stderr] Finished test [unoptimized + debuginfo] target(s) in 4.85s [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/k2_creek-d84b885a1ee68b25) [INFO] [stdout] [INFO] [stdout] running 46 tests [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Decoded: YIGLgBZUZWNobmlrZXIgS3Jhbmtlbmthc3NlgQcxMzc3NTA4jwUwMDAyMIIMMTIzNDU2Nzg5MDEygwQ1MDAwkAExhQtBbWVsaWUgU2luYYcFQXBmZWyICDExMDkxOTk1iRJDYXJsLVdvbGZmLVN0ci4gMTKKAUSLBTQ1Mjc5jAVFc3Nlbo0EMTAyMY4B/A== [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Encoded: [96, 129, 139, 128, 22, 84, 101, 99, 104, 110, 105, 107, 101, 114, 32, 75, 114, 97, 110, 107, 101, 110, 107, 97, 115, 115, 101, 129, 7, 49, 51, 55, 55, 53, 48, 56, 143, 5, 48, 48, 48, 50, 48, 130, 12, 49, 50, 51, 52, 53, 54, 55, 56, 57, 48, 49, 50, 131, 4, 53, 48, 48, 48, 144, 1, 49, 133, 11, 65, 109, 101, 108, 105, 101, 32, 83, 105, 110, 97, 135, 5, 65, 112, 102, 101, 108, 136, 8, 49, 49, 48, 57, 49, 57, 57, 53, 137, 18, 67, 97, 114, 108, 45, 87, 111, 108, 102, 102, 45, 83, 116, 114, 46, 32, 49, 50, 138, 1, 68, 139, 5, 52, 53, 50, 55, 57, 140, 5, 69, 115, 115, 101, 110, 141, 4, 49, 48, 50, 49, 142, 1, 252] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kkn [54, 65, 63, 68, 6e, 69, 6b, 65, 72, 20, 4b, 72, 61, 6e, 6b, 65, 6e, 6b, 61, 73, 73, 65] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kknr [31, 33, 37, 37, 35, 30, 38] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vknr [30, 30, 30, 32, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vnr [31, 32, 33, 34, 35, 36, 37, 38, 39, 30, 31, 32] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vs [35, 30, 30, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] se [31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] t None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] v [41, 6d, 65, 6c, 69, 65, 20, 53, 69, 6e, 61] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] nz None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] f [41, 70, 66, 65, 6c] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] gd [31, 31, 30, 39, 31, 39, 39, 35] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] sn Some([43, 61, 72, 6c, 2d, 57, 6f, 6c, 66, 66, 2d, 53, 74, 72, 2e, 20, 31, 32]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] wlc Some([44]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] plz [34, 35, 32, 37, 39] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] on [45, 73, 73, 65, 6e] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] g [31, 30, 32, 31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] ps [fc] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] ASN.1 decoded: [INFO] [stderr] KrankenKassenName: Techniker Krankenkasse [INFO] [stderr] KrankenKassenNummer: 1377508 [INFO] [stderr] VKNR: 00020 [INFO] [stderr] VersichertenNummer: 123456789012 [INFO] [stderr] VersichertenStatus: 5000 [INFO] [stderr] StatusErgänzung: 1 [INFO] [stderr] VorName: Amelie Sina [INFO] [stderr] FamilienName: Apfel [INFO] [stderr] GeburtsDatum: 11091995 [INFO] [stderr] Straßenname: Carl-Wolff-Str. 12 [INFO] [stderr] WohnsitzLänderCode: D [INFO] [stderr] Postleitzahl: 45279 [INFO] [stderr] Orstname: Essen [INFO] [stderr] GültigkeitsDatum: 1021 [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Decoded: YIGLgBZUZWNobmlrZXIgS3Jhbmtlbmthc3NlgQcxMzc3NTA4jwUwMDAyMIIMMTIzNDU2Nzg5MDEygwQ1MDAwkAExhQtBbWVsaWUgU2luYYcFQXBmZWyICDExMDkxOTk1iRJDYXJsLVdvbGZmLVN0ci4gMTKKAUSLBTQ1Mjc5jAVFc3Nlbo0EMTAyMY4B/A== [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Encoded: [96, 129, 139, 128, 22, 84, 101, 99, 104, 110, 105, 107, 101, 114, 32, 75, 114, 97, 110, 107, 101, 110, 107, 97, 115, 115, 101, 129, 7, 49, 51, 55, 55, 53, 48, 56, 143, 5, 48, 48, 48, 50, 48, 130, 12, 49, 50, 51, 52, 53, 54, 55, 56, 57, 48, 49, 50, 131, 4, 53, 48, 48, 48, 144, 1, 49, 133, 11, 65, 109, 101, 108, 105, 101, 32, 83, 105, 110, 97, 135, 5, 65, 112, 102, 101, 108, 136, 8, 49, 49, 48, 57, 49, 57, 57, 53, 137, 18, 67, 97, 114, 108, 45, 87, 111, 108, 102, 102, 45, 83, 116, 114, 46, 32, 49, 50, 138, 1, 68, 139, 5, 52, 53, 50, 55, 57, 140, 5, 69, 115, 115, 101, 110, 141, 4, 49, 48, 50, 49, 142, 1, 252] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kkn [54, 65, 63, 68, 6e, 69, 6b, 65, 72, 20, 4b, 72, 61, 6e, 6b, 65, 6e, 6b, 61, 73, 73, 65] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kknr [31, 33, 37, 37, 35, 30, 38] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vknr [30, 30, 30, 32, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vnr [31, 32, 33, 34, 35, 36, 37, 38, 39, 30, 31, 32] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vs [35, 30, 30, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] se [31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] t None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] v [41, 6d, 65, 6c, 69, 65, 20, 53, 69, 6e, 61] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] nz None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] f [41, 70, 66, 65, 6c] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] gd [31, 31, 30, 39, 31, 39, 39, 35] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] sn Some([43, 61, 72, 6c, 2d, 57, 6f, 6c, 66, 66, 2d, 53, 74, 72, 2e, 20, 31, 32]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] wlc Some([44]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] plz [34, 35, 32, 37, 39] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] on [45, 73, 73, 65, 6e] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] g [31, 30, 32, 31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] ps [fc] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] ASN.1 decoded: [INFO] [stderr] KrankenKassenName: Techniker Krankenkasse [INFO] [stderr] KrankenKassenNummer: 1377508 [INFO] [stderr] VKNR: 00020 [INFO] [stderr] VersichertenNummer: 123456789012 [INFO] [stderr] VersichertenStatus: 5000 [INFO] [stderr] StatusErgänzung: 1 [INFO] [stderr] VorName: Amelie Sina [INFO] [stderr] FamilienName: Apfel [INFO] [stderr] GeburtsDatum: 11091995 [INFO] [stderr] Straßenname: Carl-Wolff-Str. 12 [INFO] [stderr] WohnsitzLänderCode: D [INFO] [stderr] Postleitzahl: 45279 [INFO] [stderr] Orstname: Essen [INFO] [stderr] GültigkeitsDatum: 1021 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::cli] Msg error: The following required arguments were not provided: [INFO] [stderr] --url [INFO] [stderr] [INFO] [stderr] USAGE: [INFO] [stderr] test --output --url [INFO] [stderr] [INFO] [stderr] For more information try --help [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::cli] Msg error: The following required arguments were not provided: [INFO] [stderr] --url [INFO] [stderr] [INFO] [stderr] USAGE: [INFO] [stderr] test --api --url [INFO] [stderr] [INFO] [stderr] For more information try --help [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::cli] Msg error: The following required arguments were not provided: [INFO] [stderr] --url [INFO] [stderr] [INFO] [stderr] USAGE: [INFO] [stderr] test --output --url [INFO] [stderr] [INFO] [stderr] For more information try --help [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::cli] Msg error: The following required arguments were not provided: [INFO] [stderr] --url [INFO] [stderr] [INFO] [stderr] USAGE: [INFO] [stderr] test --timeout --url [INFO] [stderr] [INFO] [stderr] For more information try --help [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::cli] Msg error: The following required arguments were not provided: [INFO] [stderr] --url [INFO] [stderr] [INFO] [stderr] USAGE: [INFO] [stderr] test --timeout --url [INFO] [stderr] [INFO] [stderr] For more information try --help [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::cli] Msg error: The following required arguments were not provided: [INFO] [stderr] --url [INFO] [stderr] [INFO] [stderr] USAGE: [INFO] [stderr] test -f --url [INFO] [stderr] [INFO] [stderr] For more information try --help [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Decoded: YIGLgBZUZWNobmlrZXIgS3Jhbmtlbmthc3NlgQcxMzc3NTA4jwUwMDAyMIIMMTIzNDU2Nzg5MDEygwQ1MDAwkAExhQtBbWVsaWUgU2luYYcFQXBmZWyICDExMDkxOTk1iRJDYXJsLVdvbGZmLVN0ci4gMTKKAUSLBTQ1Mjc5jAVFc3Nlbo0EMTAyMY4B/A== [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Encoded: [96, 129, 139, 128, 22, 84, 101, 99, 104, 110, 105, 107, 101, 114, 32, 75, 114, 97, 110, 107, 101, 110, 107, 97, 115, 115, 101, 129, 7, 49, 51, 55, 55, 53, 48, 56, 143, 5, 48, 48, 48, 50, 48, 130, 12, 49, 50, 51, 52, 53, 54, 55, 56, 57, 48, 49, 50, 131, 4, 53, 48, 48, 48, 144, 1, 49, 133, 11, 65, 109, 101, 108, 105, 101, 32, 83, 105, 110, 97, 135, 5, 65, 112, 102, 101, 108, 136, 8, 49, 49, 48, 57, 49, 57, 57, 53, 137, 18, 67, 97, 114, 108, 45, 87, 111, 108, 102, 102, 45, 83, 116, 114, 46, 32, 49, 50, 138, 1, 68, 139, 5, 52, 53, 50, 55, 57, 140, 5, 69, 115, 115, 101, 110, 141, 4, 49, 48, 50, 49, 142, 1, 252] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kkn [54, 65, 63, 68, 6e, 69, 6b, 65, 72, 20, 4b, 72, 61, 6e, 6b, 65, 6e, 6b, 61, 73, 73, 65] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kknr [31, 33, 37, 37, 35, 30, 38] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vknr [30, 30, 30, 32, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vnr [31, 32, 33, 34, 35, 36, 37, 38, 39, 30, 31, 32] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vs [35, 30, 30, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] se [31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] t None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] v [41, 6d, 65, 6c, 69, 65, 20, 53, 69, 6e, 61] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] nz None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] f [41, 70, 66, 65, 6c] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] gd [31, 31, 30, 39, 31, 39, 39, 35] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] sn Some([43, 61, 72, 6c, 2d, 57, 6f, 6c, 66, 66, 2d, 53, 74, 72, 2e, 20, 31, 32]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] wlc Some([44]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] plz [34, 35, 32, 37, 39] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] on [45, 73, 73, 65, 6e] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] g [31, 30, 32, 31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] ps [fc] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] ASN.1 decoded: [INFO] [stderr] KrankenKassenName: Techniker Krankenkasse [INFO] [stderr] KrankenKassenNummer: 1377508 [INFO] [stderr] VKNR: 00020 [INFO] [stderr] VersichertenNummer: 123456789012 [INFO] [stderr] VersichertenStatus: 5000 [INFO] [stderr] StatusErgänzung: 1 [INFO] [stderr] VorName: Amelie Sina [INFO] [stderr] FamilienName: Apfel [INFO] [stderr] GeburtsDatum: 11091995 [INFO] [stderr] Straßenname: Carl-Wolff-Str. 12 [INFO] [stderr] WohnsitzLänderCode: D [INFO] [stderr] Postleitzahl: 45279 [INFO] [stderr] Orstname: Essen [INFO] [stderr] GültigkeitsDatum: 1021 [INFO] [stdout] test api::tests::deserialize_egk_carddata_v1 ... ok [INFO] [stdout] test api::tests::deserialize_kvk_carddata_v2 ... ok [INFO] [stdout] test config::tests::no_valid_url_parameter ... ignored [INFO] [stdout] test config::tests::defaults ... ok [INFO] [stdout] test config::tests::default_configuration ... ok [INFO] [stdout] test cli::required_argument_url ... ok [INFO] [stdout] test cli::tests::allowed_values_for_api ... ok [INFO] [stdout] test api::tests::deserialize_egk_carddata_v2 ... ok [INFO] [stdout] test api::v3::tests::deserialize_kvk_carddata ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Decoded: YIGLgBZUZWNobmlrZXIgS3Jhbmtlbmthc3NlgQcxMzc3NTA4jwUwMDAyMIIMMTIzNDU2Nzg5MDEygwQ1MDAwkAExhQtBbWVsaWUgU2luYYcFQXBmZWyICDExMDkxOTk1iRJDYXJsLVdvbGZmLVN0ci4gMTKKAUSLBTQ1Mjc5jAVFc3Nlbo0EMTAyMY4B/A== [INFO] [stdout] test api::tests::deserialize_kvk_carddata_v1 ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Encoded: [96, 129, 139, 128, 22, 84, 101, 99, 104, 110, 105, 107, 101, 114, 32, 75, 114, 97, 110, 107, 101, 110, 107, 97, 115, 115, 101, 129, 7, 49, 51, 55, 55, 53, 48, 56, 143, 5, 48, 48, 48, 50, 48, 130, 12, 49, 50, 51, 52, 53, 54, 55, 56, 57, 48, 49, 50, 131, 4, 53, 48, 48, 48, 144, 1, 49, 133, 11, 65, 109, 101, 108, 105, 101, 32, 83, 105, 110, 97, 135, 5, 65, 112, 102, 101, 108, 136, 8, 49, 49, 48, 57, 49, 57, 57, 53, 137, 18, 67, 97, 114, 108, 45, 87, 111, 108, 102, 102, 45, 83, 116, 114, 46, 32, 49, 50, 138, 1, 68, 139, 5, 52, 53, 50, 55, 57, 140, 5, 69, 115, 115, 101, 110, 141, 4, 49, 48, 50, 49, 142, 1, 252] [INFO] [stdout] test writer::encode::tests::xml_declaration_is_added ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kkn [54, 65, 63, 68, 6e, 69, 6b, 65, 72, 20, 4b, 72, 61, 6e, 6b, 65, 6e, 6b, 61, 73, 73, 65] [INFO] [stdout] test writer::encode::tests::xml_declaration_is_not_added ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kknr [31, 33, 37, 37, 35, 30, 38] [INFO] [stdout] test kvk::fmt::tests::fmt_returns_error_string_if_invalid_bytes_given ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vknr [30, 30, 30, 32, 30] [INFO] [stdout] test api::tests::deserialize_kvk_carddata_v3 ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vnr [31, 32, 33, 34, 35, 36, 37, 38, 39, 30, 31, 32] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vs [35, 30, 30, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] se [31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] t None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] v [41, 6d, 65, 6c, 69, 65, 20, 53, 69, 6e, 61] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] nz None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] f [41, 70, 66, 65, 6c] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] gd [31, 31, 30, 39, 31, 39, 39, 35] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] sn Some([43, 61, 72, 6c, 2d, 57, 6f, 6c, 66, 66, 2d, 53, 74, 72, 2e, 20, 31, 32]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] wlc Some([44]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] plz [34, 35, 32, 37, 39] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] on [45, 73, 73, 65, 6e] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] g [31, 30, 32, 31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] ps [fc] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] ASN.1 decoded: [INFO] [stderr] KrankenKassenName: Techniker Krankenkasse [INFO] [stderr] KrankenKassenNummer: 1377508 [INFO] [stderr] VKNR: 00020 [INFO] [stderr] VersichertenNummer: 123456789012 [INFO] [stderr] VersichertenStatus: 5000 [INFO] [stderr] StatusErgänzung: 1 [INFO] [stderr] VorName: Amelie Sina [INFO] [stderr] FamilienName: Apfel [INFO] [stderr] GeburtsDatum: 11091995 [INFO] [stderr] Straßenname: Carl-Wolff-Str. 12 [INFO] [stderr] WohnsitzLänderCode: D [INFO] [stderr] Postleitzahl: 45279 [INFO] [stderr] Orstname: Essen [INFO] [stderr] GültigkeitsDatum: 1021 [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Decoded: YIGXgBpCdW5kZXNwb2xpemVpLUtyYW5rZW5rYXNzZYEHMzYwMDM0Mo8FMDAwMjCCDDEyMzQ1Njc4OTAxM4MEMTAwMJABMYUSRGFuaWVsIEd1c3RhdiBMdXR6hwZIfG5zY2iICDE3MDUxOTYxiRJDYXJsLVdvbGZmLVN0ci4gMTKKAUSLBTQ1Mjc5jAVFc3Nlbo0EMTAyMY4BiA== [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Encoded: [96, 129, 151, 128, 26, 66, 117, 110, 100, 101, 115, 112, 111, 108, 105, 122, 101, 105, 45, 75, 114, 97, 110, 107, 101, 110, 107, 97, 115, 115, 101, 129, 7, 51, 54, 48, 48, 51, 52, 50, 143, 5, 48, 48, 48, 50, 48, 130, 12, 49, 50, 51, 52, 53, 54, 55, 56, 57, 48, 49, 51, 131, 4, 49, 48, 48, 48, 144, 1, 49, 133, 18, 68, 97, 110, 105, 101, 108, 32, 71, 117, 115, 116, 97, 118, 32, 76, 117, 116, 122, 135, 6, 72, 124, 110, 115, 99, 104, 136, 8, 49, 55, 48, 53, 49, 57, 54, 49, 137, 18, 67, 97, 114, 108, 45, 87, 111, 108, 102, 102, 45, 83, 116, 114, 46, 32, 49, 50, 138, 1, 68, 139, 5, 52, 53, 50, 55, 57, 140, 5, 69, 115, 115, 101, 110, 141, 4, 49, 48, 50, 49, 142, 1, 136] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kkn [42, 75, 6e, 64, 65, 73, 70, 6f, 6c, 69, 7a, 65, 69, 2d, 4b, 72, 61, 6e, 6b, 65, 6e, 6b, 61, 73, 73, 65] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kknr [33, 36, 30, 30, 33, 34, 32] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vknr [30, 30, 30, 32, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vnr [31, 32, 33, 34, 35, 36, 37, 38, 39, 30, 31, 33] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vs [31, 30, 30, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] se [31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] t None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] v [44, 61, 6e, 69, 65, 6c, 20, 47, 75, 73, 74, 61, 76, 20, 4c, 75, 74, 7a] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] nz None [INFO] [stdout] test kvk::fmt::tests::fmt_not_replaces_latin_alphabet_and_arabic_numbers ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] f [48, 7c, 6e, 73, 63, 68] [INFO] [stdout] test kvk::fmt::tests::fmt_replaces_chars_according_to_din_66003 ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] gd [31, 37, 30, 35, 31, 39, 36, 31] [INFO] [stdout] test http::tests::supported_api_version ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] sn Some([43, 61, 72, 6c, 2d, 57, 6f, 6c, 66, 66, 2d, 53, 74, 72, 2e, 20, 31, 32]) [INFO] [stdout] test kvk::test::decode_base64_encoded_asn1_data ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] wlc Some([44]) [INFO] [stdout] test api::tests::deserialize_egk_carddata_v3 ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] plz [34, 35, 32, 37, 39] [INFO] [stdout] test writer::encode::tests::encoding_from_xml_declaration_or_default ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] on [45, 73, 73, 65, 6e] [INFO] [stdout] test writer::files::tests::filenames ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] g [31, 30, 32, 31] [INFO] [stdout] test egk::tests::write_mfefgdo_ok ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] ps [88] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] ASN.1 decoded: [INFO] [stderr] KrankenKassenName: Bundespolizei-Krankenkasse [INFO] [stderr] KrankenKassenNummer: 3600342 [INFO] [stderr] VKNR: 00020 [INFO] [stderr] VersichertenNummer: 123456789013 [INFO] [stderr] VersichertenStatus: 1000 [INFO] [stderr] StatusErgänzung: 1 [INFO] [stderr] VorName: Daniel Gustav Lutz [INFO] [stderr] FamilienName: Hönsch [INFO] [stderr] GeburtsDatum: 17051961 [INFO] [stderr] Straßenname: Carl-Wolff-Str. 12 [INFO] [stderr] WohnsitzLänderCode: D [INFO] [stderr] Postleitzahl: 45279 [INFO] [stderr] Orstname: Essen [INFO] [stderr] GültigkeitsDatum: 1021 [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(30)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(54)) start runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE polling::epoll] add: epoll_fd=6, fd=8, ev=Event { key: 18446744073709551615, readable: false, writable: false } [INFO] [stderr] [2021-07-19T01:19:40Z TRACE polling::epoll] add: epoll_fd=6, fd=7, ev=Event { key: 18446744073709551615, readable: true, writable: false } [INFO] [stderr] [2021-07-19T01:19:40Z TRACE polling::epoll] new: epoll_fd=6, event_fd=7, timer_fd=Some(8) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: waiting on I/O [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::reactor] process_timers: 0 ready wakers [INFO] [stderr] [2021-07-19T01:19:40Z TRACE polling] Poller::wait(_, None) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE polling::epoll] wait: epoll_fd=6, timeout=None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE polling::epoll] modify: epoll_fd=6, fd=8, ev=Event { key: 18446744073709551615, readable: true, writable: false } [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closing runtime thread (ThreadId(54)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(54)) Receiver is shutdown [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(54)) end runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(54)) finished [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] signaled close for runtime thread (ThreadId(54)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closed runtime thread (ThreadId(54)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(30)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 50 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmpG1Nv2U [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmpG1Nv2U/config.ini", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmpG1Nv2U [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stdout] test api::v2::tests::deserialize_egk_carddata ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 75 us [INFO] [stdout] test config::tests::config_file_overrides ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::api::v1::tests] [INFO] [stderr] [INFO] [stderr] DIR [INFO] [stderr] Ok("/opt/rustwide/workdir") [INFO] [stderr] [INFO] [stderr] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 100 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: completed [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_std::task::builder] block_on [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(29)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: notified [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(1), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 50 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 75 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Decoded: YIGLgBZUZWNobmlrZXIgS3Jhbmtlbmthc3NlgQcxMzc3NTA4jwUwMDAyMIIMMTIzNDU2Nzg5MDEygwQ1MDAwkAExhQtBbWVsaWUgU2luYYcFQXBmZWyICDExMDkxOTk1iRJDYXJsLVdvbGZmLVN0ci4gMTKKAUSLBTQ1Mjc5jAVFc3Nlbo0EMTAyMY4B/A== [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Encoded: [96, 129, 139, 128, 22, 84, 101, 99, 104, 110, 105, 107, 101, 114, 32, 75, 114, 97, 110, 107, 101, 110, 107, 97, 115, 115, 101, 129, 7, 49, 51, 55, 55, 53, 48, 56, 143, 5, 48, 48, 48, 50, 48, 130, 12, 49, 50, 51, 52, 53, 54, 55, 56, 57, 48, 49, 50, 131, 4, 53, 48, 48, 48, 144, 1, 49, 133, 11, 65, 109, 101, 108, 105, 101, 32, 83, 105, 110, 97, 135, 5, 65, 112, 102, 101, 108, 136, 8, 49, 49, 48, 57, 49, 57, 57, 53, 137, 18, 67, 97, 114, 108, 45, 87, 111, 108, 102, 102, 45, 83, 116, 114, 46, 32, 49, 50, 138, 1, 68, 139, 5, 52, 53, 50, 55, 57, 140, 5, 69, 115, 115, 101, 110, 141, 4, 49, 48, 50, 49, 142, 1, 252] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kkn [54, 65, 63, 68, 6e, 69, 6b, 65, 72, 20, 4b, 72, 61, 6e, 6b, 65, 6e, 6b, 61, 73, 73, 65] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kknr [31, 33, 37, 37, 35, 30, 38] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vknr [30, 30, 30, 32, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vnr [31, 32, 33, 34, 35, 36, 37, 38, 39, 30, 31, 32] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vs [35, 30, 30, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] se [31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] t None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] v [41, 6d, 65, 6c, 69, 65, 20, 53, 69, 6e, 61] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] nz None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] f [41, 70, 66, 65, 6c] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] gd [31, 31, 30, 39, 31, 39, 39, 35] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] sn Some([43, 61, 72, 6c, 2d, 57, 6f, 6c, 66, 66, 2d, 53, 74, 72, 2e, 20, 31, 32]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] wlc Some([44]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] plz [34, 35, 32, 37, 39] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] on [45, 73, 73, 65, 6e] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] g [31, 30, 32, 31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] ps [fc] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] ASN.1 decoded: [INFO] [stderr] KrankenKassenName: Techniker Krankenkasse [INFO] [stderr] KrankenKassenNummer: 1377508 [INFO] [stderr] VKNR: 00020 [INFO] [stderr] VersichertenNummer: 123456789012 [INFO] [stderr] VersichertenStatus: 5000 [INFO] [stderr] StatusErgänzung: 1 [INFO] [stderr] VorName: Amelie Sina [INFO] [stderr] FamilienName: Apfel [INFO] [stderr] GeburtsDatum: 11091995 [INFO] [stderr] Straßenname: Carl-Wolff-Str. 12 [INFO] [stderr] WohnsitzLänderCode: D [INFO] [stderr] Postleitzahl: 45279 [INFO] [stderr] Orstname: Essen [INFO] [stderr] GültigkeitsDatum: 1021 [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(60)) start runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closing runtime thread (ThreadId(60)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] signaled close for runtime thread (ThreadId(60)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(60)) Receiver is shutdown [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(60)) end runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(60)) finished [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closed runtime thread (ThreadId(60)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 100 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stdout] test api::v1::tests::deserialize_egk_carddata ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stdout] test api::v1::tests::deserialize_kvk_carddata ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stdout] test http::tests::build_client_timeout ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_std::task::builder] block_on [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_std::task::builder] block_on [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmplDCpYn [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_MFEFGDO.xml" [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmplDCpYn/eGK_MFEFGDO.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmplDCpYn [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 250 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 500 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 750 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(1), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 1000 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 2500 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(31)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(32)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stdout] test egk::mfefgdo::tests::valid_xml_layout ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 5000 us [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(86)) start runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] main_loop: sleeping for 10000 us [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::http] Requesting http://127.0.0.1:37969/k2/public/api/1/carddata ... [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] wait at most 2s [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(31)) park timeout 1.999992569s [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on() [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG reqwest::connect] starting new connection: http://127.0.0.1:37969/ [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal found waiting giver, notifying [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] poll_want: taker wants! [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(87)) start runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::http] Requesting http://127.0.0.1:46243/k2/public/api/1/carddata ... [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(32)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: sleep until notification [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(1), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(2), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(83)) start runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmptsXphX [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG wiremock::mock_set] Handling request. [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::http] Requesting http://127.0.0.1:42487/k2/public/api/2/carddata ... [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(29)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG reqwest::connect] starting new connection: http://127.0.0.1:46243/ [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG reqwest::connect] starting new connection: http://127.0.0.1:42487/ [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(16777217), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal found waiting giver, notifying [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] poll_want: taker wants! [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal found waiting giver, notifying [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] poll_want: taker wants! [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG wiremock::mock_set] Handling request. [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG reqwest::async_impl::client] response '200 OK' for http://127.0.0.1:42487/k2/public/api/2/carddata [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::http] Response { url: Url { scheme: "http", cannot_be_a_base: false, username: "", password: None, host: Some(Ipv4(127.0.0.1)), port: Some(42487), path: "/k2/public/api/2/carddata", query: None, fragment: None }, status: 200, headers: {"content-type": "application/json", "content-length": "2", "date": "Mon, 19 Jul 2021 01:19:40 GMT"} } [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closing runtime thread (ThreadId(83)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] signaled close for runtime thread (ThreadId(83)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(83)) Receiver is shutdown [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(83)) end runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Closed [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(83)) finished [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closed runtime thread (ThreadId(83)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(29)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(16777217), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG wiremock::mock_set] Handling request. [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(89)) start runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::http] Requesting http://127.0.0.1:42487/k2/public/api/3/cards ... [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(29)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG reqwest::connect] starting new connection: http://127.0.0.1:42487/ [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(33554433), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal found waiting giver, notifying [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] poll_want: taker wants! [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG wiremock::mock_set] Handling request. [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG reqwest::async_impl::client] response '200 OK' for http://127.0.0.1:42487/k2/public/api/3/cards [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::http] Response { url: Url { scheme: "http", cannot_be_a_base: false, username: "", password: None, host: Some(Ipv4(127.0.0.1)), port: Some(42487), path: "/k2/public/api/3/cards", query: None, fragment: None }, status: 200, headers: {"content-type": "application/json", "content-length": "2", "date": "Mon, 19 Jul 2021 01:19:40 GMT"} } [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closing runtime thread (ThreadId(89)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] signaled close for runtime thread (ThreadId(89)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(89)) Receiver is shutdown [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(89)) end runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Closed [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(89)) finished [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closed runtime thread (ThreadId(89)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(29)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(90)) start runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::http] Requesting http://127.0.0.1:42487/k2/public/api/1/carddata ... [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::wait] (ThreadId(29)) park without timeout [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG reqwest::connect] starting new connection: http://127.0.0.1:42487/ [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(50331649), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE | WRITABLE [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal found waiting giver, notifying [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] poll_want: taker wants! [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG wiremock::mock_set] Handling request. [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG reqwest::async_impl::client] response '200 OK' for http://127.0.0.1:42487/k2/public/api/1/carddata [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::http] Response { url: Url { scheme: "http", cannot_be_a_base: false, username: "", password: None, host: Some(Ipv4(127.0.0.1)), port: Some(42487), path: "/k2/public/api/1/carddata", query: None, fragment: None }, status: 200, headers: {"content-type": "application/json", "content-length": "2", "date": "Mon, 19 Jul 2021 01:19:40 GMT"} } [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closing runtime thread (ThreadId(90)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] signaled close for runtime thread (ThreadId(90)) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(90)) Receiver is shutdown [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(90)) end runtime::block_on [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:40Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:40Z TRACE want] signal: Closed [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] (ThreadId(90)) finished [INFO] [stderr] [2021-07-19T01:19:40Z TRACE reqwest::blocking::client] closed runtime thread (ThreadId(90)) [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG wiremock::mock_server::exposed_server] Verify mock expectations. [INFO] [stderr] [2021-07-19T01:19:40Z TRACE async_io::driver] block_on: completed [INFO] [stdout] test http::tests::build_client_api_endpoint ... ok [INFO] [stdout] test http::tests::build_client_wrong_api - should panic ... ok [INFO] [stdout] test http::tests::unsupported_api_version_zero - should panic ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stdout] test http::tests::unsupported_api_version_four - should panic ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_PersoenlicheVersichertendaten.xml" [INFO] [stdout] test egk::tests::write_mfefgdo_failed ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_allgemeineVersicherungsdaten.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stdout] test egk::tests::pn_is_written ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_MFDF_HCA_EF_StatusVD.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_geschuetzteVersichertendaten.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_Pruefungsnachweis.xml" [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmptsXphX/eGK_allgemeineVersicherungsdaten.xml", [INFO] [stderr] "/tmp/.tmptsXphX/eGK_MFDF_HCA_EF_StatusVD.xml", [INFO] [stderr] "/tmp/.tmptsXphX/eGK_Pruefungsnachweis.xml", [INFO] [stderr] "/tmp/.tmptsXphX/eGK_geschuetzteVersichertendaten.xml", [INFO] [stderr] "/tmp/.tmptsXphX/eGK_PersoenlicheVersichertendaten.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmptsXphX [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmpd7vgPw [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_Pruefungsnachweis.xml" [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmpd7vgPw/eGK_Pruefungsnachweis.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmpd7vgPw [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Decoded: YIGLgBZUZWNobmlrZXIgS3Jhbmtlbmthc3NlgQcxMzc3NTA4jwUwMDAyMIIMMTIzNDU2Nzg5MDEygwQ1MDAwkAExhQtBbWVsaWUgU2luYYcFQXBmZWyICDExMDkxOTk1iRJDYXJsLVdvbGZmLVN0ci4gMTKKAUSLBTQ1Mjc5jAVFc3Nlbo0EMTAyMY4B/A== [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Encoded: [96, 129, 139, 128, 22, 84, 101, 99, 104, 110, 105, 107, 101, 114, 32, 75, 114, 97, 110, 107, 101, 110, 107, 97, 115, 115, 101, 129, 7, 49, 51, 55, 55, 53, 48, 56, 143, 5, 48, 48, 48, 50, 48, 130, 12, 49, 50, 51, 52, 53, 54, 55, 56, 57, 48, 49, 50, 131, 4, 53, 48, 48, 48, 144, 1, 49, 133, 11, 65, 109, 101, 108, 105, 101, 32, 83, 105, 110, 97, 135, 5, 65, 112, 102, 101, 108, 136, 8, 49, 49, 48, 57, 49, 57, 57, 53, 137, 18, 67, 97, 114, 108, 45, 87, 111, 108, 102, 102, 45, 83, 116, 114, 46, 32, 49, 50, 138, 1, 68, 139, 5, 52, 53, 50, 55, 57, 140, 5, 69, 115, 115, 101, 110, 141, 4, 49, 48, 50, 49, 142, 1, 252] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kkn [54, 65, 63, 68, 6e, 69, 6b, 65, 72, 20, 4b, 72, 61, 6e, 6b, 65, 6e, 6b, 61, 73, 73, 65] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kknr [31, 33, 37, 37, 35, 30, 38] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vknr [30, 30, 30, 32, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vnr [31, 32, 33, 34, 35, 36, 37, 38, 39, 30, 31, 32] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vs [35, 30, 30, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] se [31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] t None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] v [41, 6d, 65, 6c, 69, 65, 20, 53, 69, 6e, 61] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] nz None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] f [41, 70, 66, 65, 6c] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] gd [31, 31, 30, 39, 31, 39, 39, 35] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] sn Some([43, 61, 72, 6c, 2d, 57, 6f, 6c, 66, 66, 2d, 53, 74, 72, 2e, 20, 31, 32]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] wlc Some([44]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] plz [34, 35, 32, 37, 39] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] on [45, 73, 73, 65, 6e] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] g [31, 30, 32, 31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] ps [fc] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] ASN.1 decoded: [INFO] [stderr] KrankenKassenName: Techniker Krankenkasse [INFO] [stderr] KrankenKassenNummer: 1377508 [INFO] [stderr] VKNR: 00020 [INFO] [stderr] VersichertenNummer: 123456789012 [INFO] [stderr] VersichertenStatus: 5000 [INFO] [stderr] StatusErgänzung: 1 [INFO] [stderr] VorName: Amelie Sina [INFO] [stderr] FamilienName: Apfel [INFO] [stderr] GeburtsDatum: 11091995 [INFO] [stderr] Straßenname: Carl-Wolff-Str. 12 [INFO] [stderr] WohnsitzLänderCode: D [INFO] [stderr] Postleitzahl: 45279 [INFO] [stderr] Orstname: Essen [INFO] [stderr] GültigkeitsDatum: 1021 [INFO] [stdout] test api::v2::tests::deserialize_kvk_carddata ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmpcpw6iD [INFO] [stdout] test api::v3::tests::deserialize_egk_carddata ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stdout] test egk::tests::pd_is_written ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_PersoenlicheVersichertendaten.xml" [INFO] [stdout] test egk::tests::status_vd_is_written ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stdout] test egk::tests::gvd_is_written ... ok [INFO] [stderr] "/tmp/.tmpcpw6iD/eGK_PersoenlicheVersichertendaten.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmpcpw6iD [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmptqZAJw [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_MFDF_HCA_EF_StatusVD.xml" [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmptqZAJw/eGK_MFDF_HCA_EF_StatusVD.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmptqZAJw [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmpYTBU7E [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_geschuetzteVersichertendaten.xml" [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmpYTBU7E/eGK_geschuetzteVersichertendaten.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmpYTBU7E [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmp8kFwpm [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmp8kFwpm [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stdout] test config::tests::config_file_missing ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmpq7mnDv [INFO] [stdout] test egk::tests::vd_is_written ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stdout] test writer::results::tests::optional_values_are_null ... ok [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "eGK_allgemeineVersicherungsdaten.xml" [INFO] [stdout] test egk::tests::all_files_written ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmpq7mnDv/eGK_allgemeineVersicherungsdaten.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmpq7mnDv [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmpz7Cpky [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "Result.xml" [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmpz7Cpky/Result.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmpz7Cpky [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /tmp/.tmpbZlrQo [INFO] [stdout] test writer::tests::not_prompting_before_cleanup ... ok [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Decoded: YIGLgBZUZWNobmlrZXIgS3Jhbmtlbmthc3NlgQcxMzc3NTA4jwUwMDAyMIIMMTIzNDU2Nzg5MDEygwQ1MDAwkAExhQtBbWVsaWUgU2luYYcFQXBmZWyICDExMDkxOTk1iRJDYXJsLVdvbGZmLVN0ci4gMTKKAUSLBTQ1Mjc5jAVFc3Nlbo0EMTAyMY4B/A== [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] Encoded: [96, 129, 139, 128, 22, 84, 101, 99, 104, 110, 105, 107, 101, 114, 32, 75, 114, 97, 110, 107, 101, 110, 107, 97, 115, 115, 101, 129, 7, 49, 51, 55, 55, 53, 48, 56, 143, 5, 48, 48, 48, 50, 48, 130, 12, 49, 50, 51, 52, 53, 54, 55, 56, 57, 48, 49, 50, 131, 4, 53, 48, 48, 48, 144, 1, 49, 133, 11, 65, 109, 101, 108, 105, 101, 32, 83, 105, 110, 97, 135, 5, 65, 112, 102, 101, 108, 136, 8, 49, 49, 48, 57, 49, 57, 57, 53, 137, 18, 67, 97, 114, 108, 45, 87, 111, 108, 102, 102, 45, 83, 116, 114, 46, 32, 49, 50, 138, 1, 68, 139, 5, 52, 53, 50, 55, 57, 140, 5, 69, 115, 115, 101, 110, 141, 4, 49, 48, 50, 49, 142, 1, 252] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kkn [54, 65, 63, 68, 6e, 69, 6b, 65, 72, 20, 4b, 72, 61, 6e, 6b, 65, 6e, 6b, 61, 73, 73, 65] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] kknr [31, 33, 37, 37, 35, 30, 38] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vknr [30, 30, 30, 32, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vnr [31, 32, 33, 34, 35, 36, 37, 38, 39, 30, 31, 32] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] vs [35, 30, 30, 30] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] se [31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] t None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] v [41, 6d, 65, 6c, 69, 65, 20, 53, 69, 6e, 61] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] nz None [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] f [41, 70, 66, 65, 6c] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] gd [31, 31, 30, 39, 31, 39, 39, 35] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] sn Some([43, 61, 72, 6c, 2d, 57, 6f, 6c, 66, 66, 2d, 53, 74, 72, 2e, 20, 31, 32]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] wlc Some([44]) [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] plz [34, 35, 32, 37, 39] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] on [45, 73, 73, 65, 6e] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] g [31, 30, 32, 31] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk::parser] ps [fc] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::kvk] ASN.1 decoded: [INFO] [stderr] KrankenKassenName: Techniker Krankenkasse [INFO] [stderr] KrankenKassenNummer: 1377508 [INFO] [stderr] VKNR: 00020 [INFO] [stderr] VersichertenNummer: 123456789012 [INFO] [stderr] VersichertenStatus: 5000 [INFO] [stderr] StatusErgänzung: 1 [INFO] [stderr] VorName: Amelie Sina [INFO] [stderr] FamilienName: Apfel [INFO] [stderr] GeburtsDatum: 11091995 [INFO] [stderr] Straßenname: Carl-Wolff-Str. 12 [INFO] [stderr] WohnsitzLänderCode: D [INFO] [stderr] Postleitzahl: 45279 [INFO] [stderr] Orstname: Essen [INFO] [stderr] GültigkeitsDatum: 1021 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Deleted "eGK_allgemeineVersicherungsdaten.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Deleted "eGK_geschuetzteVersichertendaten.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Deleted "eGK_PersoenlicheVersichertendaten.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Deleted "eGK_MFDF_HCA_EF_StatusVD.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Deleted "eGK_Pruefungsnachweis.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Deleted "eGK_MFEFGDO.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Deleted "Result.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::encode] No encoding found. Defaulting to iso-8859-15 [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "Result.xml" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "KVK.dat" [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::writer::files] Wrote file "KVK_Daten.bin" [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmpbZlrQo/KVK_Daten.bin", [INFO] [stderr] "/tmp/.tmpbZlrQo/KVK.dat", [INFO] [stderr] "/tmp/.tmpbZlrQo/Result.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Files: [ [INFO] [stderr] "/tmp/.tmpbZlrQo/KVK_Daten.bin", [INFO] [stderr] "/tmp/.tmpbZlrQo/KVK.dat", [INFO] [stderr] "/tmp/.tmpbZlrQo/Result.xml", [INFO] [stderr] ] [INFO] [stderr] [2021-07-19T01:19:40Z TRACE k2_creek::tests] Leaving /tmp/.tmpbZlrQo [INFO] [stderr] [2021-07-19T01:19:40Z DEBUG k2_creek::tests] Current dir: /opt/rustwide/workdir [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::wait] wait timeout exceeded [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] closing runtime thread (ThreadId(86)) [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] signaled close for runtime thread (ThreadId(86)) [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] (ThreadId(86)) Receiver is shutdown [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] (ThreadId(86)) end runtime::block_on [INFO] [stdout] test http::tests::build_client_with_timeout ... ok [INFO] [stderr] [2021-07-19T01:19:42Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:42Z TRACE want] signal: Closed [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] (ThreadId(86)) finished [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] closed runtime thread (ThreadId(86)) [INFO] [stderr] [2021-07-19T01:19:42Z DEBUG wiremock::mock_server::exposed_server] Verify mock expectations. [INFO] [stderr] [2021-07-19T01:19:42Z TRACE async_io::driver] block_on: completed [INFO] [stderr] [2021-07-19T01:19:42Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:42Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:42Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:42Z DEBUG reqwest::async_impl::client] response '200 OK' for http://127.0.0.1:46243/k2/public/api/1/carddata [INFO] [stderr] [2021-07-19T01:19:42Z TRACE k2_creek::http] Response { url: Url { scheme: "http", cannot_be_a_base: false, username: "", password: None, host: Some(Ipv4(127.0.0.1)), port: Some(46243), path: "/k2/public/api/1/carddata", query: None, fragment: None }, status: 200, headers: {"content-type": "application/json", "content-length": "13", "date": "Mon, 19 Jul 2021 01:19:42 GMT"} } [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] closing runtime thread (ThreadId(87)) [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] signaled close for runtime thread (ThreadId(87)) [INFO] [stderr] [2021-07-19T01:19:42Z TRACE want] signal: Want [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] (ThreadId(87)) Receiver is shutdown [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] (ThreadId(87)) end runtime::block_on [INFO] [stderr] [2021-07-19T01:19:42Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:42Z TRACE want] signal: Closed [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] (ThreadId(87)) finished [INFO] [stderr] [2021-07-19T01:19:42Z TRACE mio::poll] deregistering event source from poller [INFO] [stderr] [2021-07-19T01:19:42Z TRACE reqwest::blocking::client] closed runtime thread (ThreadId(87)) [INFO] [stderr] [2021-07-19T01:19:42Z DEBUG wiremock::mock_server::exposed_server] Verify mock expectations. [INFO] [stderr] [2021-07-19T01:19:42Z TRACE async_io::driver] block_on: completed [INFO] [stdout] test http::tests::build_client_without_timeout ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 45 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out; finished in 2.22s [INFO] [stdout] [INFO] [stderr] Running unittests (/opt/rustwide/target/debug/deps/k2_creek-657034c5a5459ee1) [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] [stderr] Running tests/cli.rs (/opt/rustwide/target/debug/deps/cli-291361bd8350aa82) [INFO] [stdout] [INFO] [stdout] running 2 tests [INFO] [stdout] test help_is_displayed ... ok [INFO] [stdout] test usage_is_displayed ... ok [INFO] [stdout] [INFO] [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.08s [INFO] [stdout] [INFO] [stderr] Doc-tests k2-creek [INFO] [stdout] [INFO] [stdout] running 0 tests [INFO] [stdout] [INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s [INFO] [stdout] [INFO] running `Command { std: "docker" "inspect" "4d499fda7798478d4909f3d71e49fbce9463a0c29dced59d22e70908b5bcb1b6", kill_on_drop: false }` [INFO] running `Command { std: "docker" "rm" "-f" "4d499fda7798478d4909f3d71e49fbce9463a0c29dced59d22e70908b5bcb1b6", kill_on_drop: false }` [INFO] [stdout] 4d499fda7798478d4909f3d71e49fbce9463a0c29dced59d22e70908b5bcb1b6