Dec 07 09:13:56.255 INFO testing kicad_parse_gen-7.0.2 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 09:13:56.256 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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"`
Dec 07 09:13:56.824 INFO [stdout] 7c9ce96316dab8ffdecb970b7875c79ce4166e3e92971dd2cf5211fb4c4b5fcd
Dec 07 09:13:56.826 INFO running `"docker" "start" "-a" "7c9ce96316dab8ffdecb970b7875c79ce4166e3e92971dd2cf5211fb4c4b5fcd"`
Dec 07 09:13:58.120 INFO [stderr] usermod: no changes
Dec 07 09:13:58.214 INFO [stderr]    Compiling symbolic_expressions v5.0.3
Dec 07 09:13:58.214 INFO [stderr]    Compiling env_logger v0.4.3
Dec 07 09:14:01.782 INFO [stderr]    Compiling kicad_parse_gen v7.0.2 (/source)
Dec 07 09:14:20.682 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 22.55s
Dec 07 09:14:20.686 INFO [stderr] su: No module specific data is present
Dec 07 09:14:21.704 INFO running `"docker" "inspect" "7c9ce96316dab8ffdecb970b7875c79ce4166e3e92971dd2cf5211fb4c4b5fcd"`
Dec 07 09:14:21.944 INFO running `"docker" "rm" "-f" "7c9ce96316dab8ffdecb970b7875c79ce4166e3e92971dd2cf5211fb4c4b5fcd"`
Dec 07 09:14:22.175 INFO [stdout] 7c9ce96316dab8ffdecb970b7875c79ce4166e3e92971dd2cf5211fb4c4b5fcd
Dec 07 09:14:22.180 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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"`
Dec 07 09:14:22.656 INFO [stdout] ceb6ab47df6765c2faed7890a0f651a4061013f82e37dfbb652bd6eac0685e90
Dec 07 09:14:22.664 INFO running `"docker" "start" "-a" "ceb6ab47df6765c2faed7890a0f651a4061013f82e37dfbb652bd6eac0685e90"`
Dec 07 09:14:23.886 INFO [stderr] usermod: no changes
Dec 07 09:14:24.020 INFO [stderr]    Compiling kicad_parse_gen v7.0.2 (/source)
Dec 07 09:14:42.604 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 18.67s
Dec 07 09:14:42.611 INFO [stderr] su: No module specific data is present
Dec 07 09:14:43.212 INFO running `"docker" "inspect" "ceb6ab47df6765c2faed7890a0f651a4061013f82e37dfbb652bd6eac0685e90"`
Dec 07 09:14:43.613 INFO running `"docker" "rm" "-f" "ceb6ab47df6765c2faed7890a0f651a4061013f82e37dfbb652bd6eac0685e90"`
Dec 07 09:14:43.910 INFO [stdout] ceb6ab47df6765c2faed7890a0f651a4061013f82e37dfbb652bd6eac0685e90
Dec 07 09:14:43.914 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-2/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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"`
Dec 07 09:14:44.420 INFO [stdout] 2406888ceb3ed3348b0a819c6684da9cef07d6aa5080243e1171cbaa1040eae7
Dec 07 09:14:44.421 INFO running `"docker" "start" "-a" "2406888ceb3ed3348b0a819c6684da9cef07d6aa5080243e1171cbaa1040eae7"`
Dec 07 09:14:45.487 INFO [stderr] usermod: no changes
Dec 07 09:14:45.549 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.04s
Dec 07 09:14:45.575 INFO [stderr]      Running /target/debug/deps/kicad_parse_gen-60ae7f6b0d533ac1
Dec 07 09:14:45.580 INFO [stdout] 
Dec 07 09:14:45.580 INFO [stdout] running 7 tests
Dec 07 09:14:45.588 INFO [stdout] test checkfix::tests::test_allowed_1_7_1 ... ok
Dec 07 09:14:45.588 INFO [stdout] test checkfix::tests::test_allowed_1_7_2 ... ok
Dec 07 09:14:45.592 INFO [stdout] test footprint::data::test::pad_bound_180 ... ok
Dec 07 09:14:45.592 INFO [stdout] test layout::data::test_unnamed_rename ... ok
Dec 07 09:14:45.592 INFO [stdout] test footprint::data::test::pad_bound ... ok
Dec 07 09:14:45.592 INFO [stdout] test layout::data::test_is_unnamed_net ... ok
Dec 07 09:14:45.597 INFO [stdout] test footprint::data::test::bound_fail_cy ... ok
Dec 07 09:14:45.598 INFO [stdout] 
Dec 07 09:14:45.598 INFO [stdout] test result: ok. 7 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.598 INFO [stdout] 
Dec 07 09:14:45.616 INFO [stderr]      Running /target/debug/deps/adjust_layout-74e3d7b9bf62867f
Dec 07 09:14:45.624 INFO [stderr]      Running /target/debug/deps/dump_footprint-ff07ab69982208d9
Dec 07 09:14:45.624 INFO [stdout] 
Dec 07 09:14:45.624 INFO [stdout] running 0 tests
Dec 07 09:14:45.624 INFO [stdout] 
Dec 07 09:14:45.624 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.624 INFO [stdout] 
Dec 07 09:14:45.628 INFO [stdout] 
Dec 07 09:14:45.628 INFO [stdout] running 0 tests
Dec 07 09:14:45.628 INFO [stdout] 
Dec 07 09:14:45.628 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.628 INFO [stdout] 
Dec 07 09:14:45.636 INFO [stderr]      Running /target/debug/deps/dump_layout-467276b9065a7dd1
Dec 07 09:14:45.640 INFO [stderr]      Running /target/debug/deps/identify-fda95529986e82c9
Dec 07 09:14:45.640 INFO [stdout] 
Dec 07 09:14:45.640 INFO [stderr]      Running /target/debug/deps/klc_kicad_mod-c7a04f4bde58cd40
Dec 07 09:14:45.640 INFO [stdout] running 0 tests
Dec 07 09:14:45.640 INFO [stdout] 
Dec 07 09:14:45.640 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.640 INFO [stdout] 
Dec 07 09:14:45.640 INFO [stdout] 
Dec 07 09:14:45.640 INFO [stdout] running 0 tests
Dec 07 09:14:45.640 INFO [stdout] 
Dec 07 09:14:45.640 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.640 INFO [stdout] 
Dec 07 09:14:45.644 INFO [stdout] 
Dec 07 09:14:45.644 INFO [stderr]      Running /target/debug/deps/klc_symbol_lib-4a1e564c3f1d9438
Dec 07 09:14:45.644 INFO [stdout] running 0 tests
Dec 07 09:14:45.644 INFO [stderr]      Running /target/debug/deps/footprint1-4dea8a320e9fa788
Dec 07 09:14:45.644 INFO [stdout] 
Dec 07 09:14:45.644 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.644 INFO [stdout] 
Dec 07 09:14:45.644 INFO [stdout] 
Dec 07 09:14:45.644 INFO [stdout] running 0 tests
Dec 07 09:14:45.644 INFO [stdout] 
Dec 07 09:14:45.644 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.644 INFO [stdout] 
Dec 07 09:14:45.652 INFO [stdout] 
Dec 07 09:14:45.652 INFO [stdout] running 1 test
Dec 07 09:14:45.658 INFO [stdout] test parse_and_compare ... ok
Dec 07 09:14:45.658 INFO [stdout] 
Dec 07 09:14:45.658 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.658 INFO [stdout] 
Dec 07 09:14:45.658 INFO [stderr]      Running /target/debug/deps/footprint2-04bcc2b380f5956a
Dec 07 09:14:45.676 INFO [stdout] 
Dec 07 09:14:45.676 INFO [stdout] running 1 test
Dec 07 09:14:45.699 INFO [stdout] test parse_and_compare ... ok
Dec 07 09:14:45.699 INFO [stderr]      Running /target/debug/deps/fp_lib_table1-d324ab72a6d3e314
Dec 07 09:14:45.699 INFO [stdout] 
Dec 07 09:14:45.699 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.699 INFO [stdout] 
Dec 07 09:14:45.704 INFO [stdout] 
Dec 07 09:14:45.704 INFO [stdout] running 1 test
Dec 07 09:14:45.712 INFO [stdout] test parse_and_compare ... ok
Dec 07 09:14:45.712 INFO [stderr]      Running /target/debug/deps/layout1-e5088004a54910c1
Dec 07 09:14:45.712 INFO [stdout] 
Dec 07 09:14:45.712 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:45.712 INFO [stdout] 
Dec 07 09:14:45.716 INFO [stdout] 
Dec 07 09:14:45.716 INFO [stdout] running 1 test
Dec 07 09:14:46.140 INFO [stdout] test parse_and_compare ... ok
Dec 07 09:14:46.140 INFO [stderr]      Running /target/debug/deps/layout2-6b5586ee02ad416e
Dec 07 09:14:46.140 INFO [stdout] 
Dec 07 09:14:46.140 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:46.140 INFO [stdout] 
Dec 07 09:14:46.141 INFO [stdout] 
Dec 07 09:14:46.141 INFO [stdout] running 1 test
Dec 07 09:14:46.158 INFO [stderr] INFO:layout2: bound: Bound { x1: 99.1875, y1: 99.65, x2: 100.8125, y2: 100.35, is_bounded: true }
Dec 07 09:14:46.159 INFO [stderr]      Running /target/debug/deps/schematic1-f0e84c74c824bbf4
Dec 07 09:14:46.159 INFO [stdout] test parse_and_compare ... ok
Dec 07 09:14:46.159 INFO [stdout] 
Dec 07 09:14:46.159 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:46.159 INFO [stdout] 
Dec 07 09:14:46.161 INFO [stdout] 
Dec 07 09:14:46.161 INFO [stdout] running 1 test
Dec 07 09:14:46.208 INFO [stdout] test parse_and_compare ... ok
Dec 07 09:14:46.208 INFO [stderr]      Running /target/debug/deps/symbol_lib1-5dadc6831d65946e
Dec 07 09:14:46.208 INFO [stdout] 
Dec 07 09:14:46.208 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:46.208 INFO [stdout] 
Dec 07 09:14:46.208 INFO [stdout] 
Dec 07 09:14:46.208 INFO [stdout] running 1 test
Dec 07 09:14:46.212 INFO [stdout] test parse_and_compare ... ok
Dec 07 09:14:46.212 INFO [stdout] 
Dec 07 09:14:46.212 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:46.212 INFO [stdout] 
Dec 07 09:14:46.213 INFO [stderr]    Doc-tests kicad_parse_gen
Dec 07 09:14:47.556 INFO [stdout] 
Dec 07 09:14:47.556 INFO [stdout] running 0 tests
Dec 07 09:14:47.556 INFO [stdout] 
Dec 07 09:14:47.556 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 09:14:47.556 INFO [stdout] 
Dec 07 09:14:47.568 INFO [stderr] su: No module specific data is present
Dec 07 09:14:48.296 INFO running `"docker" "inspect" "2406888ceb3ed3348b0a819c6684da9cef07d6aa5080243e1171cbaa1040eae7"`
Dec 07 09:14:48.592 INFO running `"docker" "rm" "-f" "2406888ceb3ed3348b0a819c6684da9cef07d6aa5080243e1171cbaa1040eae7"`
Dec 07 09:14:48.843 INFO [stdout] 2406888ceb3ed3348b0a819c6684da9cef07d6aa5080243e1171cbaa1040eae7