|
|
|
| 1 | 2026-01-13T00:02:01.333Z | job assigned to worker 01KETAGSB7EXJWK1K3DJ7GZD5E [factory gimlet-EVT22200007-propolis, EVT22200007/54069] (queued for 28 s) |
| |
| 2 | 2026-01-13T00:02:11.218Z | starting task 0: "setup" |
| 3 | 2026-01-13T00:02:11.243Z | ++ uname -s |
| 4 | 2026-01-13T00:02:11.243Z | + kern=SunOS |
| 5 | 2026-01-13T00:02:11.243Z | + build_user=build |
| 6 | 2026-01-13T00:02:11.243Z | + build_uid=12345 |
| 7 | 2026-01-13T00:02:11.243Z | + work_dir=/work |
| 8 | 2026-01-13T00:02:11.243Z | + input_dir=/input |
| 9 | 2026-01-13T00:02:11.243Z | + [[ 0 == 12345 ]] |
| 10 | 2026-01-13T00:02:11.243Z | + case "$kern" in |
| 11 | 2026-01-13T00:02:11.243Z | + groupadd -g 12345 build |
| 12 | 2026-01-13T00:02:11.243Z | + useradd -u 12345 -g build -d /home/build -s /bin/bash -c build -P 'Primary Administrator' build |
| 13 | 2026-01-13T00:02:12.249Z | + zfs create -o mountpoint=/work rpool/work |
| 14 | 2026-01-13T00:02:12.287Z | ++ awk '$2 == "/home" { print $3 }' /etc/mnttab |
| 15 | 2026-01-13T00:02:12.311Z | + home_fs=zfs |
| 16 | 2026-01-13T00:02:12.311Z | + [[ zfs == autofs ]] |
| 17 | 2026-01-13T00:02:12.311Z | + mkdir -p /home/build |
| 18 | 2026-01-13T00:02:12.311Z | + chown build:build /home/build /work |
| 19 | 2026-01-13T00:02:14.297Z | + chmod 0700 /home/build /work |
| 20 | 2026-01-13T00:02:14.321Z | process exited: duration 3083 ms, exit code 0 |
| |
| 21 | 2026-01-13T00:02:14.370Z | starting task 1: "rust-toolchain" |
| 22 | 2026-01-13T00:02:14.394Z | + printf ' * rust toolchain channel = "%s"\n' stable |
| 23 | 2026-01-13T00:02:14.394Z | * rust toolchain channel = "stable" |
| 24 | 2026-01-13T00:02:14.394Z | * rust toolchain profile = "default" |
| 25 | 2026-01-13T00:02:14.394Z | + printf ' * rust toolchain profile = "%s"\n' default |
| 26 | 2026-01-13T00:02:14.394Z | + export RUSTUP_INIT_SKIP_PATH_CHECK=true |
| 27 | 2026-01-13T00:02:14.394Z | + RUSTUP_INIT_SKIP_PATH_CHECK=true |
| 28 | 2026-01-13T00:02:14.394Z | + curl --proto =https --tlsv1.2 -sSf https://sh.rustup.rs |
| 29 | 2026-01-13T00:02:14.394Z | + /bin/bash -s - -y --no-modify-path --default-toolchain stable --profile default |
| 30 | 2026-01-13T00:02:14.529Z | info: downloading installer |
| 31 | 2026-01-13T00:02:15.351Z | warn: It looks like you have an existing installation of Rust at: |
| 32 | 2026-01-13T00:02:15.351Z | warn: /opt/ooce/bin |
| 33 | 2026-01-13T00:02:15.351Z | warn: It is recommended that rustup be the primary Rust installation. |
| 34 | 2026-01-13T00:02:15.351Z | warn: Otherwise you may have confusion unless you are careful with your PATH. |
| 35 | 2026-01-13T00:02:15.351Z | warn: If you are sure that you want both rustup and your already installed Rust |
| 36 | 2026-01-13T00:02:15.351Z | warn: then please reply `y' or `yes' or set RUSTUP_INIT_SKIP_PATH_CHECK to yes |
| 37 | 2026-01-13T00:02:15.351Z | warn: or pass `-y' to ignore all ignorable checks. |
| 38 | 2026-01-13T00:02:15.351Z | error: cannot install while Rust is installed |
| 39 | 2026-01-13T00:02:15.351Z | warn: continuing (because the -y flag is set and the error is ignorable) |
| 40 | 2026-01-13T00:02:15.375Z | info: profile set to 'default' |
| 41 | 2026-01-13T00:02:15.375Z | info: default host triple is x86_64-unknown-illumos |
| 42 | 2026-01-13T00:02:15.375Z | info: syncing channel updates for 'stable-x86_64-unknown-illumos' |
| 43 | 2026-01-13T00:02:15.526Z | info: latest update on 2025-12-11, rust version 1.92.0 (ded5c06cf 2025-12-08) |
| 44 | 2026-01-13T00:02:15.526Z | info: downloading component 'cargo' |
| 45 | 2026-01-13T00:02:16.024Z | info: downloading component 'clippy' |
| 46 | 2026-01-13T00:02:16.115Z | info: downloading component 'rust-docs' |
| 47 | 2026-01-13T00:02:16.435Z | info: downloading component 'rust-std' |
| 48 | 2026-01-13T00:02:17.191Z | info: downloading component 'rustc' |
| 49 | 2026-01-13T00:02:19.531Z | info: downloading component 'rustfmt' |
| 50 | 2026-01-13T00:02:19.602Z | info: installing component 'cargo' |
| 51 | 2026-01-13T00:02:20.892Z | info: installing component 'clippy' |
| 52 | 2026-01-13T00:02:21.353Z | info: installing component 'rust-docs' |
| 53 | 2026-01-13T00:02:24.777Z | info: installing component 'rust-std' |
| 54 | 2026-01-13T00:02:27.160Z | info: installing component 'rustc' |
| 55 | 2026-01-13T00:02:35.818Z | info: installing component 'rustfmt' |
| 56 | 2026-01-13T00:02:36.249Z | info: default toolchain set to 'stable-x86_64-unknown-illumos' |
| 57 | 2026-01-13T00:02:36.249Z | |
| 58 | 2026-01-13T00:02:36.462Z | stable-x86_64-unknown-illumos installed - rustc 1.92.0 (ded5c06cf 2025-12-08) |
| 59 | 2026-01-13T00:02:36.462Z | |
| 60 | 2026-01-13T00:02:36.462Z | |
| 61 | 2026-01-13T00:02:36.462Z | Rust is installed now. Great! |
| 62 | 2026-01-13T00:02:36.462Z | |
| 63 | 2026-01-13T00:02:36.462Z | To get started you need Cargo's bin directory ($HOME/.cargo/bin) in your PATH |
| 64 | 2026-01-13T00:02:36.463Z | environment variable. This has not been done automatically. |
| 65 | 2026-01-13T00:02:36.463Z | |
| 66 | 2026-01-13T00:02:36.463Z | To configure your current shell, you need to source |
| 67 | 2026-01-13T00:02:36.463Z | the corresponding env file under $HOME/.cargo. |
| 68 | 2026-01-13T00:02:36.463Z | |
| 69 | 2026-01-13T00:02:36.463Z | This is usually done by running one of the following (note the leading DOT): |
| 70 | 2026-01-13T00:02:36.463Z | . "$HOME/.cargo/env" # For sh/bash/zsh/ash/dash/pdksh |
| 71 | 2026-01-13T00:02:36.463Z | source "$HOME/.cargo/env.fish" # For fish |
| 72 | 2026-01-13T00:02:36.463Z | source $"($nu.home-path)/.cargo/env.nu" # For nushell |
| 73 | 2026-01-13T00:02:36.606Z | + rustup --version |
| 74 | 2026-01-13T00:02:36.631Z | rustup 1.28.2 (e4f3ad6f8 2025-04-28) |
| 75 | 2026-01-13T00:02:36.631Z | info: This is the version for the rustup toolchain manager, not the rustc compiler. |
| 76 | 2026-01-13T00:02:36.779Z | info: The currently active `rustc` version is `rustc 1.92.0 (ded5c06cf 2025-12-08)` |
| 77 | 2026-01-13T00:02:36.803Z | + cargo --version |
| 78 | 2026-01-13T00:02:36.912Z | cargo 1.92.0 (344c4567c 2025-10-21) |
| 79 | 2026-01-13T00:02:36.936Z | + rustc --version |
| 80 | 2026-01-13T00:02:37.082Z | rustc 1.92.0 (ded5c06cf 2025-12-08) |
| 81 | 2026-01-13T00:02:37.106Z | process exited: duration 22720 ms, exit code 0 |
| |
| 82 | 2026-01-13T00:02:37.154Z | starting task 2: "authentication" |
| 83 | 2026-01-13T00:02:37.220Z | process exited: duration 64 ms, exit code 0 |
| |
| 84 | 2026-01-13T00:02:37.268Z | starting task 3: "clone repository" |
| 85 | 2026-01-13T00:02:37.292Z | + mkdir -p /work/oxidecomputer/poptrie |
| 86 | 2026-01-13T00:02:37.292Z | + git clone https://github.com/oxidecomputer/poptrie /work/oxidecomputer/poptrie |
| 87 | 2026-01-13T00:02:37.316Z | Cloning into '/work/oxidecomputer/poptrie'... |
| 88 | 2026-01-13T00:02:37.888Z | + cd /work/oxidecomputer/poptrie |
| 89 | 2026-01-13T00:02:37.888Z | + git fetch origin 6e3042f351bdb836cafa51e2d88582fcfe1b8887 |
| 90 | 2026-01-13T00:02:38.299Z | From https://github.com/oxidecomputer/poptrie |
| 91 | 2026-01-13T00:02:38.300Z | * branch 6e3042f351bdb836cafa51e2d88582fcfe1b8887 -> FETCH_HEAD |
| 92 | 2026-01-13T00:02:38.324Z | + [[ -n ry/match_31_32 ]] |
| 93 | 2026-01-13T00:02:38.324Z | ++ git branch --show-current |
| 94 | 2026-01-13T00:02:38.324Z | + current=main |
| 95 | 2026-01-13T00:02:38.324Z | + [[ main != ry/match_31_32 ]] |
| 96 | 2026-01-13T00:02:38.324Z | + git branch -f ry/match_31_32 6e3042f351bdb836cafa51e2d88582fcfe1b8887 |
| 97 | 2026-01-13T00:02:38.348Z | + git checkout -f ry/match_31_32 |
| 98 | 2026-01-13T00:02:38.348Z | Switched to branch 'ry/match_31_32' |
| 99 | 2026-01-13T00:02:38.349Z | + git reset --hard 6e3042f351bdb836cafa51e2d88582fcfe1b8887 |
| 100 | 2026-01-13T00:02:38.349Z | HEAD is now at 6e3042f kyle's feedback |
| 101 | 2026-01-13T00:02:38.373Z | process exited: duration 1080 ms, exit code 0 |
| |
| 102 | 2026-01-13T00:02:38.426Z | starting task 4: "build" |
| 103 | 2026-01-13T00:02:38.450Z | + cargo --version |
| 104 | 2026-01-13T00:02:38.555Z | cargo 1.92.0 (344c4567c 2025-10-21) |
| 105 | 2026-01-13T00:02:38.579Z | + rustc --version |
| 106 | 2026-01-13T00:02:38.705Z | rustc 1.92.0 (ded5c06cf 2025-12-08) |
| 107 | 2026-01-13T00:02:38.729Z | + banner bench |
| 108 | 2026-01-13T00:02:38.729Z | |
| 109 | 2026-01-13T00:02:38.729Z | ##### ###### # # #### # # |
| 110 | 2026-01-13T00:02:38.729Z | # # # ## # # # # # |
| 111 | 2026-01-13T00:02:38.729Z | ##### ##### # # # # ###### |
| 112 | 2026-01-13T00:02:38.729Z | # # # # # # # # # |
| 113 | 2026-01-13T00:02:38.729Z | # # # # ## # # # # |
| 114 | 2026-01-13T00:02:38.729Z | ##### ###### # # #### # # |
| 115 | 2026-01-13T00:02:38.729Z | |
| 116 | 2026-01-13T00:02:38.729Z | + cargo bench |
| 117 | 2026-01-13T00:02:39.028Z | Updating crates.io index |
| 118 | 2026-01-13T00:02:39.797Z | Downloading crates ... |
| 119 | 2026-01-13T00:02:39.872Z | Downloaded anstyle v1.0.13 |
| 120 | 2026-01-13T00:02:39.897Z | Downloaded either v1.15.0 |
| 121 | 2026-01-13T00:02:39.897Z | Downloaded ppv-lite86 v0.2.21 |
| 122 | 2026-01-13T00:02:39.897Z | Downloaded rand_xorshift v0.4.0 |
| 123 | 2026-01-13T00:02:39.897Z | Downloaded quick-error v1.2.3 |
| 124 | 2026-01-13T00:02:39.923Z | Downloaded same-file v1.0.6 |
| 125 | 2026-01-13T00:02:39.923Z | Downloaded zmij v1.0.12 |
| 126 | 2026-01-13T00:02:39.923Z | Downloaded tinytemplate v1.2.1 |
| 127 | 2026-01-13T00:02:39.923Z | Downloaded tempfile v3.24.0 |
| 128 | 2026-01-13T00:02:39.949Z | Downloaded rayon-core v1.13.0 |
| 129 | 2026-01-13T00:02:39.949Z | Downloaded serde v1.0.228 |
| 130 | 2026-01-13T00:02:39.949Z | Downloaded criterion v0.5.1 |
| 131 | 2026-01-13T00:02:39.949Z | Downloaded zerocopy-derive v0.8.33 |
| 132 | 2026-01-13T00:02:39.976Z | Downloaded plotters v0.3.7 |
| 133 | 2026-01-13T00:02:39.976Z | Downloaded serde_json v1.0.149 |
| 134 | 2026-01-13T00:02:40.009Z | Downloaded rand v0.9.2 |
| 135 | 2026-01-13T00:02:40.009Z | Downloaded regex v1.12.2 |
| 136 | 2026-01-13T00:02:40.010Z | Downloaded rayon v1.11.0 |
| 137 | 2026-01-13T00:02:40.038Z | Downloaded proptest v1.9.0 |
| 138 | 2026-01-13T00:02:40.038Z | Downloaded clap_builder v4.5.54 |
| 139 | 2026-01-13T00:02:40.038Z | Downloaded proc-macro2 v1.0.105 |
| 140 | 2026-01-13T00:02:40.038Z | Downloaded zerocopy v0.8.33 |
| 141 | 2026-01-13T00:02:40.065Z | Downloaded syn v2.0.114 |
| 142 | 2026-01-13T00:02:40.093Z | Downloaded memchr v2.7.6 |
| 143 | 2026-01-13T00:02:40.094Z | Downloaded half v2.7.1 |
| 144 | 2026-01-13T00:02:40.094Z | Downloaded getrandom v0.3.4 |
| 145 | 2026-01-13T00:02:40.094Z | Downloaded regex-syntax v0.8.8 |
| 146 | 2026-01-13T00:02:40.094Z | Downloaded serde_derive v1.0.228 |
| 147 | 2026-01-13T00:02:40.094Z | Downloaded serde_core v1.0.228 |
| 148 | 2026-01-13T00:02:40.094Z | Downloaded rustix v1.1.3 |
| 149 | 2026-01-13T00:02:40.128Z | Downloaded quote v1.0.43 |
| 150 | 2026-01-13T00:02:40.175Z | Downloaded itertools v0.10.5 |
| 151 | 2026-01-13T00:02:40.175Z | Downloaded ciborium v0.2.2 |
| 152 | 2026-01-13T00:02:40.175Z | Downloaded bit-vec v0.8.0 |
| 153 | 2026-01-13T00:02:40.175Z | Downloaded rusty-fork v0.3.1 |
| 154 | 2026-01-13T00:02:40.175Z | Downloaded rand_chacha v0.9.0 |
| 155 | 2026-01-13T00:02:40.175Z | Downloaded walkdir v2.5.0 |
| 156 | 2026-01-13T00:02:40.176Z | Downloaded wait-timeout v0.2.1 |
| 157 | 2026-01-13T00:02:40.176Z | Downloaded unicode-ident v1.0.22 |
| 158 | 2026-01-13T00:02:40.176Z | Downloaded regex-automata v0.4.13 |
| 159 | 2026-01-13T00:02:40.208Z | Downloaded unarray v0.1.4 |
| 160 | 2026-01-13T00:02:40.208Z | Downloaded cfg-if v1.0.4 |
| 161 | 2026-01-13T00:02:40.209Z | Downloaded rand_core v0.9.3 |
| 162 | 2026-01-13T00:02:40.209Z | Downloaded is-terminal v0.4.17 |
| 163 | 2026-01-13T00:02:40.209Z | Downloaded errno v0.3.14 |
| 164 | 2026-01-13T00:02:40.209Z | Downloaded criterion-plot v0.5.0 |
| 165 | 2026-01-13T00:02:40.209Z | Downloaded bit-set v0.8.0 |
| 166 | 2026-01-13T00:02:40.209Z | Downloaded plotters-backend v0.3.7 |
| 167 | 2026-01-13T00:02:40.209Z | Downloaded oorandom v11.1.5 |
| 168 | 2026-01-13T00:02:40.209Z | Downloaded fastrand v2.3.0 |
| 169 | 2026-01-13T00:02:40.210Z | Downloaded libc v0.2.180 |
| 170 | 2026-01-13T00:02:40.242Z | Downloaded crossbeam-epoch v0.9.18 |
| 171 | 2026-01-13T00:02:40.242Z | Downloaded clap v4.5.54 |
| 172 | 2026-01-13T00:02:40.242Z | Downloaded autocfg v1.5.0 |
| 173 | 2026-01-13T00:02:40.242Z | Downloaded plotters-svg v0.3.7 |
| 174 | 2026-01-13T00:02:40.243Z | Downloaded num-traits v0.2.19 |
| 175 | 2026-01-13T00:02:40.243Z | Downloaded itoa v1.0.17 |
| 176 | 2026-01-13T00:02:40.243Z | Downloaded bitflags v2.10.0 |
| 177 | 2026-01-13T00:02:40.272Z | Downloaded once_cell v1.21.3 |
| 178 | 2026-01-13T00:02:40.273Z | Downloaded fnv v1.0.7 |
| 179 | 2026-01-13T00:02:40.273Z | Downloaded clap_lex v0.7.6 |
| 180 | 2026-01-13T00:02:40.273Z | Downloaded ciborium-ll v0.2.2 |
| 181 | 2026-01-13T00:02:40.273Z | Downloaded ciborium-io v0.2.2 |
| 182 | 2026-01-13T00:02:40.273Z | Downloaded cast v0.3.0 |
| 183 | 2026-01-13T00:02:40.273Z | Downloaded aho-corasick v1.1.4 |
| 184 | 2026-01-13T00:02:40.273Z | Downloaded crossbeam-utils v0.8.21 |
| 185 | 2026-01-13T00:02:40.274Z | Downloaded crossbeam-deque v0.8.6 |
| 186 | 2026-01-13T00:02:40.274Z | Downloaded anes v0.1.6 |
| 187 | 2026-01-13T00:02:40.336Z | Compiling proc-macro2 v1.0.105 |
| 188 | 2026-01-13T00:02:40.336Z | Compiling quote v1.0.43 |
| 189 | 2026-01-13T00:02:40.336Z | Compiling libc v0.2.180 |
| 190 | 2026-01-13T00:02:40.373Z | Compiling unicode-ident v1.0.22 |
| 191 | 2026-01-13T00:02:40.373Z | Compiling cfg-if v1.0.4 |
| 192 | 2026-01-13T00:02:40.373Z | Compiling zerocopy v0.8.33 |
| 193 | 2026-01-13T00:02:40.373Z | Compiling getrandom v0.3.4 |
| 194 | 2026-01-13T00:02:40.373Z | Compiling serde_core v1.0.228 |
| 195 | 2026-01-13T00:02:40.510Z | Compiling crossbeam-utils v0.8.21 |
| 196 | 2026-01-13T00:02:40.594Z | Compiling autocfg v1.5.0 |
| 197 | 2026-01-13T00:02:40.967Z | Compiling rustix v1.1.3 |
| 198 | 2026-01-13T00:02:41.011Z | Compiling bitflags v2.10.0 |
| 199 | 2026-01-13T00:02:41.200Z | Compiling regex-syntax v0.8.8 |
| 200 | 2026-01-13T00:02:41.336Z | Compiling num-traits v0.2.19 |
| 201 | 2026-01-13T00:02:41.786Z | Compiling once_cell v1.21.3 |
| 202 | 2026-01-13T00:02:41.933Z | Compiling errno v0.3.14 |
| 203 | 2026-01-13T00:02:42.053Z | Compiling serde v1.0.228 |
| 204 | 2026-01-13T00:02:42.210Z | Compiling rand_core v0.9.3 |
| 205 | 2026-01-13T00:02:42.242Z | Compiling zmij v1.0.12 |
| 206 | 2026-01-13T00:02:42.684Z | Compiling crossbeam-epoch v0.9.18 |
| 207 | 2026-01-13T00:02:42.768Z | Compiling serde_json v1.0.149 |
| 208 | 2026-01-13T00:02:42.803Z | Compiling either v1.15.0 |
| 209 | 2026-01-13T00:02:43.054Z | Compiling syn v2.0.114 |
| 210 | 2026-01-13T00:02:43.127Z | Compiling fastrand v2.3.0 |
| 211 | 2026-01-13T00:02:43.212Z | Compiling rayon-core v1.13.0 |
| 212 | 2026-01-13T00:02:43.535Z | Compiling crossbeam-deque v0.8.6 |
| 213 | 2026-01-13T00:02:43.736Z | Compiling wait-timeout v0.2.1 |
| 214 | 2026-01-13T00:02:43.904Z | Compiling ciborium-io v0.2.2 |
| 215 | 2026-01-13T00:02:44.042Z | Compiling tempfile v3.24.0 |
| 216 | 2026-01-13T00:02:44.223Z | Compiling fnv v1.0.7 |
| 217 | 2026-01-13T00:02:44.383Z | Compiling quick-error v1.2.3 |
| 218 | 2026-01-13T00:02:44.581Z | Compiling anstyle v1.0.13 |
| 219 | 2026-01-13T00:02:44.612Z | Compiling plotters-backend v0.3.7 |
| 220 | 2026-01-13T00:02:44.808Z | Compiling clap_lex v0.7.6 |
| 221 | 2026-01-13T00:02:45.097Z | Compiling itoa v1.0.17 |
| 222 | 2026-01-13T00:02:45.258Z | Compiling bit-vec v0.8.0 |
| 223 | 2026-01-13T00:02:45.408Z | Compiling memchr v2.7.6 |
| 224 | 2026-01-13T00:02:45.606Z | Compiling clap_builder v4.5.54 |
| 225 | 2026-01-13T00:02:45.637Z | Compiling plotters-svg v0.3.7 |
| 226 | 2026-01-13T00:02:45.848Z | Compiling bit-set v0.8.0 |
| 227 | 2026-01-13T00:02:45.963Z | Compiling regex-automata v0.4.13 |
| 228 | 2026-01-13T00:02:46.084Z | Compiling rusty-fork v0.3.1 |
| 229 | 2026-01-13T00:02:46.283Z | Compiling itertools v0.10.5 |
| 230 | 2026-01-13T00:02:47.777Z | Compiling rand_xorshift v0.4.0 |
| 231 | 2026-01-13T00:02:48.017Z | Compiling rand v0.9.2 |
| 232 | 2026-01-13T00:02:49.060Z | Compiling same-file v1.0.6 |
| 233 | 2026-01-13T00:02:49.240Z | Compiling unarray v0.1.4 |
| 234 | 2026-01-13T00:02:49.325Z | Compiling cast v0.3.0 |
| 235 | 2026-01-13T00:02:49.402Z | Compiling walkdir v2.5.0 |
| 236 | 2026-01-13T00:02:49.576Z | Compiling regex v1.12.2 |
| 237 | 2026-01-13T00:02:49.647Z | Compiling criterion-plot v0.5.0 |
| 238 | 2026-01-13T00:02:50.072Z | Compiling zerocopy-derive v0.8.33 |
| 239 | 2026-01-13T00:02:50.820Z | Compiling serde_derive v1.0.228 |
| 240 | 2026-01-13T00:02:51.366Z | Compiling clap v4.5.54 |
| 241 | 2026-01-13T00:02:51.463Z | Compiling rayon v1.11.0 |
| 242 | 2026-01-13T00:02:52.111Z | Compiling plotters v0.3.7 |
| 243 | 2026-01-13T00:02:52.883Z | Compiling is-terminal v0.4.17 |
| 244 | 2026-01-13T00:02:53.012Z | Compiling poptrie v0.1.0 (/work/oxidecomputer/poptrie) |
| 245 | 2026-01-13T00:02:53.379Z | Compiling oorandom v11.1.5 |
| 246 | 2026-01-13T00:02:53.589Z | Compiling anes v0.1.6 |
| 247 | 2026-01-13T00:02:56.414Z | Compiling half v2.7.1 |
| 248 | 2026-01-13T00:02:56.468Z | Compiling ppv-lite86 v0.2.21 |
| 249 | 2026-01-13T00:02:56.953Z | Compiling ciborium-ll v0.2.2 |
| 250 | 2026-01-13T00:02:57.167Z | Compiling rand_chacha v0.9.0 |
| 251 | 2026-01-13T00:02:57.516Z | Compiling proptest v1.9.0 |
| 252 | 2026-01-13T00:02:57.572Z | Compiling tinytemplate v1.2.1 |
| 253 | 2026-01-13T00:02:57.572Z | Compiling ciborium v0.2.2 |
| 254 | 2026-01-13T00:02:58.706Z | Compiling criterion v0.5.1 |
| 255 | 2026-01-13T00:03:02.978Z | Compiling poptrie-test-util v0.1.0 (/work/oxidecomputer/poptrie/test-util) |
| 256 | 2026-01-13T00:03:14.305Z | Finished `bench` profile [optimized] target(s) in 35.47s |
| 257 | 2026-01-13T00:03:14.377Z | Running unittests src/lib.rs (target/release/deps/poptrie-d6bff7cbdecf4986) |
| 258 | 2026-01-13T00:03:14.402Z | |
| 259 | 2026-01-13T00:03:14.402Z | running 10 tests |
| 260 | 2026-01-13T00:03:14.402Z | test test::test_construct_rec ... ignored |
| 261 | 2026-01-13T00:03:14.402Z | test test::test_dense_route_bug ... ignored |
| 262 | 2026-01-13T00:03:14.402Z | test test::test_extract32 ... ignored |
| 263 | 2026-01-13T00:03:14.402Z | test test::test_lpm_overlapping_prefixes ... ignored |
| 264 | 2026-01-13T00:03:14.402Z | test test::test_match_v4 ... ignored |
| 265 | 2026-01-13T00:03:14.402Z | test test::test_match_v4_multi ... ignored |
| 266 | 2026-01-13T00:03:14.402Z | test test::test_match_v4_sus ... ignored |
| 267 | 2026-01-13T00:03:14.402Z | test test::test_match_v6 ... ignored |
| 268 | 2026-01-13T00:03:14.402Z | test test::test_short_prefix_bug ... ignored |
| 269 | 2026-01-13T00:03:14.402Z | test test::test_underflow_bug ... ignored |
| 270 | 2026-01-13T00:03:14.402Z | |
| 271 | 2026-01-13T00:03:14.402Z | test result: ok. 0 passed; 0 failed; 10 ignored; 0 measured; 0 filtered out; finished in 0.00s |
| 272 | 2026-01-13T00:03:14.402Z | |
| 273 | 2026-01-13T00:03:14.402Z | Running benches/lookup.rs (target/release/deps/lookup-bee3b802682a4331) |
| 274 | 2026-01-13T00:03:14.402Z | Gnuplot not found, using plotters backend |
| 275 | 2026-01-13T00:03:14.931Z | Benchmarking lookup/poptrie/100 |
| 276 | 2026-01-13T00:03:14.931Z | Benchmarking lookup/poptrie/100: Warming up for 3.0000 s |
| 277 | 2026-01-13T00:03:18.634Z | Benchmarking lookup/poptrie/100: Collecting 100 samples in estimated 5.0285 s (712k iterations) |
| 278 | 2026-01-13T00:03:23.644Z | Benchmarking lookup/poptrie/100: Analyzing |
| 279 | 2026-01-13T00:03:23.755Z | lookup/poptrie/100 time: [6.9210 µs 6.9954 µs 7.0821 µs] |
| 280 | 2026-01-13T00:03:23.755Z | Found 16 outliers among 100 measurements (16.00%) |
| 281 | 2026-01-13T00:03:23.755Z | 12 (12.00%) high mild |
| 282 | 2026-01-13T00:03:23.755Z | 4 (4.00%) high severe |
| 283 | 2026-01-13T00:03:24.809Z | Benchmarking lookup/naive/100 |
| 284 | 2026-01-13T00:03:24.809Z | Benchmarking lookup/naive/100: Warming up for 3.0000 s |
| 285 | 2026-01-13T00:03:29.286Z | Benchmarking lookup/naive/100: Collecting 100 samples in estimated 5.5199 s (20k iterations) |
| 286 | 2026-01-13T00:03:34.686Z | Benchmarking lookup/naive/100: Analyzing |
| 287 | 2026-01-13T00:03:34.789Z | lookup/naive/100 time: [263.89 µs 269.72 µs 275.85 µs] |
| 288 | 2026-01-13T00:03:34.789Z | Found 15 outliers among 100 measurements (15.00%) |
| 289 | 2026-01-13T00:03:34.789Z | 7 (7.00%) high mild |
| 290 | 2026-01-13T00:03:34.789Z | 8 (8.00%) high severe |
| 291 | 2026-01-13T00:03:35.852Z | Benchmarking lookup/poptrie/500 |
| 292 | 2026-01-13T00:03:35.852Z | Benchmarking lookup/poptrie/500: Warming up for 3.0000 s |
| 293 | 2026-01-13T00:03:40.609Z | Benchmarking lookup/poptrie/500: Collecting 100 samples in estimated 5.0413 s (556k iterations) |
| 294 | 2026-01-13T00:03:45.861Z | Benchmarking lookup/poptrie/500: Analyzing |
| 295 | 2026-01-13T00:03:45.967Z | lookup/poptrie/500 time: [9.3091 µs 9.6078 µs 9.9144 µs] |
| 296 | 2026-01-13T00:03:45.967Z | Found 8 outliers among 100 measurements (8.00%) |
| 297 | 2026-01-13T00:03:45.967Z | 6 (6.00%) high mild |
| 298 | 2026-01-13T00:03:45.967Z | 2 (2.00%) high severe |
| 299 | 2026-01-13T00:03:47.028Z | Benchmarking lookup/naive/500 |
| 300 | 2026-01-13T00:03:47.028Z | Benchmarking lookup/naive/500: Warming up for 3.0000 s |
| 301 | 2026-01-13T00:03:53.002Z | |
| 302 | 2026-01-13T00:03:53.002Z | Warning: Unable to complete 100 samples in 5.0s. You may wish to increase target time to 7.4s, enable flat sampling, or reduce sample count to 50. |
| 303 | 2026-01-13T00:03:53.002Z | Benchmarking lookup/naive/500: Collecting 100 samples in estimated 7.3677 s (5050 iterations) |
| 304 | 2026-01-13T00:04:00.466Z | Benchmarking lookup/naive/500: Analyzing |
| 305 | 2026-01-13T00:04:00.569Z | lookup/naive/500 time: [1.4501 ms 1.5059 ms 1.5680 ms] |
| 306 | 2026-01-13T00:04:00.569Z | Found 10 outliers among 100 measurements (10.00%) |
| 307 | 2026-01-13T00:04:00.569Z | 5 (5.00%) high mild |
| 308 | 2026-01-13T00:04:00.569Z | 5 (5.00%) high severe |
| 309 | 2026-01-13T00:04:01.679Z | Benchmarking lookup/poptrie/1000 |
| 310 | 2026-01-13T00:04:01.679Z | Benchmarking lookup/poptrie/1000: Warming up for 3.0000 s |
| 311 | 2026-01-13T00:04:07.382Z | Benchmarking lookup/poptrie/1000: Collecting 100 samples in estimated 5.0544 s (465k iterations) |
| 312 | 2026-01-13T00:04:12.301Z | Benchmarking lookup/poptrie/1000: Analyzing |
| 313 | 2026-01-13T00:04:12.409Z | lookup/poptrie/1000 time: [10.325 µs 10.565 µs 10.837 µs] |
| 314 | 2026-01-13T00:04:12.409Z | Found 6 outliers among 100 measurements (6.00%) |
| 315 | 2026-01-13T00:04:12.410Z | 4 (4.00%) high mild |
| 316 | 2026-01-13T00:04:12.410Z | 2 (2.00%) high severe |
| 317 | 2026-01-13T00:04:13.503Z | Benchmarking lookup/naive/1000 |
| 318 | 2026-01-13T00:04:13.503Z | Benchmarking lookup/naive/1000: Warming up for 3.0000 s |
| 319 | 2026-01-13T00:04:16.810Z | Benchmarking lookup/naive/1000: Collecting 100 samples in estimated 5.1731 s (1600 iterations) |
| 320 | 2026-01-13T00:04:22.239Z | Benchmarking lookup/naive/1000: Analyzing |
| 321 | 2026-01-13T00:04:22.332Z | lookup/naive/1000 time: [3.2820 ms 3.3934 ms 3.5173 ms] |
| 322 | 2026-01-13T00:04:22.333Z | Found 12 outliers among 100 measurements (12.00%) |
| 323 | 2026-01-13T00:04:22.333Z | 6 (6.00%) high mild |
| 324 | 2026-01-13T00:04:22.333Z | 6 (6.00%) high severe |
| 325 | 2026-01-13T00:04:23.307Z | Benchmarking lookup/poptrie/5000 |
| 326 | 2026-01-13T00:04:23.308Z | Benchmarking lookup/poptrie/5000: Warming up for 3.0000 s |
| 327 | 2026-01-13T00:04:27.045Z | Benchmarking lookup/poptrie/5000: Collecting 100 samples in estimated 5.0418 s (354k iterations) |
| 328 | 2026-01-13T00:04:31.970Z | Benchmarking lookup/poptrie/5000: Analyzing |
| 329 | 2026-01-13T00:04:32.087Z | lookup/poptrie/5000 time: [13.462 µs 13.831 µs 14.318 µs] |
| 330 | 2026-01-13T00:04:32.087Z | Found 14 outliers among 100 measurements (14.00%) |
| 331 | 2026-01-13T00:04:32.087Z | 5 (5.00%) high mild |
| 332 | 2026-01-13T00:04:32.087Z | 9 (9.00%) high severe |
| 333 | 2026-01-13T00:04:33.187Z | Benchmarking lookup/naive/5000 |
| 334 | 2026-01-13T00:04:33.187Z | Benchmarking lookup/naive/5000: Warming up for 3.0000 s |
| 335 | 2026-01-13T00:04:37.431Z | Benchmarking lookup/naive/5000: Collecting 100 samples in estimated 6.6571 s (400 iterations) |
| 336 | 2026-01-13T00:04:44.028Z | Benchmarking lookup/naive/5000: Analyzing |
| 337 | 2026-01-13T00:04:44.120Z | lookup/naive/5000 time: [16.263 ms 16.494 ms 16.749 ms] |
| 338 | 2026-01-13T00:04:44.120Z | Found 11 outliers among 100 measurements (11.00%) |
| 339 | 2026-01-13T00:04:44.120Z | 6 (6.00%) high mild |
| 340 | 2026-01-13T00:04:44.120Z | 5 (5.00%) high severe |
| 341 | 2026-01-13T00:04:45.075Z | Benchmarking lookup/poptrie/10000 |
| 342 | 2026-01-13T00:04:45.075Z | Benchmarking lookup/poptrie/10000: Warming up for 3.0000 s |
| 343 | 2026-01-13T00:04:48.905Z | Benchmarking lookup/poptrie/10000: Collecting 100 samples in estimated 5.0175 s (343k iterations) |
| 344 | 2026-01-13T00:04:53.795Z | Benchmarking lookup/poptrie/10000: Analyzing |
| 345 | 2026-01-13T00:04:53.898Z | lookup/poptrie/10000 time: [13.981 µs 14.301 µs 14.659 µs] |
| 346 | 2026-01-13T00:04:53.898Z | Found 9 outliers among 100 measurements (9.00%) |
| 347 | 2026-01-13T00:04:53.898Z | 3 (3.00%) high mild |
| 348 | 2026-01-13T00:04:53.898Z | 6 (6.00%) high severe |
| 349 | 2026-01-13T00:04:54.973Z | Benchmarking lookup/naive/10000 |
| 350 | 2026-01-13T00:04:54.973Z | Benchmarking lookup/naive/10000: Warming up for 3.0000 s |
| 351 | 2026-01-13T00:05:00.265Z | Benchmarking lookup/naive/10000: Collecting 100 samples in estimated 6.2275 s (300 iterations) |
| 352 | 2026-01-13T00:05:06.699Z | Benchmarking lookup/naive/10000: Analyzing |
| 353 | 2026-01-13T00:05:06.795Z | lookup/naive/10000 time: [21.068 ms 21.451 ms 21.892 ms] |
| 354 | 2026-01-13T00:05:06.795Z | Found 15 outliers among 100 measurements (15.00%) |
| 355 | 2026-01-13T00:05:06.795Z | 4 (4.00%) high mild |
| 356 | 2026-01-13T00:05:06.795Z | 11 (11.00%) high severe |
| 357 | 2026-01-13T00:05:07.760Z | |
| 358 | 2026-01-13T00:05:07.760Z | Benchmarking construction/poptrie/100 |
| 359 | 2026-01-13T00:05:07.760Z | Benchmarking construction/poptrie/100: Warming up for 3.0000 s |
| 360 | 2026-01-13T00:05:11.662Z | Benchmarking construction/poptrie/100: Collecting 100 samples in estimated 5.1091 s (86k iterations) |
| 361 | 2026-01-13T00:05:16.456Z | Benchmarking construction/poptrie/100: Analyzing |
| 362 | 2026-01-13T00:05:16.560Z | construction/poptrie/100 |
| 363 | 2026-01-13T00:05:16.560Z | time: [54.120 µs 55.843 µs 58.176 µs] |
| 364 | 2026-01-13T00:05:16.560Z | Found 9 outliers among 100 measurements (9.00%) |
| 365 | 2026-01-13T00:05:16.560Z | 5 (5.00%) high mild |
| 366 | 2026-01-13T00:05:16.560Z | 4 (4.00%) high severe |
| 367 | 2026-01-13T00:05:17.686Z | Benchmarking construction/poptrie/500 |
| 368 | 2026-01-13T00:05:17.686Z | Benchmarking construction/poptrie/500: Warming up for 3.0000 s |
| 369 | 2026-01-13T00:05:21.461Z | Benchmarking construction/poptrie/500: Collecting 100 samples in estimated 5.8173 s (25k iterations) |
| 370 | 2026-01-13T00:05:27.311Z | Benchmarking construction/poptrie/500: Analyzing |
| 371 | 2026-01-13T00:05:27.418Z | construction/poptrie/500 |
| 372 | 2026-01-13T00:05:27.418Z | time: [228.83 µs 234.94 µs 241.15 µs] |
| 373 | 2026-01-13T00:05:27.418Z | Found 10 outliers among 100 measurements (10.00%) |
| 374 | 2026-01-13T00:05:27.418Z | 5 (5.00%) high mild |
| 375 | 2026-01-13T00:05:27.418Z | 5 (5.00%) high severe |
| 376 | 2026-01-13T00:05:28.523Z | Benchmarking construction/poptrie/1000 |
| 377 | 2026-01-13T00:05:28.523Z | Benchmarking construction/poptrie/1000: Warming up for 3.0000 s |
| 378 | 2026-01-13T00:05:32.132Z | Benchmarking construction/poptrie/1000: Collecting 100 samples in estimated 6.6766 s (15k iterations) |
| 379 | 2026-01-13T00:05:38.619Z | Benchmarking construction/poptrie/1000: Analyzing |
| 380 | 2026-01-13T00:05:38.720Z | construction/poptrie/1000 |
| 381 | 2026-01-13T00:05:38.720Z | time: [423.34 µs 429.61 µs 436.52 µs] |
| 382 | 2026-01-13T00:05:38.720Z | Found 8 outliers among 100 measurements (8.00%) |
| 383 | 2026-01-13T00:05:38.720Z | 3 (3.00%) high mild |
| 384 | 2026-01-13T00:05:38.720Z | 5 (5.00%) high severe |
| 385 | 2026-01-13T00:05:39.815Z | Benchmarking construction/poptrie/5000 |
| 386 | 2026-01-13T00:05:39.815Z | Benchmarking construction/poptrie/5000: Warming up for 3.0000 s |
| 387 | 2026-01-13T00:05:44.051Z | Benchmarking construction/poptrie/5000: Collecting 100 samples in estimated 5.1743 s (2500 iterations) |
| 388 | 2026-01-13T00:05:49.153Z | Benchmarking construction/poptrie/5000: Analyzing |
| 389 | 2026-01-13T00:05:49.251Z | construction/poptrie/5000 |
| 390 | 2026-01-13T00:05:49.251Z | time: [2.0192 ms 2.0406 ms 2.0651 ms] |
| 391 | 2026-01-13T00:05:49.251Z | Found 9 outliers among 100 measurements (9.00%) |
| 392 | 2026-01-13T00:05:49.251Z | 4 (4.00%) high mild |
| 393 | 2026-01-13T00:05:49.251Z | 5 (5.00%) high severe |
| 394 | 2026-01-13T00:05:50.252Z | |
| 395 | 2026-01-13T00:05:50.277Z | Benchmarking single_lookup/poptrie/100 |
| 396 | 2026-01-13T00:05:50.277Z | Benchmarking single_lookup/poptrie/100: Warming up for 3.0000 s |
| 397 | 2026-01-13T00:05:54.168Z | Benchmarking single_lookup/poptrie/100: Collecting 100 samples in estimated 5.0000 s (686M iterations) |
| 398 | 2026-01-13T00:05:59.093Z | Benchmarking single_lookup/poptrie/100: Analyzing |
| 399 | 2026-01-13T00:05:59.199Z | single_lookup/poptrie/100 |
| 400 | 2026-01-13T00:05:59.199Z | time: [7.0186 ns 7.3077 ns 7.6222 ns] |
| 401 | 2026-01-13T00:05:59.199Z | Found 18 outliers among 100 measurements (18.00%) |
| 402 | 2026-01-13T00:05:59.199Z | 7 (7.00%) high mild |
| 403 | 2026-01-13T00:05:59.199Z | 11 (11.00%) high severe |
| 404 | 2026-01-13T00:06:00.368Z | Benchmarking single_lookup/naive/100 |
| 405 | 2026-01-13T00:06:00.368Z | Benchmarking single_lookup/naive/100: Warming up for 3.0000 s |
| 406 | 2026-01-13T00:06:04.488Z | Benchmarking single_lookup/naive/100: Collecting 100 samples in estimated 5.0009 s (20M iterations) |
| 407 | 2026-01-13T00:06:09.501Z | Benchmarking single_lookup/naive/100: Analyzing |
| 408 | 2026-01-13T00:06:09.602Z | single_lookup/naive/100 time: [238.74 ns 245.76 ns 255.14 ns] |
| 409 | 2026-01-13T00:06:09.602Z | Found 6 outliers among 100 measurements (6.00%) |
| 410 | 2026-01-13T00:06:09.602Z | 1 (1.00%) high mild |
| 411 | 2026-01-13T00:06:09.602Z | 5 (5.00%) high severe |
| 412 | 2026-01-13T00:06:10.756Z | Benchmarking single_lookup/poptrie/1000 |
| 413 | 2026-01-13T00:06:10.756Z | Benchmarking single_lookup/poptrie/1000: Warming up for 3.0000 s |
| 414 | 2026-01-13T00:06:14.429Z | Benchmarking single_lookup/poptrie/1000: Collecting 100 samples in estimated 5.0000 s (731M iterations) |
| 415 | 2026-01-13T00:06:19.466Z | Benchmarking single_lookup/poptrie/1000: Analyzing |
| 416 | 2026-01-13T00:06:19.567Z | single_lookup/poptrie/1000 |
| 417 | 2026-01-13T00:06:19.567Z | time: [6.6918 ns 6.8954 ns 7.1400 ns] |
| 418 | 2026-01-13T00:06:19.567Z | Found 14 outliers among 100 measurements (14.00%) |
| 419 | 2026-01-13T00:06:19.567Z | 3 (3.00%) high mild |
| 420 | 2026-01-13T00:06:19.567Z | 11 (11.00%) high severe |
| 421 | 2026-01-13T00:06:20.699Z | Benchmarking single_lookup/naive/1000 |
| 422 | 2026-01-13T00:06:20.699Z | Benchmarking single_lookup/naive/1000: Warming up for 3.0000 s |
| 423 | 2026-01-13T00:06:23.818Z | Benchmarking single_lookup/naive/1000: Collecting 100 samples in estimated 5.0027 s (1.7M iterations) |
| 424 | 2026-01-13T00:06:28.729Z | Benchmarking single_lookup/naive/1000: Analyzing |
| 425 | 2026-01-13T00:06:28.831Z | single_lookup/naive/1000 |
| 426 | 2026-01-13T00:06:28.831Z | time: [2.8343 µs 2.9187 µs 3.0113 µs] |
| 427 | 2026-01-13T00:06:28.831Z | Found 18 outliers among 100 measurements (18.00%) |
| 428 | 2026-01-13T00:06:28.831Z | 10 (10.00%) high mild |
| 429 | 2026-01-13T00:06:28.831Z | 8 (8.00%) high severe |
| 430 | 2026-01-13T00:06:29.938Z | Benchmarking single_lookup/poptrie/10000 |
| 431 | 2026-01-13T00:06:29.938Z | Benchmarking single_lookup/poptrie/10000: Warming up for 3.0000 s |
| 432 | 2026-01-13T00:06:33.054Z | Benchmarking single_lookup/poptrie/10000: Collecting 100 samples in estimated 5.0000 s (431M iterations) |
| 433 | 2026-01-13T00:06:37.816Z | Benchmarking single_lookup/poptrie/10000: Analyzing |
| 434 | 2026-01-13T00:06:37.912Z | single_lookup/poptrie/10000 |
| 435 | 2026-01-13T00:06:37.912Z | time: [10.967 ns 11.079 ns 11.222 ns] |
| 436 | 2026-01-13T00:06:37.912Z | Found 3 outliers among 100 measurements (3.00%) |
| 437 | 2026-01-13T00:06:37.914Z | 3 (3.00%) high severe |
| 438 | 2026-01-13T00:06:39.003Z | Benchmarking single_lookup/naive/10000 |
| 439 | 2026-01-13T00:06:39.003Z | Benchmarking single_lookup/naive/10000: Warming up for 3.0000 s |
| 440 | 2026-01-13T00:06:44.003Z | Benchmarking single_lookup/naive/10000: Collecting 100 samples in estimated 5.0096 s (263k iterations) |
| 441 | 2026-01-13T00:06:49.020Z | Benchmarking single_lookup/naive/10000: Analyzing |
| 442 | 2026-01-13T00:06:49.119Z | single_lookup/naive/10000 |
| 443 | 2026-01-13T00:06:49.119Z | time: [18.866 µs 19.104 µs 19.388 µs] |
| 444 | 2026-01-13T00:06:49.119Z | Found 6 outliers among 100 measurements (6.00%) |
| 445 | 2026-01-13T00:06:49.119Z | 2 (2.00%) high mild |
| 446 | 2026-01-13T00:06:49.119Z | 4 (4.00%) high severe |
| 447 | 2026-01-13T00:06:50.207Z | |
| 448 | 2026-01-13T00:06:50.240Z | process exited: duration 251842 ms, exit code 0 |
| |
| 449 | 2026-01-13T00:06:50.291Z | found 0 output files |