Organisationsmiragearpfa31cc ()debian-13-5.3_x86_32_opam-2.4

debian-13-5.3_x86_32_opam-2.4

Logs

Show full logs
2025-10-13 02:54.37: New job: test mirage/arp https://github.com/mirage/arp.git#refs/pull/33/head (fa31cc071334c45624e65cb91c4c23cd7dceec97) (linux-x86_64:debian-13-5.3_x86_32_opam-2.4)
Base: ocaml/opam:debian-13-ocaml-5.3@sha256:218164d5bd9111cf10ecababa0070c54277b2aeb70acf9952ec646dc7d4c356a
Opam project build

To reproduce locally:

git clone --recursive "https://github.com/mirage/arp.git" && cd "arp" && git fetch origin "refs/pull/33/head" && git reset --hard fa31cc07
cat > Dockerfile <<'END-OF-DOCKERFILE'
FROM ocaml/opam:debian-13-ocaml-5.3@sha256:218164d5bd9111cf10ecababa0070c54277b2aeb70acf9952ec646dc7d4c356a
# debian-13-5.3_x86_32_opam-2.4
USER 1000:1000
SHELL [ "/usr/bin/linux32", "/bin/sh", "-c" ]
ENV CLICOLOR_FORCE="1"
ENV OPAMCOLOR="always"
WORKDIR /src
RUN sudo ln -f /usr/bin/opam-2.4 /usr/bin/opam
RUN opam init --reinit -ni
RUN uname -rs && opam exec -- ocaml -version && opam --version
WORKDIR /src
RUN sudo chown opam /src
RUN cd ~/opam-repository && (git cat-file -e 241aae26db44294142794da0ce695e8beac418df || git fetch origin master) && git reset -q --hard 241aae26db44294142794da0ce695e8beac418df && git log --no-decorate -n1 --oneline && opam update -u
COPY --chown=1000:1000 arp.opam ./
RUN opam pin add -yn arp.dev './'
RUN echo '(lang dune 3.0)' > './dune-project'
ENV DEPS="alcotest.1.9.1 astring.0.8.5 base-bigarray.base base-bytes.base base-domains.base base-effects.base base-nnp.base base-threads.base base-unix.base bos.0.2.1 cmdliner.2.0.0 cppo.1.8.0 csexp.1.5.2 cstruct.6.2.0 domain-name.0.4.1 dune.3.20.2 dune-configurator.3.20.2 duration.0.2.1 ethernet.3.2.0 fmt.0.11.0 fpath.0.7.3 ipaddr.5.6.1 logs.0.9.0 lwt.5.9.2 macaddr.5.6.1 mirage-net.4.0.0 mirage-sleep.4.1.0 mirage-vnetif.0.6.2 ocaml.5.3.0 ocaml-base-compiler.5.3.0 ocaml-compiler.5.3.0 ocaml-config.3 ocaml-option-bytecode-only.1 ocaml-options-vanilla.1 ocaml-syntax-shims.1.0.0 ocamlbuild.0.16.1 ocamlfind.1.9.8 ocplib-endian.1.2 re.1.14.0 rresult.0.7.0 stdlib-shims.0.3.0 topkg.1.1.0 uutf.1.0.4"
ENV CI="true"
ENV OCAMLCI="true"
RUN opam update --depexts && opam install --cli=2.4 --depext-only -y arp.dev $DEPS
RUN opam install $DEPS
COPY --chown=1000:1000 . /src
RUN opam exec -- dune build @install @check @runtest && rm -rf _build

END-OF-DOCKERFILE
docker build .
END-REPRO-BLOCK

