[INFO] cloning repository https://github.com/a-givertzman/rust-sal-sync
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/a-givertzman/rust-sal-sync" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fa-givertzman%2Frust-sal-sync", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fa-givertzman%2Frust-sal-sync'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] d3deab1bfe7bfb790f311cadb825e11c79bbe2a3
[INFO] testing a-givertzman/rust-sal-sync against 1.83.0 for beta-1.84.0-4-retry
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fa-givertzman%2Frust-sal-sync" "/workspace/builds/worker-3-tc1/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-3-tc1/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/a-givertzman/rust-sal-sync on toolchain 1.83.0
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.83.0" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] started tweaking git repo https://github.com/a-givertzman/rust-sal-sync
[INFO] finished tweaking git repo https://github.com/a-givertzman/rust-sal-sync
[INFO] tweaked toml for git repo https://github.com/a-givertzman/rust-sal-sync written to /workspace/builds/worker-3-tc1/source/Cargo.toml
[INFO] crate git repo https://github.com/a-givertzman/rust-sal-sync already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1.83.0" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating git repository `https://github.com/a-givertzman/rust-api-tools.git`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Updating git repository `https://github.com/a-givertzman/rust-debuging.git`
[INFO] [stderr]     Updating git repository `https://github.com/a-givertzman/rust-testing.git`
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded lexical v7.0.2
[INFO] [stderr]   Downloaded lexical-core v1.0.2
[INFO] [stderr]   Downloaded lexical-write-integer v1.0.2
[INFO] [stderr]   Downloaded lexical-util v1.0.3
[INFO] [stderr]   Downloaded lexical-parse-integer v1.0.2
[INFO] [stderr]   Downloaded lexical-write-float v1.0.2
[INFO] [stderr]   Downloaded lexical-parse-float v1.0.2
[INFO] [stderr]   Downloaded concat-in-place v1.1.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+1.83.0" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] cf76162779dd98e3513508f46a7a048ebc58c4f07d02880745764036304a7b0f
[INFO] running `Command { std: "docker" "start" "-a" "cf76162779dd98e3513508f46a7a048ebc58c4f07d02880745764036304a7b0f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "cf76162779dd98e3513508f46a7a048ebc58c4f07d02880745764036304a7b0f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "cf76162779dd98e3513508f46a7a048ebc58c4f07d02880745764036304a7b0f", kill_on_drop: false }`
[INFO] [stdout] cf76162779dd98e3513508f46a7a048ebc58c4f07d02880745764036304a7b0f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+1.83.0" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 4522c1fcc040e27e7275c1448e5e0f6dd59135fabf0be385af20033f06e890c7
[INFO] running `Command { std: "docker" "start" "-a" "4522c1fcc040e27e7275c1448e5e0f6dd59135fabf0be385af20033f06e890c7", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.89
[INFO] [stderr]    Compiling unicode-ident v1.0.13
[INFO] [stderr]    Compiling libc v0.2.162
[INFO] [stderr]    Compiling autocfg v1.4.0
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling version_check v0.9.5
[INFO] [stderr]    Compiling typenum v1.17.0
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling serde v1.0.215
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling tinyvec_macros v0.1.1
[INFO] [stderr]    Compiling regex-syntax v0.8.5
[INFO] [stderr]    Compiling log v0.4.22
[INFO] [stderr]    Compiling static_assertions v1.1.0
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling bytes v1.8.0
[INFO] [stderr]    Compiling tinyvec v1.8.0
[INFO] [stderr]    Compiling anstyle-parse v0.2.6
[INFO] [stderr]    Compiling lexical-util v1.0.3
[INFO] [stderr]    Compiling anstyle-query v1.1.2
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.1
[INFO] [stderr]    Compiling parking_lot_core v0.9.10
[INFO] [stderr]    Compiling futures-core v0.3.31
[INFO] [stderr]    Compiling ryu v1.0.18
[INFO] [stderr]    Compiling unicode-properties v0.1.3
[INFO] [stderr]    Compiling colorchoice v1.0.3
[INFO] [stderr]    Compiling pin-project-lite v0.2.15
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling cpufeatures v0.2.15
[INFO] [stderr]    Compiling itoa v1.0.11
[INFO] [stderr]    Compiling unicode-bidi v0.3.17
[INFO] [stderr]    Compiling serde_json v1.0.132
[INFO] [stderr]    Compiling anstyle v1.0.10
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling anstream v0.6.18
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling iana-time-zone v0.1.61
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling slab v0.4.9
[INFO] [stderr]    Compiling lock_api v0.4.12
[INFO] [stderr]    Compiling fallible-iterator v0.2.0
[INFO] [stderr]    Compiling smallvec v1.13.2
[INFO] [stderr]    Compiling siphasher v0.3.11
[INFO] [stderr]    Compiling phf_shared v0.11.2
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling futures-task v0.3.31
[INFO] [stderr]    Compiling phf v0.11.2
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling unicode-normalization v0.1.24
[INFO] [stderr]    Compiling lexical-parse-integer v1.0.2
[INFO] [stderr]    Compiling lexical-write-integer v1.0.2
[INFO] [stderr]    Compiling equivalent v1.0.1
[INFO] [stderr]    Compiling hashbrown v0.15.1
[INFO] [stderr]    Compiling quote v1.0.37
[INFO] [stderr]    Compiling whoami v1.5.2
[INFO] [stderr]    Compiling percent-encoding v2.3.1
[INFO] [stderr]    Compiling fxhash v0.2.1
[INFO] [stderr]    Compiling lexical-write-float v1.0.2
[INFO] [stderr]    Compiling lexical-parse-float v1.0.2
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling hashers v1.0.1
[INFO] [stderr]    Compiling concat-string v1.0.1
[INFO] [stderr]    Compiling concat-in-place v1.1.0
[INFO] [stderr]    Compiling syn v2.0.87
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling crypto-common v0.1.6
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling socket2 v0.5.7
[INFO] [stderr]    Compiling mio v1.0.2
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling parking_lot v0.12.3
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling stringprep v0.1.5
[INFO] [stderr]    Compiling lexical-core v1.0.2
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling md-5 v0.10.6
[INFO] [stderr]    Compiling sha2 v0.10.8
[INFO] [stderr]    Compiling lexical v7.0.2
[INFO] [stderr]    Compiling chrono v0.4.38
[INFO] [stderr]    Compiling tokio v1.41.1
[INFO] [stderr]    Compiling regex-automata v0.4.9
[INFO] [stderr]    Compiling regex v1.11.1
[INFO] [stderr]    Compiling zerocopy-derive v0.7.35
[INFO] [stderr]    Compiling serde_derive v1.0.215
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling async-trait v0.1.83
[INFO] [stderr]    Compiling env_filter v0.1.2
[INFO] [stderr]    Compiling env_logger v0.11.5
[INFO] [stderr]    Compiling debugging v0.0.1 (https://github.com/a-givertzman/rust-debuging.git?tag=0.0.1#18c3318a)
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling zerocopy v0.7.35
[INFO] [stderr]    Compiling tokio-util v0.7.12
[INFO] [stderr]    Compiling ppv-lite86 v0.2.20
[INFO] [stderr]    Compiling rand_chacha v0.3.1
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling postgres-protocol v0.6.7
[INFO] [stderr]    Compiling testing v0.0.2 (https://github.com/a-givertzman/rust-testing.git?tag=0.0.2#b810ec56)
[INFO] [stderr]    Compiling testing v0.1.1 (https://github.com/a-givertzman/rust-testing.git?tag=0.1.2#f18b3370)
[INFO] [stderr]    Compiling indexmap v2.6.0
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling postgres-types v0.2.8
[INFO] [stderr]    Compiling tokio-postgres v0.7.12
[INFO] [stderr]    Compiling postgres v0.19.9
[INFO] [stderr]    Compiling api-tools v0.0.6 (https://github.com/a-givertzman/rust-api-tools.git?tag=0.1.1#e7c72798)
[INFO] [stderr]    Compiling sal-sync v0.0.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 43.26s
[INFO] running `Command { std: "docker" "inspect" "4522c1fcc040e27e7275c1448e5e0f6dd59135fabf0be385af20033f06e890c7", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4522c1fcc040e27e7275c1448e5e0f6dd59135fabf0be385af20033f06e890c7", kill_on_drop: false }`
[INFO] [stdout] 4522c1fcc040e27e7275c1448e5e0f6dd59135fabf0be385af20033f06e890c7
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+1.83.0" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6c495eb6e4120d9bf66cce14c3214938b7f3940f56904f05565586cb002c399c
[INFO] running `Command { std: "docker" "start" "-a" "6c495eb6e4120d9bf66cce14c3214938b7f3940f56904f05565586cb002c399c", kill_on_drop: false }`
[INFO] [stderr]    Compiling sal-sync v0.0.3 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 6.74s
[INFO] running `Command { std: "docker" "inspect" "6c495eb6e4120d9bf66cce14c3214938b7f3940f56904f05565586cb002c399c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6c495eb6e4120d9bf66cce14c3214938b7f3940f56904f05565586cb002c399c", kill_on_drop: false }`
[INFO] [stdout] 6c495eb6e4120d9bf66cce14c3214938b7f3940f56904f05565586cb002c399c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "RUSTDOCFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:f3a9d4ad9d972b27faf3965f35b62e55ba32bbce8f20bc8fe909558a86702fde" "/opt/rustwide/cargo-home/bin/cargo" "+1.83.0" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 74b1a8976a9f8a892df35901d680c583982374fdb715f3a8fd72fbe32b47f55e
[INFO] running `Command { std: "docker" "start" "-a" "74b1a8976a9f8a892df35901d680c583982374fdb715f3a8fd72fbe32b47f55e", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.14s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sal_sync-618b1072cd78631e)
[INFO] [stdout] 
[INFO] [stdout] running 74 tests
[INFO] [stdout] test tests::unit::services::conf::conf_tree_test::config_tree::valid ... ok
[INFO] [stdout] test tests::unit::services::entity::cot_test::cot::contains ... ok
[INFO] [stdout] test tests::unit::services::conf::conf_tree_test::config_tree::as_type ... ok
[INFO] [stdout] test tests::unit::services::entity::cot_test::cot::as_str ... ok
[INFO] [stdout] test tests::unit::services::entity::name_test::name::into_string ... ok
[INFO] [stdout] test tests::unit::services::entity::name_test::name::join ... ok
[INFO] [stdout] test tests::unit::services::entity::cot_test::cot::default ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_address_test::point_config_address::empty ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_test::point_config::deserialize_json ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_type_test::point_config_type::serialize ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_address_test::point_config_address::serialize_json ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_test::point_config::serialize ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_type_test::point_config_type::deserialize_json ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_address_test::point_config_address::serialize_yaml ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_type_test::point_config_type::deserialize_yaml ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_address_test::point_config_address::deserialize_yaml ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_address_test::point_config_address::deserialize_json ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_type_test::point_config_type::to_string ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::abs ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::add ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::bitor ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::div ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::mul ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::new ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::bitand ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::new_bool ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::new_double ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::pow ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::sub ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::deserialize_json ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::status ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::new_real ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::name ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::new_int ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::to_bool ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::timestamp ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::to_real ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::to_string ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::cot ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::to_double ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::dest ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::tx_id ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::to_int ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::serialize_json ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::value ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_tx_id_test::point_tx_id::test_add ... ok
[INFO] [stdout] test tests::unit::services::service::service_test::trait_service::basic ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::type_ ... ok
[INFO] [stdout] test tests::unit::services::service::link_name_test::link_name::split ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::new_string ... ok
[INFO] [stdout] test tests::unit::services::service::link_name_test::link_name::queue ... ok
[INFO] [stdout] test tests::unit::services::subscription::subscription_ctiteria_test::subscription_criteria::performance ... ignored, Performance test
[INFO] [stdout] test tests::unit::services::service::link_name_test::link_name::service ... ok
[INFO] [stdout] test tests::unit::services::subscription::subscription_ctiteria_test::subscription_criteria::destination ... ok
[INFO] [stdout] test tests::unit::services::types::bool_test::bool::test_add ... ok
[INFO] [stdout] test tests::unit::services::types::bool_test::bool::test_bit_and ... ok
[INFO] [stdout] test tests::unit::services::types::bool_test::bool::test_bit_or ... ok
[INFO] [stdout] test tests::unit::services::types::bool_test::bool::test_mul ... ok
[INFO] [stdout] test tests::unit::services::service::service_handles_test::service_handles::into_iter ... ok
[INFO] [stdout] test tests::unit::services::service::service_handles_test::service_handles::wait ... ok
[INFO] [stdout] test tests::unit::services::types::type_of_test::type_of::basic ... ok
[INFO] [stdout] test tests::unit::services::future::future_test::future::then ... ok
[INFO] [stdout] test tests::unit::services::service::service_test::trait_service::extend_subscription - should panic ... ok
[INFO] [stdout] test tests::unit::services::service::service_test::trait_service::gi - should panic ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_test::point_config::deserialize_yaml ... ok
[INFO] [stdout] test tests::unit::services::service::service_test::trait_service::get_link - should panic ... ok
[INFO] [stdout] test tests::unit::services::service::service_test::trait_service::unsubscribe - should panic ... ok
[INFO] [stdout] test tests::unit::services::service::service_test::trait_service::subscribe - should panic ... ok
[INFO] [stdout] test tests::unit::services::subscription::subscriptions_test::subscriptions::new ... ok
[INFO] [stdout] test tests::unit::services::service::service_cycle_test::service_cycle::basic ... FAILED
[INFO] [stdout] test tests::unit::services::subscription::conf_subscribe_test::conf_subscribe::new ... ok
[INFO] [stdout] test tests::unit::services::task::functions::conf::fn_conf_keyword_test::fn_conf_keywd::invalid ... ok
[INFO] [stdout] test tests::unit::services::task::functions::conf::fn_conf_keyword_test::fn_conf_keywd::valid ... ok
[INFO] [stdout] test tests::unit::services::task::functions::conf::fn_conf_keyword_test::fn_conf_keywd::valid_options ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- tests::unit::services::service::service_cycle_test::service_cycle::basic stdout ----
[INFO] [stdout] 
[INFO] [stdout] test ServiceCycle
[INFO] [stdout] 
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [32mINFO [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m target cycle interval: 1 ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [32mINFO [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m detecting load range...
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [32mINFO [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m load range 1...2305
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [32mINFO [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m elapsed for max load: 1.300039ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 210.089µs, elapsed 1.210089ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 274.169µs, elapsed 1.274169ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.001854939
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.003979068
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.003501578
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 53.479µs, elapsed 1.053479ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.004579918
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 191.8µs, elapsed 1.1918ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 29.69µs, elapsed 1.02969ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 4.096117ms, elapsed 5.096117ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 103.849µs, elapsed 1.103849ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 144.83µs, elapsed 1.14483ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 244.269µs, elapsed 1.244269ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 1.371849ms, elapsed 2.371849ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 3.882687ms, elapsed 4.882687ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 235.899µs, elapsed 1.235899ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.002785189
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.003246268
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 8.68µs, elapsed 1.00868ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.003156958
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 3.574497ms, elapsed 4.574497ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 154.31µs, elapsed 1.15431ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.003078068
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.002521909
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 146.169µs, elapsed 1.146169ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 185.269µs, elapsed 1.185269ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 237.459µs, elapsed 1.237459ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 2.834188ms, elapsed 3.834188ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.006217307
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 102.03µs, elapsed 1.10203ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.01775789
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 181.539µs, elapsed 1.181539ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.002556748
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.003965698
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.003884218
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 31.629µs, elapsed 1.031629ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 72.879µs, elapsed 1.072879ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.010641745
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 83.44µs, elapsed 1.08344ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.007703516
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.002857198
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 25.23µs, elapsed 1.02523ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.007910415
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.003940148
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): targetInSecs: 0.001 != cycleElapsed 0.003990688
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 66.709µs, elapsed 1.066709ms
[INFO] [stdout] [90m[[0m2024-12-14T08:52:30Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 139.01µs, elapsed 1.13901ms
[INFO] [stdout] thread 'tests::unit::services::service::service_cycle_test::service_cycle::basic' panicked at src/tests/unit/services/service/service_cycle_test.rs:101:13:
[INFO] [stdout] to much errors (20), a few errors will be ok, but not more then 5% (20) of test cycles
[INFO] [stdout] stack backtrace:
[INFO] [stdout]    0: rust_begin_unwind
[INFO] [stdout]              at /rustc/90b35a6239c3d8bdabc530a6a0816f7ff89a0aaf/library/std/src/panicking.rs:665:5
[INFO] [stdout]    1: core::panicking::panic_fmt
[INFO] [stdout]              at /rustc/90b35a6239c3d8bdabc530a6a0816f7ff89a0aaf/library/core/src/panicking.rs:74:14
[INFO] [stdout]    2: sal_sync::tests::unit::services::service::service_cycle_test::service_cycle::basic
[INFO] [stdout]              at ./src/tests/unit/services/service/service_cycle_test.rs:101:13
[INFO] [stdout]    3: sal_sync::tests::unit::services::service::service_cycle_test::service_cycle::basic::{{closure}}
[INFO] [stdout]              at ./src/tests/unit/services/service/service_cycle_test.rs:27:15
[INFO] [stdout]    4: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/90b35a6239c3d8bdabc530a6a0816f7ff89a0aaf/library/core/src/ops/function.rs:250:5
[INFO] [stdout]    5: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/90b35a6239c3d8bdabc530a6a0816f7ff89a0aaf/library/core/src/ops/function.rs:250:5
[INFO] [stdout] note: Some details are omitted, run with `RUST_BACKTRACE=full` for a verbose backtrace.
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     tests::unit::services::service::service_cycle_test::service_cycle::basic
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 72 passed; 1 failed; 1 ignored; 0 measured; 0 filtered out; finished in 0.85s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "74b1a8976a9f8a892df35901d680c583982374fdb715f3a8fd72fbe32b47f55e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "74b1a8976a9f8a892df35901d680c583982374fdb715f3a8fd72fbe32b47f55e", kill_on_drop: false }`
[INFO] [stdout] 74b1a8976a9f8a892df35901d680c583982374fdb715f3a8fd72fbe32b47f55e
