[INFO] fetching crate images_and_words 0.2.0...
[INFO] testing images_and_words-0.2.0 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-1
[INFO] extracting crate images_and_words 0.2.0 into /workspace/builds/worker-0-tc1/source
[INFO] started tweaking crates.io crate images_and_words 0.2.0
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate images_and_words 0.2.0
[INFO] tweaked toml for crates.io crate images_and_words 0.2.0 written to /workspace/builds/worker-0-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate images_and_words 0.2.0 on toolchain 562dee4820c458d823175268e41601d4c060588a
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate images_and_words 0.2.0 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" "+562dee4820c458d823175268e41601d4c060588a" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded range-alloc v0.1.4
[INFO] [stderr]   Downloaded gpu-descriptor v0.3.2
[INFO] [stderr]   Downloaded ordered-float v5.0.0
[INFO] [stderr]   Downloaded wgpu-core-deps-wasm v27.0.0
[INFO] [stderr]   Downloaded presser v0.3.1
[INFO] [stderr]   Downloaded endi v1.1.1
[INFO] [stderr]   Downloaded gpu-allocator v0.27.0
[INFO] [stderr]   Downloaded zbus-lockstep v0.5.1
[INFO] [stderr]   Downloaded atomic_float v1.1.0
[INFO] [stderr]   Downloaded zbus-lockstep-macros v0.5.1
[INFO] [stderr]   Downloaded zvariant_derive v5.8.0
[INFO] [stderr]   Downloaded exfiltrate_internal v0.2.0
[INFO] [stderr]   Downloaded async-executor v1.13.3
[INFO] [stderr]   Downloaded atspi-connection v0.9.0
[INFO] [stderr]   Downloaded atspi-proxies v0.13.0
[INFO] [stderr]   Downloaded accesskit_consumer v0.31.0
[INFO] [stderr]   Downloaded accesskit v0.21.1
[INFO] [stderr]   Downloaded wayland-backend v0.3.11
[INFO] [stderr]   Downloaded portable_async_sleep v0.1.1
[INFO] [stderr]   Downloaded atspi-common v0.9.0
[INFO] [stderr]   Downloaded atspi-common v0.13.0
[INFO] [stderr]   Downloaded atomiclock_spinlock v0.1.0
[INFO] [stderr]   Downloaded atomiclock v0.1.0
[INFO] [stderr]   Downloaded send_cells v0.2.1
[INFO] [stderr]   Downloaded vectormatrix v0.1.2
[INFO] [stderr]   Downloaded app_window v0.3.1
[INFO] [stderr]   Downloaded atomiclock_async v0.1.0
[INFO] [stderr]   Downloaded quick-xml v0.36.2
[INFO] [stderr]   Downloaded zbus v5.12.0
[INFO] [stderr]   Downloaded wayland-protocols v0.32.9
[INFO] [stderr]   Downloaded logwise v0.4.0
[INFO] [stderr]   Downloaded logwise v0.2.4
[INFO] [stderr]   Downloaded continue v0.1.1
[INFO] [stderr]   Downloaded async_file v0.1.2
[INFO] [stderr]   Downloaded priority v0.1.1
[INFO] [stderr]   Downloaded wasm_safe_mutex v0.1.2
[INFO] [stderr]   Downloaded ampsc v0.2.0
[INFO] [stderr]   Downloaded zvariant v5.8.0
[INFO] [stderr]   Downloaded io-uring v0.7.11
[INFO] [stderr]   Downloaded continue_stream v0.1.0
[INFO] [stderr]   Downloaded test_executors v0.4.0
[INFO] [stderr]   Downloaded cc v1.2.48
[INFO] [stderr]   Downloaded zerocopy v0.8.30
[INFO] [stderr]   Downloaded some_executor v0.6.2
[INFO] [stderr]   Downloaded vec_parallel v0.1.3
[INFO] [stderr]   Downloaded wayland-client v0.31.11
[INFO] [stderr]   Downloaded futures-lite v2.6.1
[INFO] [stderr]   Downloaded minicov v0.3.7
[INFO] [stderr]   Downloaded polling v3.11.0
[INFO] [stderr]   Downloaded async-io v2.6.0
[INFO] [stderr]   Downloaded zbus_macros v5.12.0
[INFO] [stderr]   Downloaded zune-png v0.4.10
[INFO] [stderr]   Downloaded rmp-serde v1.3.0
[INFO] [stderr]   Downloaded wasm-bindgen-test v0.3.56
[INFO] [stderr]   Downloaded wgpu-core-deps-apple v27.0.0
[INFO] [stderr]   Downloaded accesskit_atspi_common v0.14.2
[INFO] [stderr]   Downloaded accesskit_unix v0.17.2
[INFO] [stderr]   Downloaded async-lock v3.4.1
[INFO] [stderr]   Downloaded async-process v2.5.0
[INFO] [stderr]   Downloaded wayland-scanner v0.31.7
[INFO] [stderr]   Downloaded wasm_thread v0.3.3
[INFO] [stderr]   Downloaded atspi v0.29.0
[INFO] [stderr]   Downloaded wgpu-core-deps-emscripten v27.0.0
[INFO] [stderr]   Downloaded atspi-proxies v0.9.0
[INFO] [stderr]   Downloaded atspi v0.25.0
[INFO] [stderr]   Downloaded atspi-connection v0.13.0
[INFO] [stderr]   Downloaded signal-hook-registry v1.4.7
[INFO] [stderr]   Downloaded async-signal v0.2.13
[INFO] [stderr]   Downloaded zbus_names v4.2.0
[INFO] [stderr]   Downloaded swift-rs v1.0.7
[INFO] [stderr]   Downloaded blocking v1.6.2
[INFO] [stderr]   Downloaded rmp v0.8.14
[INFO] [stderr]   Downloaded test_executors_proc v0.3.5
[INFO] [stderr]   Downloaded async-channel v2.5.0
[INFO] [stderr]   Downloaded exfiltrate v0.2.0
[INFO] [stderr]   Downloaded wasm-bindgen-test-macro v0.3.56
[INFO] [stderr]   Downloaded wayland-cursor v0.31.11
[INFO] [stderr]   Downloaded wayland-sys v0.31.7
[INFO] [stderr]   Downloaded logwise_proc v0.4.0
[INFO] [stderr]   Downloaded logwise_proc v0.1.1
[INFO] [stderr]   Downloaded zbus_xml v5.0.2
[INFO] [stderr]   Downloaded zvariant_utils v3.2.1
[INFO] [stderr]   Downloaded xcursor v0.3.10
[INFO] [stderr]   Downloaded treiber_stack v1.1.1
[INFO] [stderr]   Downloaded zerocopy-derive v0.8.30
[INFO] [stderr]   Downloaded metal v0.32.0
[INFO] [stderr]   Downloaded await_values v0.2.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] f5c6ca540862e23655274b7a7cfbc1addf21521ef497696f06957c196a895bba
[INFO] running `Command { std: "docker" "start" "-a" "f5c6ca540862e23655274b7a7cfbc1addf21521ef497696f06957c196a895bba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "f5c6ca540862e23655274b7a7cfbc1addf21521ef497696f06957c196a895bba", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f5c6ca540862e23655274b7a7cfbc1addf21521ef497696f06957c196a895bba", kill_on_drop: false }`
[INFO] [stdout] f5c6ca540862e23655274b7a7cfbc1addf21521ef497696f06957c196a895bba
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=forbid" "-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] ec86bc94906d13b056a2816030bd3942a935340dabce018ce345aa68b214396b
[INFO] running `Command { std: "docker" "start" "-a" "ec86bc94906d13b056a2816030bd3942a935340dabce018ce345aa68b214396b", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling bitflags v2.10.0
[INFO] [stderr]    Compiling libc v0.2.177
[INFO] [stderr]    Compiling logwise_proc v0.1.1
[INFO] [stderr]    Compiling libm v0.2.15
[INFO] [stderr]    Compiling num-traits v0.2.19
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling zerocopy v0.8.30
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling naga v27.0.3
[INFO] [stderr]    Compiling libloading v0.8.9
[INFO] [stderr]    Compiling logwise v0.2.4
[INFO] [stderr]    Compiling log v0.4.28
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling indexmap v2.12.1
[INFO] [stderr]    Compiling codespan-reporting v0.12.0
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling concurrent-queue v2.5.0
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling gpu-alloc-types v0.3.0
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling gpu-descriptor-types v0.2.0
[INFO] [stderr]    Compiling spirv v0.3.0+sdk-1.3.268.0
[INFO] [stderr]    Compiling wgpu-hal v27.0.4
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling arrayvec v0.7.6
[INFO] [stderr]    Compiling winnow v0.7.14
[INFO] [stderr]    Compiling rustc-hash v1.1.0
[INFO] [stderr]    Compiling hexf-parse v0.2.1
[INFO] [stderr]    Compiling event-listener v5.4.1
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling gpu-descriptor v0.3.2
[INFO] [stderr]    Compiling khronos-egl v6.0.0
[INFO] [stderr]    Compiling gpu-alloc v0.6.0
[INFO] [stderr]    Compiling ash v0.38.0+1.3.281
[INFO] [stderr]    Compiling ordered-float v5.0.0
[INFO] [stderr]    Compiling toml_datetime v0.7.3
[INFO] [stderr]    Compiling renderdoc-sys v1.1.0
[INFO] [stderr]    Compiling profiling v1.0.17
[INFO] [stderr]    Compiling glow v0.16.0
[INFO] [stderr]    Compiling priority v0.1.1
[INFO] [stderr]    Compiling crc32fast v1.5.0
[INFO] [stderr]    Compiling event-listener-strategy v0.5.4
[INFO] [stderr]    Compiling wgpu-core v27.0.3
[INFO] [stderr]    Compiling litrs v1.0.0
[INFO] [stderr]    Compiling logwise_proc v0.4.0
[INFO] [stderr]    Compiling fastrand v2.3.0
[INFO] [stderr]    Compiling piper v0.2.4
[INFO] [stderr]    Compiling miniz_oxide v0.8.9
[INFO] [stderr]    Compiling async-channel v2.5.0
[INFO] [stderr]    Compiling futures-lite v2.6.1
[INFO] [stderr]    Compiling wgpu v27.0.1
[INFO] [stderr]    Compiling document-features v0.2.12
[INFO] [stderr]    Compiling toml_parser v1.0.4
[INFO] [stderr]    Compiling arc-swap v1.7.1
[INFO] [stderr]    Compiling flate2 v1.1.5
[INFO] [stderr]    Compiling blocking v1.6.2
[INFO] [stderr]    Compiling num_cpus v1.17.0
[INFO] [stderr]    Compiling treiber_stack v1.1.1
[INFO] [stderr]    Compiling vectormatrix v0.1.2
[INFO] [stderr]    Compiling toml_edit v0.23.7
[INFO] [stderr]    Compiling png v0.18.0
[INFO] [stderr]    Compiling send_cells v0.2.1
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling zerocopy-derive v0.8.30
[INFO] [stderr]    Compiling bytemuck_derive v1.10.2
[INFO] [stderr]    Compiling proc-macro-crate v3.4.0
[INFO] [stderr]    Compiling test_executors_proc v0.3.5
[INFO] [stderr]    Compiling bytemuck v1.24.0
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling continue v0.1.1
[INFO] [stderr]    Compiling wgpu-types v27.0.1
[INFO] [stderr]    Compiling wasm_safe_mutex v0.1.2
[INFO] [stderr]    Compiling some_executor v0.6.2
[INFO] [stderr]    Compiling portable_async_sleep v0.1.1
[INFO] [stderr]    Compiling logwise v0.4.0
[INFO] [stderr]    Compiling await_values v0.2.0
[INFO] [stderr]    Compiling async_file v0.1.2
[INFO] [stderr]    Compiling test_executors v0.4.0
[INFO] [stderr]    Compiling vec_parallel v0.1.3
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling wgpu-core-deps-windows-linux-android v27.0.0
[INFO] [stderr]    Compiling images_and_words v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 1m 53s
[INFO] running `Command { std: "docker" "inspect" "ec86bc94906d13b056a2816030bd3942a935340dabce018ce345aa68b214396b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "ec86bc94906d13b056a2816030bd3942a935340dabce018ce345aa68b214396b", kill_on_drop: false }`
[INFO] [stdout] ec86bc94906d13b056a2816030bd3942a935340dabce018ce345aa68b214396b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=forbid" "-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 6ca3710e76cc29b59a423984781d06f1c4795ea747391ed21f5fdc2be36fb03b
[INFO] running `Command { std: "docker" "start" "-a" "6ca3710e76cc29b59a423984781d06f1c4795ea747391ed21f5fdc2be36fb03b", kill_on_drop: false }`
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling wasm-bindgen-shared v0.2.106
[INFO] [stderr]    Compiling bumpalo v3.19.0
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling wasm-bindgen v0.2.106
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling wasm-bindgen-macro-support v0.2.106
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling zerocopy-derive v0.8.30
[INFO] [stderr]    Compiling bytemuck_derive v1.10.2
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling test_executors_proc v0.3.5
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling zerocopy v0.8.30
[INFO] [stderr]    Compiling continue v0.1.1
[INFO] [stderr]    Compiling wasm_safe_mutex v0.1.2
[INFO] [stderr]    Compiling some_executor v0.6.2
[INFO] [stderr]    Compiling portable_async_sleep v0.1.1
[INFO] [stderr]    Compiling bytemuck v1.24.0
[INFO] [stderr]    Compiling wgpu-types v27.0.1
[INFO] [stderr]    Compiling logwise v0.4.0
[INFO] [stderr]    Compiling await_values v0.2.0
[INFO] [stderr]    Compiling test_executors v0.4.0
[INFO] [stderr]    Compiling async_file v0.1.2
[INFO] [stderr]    Compiling wasm-bindgen-macro v0.2.106
[INFO] [stderr]    Compiling vec_parallel v0.1.3
[INFO] [stderr]    Compiling console_error_panic_hook v0.1.7
[INFO] [stderr]    Compiling half v2.7.1
[INFO] [stderr]    Compiling naga v27.0.3
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling wgpu-hal v27.0.4
[INFO] [stderr]    Compiling wgpu-core-deps-windows-linux-android v27.0.0
[INFO] [stderr]    Compiling wgpu-core v27.0.3
[INFO] [stderr]    Compiling wgpu v27.0.1
[INFO] [stderr]    Compiling images_and_words v0.2.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 37s
[INFO] running `Command { std: "docker" "inspect" "6ca3710e76cc29b59a423984781d06f1c4795ea747391ed21f5fdc2be36fb03b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "6ca3710e76cc29b59a423984781d06f1c4795ea747391ed21f5fdc2be36fb03b", kill_on_drop: false }`
[INFO] [stdout] 6ca3710e76cc29b59a423984781d06f1c4795ea747391ed21f5fdc2be36fb03b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-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=forbid" "-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:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+562dee4820c458d823175268e41601d4c060588a" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 394b5eadb5dc20962175c6e7b2b6eb5f20219099cb37abfa3de839ab2370f6ae
[INFO] running `Command { std: "docker" "start" "-a" "394b5eadb5dc20962175c6e7b2b6eb5f20219099cb37abfa3de839ab2370f6ae", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.36s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/images_and_words-f4a806854abf9325)
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test bindings::forward::dynamic::buffer::tests::send ... ok
[INFO] [stdout] test bindings::software::texture::scaled_iterator::tests::output_coordinates ... ok
[INFO] [stdout] test bindings::software::texture::scaled_iterator::tests::test ... ok
[INFO] [stdout] test bindings::software::texture::scaled_row_cell::test_rescale ... ok
[INFO] [stdout] test imp::wgpu::cell::tests::test_cell_construction ... ok
[INFO] [stdout] test bindings::software::texture::scaled_32::clamped ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/buffer_performance.rs (/opt/rustwide/target/debug/deps/buffer_performance-fbc98ec323a079dd)
[INFO] [stdout] 
[INFO] [stderr]  0 INFO: src/images/engine.rs:63:9 [0ns] Engine::rendering_to() started
[INFO] [stdout] running 1 test
[INFO] [stderr]  0 INFO: src/images/engine.rs:65:9 [34.04µs] Creating EntryPoint...
[INFO] [stderr] error: XDG_RUNTIME_DIR is invalid or not set in the environment.
[INFO] [stderr]  0 INFO: src/images/engine.rs:67:9 [883.62007ms] EntryPoint created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:69:9 [883.85762ms] Providing EntryPoint to view...
[INFO] [stderr]  0 INFO: src/images/engine.rs:71:9 [884.14166ms] EntryPoint provided to view successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:73:9 [884.22781ms] Getting view size and scale...
[INFO] [stderr]  0 INFO: src/images/engine.rs:75:9 [884.23959ms] View size: 600x600, scale: 600
[INFO] [stderr]  0 INFO: src/images/engine.rs:82:9 [884.27131ms] Picking unbound device...
[INFO] [stderr]  0 INFO: src/images/engine.rs:84:9 [909.96814ms] Unbound device picked successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:86:9 [910.16952ms] Binding device...
[INFO] [stderr]  0 INFO: src/images/engine.rs:88:9 [1.067832898s] Device bound successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:90:9 [1.068114318s] Creating implementation engine...
[INFO] [stderr]  0 INFO: src/imp/wgpu/engine.rs:8:9 [1.068173198s] wgpu::Engine::rendering_to_view() started
[INFO] [stderr]  0 INFO: src/imp/wgpu/engine.rs:10:9 [1.068185418s] wgpu::Engine::rendering_to_view() completed
[INFO] [stderr]  0 INFO: src/images/engine.rs:93:9 [1.068195718s] Implementation engine created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:95:9 [1.068389928s] Creating Engine struct...
[INFO] [stderr]  0 INFO: src/images/engine.rs:102:9 [1.068403208s] Engine struct created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:104:9 [1.068413948s] Creating final port...
[INFO] [stderr]  0 INFO: src/imp/wgpu/port/internal.rs:111:17 [1.074004388s] Port surface not initialized - picking Bgra8UnormSrgb as default format
[INFO] [stderr]  0 INFO: src/images/engine.rs:113:9 [1.074288938s] Final port created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:115:9 [1.074478568s] Setting main port...
[INFO] [stderr]  0 INFO: src/images/engine.rs:117:9 [1.074955898s] Engine::rendering_to() completed successfully
[INFO] [stderr]  0 INFO: tests/buffer_performance.rs:129:13 [1.075931278s] === Testing buffer write performance ===
[INFO] [stderr]  0 INFO: tests/buffer_performance.rs:152:17 [1.172622657s]   Buffer write iteration 1 took: 16.26µs
[INFO] [stderr]  0 INFO: tests/buffer_performance.rs:152:17 [1.177875057s]   Buffer write iteration 2 took: 7.65µs
[INFO] [stderr]  0 INFO: tests/buffer_performance.rs:152:17 [1.184695417s]   Buffer write iteration 3 took: 8.03µs
[INFO] [stderr]  0 INFO: tests/buffer_performance.rs:164:13 [1.185833227s] Average buffer write time: 10.646µs
[INFO] [stdout] test main ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.19s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/sendable_futures.rs (/opt/rustwide/target/debug/deps/sendable_futures-b7e3ed5c013eb563)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]  0 INFO: src/images/engine.rs:63:9 [0ns] Engine::rendering_to() started
[INFO] [stderr]  0 INFO: src/images/engine.rs:65:9 [43.049µs] Creating EntryPoint...
[INFO] [stderr] error: XDG_RUNTIME_DIR is invalid or not set in the environment.
[INFO] [stderr]  0 INFO: src/images/engine.rs:67:9 [202.516807ms] EntryPoint created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:69:9 [202.556027ms] Providing EntryPoint to view...
[INFO] [stderr]  0 INFO: src/images/engine.rs:71:9 [202.572597ms] EntryPoint provided to view successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:73:9 [202.583567ms] Getting view size and scale...
[INFO] [stderr]  0 INFO: src/images/engine.rs:75:9 [202.594597ms] View size: 600x600, scale: 600
[INFO] [stderr]  0 INFO: src/images/engine.rs:82:9 [202.622687ms] Picking unbound device...
[INFO] [stderr]  0 INFO: src/images/engine.rs:84:9 [289.204076ms] Unbound device picked successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:86:9 [289.440766ms] Binding device...
[INFO] [stderr]  0 INFO: src/images/engine.rs:88:9 [333.869176ms] Device bound successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:90:9 [333.900416ms] Creating implementation engine...
[INFO] [stderr]  0 INFO: src/imp/wgpu/engine.rs:8:9 [333.912706ms] wgpu::Engine::rendering_to_view() started
[INFO] [stderr]  0 INFO: src/imp/wgpu/engine.rs:10:9 [333.924686ms] wgpu::Engine::rendering_to_view() completed
[INFO] [stderr]  0 INFO: src/images/engine.rs:93:9 [333.935986ms] Implementation engine created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:95:9 [333.946596ms] Creating Engine struct...
[INFO] [stderr]  0 INFO: src/images/engine.rs:102:9 [333.957005ms] Engine struct created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:104:9 [333.967856ms] Creating final port...
[INFO] [stderr]  0 INFO: src/imp/wgpu/port/internal.rs:111:17 [334.697796ms] Port surface not initialized - picking Bgra8UnormSrgb as default format
[INFO] [stderr]  0 INFO: src/images/engine.rs:113:9 [334.718496ms] Final port created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:115:9 [334.730925ms] Setting main port...
[INFO] [stderr]  0 INFO: src/images/engine.rs:117:9 [334.745965ms] Engine::rendering_to() completed successfully
[INFO] [stdout] test main ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.34s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/texture_alignment.rs (/opt/rustwide/target/debug/deps/texture_alignment-7e667a5474ac84a6)
[INFO] [stdout] 
[INFO] [stdout] running 5 tests
[INFO] [stderr]  0 INFO: src/images/engine.rs:63:9 [0ns] Engine::rendering_to() started
[INFO] [stderr]  0 INFO: src/images/engine.rs:65:9 [33.8µs] Creating EntryPoint...
[INFO] [stderr]  2 INFO: src/images/engine.rs:63:9 [182.87µs] Engine::rendering_to() started
[INFO] [stderr]  1 INFO: src/images/engine.rs:63:9 [98.06µs] Engine::rendering_to() started
[INFO] [stderr]  1 INFO: src/images/engine.rs:65:9 [434.43µs] Creating EntryPoint...
[INFO] [stderr]  2 INFO: src/images/engine.rs:65:9 [1.47238ms] Creating EntryPoint...
[INFO] [stderr]  3 INFO: src/images/engine.rs:63:9 [6.28012ms] Engine::rendering_to() started
[INFO] [stderr]  3 INFO: src/images/engine.rs:65:9 [6.88755ms] Creating EntryPoint...
[INFO] [stderr]  4 INFO: src/images/engine.rs:63:9 [7.28023ms] Engine::rendering_to() started
[INFO] [stderr]  4 INFO: src/images/engine.rs:65:9 [7.31075ms] Creating EntryPoint...
[INFO] [stderr] error: XDG_RUNTIME_DIR is invalid or not set in the environment.
[INFO] [stderr] error: XDG_RUNTIME_DIR is invalid or not set in the environment.
[INFO] [stderr] error: XDG_RUNTIME_DIR is invalid or not set in the environment.
[INFO] [stderr] error: XDG_RUNTIME_DIR is invalid or not set in the environment.
[INFO] [stderr] error: XDG_RUNTIME_DIR is invalid or not set in the environment.
[INFO] [stderr]  1 INFO: src/images/engine.rs:67:9 [302.410836ms] EntryPoint created successfully
[INFO] [stderr]  1 INFO: src/images/engine.rs:69:9 [307.892356ms] Providing EntryPoint to view...
[INFO] [stderr]  1 INFO: src/images/engine.rs:71:9 [309.750116ms] EntryPoint provided to view successfully
[INFO] [stderr]  1 INFO: src/images/engine.rs:73:9 [316.245866ms] Getting view size and scale...
[INFO] [stderr]  1 INFO: src/images/engine.rs:75:9 [317.871786ms] View size: 600x600, scale: 600
[INFO] [stderr]  1 INFO: src/images/engine.rs:82:9 [320.399556ms] Picking unbound device...
[INFO] [stderr]  0 INFO: src/images/engine.rs:67:9 [436.353055ms] EntryPoint created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:69:9 [436.402485ms] Providing EntryPoint to view...
[INFO] [stderr]  0 INFO: src/images/engine.rs:71:9 [436.422125ms] EntryPoint provided to view successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:73:9 [436.434705ms] Getting view size and scale...
[INFO] [stderr]  0 INFO: src/images/engine.rs:75:9 [436.446925ms] View size: 600x600, scale: 600
[INFO] [stderr]  0 INFO: src/images/engine.rs:82:9 [436.466985ms] Picking unbound device...
[INFO] [stderr]  2 INFO: src/images/engine.rs:67:9 [470.174154ms] EntryPoint created successfully
[INFO] [stderr]  2 INFO: src/images/engine.rs:69:9 [470.579394ms] Providing EntryPoint to view...
[INFO] [stderr]  2 INFO: src/images/engine.rs:71:9 [471.092134ms] EntryPoint provided to view successfully
[INFO] [stderr]  2 INFO: src/images/engine.rs:73:9 [471.304074ms] Getting view size and scale...
[INFO] [stderr]  2 INFO: src/images/engine.rs:75:9 [471.633354ms] View size: 600x600, scale: 600
[INFO] [stderr]  2 INFO: src/images/engine.rs:82:9 [472.703324ms] Picking unbound device...
[INFO] [stderr]  4 INFO: src/images/engine.rs:67:9 [523.571254ms] EntryPoint created successfully
[INFO] [stderr]  4 INFO: src/images/engine.rs:69:9 [524.011894ms] Providing EntryPoint to view...
[INFO] [stderr]  4 INFO: src/images/engine.rs:71:9 [524.181344ms] EntryPoint provided to view successfully
[INFO] [stderr]  4 INFO: src/images/engine.rs:73:9 [524.340164ms] Getting view size and scale...
[INFO] [stderr]  4 INFO: src/images/engine.rs:75:9 [524.601784ms] View size: 600x600, scale: 600
[INFO] [stderr]  4 INFO: src/images/engine.rs:82:9 [525.186034ms] Picking unbound device...
[INFO] [stderr]  3 INFO: src/images/engine.rs:67:9 [577.557293ms] EntryPoint created successfully
[INFO] [stderr]  3 INFO: src/images/engine.rs:69:9 [577.923203ms] Providing EntryPoint to view...
[INFO] [stderr]  3 INFO: src/images/engine.rs:71:9 [578.099413ms] EntryPoint provided to view successfully
[INFO] [stderr]  3 INFO: src/images/engine.rs:73:9 [578.112123ms] Getting view size and scale...
[INFO] [stderr]  3 INFO: src/images/engine.rs:75:9 [578.123583ms] View size: 600x600, scale: 600
[INFO] [stderr]  3 INFO: src/images/engine.rs:82:9 [578.142393ms] Picking unbound device...
[INFO] [stderr]  3 INFO: src/images/engine.rs:84:9 [584.102103ms] Unbound device picked successfully
[INFO] [stderr]  3 INFO: src/images/engine.rs:86:9 [584.129203ms] Binding device...
[INFO] [stderr]  1 INFO: src/images/engine.rs:84:9 [588.761813ms] Unbound device picked successfully
[INFO] [stderr]  1 INFO: src/images/engine.rs:86:9 [588.789483ms] Binding device...
[INFO] [stderr]  2 INFO: src/images/engine.rs:84:9 [590.187193ms] Unbound device picked successfully
[INFO] [stderr]  2 INFO: src/images/engine.rs:86:9 [590.203493ms] Binding device...
[INFO] [stderr]  0 INFO: src/images/engine.rs:84:9 [590.494943ms] Unbound device picked successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:86:9 [590.509533ms] Binding device...
[INFO] [stderr]  4 INFO: src/images/engine.rs:84:9 [591.953173ms] Unbound device picked successfully
[INFO] [stderr]  4 INFO: src/images/engine.rs:86:9 [591.969703ms] Binding device...
[INFO] [stderr]  3 INFO: src/images/engine.rs:88:9 [765.636661ms] Device bound successfully
[INFO] [stderr]  3 INFO: src/images/engine.rs:90:9 [766.127881ms] Creating implementation engine...
[INFO] [stderr]  3 INFO: src/imp/wgpu/engine.rs:8:9 [766.141791ms] wgpu::Engine::rendering_to_view() started
[INFO] [stderr]  3 INFO: src/imp/wgpu/engine.rs:10:9 [766.153341ms] wgpu::Engine::rendering_to_view() completed
[INFO] [stderr]  3 INFO: src/images/engine.rs:93:9 [766.164161ms] Implementation engine created successfully
[INFO] [stderr]  3 INFO: src/images/engine.rs:95:9 [766.175681ms] Creating Engine struct...
[INFO] [stderr]  3 INFO: src/images/engine.rs:102:9 [766.917251ms] Engine struct created successfully
[INFO] [stderr]  3 INFO: src/images/engine.rs:104:9 [766.930021ms] Creating final port...
[INFO] [stderr]  3 INFO: src/imp/wgpu/port/internal.rs:111:17 [767.867381ms] Port surface not initialized - picking Bgra8UnormSrgb as default format
[INFO] [stderr]  3 INFO: src/images/engine.rs:113:9 [767.897891ms] Final port created successfully
[INFO] [stderr]  3 INFO: src/images/engine.rs:115:9 [767.909171ms] Setting main port...
[INFO] [stderr]  3 INFO: src/images/engine.rs:117:9 [767.926291ms] Engine::rendering_to() completed successfully
[INFO] [stderr]  1 INFO: src/images/engine.rs:88:9 [772.566531ms] Device bound successfully
[INFO] [stderr]  1 INFO: src/images/engine.rs:90:9 [772.593161ms] Creating implementation engine...
[INFO] [stderr]  1 INFO: src/imp/wgpu/engine.rs:8:9 [772.605901ms] wgpu::Engine::rendering_to_view() started
[INFO] [stderr]  1 INFO: src/imp/wgpu/engine.rs:10:9 [772.617011ms] wgpu::Engine::rendering_to_view() completed
[INFO] [stderr]  1 INFO: src/images/engine.rs:93:9 [772.628571ms] Implementation engine created successfully
[INFO] [stderr]  1 INFO: src/images/engine.rs:95:9 [772.638981ms] Creating Engine struct...
[INFO] [stderr]  1 INFO: src/images/engine.rs:102:9 [772.650961ms] Engine struct created successfully
[INFO] [stderr]  1 INFO: src/images/engine.rs:104:9 [772.663071ms] Creating final port...
[INFO] [stderr]  1 INFO: src/imp/wgpu/port/internal.rs:111:17 [773.327091ms] Port surface not initialized - picking Bgra8UnormSrgb as default format
[INFO] [stderr]  1 INFO: src/images/engine.rs:113:9 [773.349151ms] Final port created successfully
[INFO] [stderr]  1 INFO: src/images/engine.rs:115:9 [773.359321ms] Setting main port...
[INFO] [stderr]  1 INFO: src/images/engine.rs:117:9 [773.371141ms] Engine::rendering_to() completed successfully
[INFO] [stderr]  2 INFO: src/images/engine.rs:88:9 [930.789489ms] Device bound successfully
[INFO] [stderr]  2 INFO: src/images/engine.rs:90:9 [930.822519ms] Creating implementation engine...
[INFO] [stderr]  2 INFO: src/imp/wgpu/engine.rs:8:9 [930.841359ms] wgpu::Engine::rendering_to_view() started
[INFO] [stderr]  2 INFO: src/imp/wgpu/engine.rs:10:9 [930.852459ms] wgpu::Engine::rendering_to_view() completed
[INFO] [stderr]  2 INFO: src/images/engine.rs:93:9 [930.863279ms] Implementation engine created successfully
[INFO] [stderr]  2 INFO: src/images/engine.rs:95:9 [930.874219ms] Creating Engine struct...
[INFO] [stderr]  2 INFO: src/images/engine.rs:102:9 [930.885489ms] Engine struct created successfully
[INFO] [stderr]  2 INFO: src/images/engine.rs:104:9 [930.895649ms] Creating final port...
[INFO] [stderr]  2 INFO: src/imp/wgpu/port/internal.rs:111:17 [932.625689ms] Port surface not initialized - picking Bgra8UnormSrgb as default format
[INFO] [stderr]  2 INFO: src/images/engine.rs:113:9 [932.657399ms] Final port created successfully
[INFO] [stderr]  2 INFO: src/images/engine.rs:115:9 [932.670199ms] Setting main port...
[INFO] [stderr]  2 INFO: src/images/engine.rs:117:9 [932.685129ms] Engine::rendering_to() completed successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:88:9 [1.153740636s] Device bound successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:90:9 [1.153776666s] Creating implementation engine...
[INFO] [stderr]  0 INFO: src/imp/wgpu/engine.rs:8:9 [1.153791176s] wgpu::Engine::rendering_to_view() started
[INFO] [stderr]  0 INFO: src/imp/wgpu/engine.rs:10:9 [1.153803396s] wgpu::Engine::rendering_to_view() completed
[INFO] [stderr]  0 INFO: src/images/engine.rs:93:9 [1.153815866s] Implementation engine created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:95:9 [1.153827436s] Creating Engine struct...
[INFO] [stderr]  0 INFO: src/images/engine.rs:102:9 [1.153841006s] Engine struct created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:104:9 [1.153852876s] Creating final port...
[INFO] [stderr]  0 INFO: src/imp/wgpu/port/internal.rs:111:17 [1.161657566s] Port surface not initialized - picking Bgra8UnormSrgb as default format
[INFO] [stderr]  0 INFO: src/images/engine.rs:113:9 [1.161855226s] Final port created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:115:9 [1.162028876s] Setting main port...
[INFO] [stderr]  0 INFO: src/images/engine.rs:117:9 [1.162205816s] Engine::rendering_to() completed successfully
[INFO] [stderr]  4 INFO: src/images/engine.rs:88:9 [1.162695176s] Device bound successfully
[INFO] [stderr]  4 INFO: src/images/engine.rs:90:9 [1.162928516s] Creating implementation engine...
[INFO] [stderr]  4 INFO: src/imp/wgpu/engine.rs:8:9 [1.163263386s] wgpu::Engine::rendering_to_view() started
[INFO] [stderr]  4 INFO: src/imp/wgpu/engine.rs:10:9 [1.163545366s] wgpu::Engine::rendering_to_view() completed
[INFO] [stderr]  4 INFO: src/images/engine.rs:93:9 [1.163848516s] Implementation engine created successfully
[INFO] [stderr]  4 INFO: src/images/engine.rs:95:9 [1.166240966s] Creating Engine struct...
[INFO] [stderr]  4 INFO: src/images/engine.rs:102:9 [1.166533716s] Engine struct created successfully
[INFO] [stderr]  4 INFO: src/images/engine.rs:104:9 [1.166836176s] Creating final port...
[INFO] [stderr]  4 INFO: src/imp/wgpu/port/internal.rs:111:17 [1.170780956s] Port surface not initialized - picking Bgra8UnormSrgb as default format
[INFO] [stderr]  4 INFO: src/images/engine.rs:113:9 [1.179488446s] Final port created successfully
[INFO] [stderr]  4 INFO: src/images/engine.rs:115:9 [1.179703936s] Setting main port...
[INFO] [stderr]  4 INFO: src/images/engine.rs:117:9 [1.180028936s] Engine::rendering_to() completed successfully
[INFO] [stdout] test async_test_test_texture_alignment_ok_width_64 ... ok
[INFO] [stdout] test async_test_test_texture_alignment_error_width_150 ... ok
[INFO] [stdout] test async_test_test_texture_alignment_error_width_100 ... ok
[INFO] [stdout] test async_test_test_texture_alignment_error_width_63 ... ok
[INFO] [stdout] test async_test_test_texture_alignment_ok_width_128 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.33s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/wgpu_cell_threading_error.rs (/opt/rustwide/target/debug/deps/wgpu_cell_threading_error-d79d337a78e57b63)
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stderr]  0 INFO: src/images/engine.rs:63:9 [0ns] Engine::rendering_to() started
[INFO] [stderr]  0 INFO: src/images/engine.rs:65:9 [30.12µs] Creating EntryPoint...
[INFO] [stderr] error: XDG_RUNTIME_DIR is invalid or not set in the environment.
[INFO] [stderr]  0 INFO: src/images/engine.rs:67:9 [129.382008ms] EntryPoint created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:69:9 [129.424378ms] Providing EntryPoint to view...
[INFO] [stderr]  0 INFO: src/images/engine.rs:71:9 [129.440438ms] EntryPoint provided to view successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:73:9 [129.450758ms] Getting view size and scale...
[INFO] [stderr]  0 INFO: src/images/engine.rs:75:9 [129.461298ms] View size: 600x600, scale: 600
[INFO] [stderr]  0 INFO: src/images/engine.rs:82:9 [129.479268ms] Picking unbound device...
[INFO] [stderr]  0 INFO: src/images/engine.rs:84:9 [167.313798ms] Unbound device picked successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:86:9 [167.348378ms] Binding device...
[INFO] [stderr]  0 INFO: src/images/engine.rs:88:9 [326.298246ms] Device bound successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:90:9 [326.492266ms] Creating implementation engine...
[INFO] [stderr]  0 INFO: src/imp/wgpu/engine.rs:8:9 [326.619016ms] wgpu::Engine::rendering_to_view() started
[INFO] [stderr]  0 INFO: src/imp/wgpu/engine.rs:10:9 [326.740396ms] wgpu::Engine::rendering_to_view() completed
[INFO] [stderr]  0 INFO: src/images/engine.rs:93:9 [331.929826ms] Implementation engine created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:95:9 [332.075426ms] Creating Engine struct...
[INFO] [stderr]  0 INFO: src/images/engine.rs:102:9 [332.195646ms] Engine struct created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:104:9 [332.498336ms] Creating final port...
[INFO] [stderr]  0 INFO: src/imp/wgpu/port/internal.rs:111:17 [333.607936ms] Port surface not initialized - picking Bgra8UnormSrgb as default format
[INFO] [stderr]  0 INFO: src/images/engine.rs:113:9 [333.818586ms] Final port created successfully
[INFO] [stderr]  0 INFO: src/images/engine.rs:115:9 [334.006036ms] Setting main port...
[INFO] [stderr]  0 INFO: src/images/engine.rs:117:9 [334.457586ms] Engine::rendering_to() completed successfully
[INFO] [stdout] test main ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.34s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests images_and_words
[INFO] [stdout] 
[INFO] [stdout] running 118 tests
[INFO] [stdout] test src/bindings/coordinates.rs - bindings::coordinates::RasterCoord2D::new (line 68) ... ok
[INFO] [stdout] test src/bindings/forward.rs - bindings::forward (line 47) ... ok
[INFO] [stdout] test src/bindings/coordinates.rs - bindings::coordinates::RasterCoord2D (line 39) ... ok
[INFO] [stdout] test src/bindings/bind_style.rs - bindings::bind_style (line 19) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/buffer.rs - bindings::forward::dynamic::buffer (line 36) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/buffer.rs - bindings::forward::dynamic::buffer::Buffer (line 166) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/buffer.rs - bindings::forward::dynamic::buffer::Buffer<Element>::access_write (line 554) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/buffer.rs - bindings::forward::dynamic::buffer::CPUWriteAccess<'_,Element>::write (line 250) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/buffer.rs - bindings::forward::dynamic::buffer::Buffer<Element>::new (line 468) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/frame_texture.rs - bindings::forward::dynamic::frame_texture::CPUWriteGuard (line 245) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/frame_texture.rs - bindings::forward::dynamic::frame_texture (line 26) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/frame_texture.rs - bindings::forward::dynamic::frame_texture::CPUWriteGuard<'a,Format>::replace (line 496) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/buffer.rs - bindings::forward::dynamic::buffer::CRepr (line 625) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/frame_texture.rs - bindings::forward::dynamic::frame_texture::FrameTexture (line 418) ... ok
[INFO] [stdout] test src/bindings/bind_style.rs - bindings::bind_style::BindSlot (line 410) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic.rs - bindings::forward::dynamic (line 70) ... ok
[INFO] [stdout] test src/bindings/coordinates.rs - bindings::coordinates::RasterCoord2D::origin (line 83) ... ok
[INFO] [stdout] test src/bindings/forward/static.rs - bindings::forward::r#static (line 58) ... ok
[INFO] [stdout] test src/bindings/forward/static/buffer.rs - bindings::forward::r#static::buffer::Buffer (line 100) ... ok
[INFO] [stdout] test src/bindings/forward/static/texture.rs - bindings::forward::r#static::texture (line 17) ... ok
[INFO] [stdout] test src/bindings/forward/static/buffer.rs - bindings::forward::r#static::buffer::Buffer<Element>::new (line 222) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/frame_texture.rs - bindings::forward::dynamic::frame_texture::FrameTexture<Format>::dequeue (line 627) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/frame_texture.rs - bindings::forward::dynamic::frame_texture::FrameTexture<Format>::new (line 549) ... ok
[INFO] [stdout] test src/bindings/forward/dynamic/frame_texture.rs - bindings::forward::dynamic::frame_texture::TextureRenderSide (line 156) ... ok
[INFO] [stdout] test src/bindings/forward/static/texture.rs - bindings::forward::r#static::texture::Texture<Format>::from_software (line 188) ... ok
[INFO] [stdout] test src/bindings/sampler.rs - bindings::sampler (line 16) ... ok
[INFO] [stdout] test src/bindings/forward/static/buffer.rs - bindings::forward::r#static::buffer (line 27) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture (line 33) ... ok
[INFO] [stdout] test src/bindings/forward/static/texture.rs - bindings::forward::r#static::texture::Texture<Format>::new_slice (line 286) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texel::new_clamping (line 231) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texture<Format>::map (line 780) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texture (line 136) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texture<Format>::new_with (line 525) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texture<Format>::new_cloning (line 714) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texture<Format>::new_with_parallel (line 570) ... ok
[INFO] [stdout] test src/bindings/forward/static/texture.rs - bindings::forward::r#static::texture::Texture<Format>::new (line 117) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Normalized (line 299) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texel (line 174) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::Scaled32 (line 33) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texture<Format>::new (line 489) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::linear_to_srgb (line 90) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::Scaled32::from (line 341) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::Scaled32::new_clamping_inside_imprecise (line 97) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::sample_bilinear (line 853) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::Scaled32::offset_clamped (line 243) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::Scaled32::reference_texel (line 192) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::Scaled32::s32 (line 213) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texture (line 150) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::sealed (line 398) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::S32 (line 306) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::Scaled32::new (line 63) ... ok
[INFO] [stdout] test src/bindings/software/texture/vtexture.rs - bindings::software::texture::vtexture::VTexture::read (line 127) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::Scaled32::x_evenly (line 160) ... ok
[INFO] [stdout] test src/bindings/software/texture/scaled_32.rs - bindings::software::texture::scaled_32::Scaled32::y_evenly (line 175) ... ok
[INFO] [stdout] test src/bindings/software/texture/vtexture.rs - bindings::software::texture::vtexture (line 11) ... ok
[INFO] [stdout] test src/bindings/software/texture/vtexture.rs - bindings::software::texture::vtexture::VTexture::height (line 101) ... ok
[INFO] [stdout] test src/bindings/visible_to.rs - bindings::visible_to (line 20) ... ok
[INFO] [stdout] test src/bindings/visible_to.rs - bindings::visible_to::TextureConfig (line 187) ... ok
[INFO] [stdout] test src/bindings/software/texture/vtexture.rs - bindings::software::texture::vtexture::VTexture::width (line 87) ... ok
[INFO] [stdout] test src/bindings/software/texture/vtexture.rs - bindings::software::texture::vtexture (line 31) ... ok
[INFO] [stdout] test src/images/index_algorithms.rs - images::index_algorithms (line 36) ... ok
[INFO] [stdout] test src/bindings/visible_to.rs - bindings::visible_to::CPUStrategy (line 153) ... ok
[INFO] [stdout] test src/images/index_algorithms.rs - images::index_algorithms::IndexGenerator::new (line 159) ... ok
[INFO] [stdout] test src/images/index_algorithms.rs - images::index_algorithms::IndexGenerator::default (line 301) ... ok
[INFO] [stdout] test src/bindings/visible_to.rs - bindings::visible_to::GPUBufferUsage (line 100) ... ok
[INFO] [stdout] test src/images/index_algorithms.rs - images::index_algorithms::IndexGenerator::num_triangles (line 199) ... ok
[INFO] [stdout] test src/images/port.rs - images::port::Port::add_fixed_pass (line 551) ... ok
[INFO] [stdout] test src/images/port.rs - images::port::Port::new (line 502) ... ok
[INFO] [stdout] test src/images/port.rs - images::port::Port::start (line 668) ... ok
[INFO] [stdout] test src/images/projection.rs - images::projection (line 19) ... ok
[INFO] [stdout] test src/images/projection.rs - images::projection (line 35) ... ok
[INFO] [stdout] test src/images/projection.rs - images::projection::Projection (line 164) ... ok
[INFO] [stdout] test src/images/index_algorithms.rs - images::index_algorithms (line 16) ... ok
[INFO] [stdout] test src/bindings/visible_to.rs - bindings::visible_to::TextureUsage (line 44) ... ok
[INFO] [stdout] test src/images/index_algorithms.rs - images::index_algorithms::IndexGenerator::index_for (line 231) ... ok
[INFO] [stdout] test src/images/projection.rs - images::projection::ScreenCoord (line 316) ... ok
[INFO] [stdout] test src/images/index_algorithms.rs - images::index_algorithms::IndexGenerator::num_indices (line 180) ... ok
[INFO] [stdout] test src/images/port.rs - images::port::PortReporter (line 274) ... ok
[INFO] [stdout] test src/images/projection.rs - images::projection::Projection::project (line 231) ... ok
[INFO] [stdout] test src/images/render_pass.rs - images::render_pass::DrawCommand (line 143) ... ok
[INFO] [stdout] test src/images/projection.rs - images::projection::WorldCoord (line 339) ... ok
[INFO] [stdout] test src/images/port.rs - images::port (line 14) ... ok
[INFO] [stdout] test src/images/render_pass.rs - images::render_pass (line 15) ... ok
[INFO] [stdout] test src/images/projection.rs - images::projection::Projection::new (line 196) ... ok
[INFO] [stdout] test src/images/shader.rs - images::shader::FragmentShader (line 26) ... ok
[INFO] [stdout] test src/images/shader.rs - images::shader::VertexShader (line 81) ... ok
[INFO] [stdout] test src/images/shader.rs - images::shader::VertexShader (line 99) ... ok
[INFO] [stdout] test src/images/vertex_layout.rs - images::vertex_layout::VertexFieldType (line 78) ... ok
[INFO] [stdout] test src/images/shader.rs - images::shader::FragmentShader (line 42) ... ok
[INFO] [stdout] test src/images/vertex_layout.rs - images::vertex_layout::VertexLayout::add_field (line 137) ... ok
[INFO] [stdout] test src/images/vertex_layout.rs - images::vertex_layout::VertexLayout::default (line 168) ... ok
[INFO] [stdout] test src/images/vertex_layout.rs - images::vertex_layout (line 16) ... ok
[INFO] [stdout] test src/images/vertex_layout.rs - images::vertex_layout::VertexLayout (line 42) ... ok
[INFO] [stdout] test src/images/view.rs - images::view (line 24) ... ok
[INFO] [stdout] test src/images/shader.rs - images::shader::VertexShader::new (line 190) ... ok
[INFO] [stdout] test src/images/vertex_layout.rs - images::vertex_layout::VertexLayout::new (line 111) ... ok
[INFO] [stdout] test src/lib.rs - (line 116) ... ok
[INFO] [stdout] test src/lib.rs - (line 203) ... ok
[INFO] [stdout] test src/images/view.rs - images::view::View::for_testing (line 295) ... ok
[INFO] [stdout] test src/bindings/software/texture.rs - bindings::software::texture::Texture<Format>::new_from_path (line 644) ... ok
[INFO] [stdout] test src/lib.rs - (line 350) ... ok
[INFO] [stdout] test src/images/shader.rs - images::shader::FragmentShader::new (line 151) ... ok
[INFO] [stdout] test src/images/render_pass.rs - images::render_pass::DrawCommand (line 135) ... ok
[INFO] [stdout] test src/images/view.rs - images::view (line 15) ... ok
[INFO] [stdout] test src/lib.rs - pixel_formats (line 533) ... ok
[INFO] [stdout] test src/lib.rs - pixel_formats (line 541) ... ok
[INFO] [stdout] test src/pixel_formats.rs - pixel_formats::BGRA8UnormPixelSRGB (line 515) ... ok
[INFO] [stdout] test src/pixel_formats.rs - pixel_formats::Float4 (line 598) ... ok
[INFO] [stdout] test src/pixel_formats.rs - pixel_formats::R8UNorm (line 164) ... ok
[INFO] [stdout] test src/pixel_formats.rs - pixel_formats::RGBA8UNorm (line 411) ... ok
[INFO] [stdout] test src/pixel_formats.rs - pixel_formats::Unorm4 (line 368) ... ok
[INFO] [stdout] test src/lib.rs - (line 430) ... ok
[INFO] [stdout] test src/lib.rs - images (line 511) ... ok
[INFO] [stdout] test src/lib.rs - (line 380) ... ok
[INFO] [stdout] test src/images/view.rs - images::view (line 52) ... ok
[INFO] [stdout] test src/lib.rs - (line 80) ... ok
[INFO] [stdout] test src/lib.rs - (line 312) ... ok
[INFO] [stdout] test src/lib.rs - (line 294) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 118 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 1.06s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 4.40s; merged doctests compilation took 3.16s
[INFO] running `Command { std: "docker" "inspect" "394b5eadb5dc20962175c6e7b2b6eb5f20219099cb37abfa3de839ab2370f6ae", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "394b5eadb5dc20962175c6e7b2b6eb5f20219099cb37abfa3de839ab2370f6ae", kill_on_drop: false }`
[INFO] [stdout] 394b5eadb5dc20962175c6e7b2b6eb5f20219099cb37abfa3de839ab2370f6ae