2025-10-13 02:54.37: Using cache hint "mirage/arp-ocaml/opam:debian-13-ocaml-5.3@sha256:218164d5bd9111cf10ecababa0070c54277b2aeb70acf9952ec646dc7d4c356a-debian-13-5.3_x86_32_opam-2.4-984515c6e509d799804d71ad1b555f3d"
2025-10-13 02:54.37: Using OBuilder spec:
((from ocaml/opam:debian-13-ocaml-5.3@sha256:218164d5bd9111cf10ecababa0070c54277b2aeb70acf9952ec646dc7d4c356a)
 (comment debian-13-5.3_x86_32_opam-2.4)
 (user (uid 1000) (gid 1000))
 (shell /usr/bin/linux32 /bin/sh -c)
 (env CLICOLOR_FORCE 1)
 (env OPAMCOLOR always)
 (workdir /src)
 (run (shell "sudo ln -f /usr/bin/opam-2.4 /usr/bin/opam"))
 (run (shell "opam init --reinit -ni"))
 (run (shell "uname -rs && opam exec -- ocaml -version && opam --version"))
 (workdir /src)
 (run (shell "sudo chown opam /src"))
 (run (cache (opam-archives (target /home/opam/.opam/download-cache)))
      (network host)
      (shell "cd ~/opam-repository && (git cat-file -e 241aae26db44294142794da0ce695e8beac418df || git fetch origin master) && git reset -q --hard 241aae26db44294142794da0ce695e8beac418df && git log --no-decorate -n1 --oneline && opam update -u"))
 (copy (src arp.opam) (dst ./))
 (run (network host)
      (shell "opam pin add -yn arp.dev './'"))
 (run (network host)
      (shell "echo '(lang dune 3.0)' > './dune-project'"))
 (env DEPS "alcotest.1.9.1 astring.0.8.5 base-bigarray.base base-bytes.base base-domains.base base-effects.base base-nnp.base base-threads.base base-unix.base bos.0.2.1 cmdliner.2.0.0 cppo.1.8.0 csexp.1.5.2 cstruct.6.2.0 domain-name.0.4.1 dune.3.20.2 dune-configurator.3.20.2 duration.0.2.1 ethernet.3.2.0 fmt.0.11.0 fpath.0.7.3 ipaddr.5.6.1 logs.0.9.0 lwt.5.9.2 macaddr.5.6.1 mirage-net.4.0.0 mirage-sleep.4.1.0 mirage-vnetif.0.6.2 ocaml.5.3.0 ocaml-base-compiler.5.3.0 ocaml-compiler.5.3.0 ocaml-config.3 ocaml-option-bytecode-only.1 ocaml-options-vanilla.1 ocaml-syntax-shims.1.0.0 ocamlbuild.0.16.1 ocamlfind.1.9.8 ocplib-endian.1.2 re.1.14.0 rresult.0.7.0 stdlib-shims.0.3.0 topkg.1.1.0 uutf.1.0.4")
 (env CI true)
 (env OCAMLCI true)
 (run (cache (opam-archives (target /home/opam/.opam/download-cache)))
      (network host)
      (shell "opam update --depexts && opam install --cli=2.4 --depext-only -y arp.dev $DEPS"))
 (run (cache (opam-archives (target /home/opam/.opam/download-cache)))
      (network host)
      (shell "opam install $DEPS"))
 (copy (src .) (dst /src))
 (run (shell "opam exec -- dune build @install @check @runtest && rm -rf _build"))
)

2025-10-13 02:54.37: Waiting for resource in pool OCluster
2025-10-13 02:54.37: Waiting for worker…
2025-10-13 02:54.37: Got resource from pool OCluster
Building on eumache
All commits already cached
HEAD is now at fa31cc0 reenable entries_expire test for macOS and windows

