[INFO] fetching crate pombase-gocam 0.128.0...
[INFO] testing pombase-gocam-0.128.0 against master#562dee4820c458d823175268e41601d4c060588a for pr-154210-2
[INFO] extracting crate pombase-gocam 0.128.0 into /workspace/builds/worker-4-tc1/source
[INFO] started tweaking crates.io crate pombase-gocam 0.128.0
[INFO] finished tweaking crates.io crate pombase-gocam 0.128.0
[INFO] tweaked toml for crates.io crate pombase-gocam 0.128.0 written to /workspace/builds/worker-4-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate pombase-gocam 0.128.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 pombase-gocam 0.128.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] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] 3ed1bfdcd7a2ac60632dae110233db1ce011c79564eaf69a7ae2956c32f61ce2
[INFO] running `Command { std: "docker" "start" "-a" "3ed1bfdcd7a2ac60632dae110233db1ce011c79564eaf69a7ae2956c32f61ce2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "3ed1bfdcd7a2ac60632dae110233db1ce011c79564eaf69a7ae2956c32f61ce2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "3ed1bfdcd7a2ac60632dae110233db1ce011c79564eaf69a7ae2956c32f61ce2", kill_on_drop: false }`
[INFO] [stdout] 3ed1bfdcd7a2ac60632dae110233db1ce011c79564eaf69a7ae2956c32f61ce2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] e02b8f0b8a753ff764c5dfaad22955a1bf9e3c72e28c729bee002b5cb08990bc
[INFO] running `Command { std: "docker" "start" "-a" "e02b8f0b8a753ff764c5dfaad22955a1bf9e3c72e28c729bee002b5cb08990bc", kill_on_drop: false }`
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling siphasher v1.0.2
[INFO] [stderr]    Compiling rand_core v0.6.4
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling syn v2.0.117
[INFO] [stderr]    Compiling itoa v1.0.18
[INFO] [stderr]    Compiling phf_shared v0.11.3
[INFO] [stderr]    Compiling rand v0.8.5
[INFO] [stderr]    Compiling regex-syntax v0.8.10
[INFO] [stderr]    Compiling hashbrown v0.15.5
[INFO] [stderr]    Compiling fixedbitset v0.5.7
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling phf_generator v0.11.3
[INFO] [stderr]    Compiling ryu v1.0.23
[INFO] [stderr]    Compiling unsafe-libyaml v0.2.11
[INFO] [stderr]    Compiling regex-automata v0.4.14
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling thiserror-impl v2.0.18
[INFO] [stderr]    Compiling phf_macros v0.11.3
[INFO] [stderr]    Compiling phf v0.11.3
[INFO] [stderr]    Compiling serde_yaml v0.9.34+deprecated
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling regex v1.12.3
[INFO] [stderr]    Compiling petgraph v0.8.3
[INFO] [stderr]    Compiling pombase-gocam v0.128.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 45.49s
[INFO] running `Command { std: "docker" "inspect" "e02b8f0b8a753ff764c5dfaad22955a1bf9e3c72e28c729bee002b5cb08990bc", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e02b8f0b8a753ff764c5dfaad22955a1bf9e3c72e28c729bee002b5cb08990bc", kill_on_drop: false }`
[INFO] [stdout] e02b8f0b8a753ff764c5dfaad22955a1bf9e3c72e28c729bee002b5cb08990bc
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] 9ac3ae0ed22e60999b733c526adb26ad667f63f2a64243ac1592b1ff90b57269
[INFO] running `Command { std: "docker" "start" "-a" "9ac3ae0ed22e60999b733c526adb26ad667f63f2a64243ac1592b1ff90b57269", kill_on_drop: false }`
[INFO] [stderr]    Compiling pombase-gocam v0.128.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 8.05s
[INFO] running `Command { std: "docker" "inspect" "9ac3ae0ed22e60999b733c526adb26ad667f63f2a64243ac1592b1ff90b57269", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "9ac3ae0ed22e60999b733c526adb26ad667f63f2a64243ac1592b1ff90b57269", kill_on_drop: false }`
[INFO] [stdout] 9ac3ae0ed22e60999b733c526adb26ad667f63f2a64243ac1592b1ff90b57269
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-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] 216b09883da82afbbde1d96133819481e1d21b2c2fb24f6e7dd3be387e817289
[INFO] running `Command { std: "docker" "start" "-a" "216b09883da82afbbde1d96133819481e1d21b2c2fb24f6e7dd3be387e817289", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.09s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/pombase_gocam-f0520662d407e00d)
[INFO] [stdout] 
[INFO] [stdout] running 27 tests
[INFO] [stdout] test graph::tests::parse_raw_test ... ok
[INFO] [stdout] test overlaps::tests::test_node_rel_direction ... ok
[INFO] [stdout] test raw::tests::parse_raw_test ... ok
[INFO] [stdout] test overlaps::tests::test_inputs_outputs_of ... ok
[INFO] [stdout] test overlaps::tests::test_inputs_for ... ok
[INFO] [stdout] test overlaps::tests::test_outputs_for ... ok
[INFO] [stdout] test tests::location_of_chemical ... ok
[INFO] [stdout] test gocam_py::tests::parse_test ... ok
[INFO] [stdout] test raw::tests::parse_raw_test_with_complement ... ok
[INFO] [stdout] test tests::model_activity_enabled_by_test ... ok
[INFO] [stdout] test tests::parse_test ... ok
[INFO] [stdout] test tests::merge_test ... ok
[INFO] [stdout] test overlaps::tests::overlap_test ... ok
[INFO] [stdout] test overlaps::tests::overlap_home_model_test ... ok
[INFO] [stdout] test tests::remove_chemicals_inputs_outputs_only_test ... ok
[INFO] [stdout] test tests::retain_largest_subgraph_test ... ok
[INFO] [stdout] test tests::test_genes_enabling_activities ... ok
[INFO] [stdout] test tests::test_genes_in_model ... ok
[INFO] [stdout] test tests::retain_enabling_genes_test ... ok
[INFO] [stdout] test overlaps::tests::find_overlaps_test ... ok
[INFO] [stdout] test tests::test_has_location ... ok
[INFO] [stdout] test tests::test_modified_genes_in_model ... ok
[INFO] [stdout] test tests::parse_yaml_test ... ok
[INFO] [stdout] test tests::remove_chemicals_test ... ok
[INFO] [stdout] test tests::merge_test_mss51_remove_chemicals ... ok
[INFO] [stdout] test tests::merge_test_three_models ... ok
[INFO] [stdout] test tests::merge_test_mss51 ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 27 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.74s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests pombase_gocam
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test src/raw.rs - raw (line 8) ... ok
[INFO] [stdout] test src/raw.rs - raw::GoCamRawModel (line 274) ... ok
[INFO] [stdout] test src/raw.rs - raw::gocam_parse_raw (line 436) ... ok
[INFO] [stdout] test src/lib.rs - GoCamModel::new_from_raw (line 259) ... ok
[INFO] [stdout] test src/lib.rs - parse_raw_gocam_model (line 1868) ... ok
[INFO] [stdout] test src/lib.rs - (line 17) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 6 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.06s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 1.07s; merged doctests compilation took 0.94s
[INFO] running `Command { std: "docker" "inspect" "216b09883da82afbbde1d96133819481e1d21b2c2fb24f6e7dd3be387e817289", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "216b09883da82afbbde1d96133819481e1d21b2c2fb24f6e7dd3be387e817289", kill_on_drop: false }`
[INFO] [stdout] 216b09883da82afbbde1d96133819481e1d21b2c2fb24f6e7dd3be387e817289