Nov 18 04:47:14.681 INFO testing opcua-core-0.4.0 against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 18 04:47:14.681 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 04:47:15.163 INFO [stdout] 497af5d9123c18bba5107f60c62e191fd43990ad5a902ccaf528851181252654
Nov 18 04:47:15.165 INFO running `"docker" "start" "-a" "497af5d9123c18bba5107f60c62e191fd43990ad5a902ccaf528851181252654"`
Nov 18 04:47:16.244 INFO [stderr] usermod: no changes
Nov 18 04:47:16.468 INFO [stderr]    Compiling opcua-types v0.4.0
Nov 18 04:47:53.427 INFO [stderr]    Compiling opcua-core v0.4.0 (/source)
Nov 18 04:48:04.966 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 48.69s
Nov 18 04:48:04.983 INFO [stderr] su: No module specific data is present
Nov 18 04:48:06.301 INFO running `"docker" "inspect" "497af5d9123c18bba5107f60c62e191fd43990ad5a902ccaf528851181252654"`
Nov 18 04:48:06.573 INFO running `"docker" "rm" "-f" "497af5d9123c18bba5107f60c62e191fd43990ad5a902ccaf528851181252654"`
Nov 18 04:48:06.849 INFO [stdout] 497af5d9123c18bba5107f60c62e191fd43990ad5a902ccaf528851181252654
Nov 18 04:48:06.851 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 04:48:07.219 INFO [stdout] 5d67b50315623931195777102d1d60eabdfe4fd2f2c1d317681aed40153aa3c0
Nov 18 04:48:07.220 INFO running `"docker" "start" "-a" "5d67b50315623931195777102d1d60eabdfe4fd2f2c1d317681aed40153aa3c0"`
Nov 18 04:48:07.940 INFO [stderr] usermod: no changes
Nov 18 04:48:08.130 INFO [stderr]    Compiling opcua-core v0.4.0 (/source)
Nov 18 04:48:23.383 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 15.42s
Nov 18 04:48:23.393 INFO [stderr] su: No module specific data is present
Nov 18 04:48:23.735 INFO running `"docker" "inspect" "5d67b50315623931195777102d1d60eabdfe4fd2f2c1d317681aed40153aa3c0"`
Nov 18 04:48:23.844 INFO running `"docker" "rm" "-f" "5d67b50315623931195777102d1d60eabdfe4fd2f2c1d317681aed40153aa3c0"`
Nov 18 04:48:23.979 INFO [stdout] 5d67b50315623931195777102d1d60eabdfe4fd2f2c1d317681aed40153aa3c0
Nov 18 04:48:23.983 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-2/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 18 04:48:24.220 INFO [stdout] e0b871d47be0dd2e8e0a19173ee660fbc7c5b45d52eef8c5f03c705a885b7ebc
Nov 18 04:48:24.222 INFO running `"docker" "start" "-a" "e0b871d47be0dd2e8e0a19173ee660fbc7c5b45d52eef8c5f03c705a885b7ebc"`
Nov 18 04:48:25.074 INFO [stderr] usermod: no changes
Nov 18 04:48:25.319 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.21s
Nov 18 04:48:25.320 INFO [stderr]      Running /target/debug/deps/opcua_core-8e89b933fbd2c8f8
Nov 18 04:48:25.334 INFO [stdout] 
Nov 18 04:48:25.334 INFO [stdout] running 47 tests
Nov 18 04:48:25.424 INFO [stdout] test tests::authentication::user_name_identity_token_valid ... ok
Nov 18 04:48:25.424 INFO [stdout] test crypto::x509::parse_asn1_date_test ... ok
Nov 18 04:48:25.424 INFO [stdout] test tests::authentication::user_name_identity_token_plaintext ... ok
Nov 18 04:48:25.431 INFO [stdout] test tests::chunk::security_policy_symmetric_encrypt_decrypt ... ok
Nov 18 04:48:25.434 INFO [stdout] test tests::chunk::open_secure_channel ... ok
Nov 18 04:48:25.438 INFO [stdout] test tests::chunk::asymmetric_decrypt_and_verify_sample_chunk ... ok
Nov 18 04:48:25.438 INFO [stdout] test tests::chunk::open_secure_channel_response ... ok
Nov 18 04:48:25.451 INFO [stdout] test tests::chunk::chunk_open_secure_channel ... ok
Nov 18 04:48:25.463 INFO [stdout] test tests::comms::hello ... ok
Nov 18 04:48:25.464 INFO [stdout] test tests::comms::secure_channel_nonce ... ok
Nov 18 04:48:25.471 INFO [stdout] test tests::crypto::aes_test ... ok
Nov 18 04:48:25.495 INFO [stdout] test tests::comms::acknowledge ... ok
Nov 18 04:48:25.783 INFO [stdout] test tests::crypto::calculate_cipher_text_size ... ok
Nov 18 04:48:26.194 INFO [stdout] test tests::crypto::asymmetric_encrypt_and_decrypt ... ok
Nov 18 04:48:26.376 INFO [stdout] test tests::chunk::validate_chunks_request_id ... ok
Nov 18 04:48:26.465 INFO [stdout] test tests::chunk::validate_chunks_secure_channel_id ... ok
Nov 18 04:48:26.519 INFO [stdout] test tests::crypto::certificate_with_application_uri_mismatch ... ok
Nov 18 04:48:26.567 INFO [stdout] test tests::crypto::create_cert ... ok
Nov 18 04:48:26.576 INFO [stdout] test tests::chunk::chunk_multi_chunk_intermediate_final ... ok
Nov 18 04:48:26.585 INFO [stdout] test tests::crypto::derive_keys_from_nonce ... ok
Nov 18 04:48:26.587 INFO [stdout] test tests::crypto::derive_keys_from_nonce_basic128rsa15 ... ok
Nov 18 04:48:26.593 INFO [stdout] test tests::chunk::validate_chunks_sequence_number ... ok
Nov 18 04:48:26.607 INFO [stdout] test tests::crypto::ensure_pki_path ... ok
Nov 18 04:48:26.607 INFO [stdout] test tests::crypto::generate_nonce ... ok
Nov 18 04:48:26.611 INFO [stdout] test tests::chunk::max_message_size ... ok
Nov 18 04:48:26.611 INFO [stdout] test tests::crypto::sign_hmac_sha1 ... ok
Nov 18 04:48:26.619 INFO [stdout] test tests::crypto::sign_hmac_sha256 ... ok
Nov 18 04:48:26.704 INFO [stdout] test tests::crypto::create_rejected_cert_in_pki ... ok
Nov 18 04:48:26.723 INFO [stdout] test tests::crypto::test_and_reject_application_instance_cert ... ok
Nov 18 04:48:26.745 INFO [stdout] test tests::crypto::test_and_trust_application_instance_cert ... ok
Nov 18 04:48:26.759 INFO [stdout] test tests::crypto::sign_verify_sha256 ... ok
Nov 18 04:48:26.775 INFO [stdout] test tests::crypto::test_and_reject_thumbprint_mismatch ... ok
Nov 18 04:48:26.802 INFO [stdout] test tests::crypto::sign_verify_sha1 ... ok
Nov 18 04:48:26.803 INFO [stdout] test tests::secure_channel::symmetric_sign_and_encrypt_message_chunk_basic128rsa15 ... ok
Nov 18 04:48:26.811 INFO [stdout] test tests::secure_channel::symmetric_sign_and_encrypt_message_chunk_basic256 ... ok
Nov 18 04:48:26.811 INFO [stdout] test tests::secure_channel::symmetric_sign_and_encrypt_message_chunk_basic256sha256 ... ok
Nov 18 04:48:26.811 INFO [stdout] test tests::secure_channel::symmetric_sign_message_chunk_basic128rsa15 ... ok
Nov 18 04:48:26.812 INFO [stdout] test tests::secure_channel::symmetric_sign_message_chunk_basic256 ... ok
Nov 18 04:48:26.839 INFO [stdout] test tests::secure_channel::symmetric_sign_message_chunk_basic256sha256 ... ok
Nov 18 04:48:26.839 INFO [stdout] test tests::services::get_endpoints_request ... ok
Nov 18 04:48:26.923 INFO [stdout] test tests::chunk::chunk_multi_encode_decode ... ok
Nov 18 04:48:27.583 INFO [stdout] test tests::crypto::certificate_with_hostname_mismatch ... ok
Nov 18 04:48:28.164 INFO [stdout] test tests::crypto::create_own_cert_in_pki ... ok
Nov 18 04:48:28.467 INFO [stdout] test tests::crypto::calculate_cipher_text_size2 ... ok
Nov 18 04:48:29.171 INFO [stdout] test tests::secure_channel::asymmetric_sign_and_encrypt_message_chunk_basic256 ... ok
Nov 18 04:48:29.818 INFO [stdout] test tests::secure_channel::asymmetric_sign_and_encrypt_message_chunk_basic128rsa15 ... ok
Nov 18 04:48:29.924 INFO [stdout] test tests::secure_channel::asymmetric_sign_and_encrypt_message_chunk_basic256sha256 ... ok
Nov 18 04:48:29.924 INFO [stdout] 
Nov 18 04:48:29.924 INFO [stdout] test result: ok. 47 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:48:29.924 INFO [stdout] 
Nov 18 04:48:29.925 INFO [stderr]    Doc-tests opcua-core
Nov 18 04:48:38.467 INFO [stdout] 
Nov 18 04:48:38.467 INFO [stdout] running 0 tests
Nov 18 04:48:38.467 INFO [stdout] 
Nov 18 04:48:38.467 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 18 04:48:38.467 INFO [stdout] 
Nov 18 04:48:38.478 INFO [stderr] su: No module specific data is present
Nov 18 04:48:38.932 INFO running `"docker" "inspect" "e0b871d47be0dd2e8e0a19173ee660fbc7c5b45d52eef8c5f03c705a885b7ebc"`
Nov 18 04:48:39.049 INFO running `"docker" "rm" "-f" "e0b871d47be0dd2e8e0a19173ee660fbc7c5b45d52eef8c5f03c705a885b7ebc"`
Nov 18 04:48:39.162 INFO [stdout] e0b871d47be0dd2e8e0a19173ee660fbc7c5b45d52eef8c5f03c705a885b7ebc