(from ocaml/opam:debian-13-ocaml-5.3@sha256:218164d5bd9111cf10ecababa0070c54277b2aeb70acf9952ec646dc7d4c356a)
Unable to find image 'ocaml/opam:debian-13-ocaml-5.3@sha256:218164d5bd9111cf10ecababa0070c54277b2aeb70acf9952ec646dc7d4c356a' locally
docker.io/ocaml/opam@sha256:218164d5bd9111cf10ecababa0070c54277b2aeb70acf9952ec646dc7d4c356a: Pulling from ocaml/opam
1859827bd598: Already exists
Digest: sha256:218164d5bd9111cf10ecababa0070c54277b2aeb70acf9952ec646dc7d4c356a
Status: Downloaded newer image for ocaml/opam@sha256:218164d5bd9111cf10ecababa0070c54277b2aeb70acf9952ec646dc7d4c356a
2025-10-13 02:54.37 ---> using "69591fed65abc2698ad9f231c4e8520ef59828a7352c177ba5135a1c6c1f0624" from cache

/: (comment debian-13-5.3_x86_32_opam-2.4)

/: (user (uid 1000) (gid 1000))

/: (shell /usr/bin/linux32 /bin/sh -c)

/: (env CLICOLOR_FORCE 1)

/: (env OPAMCOLOR always)

/: (workdir /src)

/src: (run (shell "sudo ln -f /usr/bin/opam-2.4 /usr/bin/opam"))
2025-10-13 02:54.37 ---> using "10f17a0a968cfcc0790644e00d98f001e0d8dacf77314070e33fe3e92e547fd7" from cache

/src: (run (shell "opam init --reinit -ni"))
Configuring from /home/opam/.opamrc and then from built-in defaults.
Checking for available remotes: rsync and local, git.
  - you won't be able to use mercurial repositories unless you install the hg command on your system.
  - you won't be able to use darcs repositories unless you install the darcs command on your system.

This version of opam requires an update to the layout of /home/opam/.opam from version 2.0 to version 2.2, which can't be reverted.
You may want to back it up before going further.

Continue? [Y/n] y
Format upgrade done.

<><> Updating repositories ><><><><><><><><><><><><><><><><><><><><><><><><><><>
[default] Initialised
2025-10-13 02:54.37 ---> using "4a76fb6fce6e54a78b0de9a3efa6babcb344b21a4c8267483332f8f8318a1a19" from cache

/src: (run (shell "uname -rs && opam exec -- ocaml -version && opam --version"))
Linux 5.15.0-131-generic
The OCaml toplevel, version 5.3.0
2.4.1
2025-10-13 02:54.37 ---> using "b2d7f0b692614e3a0377cecf6f8556a238e11105cbc3fe860fbfaa7b77b65e04" from cache

/src: (workdir /src)

/src: (run (shell "sudo chown opam /src"))
2025-10-13 02:54.37 ---> using "82de323c24bac43ec8a0f5cced0f37534dc0fa8caa9744f3f9cc036ccbca8861" from cache

/src: (run (cache (opam-archives (target /home/opam/.opam/download-cache)))
           (network host)
           (shell "cd ~/opam-repository && (git cat-file -e 241aae26db44294142794da0ce695e8beac418df || git fetch origin master) && git reset -q --hard 241aae26db44294142794da0ce695e8beac418df && git log --no-decorate -n1 --oneline && opam update -u"))
From https://github.com/ocaml/opam-repository
 * branch                  master     -> FETCH_HEAD
   bcac5d1731..1abfcdbf14  master     -> origin/master
241aae26db Merge pull request #28629 from dinosaure/release-alcotest-1.9.1

<><> Updating package repositories ><><><><><><><><><><><><><><><><><><><><><><>
[default] synchronised from git+file:///home/opam/opam-repository

Already up-to-date.
Nothing to do.
# To update the current shell environment, run: eval $(opam env)
2025-10-13 02:54.37 ---> using "19ee4c5c2435e528ad29ac0531520bd014bb3662bad2c7bbbb0468590db8f298" from cache

/src: (copy (src arp.opam) (dst ./))
2025-10-13 02:54.37 ---> using "8a4e2eeb597cc6f582924a75928325e611aed25fac63442db18a62979b7a031b" from cache

/src: (run (network host)
           (shell "opam pin add -yn arp.dev './'"))
