[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] 5ffba64f327094ffa29e070e06fba141078fe7e3
[INFO] testing a-givertzman/rust-sal-sync/5ffba64f327094ffa29e070e06fba141078fe7e3 against nightly-2024-10-28+rustflags=-Zrandomize-layout for randomize-layout
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2Fa-givertzman%2Frust-sal-sync" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/a-givertzman/rust-sal-sync on toolchain nightly-2024-10-28
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+nightly-2024-10-28" "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-0-tc2/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" "+nightly-2024-10-28" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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:4a844ea9eb2546a2d2c7022eacef16ef2e8229c7fbb2c7d4d55a9ceca922f72d" "/opt/rustwide/cargo-home/bin/cargo" "+nightly-2024-10-28" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 083c5c1c24fc2961c8a076c077a302517753be9ec08fde5160467ac0cb68db5a
[INFO] running `Command { std: "docker" "start" "-a" "083c5c1c24fc2961c8a076c077a302517753be9ec08fde5160467ac0cb68db5a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "083c5c1c24fc2961c8a076c077a302517753be9ec08fde5160467ac0cb68db5a", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "083c5c1c24fc2961c8a076c077a302517753be9ec08fde5160467ac0cb68db5a", kill_on_drop: false }`
[INFO] [stdout] 083c5c1c24fc2961c8a076c077a302517753be9ec08fde5160467ac0cb68db5a
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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 -Zrandomize-layout" "-e" "RUSTDOCFLAGS=--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:4a844ea9eb2546a2d2c7022eacef16ef2e8229c7fbb2c7d4d55a9ceca922f72d" "/opt/rustwide/cargo-home/bin/cargo" "+nightly-2024-10-28" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 860127bde424b0fe6248159267966af5f6bf530c529434d2652893a3f6077b69
[INFO] running `Command { std: "docker" "start" "-a" "860127bde424b0fe6248159267966af5f6bf530c529434d2652893a3f6077b69", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.86
[INFO] [stderr]    Compiling unicode-ident v1.0.12
[INFO] [stderr]    Compiling libc v0.2.158
[INFO] [stderr]    Compiling autocfg v1.3.0
[INFO] [stderr]    Compiling cfg-if v1.0.0
[INFO] [stderr]    Compiling typenum v1.17.0
[INFO] [stderr]    Compiling version_check v0.9.5
[INFO] [stderr]    Compiling memchr v2.7.4
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling serde v1.0.208
[INFO] [stderr]    Compiling subtle v2.6.1
[INFO] [stderr]    Compiling tinyvec_macros v0.1.1
[INFO] [stderr]    Compiling generic-array v0.14.7
[INFO] [stderr]    Compiling regex-syntax v0.8.4
[INFO] [stderr]    Compiling log v0.4.22
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling tinyvec v1.8.0
[INFO] [stderr]    Compiling aho-corasick v1.1.3
[INFO] [stderr]    Compiling bytes v1.7.1
[INFO] [stderr]    Compiling quote v1.0.37
[INFO] [stderr]    Compiling getrandom v0.2.15
[INFO] [stderr]    Compiling utf8parse v0.2.2
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling syn v2.0.75
[INFO] [stderr]    Compiling static_assertions v1.1.0
[INFO] [stderr]    Compiling lexical-util v0.8.5
[INFO] [stderr]    Compiling anstyle-parse v0.2.5
[INFO] [stderr]    Compiling unicode-normalization v0.1.23
[INFO] [stderr]    Compiling lock_api v0.4.12
[INFO] [stderr]    Compiling slab v0.4.9
[INFO] [stderr]    Compiling futures-sink v0.3.30
[INFO] [stderr]    Compiling unicode-properties v0.1.2
[INFO] [stderr]    Compiling itoa v1.0.11
[INFO] [stderr]    Compiling cpufeatures v0.2.13
[INFO] [stderr]    Compiling pin-project-lite v0.2.14
[INFO] [stderr]    Compiling crypto-common v0.1.6
[INFO] [stderr]    Compiling block-buffer v0.10.4
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.1
[INFO] [stderr]    Compiling futures-core v0.3.30
[INFO] [stderr]    Compiling colorchoice v1.0.2
[INFO] [stderr]    Compiling digest v0.10.7
[INFO] [stderr]    Compiling anstyle-query v1.1.1
[INFO] [stderr]    Compiling anstyle v1.0.8
[INFO] [stderr]    Compiling serde_json v1.0.125
[INFO] [stderr]    Compiling unicode-bidi v0.3.15
[INFO] [stderr]    Compiling ryu v1.0.18
[INFO] [stderr]    Compiling parking_lot_core v0.9.10
[INFO] [stderr]    Compiling anstream v0.6.15
[INFO] [stderr]    Compiling hmac v0.12.1
[INFO] [stderr]    Compiling sha2 v0.10.8
[INFO] [stderr]    Compiling md-5 v0.10.6
[INFO] [stderr]    Compiling stringprep v0.1.5
[INFO] [stderr]    Compiling mio v1.0.2
[INFO] [stderr]    Compiling regex-automata v0.4.7
[INFO] [stderr]    Compiling socket2 v0.5.7
[INFO] [stderr]    Compiling iana-time-zone v0.1.60
[INFO] [stderr]    Compiling humantime v2.1.0
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling fallible-iterator v0.2.0
[INFO] [stderr]    Compiling siphasher v0.3.11
[INFO] [stderr]    Compiling smallvec v1.13.2
[INFO] [stderr]    Compiling phf_shared v0.11.2
[INFO] [stderr]    Compiling chrono v0.4.38
[INFO] [stderr]    Compiling tokio v1.39.3
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling futures-task v0.3.30
[INFO] [stderr]    Compiling parking_lot v0.12.3
[INFO] [stderr]    Compiling phf v0.11.2
[INFO] [stderr]    Compiling futures-channel v0.3.30
[INFO] [stderr]    Compiling lexical-write-integer v0.8.5
[INFO] [stderr]    Compiling lexical-parse-integer v0.8.6
[INFO] [stderr]    Compiling equivalent v1.0.1
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling whoami v1.5.1
[INFO] [stderr]    Compiling percent-encoding v2.3.1
[INFO] [stderr]    Compiling lexical-parse-float v0.8.5
[INFO] [stderr]    Compiling lexical-write-float v0.8.5
[INFO] [stderr]    Compiling fxhash v0.2.1
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling lexical-core v0.8.5
[INFO] [stderr]    Compiling regex v1.10.6
[INFO] [stderr]    Compiling lexical v6.1.1
[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 env_filter v0.1.2
[INFO] [stderr]    Compiling zerocopy-derive v0.7.35
[INFO] [stderr]    Compiling serde_derive v1.0.208
[INFO] [stderr]    Compiling env_logger v0.11.5
[INFO] [stderr]    Compiling futures-macro v0.3.30
[INFO] [stderr]    Compiling async-trait v0.1.81
[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.30
[INFO] [stderr]    Compiling zerocopy v0.7.35
[INFO] [stderr]    Compiling ppv-lite86 v0.2.20
[INFO] [stderr]    Compiling tokio-util v0.7.11
[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#f18b3370)
[INFO] [stderr]    Compiling indexmap v2.4.0
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling postgres-types v0.2.7
[INFO] [stderr]    Compiling tokio-postgres v0.7.11
[INFO] [stderr]    Compiling postgres v0.19.8
[INFO] [stderr]    Compiling api-tools v0.0.6 (https://github.com/a-givertzman/rust-api-tools.git?tag=0.0.6#78057d82)
[INFO] [stderr]    Compiling sal-sync v0.0.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 14.22s
[INFO] running `Command { std: "docker" "inspect" "860127bde424b0fe6248159267966af5f6bf530c529434d2652893a3f6077b69", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "860127bde424b0fe6248159267966af5f6bf530c529434d2652893a3f6077b69", kill_on_drop: false }`
[INFO] [stdout] 860127bde424b0fe6248159267966af5f6bf530c529434d2652893a3f6077b69
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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 -Zrandomize-layout" "-e" "RUSTDOCFLAGS=--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:4a844ea9eb2546a2d2c7022eacef16ef2e8229c7fbb2c7d4d55a9ceca922f72d" "/opt/rustwide/cargo-home/bin/cargo" "+nightly-2024-10-28" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 1057f5eaf317a6bbf699880e8bd62f92121327c40ed9c5c28c34de0bb2ac5ef8
[INFO] running `Command { std: "docker" "start" "-a" "1057f5eaf317a6bbf699880e8bd62f92121327c40ed9c5c28c34de0bb2ac5ef8", kill_on_drop: false }`
[INFO] [stderr]    Compiling sal-sync v0.0.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.16s
[INFO] running `Command { std: "docker" "inspect" "1057f5eaf317a6bbf699880e8bd62f92121327c40ed9c5c28c34de0bb2ac5ef8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1057f5eaf317a6bbf699880e8bd62f92121327c40ed9c5c28c34de0bb2ac5ef8", kill_on_drop: false }`
[INFO] [stdout] 1057f5eaf317a6bbf699880e8bd62f92121327c40ed9c5c28c34de0bb2ac5ef8
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/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 -Zrandomize-layout" "-e" "RUSTDOCFLAGS=--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:4a844ea9eb2546a2d2c7022eacef16ef2e8229c7fbb2c7d4d55a9ceca922f72d" "/opt/rustwide/cargo-home/bin/cargo" "+nightly-2024-10-28" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 9370647e486dfd9fde3d46b486dd75cb22c8c413ba9b523f0f5f8e312dc60372
[INFO] running `Command { std: "docker" "start" "-a" "9370647e486dfd9fde3d46b486dd75cb22c8c413ba9b523f0f5f8e312dc60372", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.12s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/sal_sync-b7cb202ffc1a924d)
[INFO] [stdout] 
[INFO] [stdout] running 74 tests
[INFO] [stdout] test tests::unit::services::entity::cot_test::cot::as_str ... ok
[INFO] [stdout] test tests::unit::services::conf::conf_tree_test::config_tree::as_type ... ok
[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::entity::name_test::name::into_string ... 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::deserialize_json ... ok
[INFO] [stdout] test tests::unit::services::entity::name_test::name::join ... 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_address_test::point_config_address::deserialize_yaml ... 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_json ... 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_type_test::point_config_type::to_string ... 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_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_config_test::point_config::serialize ... 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_hlr_test::point_hlr::div ... 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::new ... 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_hlr_test::point_hlr::new_bool ... 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_real ... 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_hlr_test::point_hlr::to_bool ... 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_int ... 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::to_real ... 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::new_double ... 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_hlr_test::point_hlr::to_string ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::deserialize_json ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_hlr_test::point_hlr::new_string ... 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::name ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::tx_id ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::status ... 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::type_ ... ok
[INFO] [stdout] test tests::unit::services::service::link_name_test::link_name::service ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::timestamp ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_test::point::value ... ok
[INFO] [stdout] test tests::unit::services::service::link_name_test::link_name::queue ... ok
[INFO] [stdout] test tests::unit::services::service::link_name_test::link_name::split ... 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::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::service::service_test::trait_service::extend_subscription - should panic ... 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::gi - 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::subscription_ctiteria_test::subscription_criteria::performance ... ignored, Performance test
[INFO] [stdout] test tests::unit::services::service::service_test::trait_service::unsubscribe - should panic ... ok
[INFO] [stdout] test tests::unit::services::subscription::subscription_ctiteria_test::subscription_criteria::destination ... ok
[INFO] [stdout] test tests::unit::services::entity::point::point_config_test::point_config::deserialize_yaml ... 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::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::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-11-02T23:22:18Z [32mINFO [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m target cycle interval: 1 ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [32mINFO [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m detecting load range...
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [32mINFO [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m load range 1...2602
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [32mINFO [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m elapsed for max load: 1.31744ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00833353
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00331887
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 1.39191ms, elapsed 2.39191ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 148.159µs, elapsed 1.148159ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.005085539
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 213.05µs, elapsed 1.21305ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 11.05µs, elapsed 1.01105ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.004343579
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 8.62µs, elapsed 1.00862ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00394124
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00280068
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 194.64µs, elapsed 1.19464ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.004756319
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 456.259µs, elapsed 1.456259ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.006204879
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.002889999
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 493.76µs, elapsed 1.49376ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [33mWARN [0m sal_sync::tests::unit::services::service::service_cycle_test::service_cycle[90m][0m values must be aprox equals (3 digits): mathElapsed: 0.00149322 != cycleElapsed 0.00151877
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 21.37µs, elapsed 1.02137ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.004126179
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 269.15µs, elapsed 1.26915ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 291.01µs, elapsed 1.29101ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.002197599
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 196.95µs, elapsed 1.19695ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00375304
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00282511
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 21.359µs, elapsed 1.021359ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 265.109µs, elapsed 1.265109ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00551476
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00196737
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00390367
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 154.069µs, elapsed 1.154069ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 411.48µs, elapsed 1.41148ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00327038
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.003920819
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.004670439
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 47.35µs, elapsed 1.04735ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.004267569
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 374.74µs, elapsed 1.37474ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 84.6µs, elapsed 1.0846ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 2.620079ms, elapsed 3.620079ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 33.12µs, elapsed 1.03312ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.00439033
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 529.129µs, elapsed 1.529129ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 254.52µs, elapsed 1.25452ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [1m[31mERROR[0m sal_sync::services::service::service_cycle[90m][0m service_cycle_test/ServiceCycle.wait | exceeded 1ms by 76.08µs, elapsed 1.07608ms
[INFO] [stdout] [90m[[0m2024-11-02T23:22:18Z [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.003688949
[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 (23), 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/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/std/src/panicking.rs:665:5
[INFO] [stdout]    1: core::panicking::panic_fmt
[INFO] [stdout]              at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/panicking.rs:75: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/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/library/core/src/ops/function.rs:250:5
[INFO] [stdout]    5: core::ops::function::FnOnce::call_once
[INFO] [stdout]              at /rustc/df4ca44d3fbc9301ee17f30f4d474e6ae4b05252/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.64s
[INFO] [stdout] 
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] running `Command { std: "docker" "inspect" "9370647e486dfd9fde3d46b486dd75cb22c8c413ba9b523f0f5f8e312dc60372", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9370647e486dfd9fde3d46b486dd75cb22c8c413ba9b523f0f5f8e312dc60372", kill_on_drop: false }`
[INFO] [stdout] 9370647e486dfd9fde3d46b486dd75cb22c8c413ba9b523f0f5f8e312dc60372
