[INFO] fetching crate kanata-keyberon 0.190.0...
[INFO] testing kanata-keyberon-0.190.0 against try#b83b707f97d809763b7861afa7638871f3339a33 for pr-145838-1
[INFO] extracting crate kanata-keyberon 0.190.0 into /workspace/builds/worker-5-tc2/source
[INFO] started tweaking crates.io crate kanata-keyberon 0.190.0
[INFO] finished tweaking crates.io crate kanata-keyberon 0.190.0
[INFO] tweaked toml for crates.io crate kanata-keyberon 0.190.0 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate kanata-keyberon 0.190.0 on toolchain b83b707f97d809763b7861afa7638871f3339a33
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate kanata-keyberon 0.190.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" "+b83b707f97d809763b7861afa7638871f3339a33" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] de2ee69c17796b66499dfb2cc7d2e0fddb977d9d0bbca9b61f631682d3a7898f
[INFO] running `Command { std: "docker" "start" "-a" "de2ee69c17796b66499dfb2cc7d2e0fddb977d9d0bbca9b61f631682d3a7898f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "de2ee69c17796b66499dfb2cc7d2e0fddb977d9d0bbca9b61f631682d3a7898f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "de2ee69c17796b66499dfb2cc7d2e0fddb977d9d0bbca9b61f631682d3a7898f", kill_on_drop: false }`
[INFO] [stdout] de2ee69c17796b66499dfb2cc7d2e0fddb977d9d0bbca9b61f631682d3a7898f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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" "-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] f4c69077ccb8a5c9df33370ccb69b7544850ecef06092dec3d230b79921b4f2c
[INFO] running `Command { std: "docker" "start" "-a" "f4c69077ccb8a5c9df33370ccb69b7544850ecef06092dec3d230b79921b4f2c", kill_on_drop: false }`
[INFO] [stderr]    Compiling semver v1.0.23
[INFO] [stderr]    Compiling byteorder v1.5.0
[INFO] [stderr]    Compiling arraydeque v0.5.1
[INFO] [stderr]    Compiling spin v0.9.8
[INFO] [stderr]    Compiling kanata-keyberon-macros v0.2.0
[INFO] [stderr]    Compiling hash32 v0.2.1
[INFO] [stderr]    Compiling rustc_version v0.4.1
[INFO] [stderr]    Compiling heapless v0.7.17
[INFO] [stderr]    Compiling kanata-keyberon v0.190.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.95s
[INFO] running `Command { std: "docker" "inspect" "f4c69077ccb8a5c9df33370ccb69b7544850ecef06092dec3d230b79921b4f2c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "f4c69077ccb8a5c9df33370ccb69b7544850ecef06092dec3d230b79921b4f2c", kill_on_drop: false }`
[INFO] [stdout] f4c69077ccb8a5c9df33370ccb69b7544850ecef06092dec3d230b79921b4f2c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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" "-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 03d3603cb47f0dd3ea4e7066be95ec6828ceec8c1ec9e6e31fffb8774f9cd235
[INFO] running `Command { std: "docker" "start" "-a" "03d3603cb47f0dd3ea4e7066be95ec6828ceec8c1ec9e6e31fffb8774f9cd235", kill_on_drop: false }`
[INFO] [stderr]    Compiling kanata-keyberon v0.190.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.98s
[INFO] running `Command { std: "docker" "inspect" "03d3603cb47f0dd3ea4e7066be95ec6828ceec8c1ec9e6e31fffb8774f9cd235", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "03d3603cb47f0dd3ea4e7066be95ec6828ceec8c1ec9e6e31fffb8774f9cd235", kill_on_drop: false }`
[INFO] [stdout] 03d3603cb47f0dd3ea4e7066be95ec6828ceec8c1ec9e6e31fffb8774f9cd235
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-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" "-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:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 4073ff1aa40b95e3837558fb1420021b39ea805cbe19604f25508b22b189ce87
[INFO] running `Command { std: "docker" "start" "-a" "4073ff1aa40b95e3837558fb1420021b39ea805cbe19604f25508b22b189ce87", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stdout] 
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/kanata_keyberon-d4fdb79cf49e3f64)
[INFO] [stdout] running 77 tests
[INFO] [stdout] test action::switch::bool_evaluation_test_0 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_1 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_10 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_3 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_11 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_12 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_2 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_4 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_5 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_6 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_9 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_7 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_max_depth_does_not_panic ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_5 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_3 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_1 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_2 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_7 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_4 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_0 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_6 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_9 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_or_equivalency_not_6 ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_not_8 ... ok
[INFO] [stdout] test action::switch::switch_historical_inputs ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_or_equivalency_not_7 ... ok
[INFO] [stdout] test action::switch::switch_inputs ... ok
[INFO] [stdout] test action::switch::switch_no_actions ... ok
[INFO] [stdout] test layout::check_queue_size ... ok
[INFO] [stdout] test key_code::keycode_max_test ... ok
[INFO] [stdout] test layout::extra_waiting_size_constraint ... ok
[INFO] [stdout] test layout::test::basic_hold_tap ... ok
[INFO] [stdout] test layout::test::custom ... ok
[INFO] [stdout] test action::switch::switch_break ... ok
[INFO] [stdout] test action::switch::switch_fallthrough ... ok
[INFO] [stdout] test action::switch::switch_historical_1 ... ok
[INFO] [stdout] test action::switch::switch_historical_bools ... ok
[INFO] [stderr]    Doc-tests kanata_keyberon
[INFO] [stdout] test action::switch::switch_historical_ticks_since ... ok
[INFO] [stdout] test layout::test::custom_handler ... ok
[INFO] [stdout] test layout::test::hold_on_press ... ok
[INFO] [stdout] test layout::test::hold_tap_interleaved_timeout ... ok
[INFO] [stdout] test layout::test::multiple_actions ... ok
[INFO] [stdout] test layout::test::multiple_layers ... ok
[INFO] [stdout] test layout::test::one_shot ... ok
[INFO] [stdout] test layout::test::basic_hold_tap_repress_timeout ... ok
[INFO] [stdout] test layout::test::permissive_hold ... ok
[INFO] [stdout] test layout::test::one_shot_end_on_release ... ok
[INFO] [stdout] test layout::test::one_shot_end_press_or_repress ... ok
[INFO] [stdout] test layout::test::tap_dance_eager ... ok
[INFO] [stdout] test layout::test::one_shot_tap_hold ... ok
[INFO] [stdout] test layout::test::simultaneous_hold ... ok
[INFO] [stdout] test layout::test::tap_dance_uneager ... ok
[INFO] [stdout] test layout::test::one_shot_multi ... ok
[INFO] [stdout] test layout::test::release_state ... ok
[INFO] [stdout] test layout::test::tap_hold_interval_short_hold ... ok
[INFO] [stdout] test layout::test::test_chord ... ok
[INFO] [stdout] test layout::test::tap_hold_interval_interleave ... ok
[INFO] [stdout] test layout::test::test_chord_multi_waiting_decomposition ... ok
[INFO] [stdout] test layout::test::test_clear_multiple_keycodes ... ok
[INFO] [stdout] test layout::test::test_fork ... ok
[INFO] [stdout] test layout::test::test_multiple_taphold_trans ... ok
[INFO] [stdout] test layout::test::test_repeat ... ok
[INFO] [stdout] test layout::test::test_trans_in_action_on_first_layer ... ok
[INFO] [stdout] test layout::test::test_trans_in_multi ... ok
[INFO] [stdout] test layout::test::test_trans_in_fork ... ok
[INFO] [stdout] test layout::test::test_trans_in_chords ... ok
[INFO] [stdout] test layout::test::test_trans_in_stacked_held_layers ... ok
[INFO] [stdout] test layout::test::test_trans_in_switch ... ok
[INFO] [stdout] test layout::test::test_trans_in_tapdance_eager ... ok
[INFO] [stdout] test layout::test::test_trans_in_taphold_hold ... ok
[INFO] [stdout] test layout::test::test_trans_in_tapdance_lazy ... ok
[INFO] [stdout] test layout::test::test_trans_in_taphold_tap ... ok
[INFO] [stdout] test layout::test::tap_hold_interval ... ok
[INFO] [stdout] test layout::test::trans_in_multi_works_with_all_trans_settings ... ok
[INFO] [stdout] test layout::test::tap_hold_interval_different_hold ... ok
[INFO] [stdout] test layout::test::test_chord_normalkey_order ... ok
[INFO] [stdout] test action::switch::bool_evaluation_test_more_than_max_depth_panics - should panic ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 77 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/layout.rs - layout::Event::transform (line 188) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.18s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "4073ff1aa40b95e3837558fb1420021b39ea805cbe19604f25508b22b189ce87", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "4073ff1aa40b95e3837558fb1420021b39ea805cbe19604f25508b22b189ce87", kill_on_drop: false }`
[INFO] [stdout] 4073ff1aa40b95e3837558fb1420021b39ea805cbe19604f25508b22b189ce87