[arp.dev] synchronised (file:///src)
arp is now pinned to file:///src (version dev)
2025-10-13 02:54.37 ---> using "19a325009edbe83093866dcbeacb5af848ddd038a41d8d214fa0b1b8272e0fbe" from cache

/src: (run (network host)
           (shell "echo '(lang dune 3.0)' > './dune-project'"))
2025-10-13 02:54.37 ---> using "e011bdf98e763fd6b208917f2ec7882dfa2cef52902ea203e6829aef9bc3dd51" from cache

/src: (env DEPS "alcotest.1.9.1 astring.0.8.5 base-bigarray.base base-bytes.base base-domains.base base-effects.base base-nnp.base base-threads.base base-unix.base bos.0.2.1 cmdliner.2.0.0 cppo.1.8.0 csexp.1.5.2 cstruct.6.2.0 domain-name.0.4.1 dune.3.20.2 dune-configurator.3.20.2 duration.0.2.1 ethernet.3.2.0 fmt.0.11.0 fpath.0.7.3 ipaddr.5.6.1 logs.0.9.0 lwt.5.9.2 macaddr.5.6.1 mirage-net.4.0.0 mirage-sleep.4.1.0 mirage-vnetif.0.6.2 ocaml.5.3.0 ocaml-base-compiler.5.3.0 ocaml-compiler.5.3.0 ocaml-config.3 ocaml-option-bytecode-only.1 ocaml-options-vanilla.1 ocaml-syntax-shims.1.0.0 ocamlbuild.0.16.1 ocamlfind.1.9.8 ocplib-endian.1.2 re.1.14.0 rresult.0.7.0 stdlib-shims.0.3.0 topkg.1.1.0 uutf.1.0.4")

/src: (env CI true)

/src: (env OCAMLCI true)

/src: (run (cache (opam-archives (target /home/opam/.opam/download-cache)))
           (network host)
           (shell "opam update --depexts && opam install --cli=2.4 --depext-only -y arp.dev $DEPS"))
+ /usr/bin/sudo "apt-get" "update"
- Hit:1 http://deb.debian.org/debian trixie InRelease
- Get:2 http://deb.debian.org/debian trixie-updates InRelease [47.3 kB]
- Get:3 http://deb.debian.org/debian-security trixie-security InRelease [43.4 kB]
- Get:4 http://deb.debian.org/debian-security trixie-security/main i386 Packages [49.1 kB]
- Fetched 140 kB in 0s (706 kB/s)
- Reading package lists...
- 

<><> Synchronising pinned packages ><><><><><><><><><><><><><><><><><><><><><><>
[arp.dev] synchronised (file:///src)

[NOTE] Package ocaml-options-vanilla is already installed (current version is 1).
[NOTE] Package ocaml-option-bytecode-only is already installed (current version is 1).
[NOTE] Package ocaml-config is already installed (current version is 3).
[NOTE] Package ocaml-compiler is already installed (current version is 5.3.0).
[NOTE] Package ocaml-base-compiler is already installed (current version is 5.3.0).
[NOTE] Package ocaml is already installed (current version is 5.3.0).
[NOTE] Package base-unix is already installed (current version is base).
[NOTE] Package base-threads is already installed (current version is base).
[NOTE] Package base-nnp is already installed (current version is base).
[NOTE] Package base-effects is already installed (current version is base).
[NOTE] Package base-domains is already installed (current version is base).
[NOTE] Package base-bigarray is already installed (current version is base).
2025-10-13 02:54.37 ---> using "25565cbc8b2592f5a5edde9126af7c3c45e1810ea0a727f624c000805321457d" from cache

/src: (run (cache (opam-archives (target /home/opam/.opam/download-cache)))
           (network host)
           (shell "opam install $DEPS"))
[NOTE] Package ocaml-options-vanilla is already installed (current version is 1).
[NOTE] Package ocaml-option-bytecode-only is already installed (current version is 1).
[NOTE] Package ocaml-config is already installed (current version is 3).
[NOTE] Package ocaml-compiler is already installed (current version is 5.3.0).
[NOTE] Package ocaml-base-compiler is already installed (current version is 5.3.0).
[NOTE] Package ocaml is already installed (current version is 5.3.0).
[NOTE] Package base-unix is already installed (current version is base).
[NOTE] Package base-threads is already installed (current version is base).
[NOTE] Package base-nnp is already installed (current version is base).
[NOTE] Package base-effects is already installed (current version is base).
[NOTE] Package base-domains is already installed (current version is base).
[NOTE] Package base-bigarray is already installed (current version is base).
The following actions will be performed:
=== install 31 packages
  - install alcotest           1.9.1
  - install astring            0.8.5
  - install base-bytes         base
  - install bos                0.2.1
  - install cmdliner           2.0.0
  - install cppo               1.8.0
  - install csexp              1.5.2
  - install cstruct            6.2.0
  - install domain-name        0.4.1
  - install dune               3.20.2
  - install dune-configurator  3.20.2
  - install duration           0.2.1
  - install ethernet           3.2.0
  - install fmt                0.11.0
  - install fpath              0.7.3
  - install ipaddr             5.6.1
  - install logs               0.9.0
  - install lwt                5.9.2
  - install macaddr            5.6.1
  - install mirage-net         4.0.0
  - install mirage-sleep       4.1.0
  - install mirage-vnetif      0.6.2
  - install ocaml-syntax-shims 1.0.0
  - install ocamlbuild         0.16.1
  - install ocamlfind          1.9.8
  - install ocplib-endian      1.2
  - install re                 1.14.0
  - install rresult            0.7.0
  - install stdlib-shims       0.3.0
  - install topkg              1.1.0
  - install uutf               1.0.4

<><> Processing actions <><><><><><><><><><><><><><><><><><><><><><><><><><><><>
-> retrieved alcotest.1.9.1  (cached)
-> retrieved astring.0.8.5  (cached)
-> retrieved bos.0.2.1  (cached)
-> retrieved cmdliner.2.0.0  (cached)
-> retrieved cppo.1.8.0  (cached)
-> retrieved csexp.1.5.2  (cached)
-> retrieved cstruct.6.2.0  (cached)
-> retrieved domain-name.0.4.1  (cached)
-> retrieved duration.0.2.1  (cached)
-> retrieved ethernet.3.2.0  (cached)
-> retrieved fmt.0.11.0  (cached)
-> retrieved fpath.0.7.3  (cached)
-> retrieved ipaddr.5.6.1, macaddr.5.6.1  (cached)
-> retrieved logs.0.9.0  (cached)
-> retrieved mirage-net.4.0.0  (cached)
-> retrieved mirage-sleep.4.1.0  (cached)
-> retrieved lwt.5.9.2  (cached)
-> retrieved mirage-vnetif.0.6.2  (cached)
-> retrieved ocaml-syntax-shims.1.0.0  (cached)
-> retrieved ocamlbuild.0.16.1  (cached)
-> retrieved ocamlfind.1.9.8  (cached)
-> retrieved ocplib-endian.1.2  (cached)
-> retrieved re.1.14.0  (cached)
-> retrieved rresult.0.7.0  (cached)
-> retrieved stdlib-shims.0.3.0  (cached)
-> retrieved uutf.1.0.4  (cached)
-> retrieved topkg.1.1.0  (cached)
-> retrieved dune.3.20.2, dune-configurator.3.20.2  (cached)
-> installed cmdliner.2.0.0
-> installed ocamlfind.1.9.8
-> installed base-bytes.base
-> installed ocamlbuild.0.16.1
-> installed topkg.1.1.0
-> installed rresult.0.7.0
-> installed uutf.1.0.4
-> installed fmt.0.11.0
-> installed astring.0.8.5
-> installed fpath.0.7.3
-> installed dune.3.20.2
-> installed duration.0.2.1
-> installed stdlib-shims.0.3.0
-> installed macaddr.5.6.1
-> installed csexp.1.5.2
-> installed cstruct.6.2.0
-> installed domain-name.0.4.1
-> installed re.1.14.0
-> installed ipaddr.5.6.1
-> installed cppo.1.8.0
-> installed ocplib-endian.1.2
-> installed dune-configurator.3.20.2
-> installed ocaml-syntax-shims.1.0.0
-> installed alcotest.1.9.1
-> installed lwt.5.9.2
-> installed mirage-net.4.0.0
-> installed mirage-sleep.4.1.0
-> installed logs.0.9.0
-> installed mirage-vnetif.0.6.2
-> installed ethernet.3.2.0
-> installed bos.0.2.1
Done.
# To update the current shell environment, run: eval $(opam env)
2025-10-13 02:54.37 ---> using "cce189c21391779fd26cfdbc02b541b97f16db73e1e122ee4f23bf54559319a1" from cache

/src: (copy (src .) (dst /src))
2025-10-13 02:54.38 ---> saved as "02e8a7226bb18516e6a19c6648bbe2eb38438fcc150a7d30e9094f6a326c82d0"

/src: (run (shell "opam exec -- dune build @install @check @runtest && rm -rf _build"))
(cd _build/default/test && ./tests.exe)
Testing `ARP tests'.
This run has ID `PG4OGIMU'.

  [OK]          Coder            0   valid arp decoding.
  [OK]          Coder            1   unhandled arp decoding.
  [OK]          Coder            2   short arp decoding.
  [OK]          Coder            3   invalid operation decoding.
  [OK]          Coder            4   decoding is inverse of encoding.
  [OK]          Coder            5   encode_into works.
  [OK]          Coder            6   encode_into fails with small bufs.
  [OK]          Handler          0   create raises.
  [OK]          Handler          1   basic tests.
  [OK]          Handler          2   remove test.
  [OK]          Handler          3   remove no test.
  [OK]          Handler          4   alias test.
  [OK]          Handler          5   alias remove test.
  [OK]          Handler          6   static test.
  [OK]          Handler          7   static alias test.
  [OK]          Handler          8   more tests.
  [OK]          Handler          9   handle good.
  [OK]          Handler         10   handle generates req.
  [OK]          Handler         11   handle generates req, next doesn't.
  [OK]          Handler         12   alias wakes.
  [OK]          Handler         13   static wakes.
  [OK]          Handler         14   handle timeout.
  [OK]          Handler         15   request send before timeout.
  [OK]          Handler         16   multiple requests are send.
  [OK]          Handler         17   multiple requests are send 2.
  [OK]          Handler         18   handle reply.
  [OK]          Handler         19   handle garp.
  [OK]          Handler         20   answers broadcast request.
  [OK]          Handler         21   answers unicast request.
  [OK]          Handler         22   not answering random request.
  [OK]          Handler         23   ignoring random.
  [OK]          Handler         24   reply does not harm static entries.
  [OK]          Handler         25   reply is in cache.
  [OK]          Handler         26   dynamic entry can be queried.
  [OK]          Handler         27   reply times out.
  [OK]          Handler         28   dynamic entry overriden by same.
  [OK]          Handler         29   dynamic entry overriden by other.
  [OK]          Handler         30   dynamic entry is not advertised.
  [OK]          Handler         31   reply wakes tasks.

Full test results in `/src/_build/default/test/_build/_tests/ARP tests'.
Test Successful in 0.833s. 39 tests run.
(cd _build/default/test/mirage && ./tests.exe)
Testing `arp'.
This run has ID `TQI39M92'.

  [OK]          arp          0   conversions neither lose nor gain information.
  [OK]          arp          1   nonsense requests are ignored.
  [OK]          arp          2   requests are responded to.
  [OK]          arp          3   entries expire.
  [OK]          arp          4   irrelevant requests are ignored.
  [OK]          arp          5   set_ip sets ip, sends GARP.
  [OK]          arp          6   add_ip, get_ip and remove_ip as advertised.
  [OK]          arp          7   GARPs are heard and not cached.
  [OK]          arp          8   unsolicited unicast replies are heard and no...
  [OK]          arp          9   solicited unicast replies resolve pending th...
  [OK]          arp         10   entries are replaced with new information.
  [OK]          arp         11   unreachable IPs time out.
  [OK]          arp         12   queries are tried repeatedly before timing out.

Test Successful in 5.779s. 13 tests run.
ASSERT serialize/deserialize
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:03
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:01)
tests.exe: [DEBUG] starting arp listener for 02:50:00:00:00:01
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [INFO] Failed to parse ARP frame ARP message has unsupported operation 3
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [INFO] Failed to parse ARP frame ARP message has unsupported operation 65535
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [INFO] Failed to parse ARP frame ARP message has unsupported operation 255
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [INFO] Failed to parse ARP frame ARP message has unsupported operation 256
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [INFO] Failed to parse ARP frame ARP message has unsupported operation 257
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [INFO] Failed to parse ARP frame ARP message has unsupported operation 0
tests.exe: [DEBUG] sending ARP request for 192.168.3.10 --> Pending
ASSERT parsed packet comparison
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:02)
tests.exe: [DEBUG] resending ARP request for 192.168.3.10 (5 left)
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.10 (02:50:00:00:00:01)
tests.exe: [DEBUG] starting arp listener for 02:50:00:00:00:02
tests.exe: [DEBUG] resending ARP request for 192.168.3.10 (4 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.10 (3 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.10 (2 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.10 (1 left)
tests.exe: [INFO] ARP timeout after 5 retries for 192.168.3.10
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [DEBUG] replying to ARP request for 192.168.3.1 from 192.168.3.10 (mac 02:50:00:00:00:01)
ASSERT parsed packet comparison
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.10 (02:50:00:00:00:01)
tests.exe: [DEBUG] starting arp listener for 02:50:00:00:00:01
tests.exe: [DEBUG] sending ARP request for 192.168.3.1 --> Pending
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (5 left)
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:02)
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [DEBUG] ARP reply received for 192.168.3.1/02:50:00:00:00:02, adding cache entry
tests.exe: [DEBUG] Set IP for 02:50:00:00:00:02 to 192.168.3.1
tests.exe: [DEBUG] Listener table contents after IP set on claimant: mac 02:50:00:00:00:01 ip 192.168.3.10 entries 2 timeout 800 retries 5
192.168.3.1 at 02:50:00:00:00:02 (timeout in 40)
192.168.3.10 at 02:50:00:00:00:01 (static advertising)

ASSERT mismatch for expected query value
tests.exe: [DEBUG] ARP entry 192.168.3.1 (mac 02:50:00:00:00:02) timed out --> Stale
tests.exe: [DEBUG] removing stale ARP entry 192.168.3.1 (mac 02:50:00:00:00:02)
tests.exe: [DEBUG] sending ARP request for 192.168.3.1 --> Pending
ASSERT parsed packet comparison
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:01)
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.10 (02:50:00:00:00:02)
tests.exe: [DEBUG] starting arp listener for 02:50:00:00:00:01
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [DEBUG] ignoring ARP request for 0.0.0.0 from 192.168.3.10 (mac 02:50:00:00:00:02)
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [DEBUG] ignoring ARP request for 255.255.255.255 from 192.168.3.10 (mac 02:50:00:00:00:02)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (5 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (4 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (3 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (2 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (1 left)
tests.exe: [INFO] ARP timeout after 5 retries for 192.168.3.1
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:01)
ASSERT parsed packet comparison
ASSERT garp emitted when setting ip
ASSERT list of bound IPs on initialization
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:01)
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.10 (02:50:00:00:00:01)
ASSERT list of bound IPs after setting two IPs
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
ASSERT bound ips is an empty list on startup
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:01)
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:01)
ASSERT set ips with duplicate elements result in deduplication
ASSERT ip list is empty after removing only ip
ASSERT ip list is empty after removing from empty list
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:01)
ASSERT first ip is the only member of the set of bound ips
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:01)
ASSERT adding ips is idempotent
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [DEBUG] sending ARP request for 192.168.3.1 --> Pending
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:02)
tests.exe: [DEBUG] ARP reply received for 192.168.3.1/02:50:00:00:00:02, adding cache entry
ASSERT mismatch for expected query value
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [DEBUG] starting arp listener for 02:50:00:00:00:01
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [DEBUG] sending ARP request for 192.168.3.1 --> Pending
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (5 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (4 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (3 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (2 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (1 left)
tests.exe: [INFO] ARP timeout after 5 retries for 192.168.3.1
tests.exe: [WARNING] Timeout querying 192.168.3.1. Table contents: mac 02:50:00:00:00:01 ip 0.0.0.0 entries 0 timeout 800 retries 5

tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [DEBUG] starting arp listener for 02:50:00:00:00:01
tests.exe: [DEBUG] sending ARP request for 192.168.3.1 --> Pending
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [DEBUG] ARP reply received for 192.168.3.1/02:50:00:00:00:02, adding cache entry
ASSERT mismatch for expected query value
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:03
tests.exe: [DEBUG] sending ARP request for 192.168.3.1 --> Pending
tests.exe: [DEBUG] arp listener started
tests.exe: [DEBUG] starting arp listener for 02:50:00:00:00:01
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:02)
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [DEBUG] ARP reply received for 192.168.3.1/02:50:00:00:00:02, adding cache entry
tests.exe: [DEBUG] Set IP for 02:50:00:00:00:02 to 192.168.3.1
tests.exe: [DEBUG] Listener table contents after IP set on claimant: mac 02:50:00:00:00:01 ip 0.0.0.0 entries 1 timeout 800 retries 5
192.168.3.1 at 02:50:00:00:00:02 (timeout in 40)

ASSERT mismatch for expected query value
tests.exe: [INFO] Sending gratuitous ARP for 192.168.3.1 (02:50:00:00:00:03)
tests.exe: [DEBUG] frame received for arpv4
tests.exe: [WARNING] MAC address for 192.168.3.1 moved from 02:50:00:00:00:02 to 02:50:00:00:00:03, marked as stale
tests.exe: [DEBUG] Set IP for 02:50:00:00:00:03 to 192.168.3.1
tests.exe: [DEBUG] Listener table contents after IP set on claimant: mac 02:50:00:00:00:01 ip 0.0.0.0 entries 1 timeout 800 retries 5
192.168.3.1 at 02:50:00:00:00:03 (stale, timeout in 800)

tests.exe: [DEBUG] request for stale entry 192.168.3.1/02:50:00:00:00:03 --> Probing
ASSERT mismatch for expected query value
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [DEBUG] sending ARP request for 192.168.3.1 --> Pending
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (5 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (4 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (3 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (2 left)
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (1 left)
tests.exe: [INFO] ARP timeout after 5 retries for 192.168.3.1
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:01
tests.exe: [INFO] Connected Ethernet interface 02:50:00:00:00:02
tests.exe: [DEBUG] sending ARP request for 192.168.3.1 --> Pending
ASSERT parsed packet comparison
tests.exe: [DEBUG] resending ARP request for 192.168.3.1 (5 left)
ASSERT parsed packet comparison
2025-10-13 02:54.48 ---> saved as "b567747bc8df0ffba0d6da8eef3a982e0e417efb2d0ce6c25602c9857d7418aa"
Job succeeded
2025-10-13 02:54.48: Job succeeded