[go: up one dir, main page]

Skip to content
Unstable

Console Output

Skipping 3,561 KB.. Full Log
epair2a: Ethernet address: 02:5e:52:c8:30:0a
20:37:21 epair2b: Ethernet address: 02:5e:52:c8:30:0b
20:37:21 epair2a: link state changed to UP
20:37:21 epair2b: link state changed to UP
20:37:22 epair3a: Ethernet address: 02:3f:1f:01:ae:0a
20:37:22 epair3b: Ethernet address: 02:3f:1f:01:ae:0b
20:37:22 epair3a: link state changed to UP
20:37:22 epair3b: link state changed to UP
20:37:46 epair0a: link state changed to DOWN
20:37:46 epair0b: link state changed to DOWN
20:37:49 epair1a: link state changed to DOWN
20:37:49 epair1b: link state changed to DOWN
20:37:51 epair3b: link state changed to DOWN
20:37:51 epair3a: link state changed to DOWN
20:37:53 epair2b: link state changed to DOWN
20:37:53 epair2a: link state changed to DOWN
20:37:57 passed  [27.495s]
20:38:00 sys/netipsec/tunnel/aesni_aes_cbc_256_hmac_sha2_256:v4  ->  epair0a: Ethernet address: 02:c8:26:bd:30:0a
20:38:00 epair0b: Ethernet address: 02:c8:26:bd:30:0b
20:38:00 epair0a: link state changed to UP
20:38:00 epair0b: link state changed to UP
20:38:01 epair1a: Ethernet address: 02:62:7c:09:81:0a
20:38:01 epair1b: Ethernet address: 02:62:7c:09:81:0b
20:38:01 epair1a: link state changed to UP
20:38:01 epair1b: link state changed to UP
20:38:02 epair2a: Ethernet address: 02:34:1a:b6:82:0a
20:38:02 epair2b: Ethernet address: 02:34:1a:b6:82:0b
20:38:02 epair2a: link state changed to UP
20:38:02 epair2b: link state changed to UP
20:38:02 epair3a: Ethernet address: 02:ae:7e:7f:85:0a
20:38:02 epair3b: Ethernet address: 02:ae:7e:7f:85:0b
20:38:02 epair3a: link state changed to UP
20:38:02 epair3b: link state changed to UP
20:38:27 epair0a: link state changed to DOWN
20:38:27 epair0b: link state changed to DOWN
20:38:29 epair1a: link state changed to DOWN
20:38:29 epair1b: link state changed to DOWN
20:38:32 epair3b: link state changed to DOWN
20:38:32 epair3a: link state changed to DOWN
20:38:33 epair2b: link state changed to DOWN
20:38:33 epair2a: link state changed to DOWN
20:38:37 passed  [27.053s]
20:38:40 sys/netipsec/tunnel/aesni_aes_cbc_256_hmac_sha2_256:v6  ->  epair0a: Ethernet address: 02:95:e5:41:61:0a
20:38:40 epair0b: Ethernet address: 02:95:e5:41:61:0b
20:38:40 epair0a: link state changed to UP
20:38:40 epair0b: link state changed to UP
20:38:41 epair1a: Ethernet address: 02:1e:c8:91:b1:0a
20:38:41 epair1b: Ethernet address: 02:1e:c8:91:b1:0b
20:38:41 epair1a: link state changed to UP
20:38:41 epair1b: link state changed to UP
20:38:42 epair2a: Ethernet address: 02:cc:68:77:31:0a
20:38:42 epair2b: Ethernet address: 02:cc:68:77:31:0b
20:38:42 epair2a: link state changed to UP
20:38:42 epair2b: link state changed to UP
20:38:43 epair3a: Ethernet address: 02:82:1e:e1:e5:0a
20:38:43 epair3b: Ethernet address: 02:82:1e:e1:e5:0b
20:38:43 epair3a: link state changed to UP
20:38:43 epair3b: link state changed to UP
20:39:08 epair0a: link state changed to DOWN
20:39:08 epair0b: link state changed to DOWN
20:39:10 epair1a: link state changed to DOWN
20:39:10 epair1b: link state changed to DOWN
20:39:12 epair3b: link state changed to DOWN
20:39:12 epair3a: link state changed to DOWN
20:39:14 epair2b: link state changed to DOWN
20:39:14 epair2a: link state changed to DOWN
20:39:18 passed  [27.363s]
20:39:21 sys/netipsec/tunnel/aesni_aes_gcm_128:v4  ->  epair0a: Ethernet address: 02:fe:14:fc:ca:0a
20:39:21 epair0b: Ethernet address: 02:fe:14:fc:ca:0b
20:39:21 epair0a: link state changed to UP
20:39:21 epair0b: link state changed to UP
20:39:22 epair1a: Ethernet address: 02:d8:8b:c2:13:0a
20:39:22 epair1b: Ethernet address: 02:d8:8b:c2:13:0b
20:39:22 epair1a: link state changed to UP
20:39:22 epair1b: link state changed to UP
20:39:23 epair2a: Ethernet address: 02:79:76:a8:f5:0a
20:39:23 epair2b: Ethernet address: 02:79:76:a8:f5:0b
20:39:23 epair2a: link state changed to UP
20:39:23 epair2b: link state changed to UP
20:39:24 epair3a: Ethernet address: 02:8c:40:cc:ec:0a
20:39:24 epair3b: Ethernet address: 02:8c:40:cc:ec:0b
20:39:24 epair3a: link state changed to UP
20:39:24 epair3b: link state changed to UP
20:39:48 epair0a: link state changed to DOWN
20:39:48 epair0b: link state changed to DOWN
20:39:50 epair1a: link state changed to DOWN
20:39:50 epair1b: link state changed to DOWN
20:39:53 epair3b: link state changed to DOWN
20:39:53 epair3a: link state changed to DOWN
20:39:55 epair2b: link state changed to DOWN
20:39:55 epair2a: link state changed to DOWN
20:39:59 passed  [27.152s]
20:40:02 sys/netipsec/tunnel/aesni_aes_gcm_128:v6  ->  epair0a: Ethernet address: 02:0e:c9:f4:c6:0a
20:40:02 epair0b: Ethernet address: 02:0e:c9:f4:c6:0b
20:40:02 epair0a: link state changed to UP
20:40:02 epair0b: link state changed to UP
20:40:03 epair1a: Ethernet address: 02:e3:97:63:33:0a
20:40:03 epair1b: Ethernet address: 02:e3:97:63:33:0b
20:40:03 epair1a: link state changed to UP
20:40:03 epair1b: link state changed to UP
20:40:03 epair2a: Ethernet address: 02:ec:60:1b:6d:0a
20:40:03 epair2b: Ethernet address: 02:ec:60:1b:6d:0b
20:40:03 epair2a: link state changed to UP
20:40:03 epair2b: link state changed to UP
20:40:04 epair3a: Ethernet address: 02:59:4f:7c:83:0a
20:40:04 epair3b: Ethernet address: 02:59:4f:7c:83:0b
20:40:04 epair3a: link state changed to UP
20:40:04 epair3b: link state changed to UP
20:40:29 epair0a: link state changed to DOWN
20:40:29 epair0b: link state changed to DOWN
20:40:31 epair1a: link state changed to DOWN
20:40:31 epair1b: link state changed to DOWN
20:40:34 epair3b: link state changed to DOWN
20:40:34 epair3a: link state changed to DOWN
20:40:35 epair2b: link state changed to DOWN
20:40:35 epair2a: link state changed to DOWN
20:40:39 passed  [27.467s]
20:40:43 sys/netipsec/tunnel/aesni_aes_gcm_256:v4  ->  epair0a: Ethernet address: 02:a4:45:41:a0:0a
20:40:43 epair0b: Ethernet address: 02:a4:45:41:a0:0b
20:40:43 epair0a: link state changed to UP
20:40:43 epair0b: link state changed to UP
20:40:43 epair1a: Ethernet address: 02:a7:f7:71:47:0a
20:40:43 epair1b: Ethernet address: 02:a7:f7:71:47:0b
20:40:43 epair1a: link state changed to UP
20:40:43 epair1b: link state changed to UP
20:40:44 epair2a: Ethernet address: 02:6f:88:8e:6f:0a
20:40:44 epair2b: Ethernet address: 02:6f:88:8e:6f:0b
20:40:44 epair2a: link state changed to UP
20:40:44 epair2b: link state changed to UP
20:40:45 epair3a: Ethernet address: 02:da:aa:2c:df:0a
20:40:45 epair3b: Ethernet address: 02:da:aa:2c:df:0b
20:40:45 epair3a: link state changed to UP
20:40:45 epair3b: link state changed to UP
20:41:09 epair0a: link state changed to DOWN
20:41:09 epair0b: link state changed to DOWN
20:41:12 epair1a: link state changed to DOWN
20:41:12 epair1b: link state changed to DOWN
20:41:14 epair3b: link state changed to DOWN
20:41:14 epair3a: link state changed to DOWN
20:41:16 epair2b: link state changed to DOWN
20:41:16 epair2a: link state changed to DOWN
20:41:20 passed  [27.230s]
20:41:23 sys/netipsec/tunnel/aesni_aes_gcm_256:v6  ->  epair0a: Ethernet address: 02:45:59:1f:ff:0a
20:41:23 epair0b: Ethernet address: 02:45:59:1f:ff:0b
20:41:23 epair0a: link state changed to UP
20:41:23 epair0b: link state changed to UP
20:41:24 epair1a: Ethernet address: 02:a2:a1:ce:d2:0a
20:41:24 epair1b: Ethernet address: 02:a2:a1:ce:d2:0b
20:41:24 epair1a: link state changed to UP
20:41:24 epair1b: link state changed to UP
20:41:25 epair2a: Ethernet address: 02:2b:59:d4:4d:0a
20:41:25 epair2b: Ethernet address: 02:2b:59:d4:4d:0b
20:41:25 epair2a: link state changed to UP
20:41:25 epair2b: link state changed to UP
20:41:26 epair3a: Ethernet address: 02:c1:2e:f9:4e:0a
20:41:26 epair3b: Ethernet address: 02:c1:2e:f9:4e:0b
20:41:26 epair3a: link state changed to UP
20:41:26 epair3b: link state changed to UP
20:41:50 epair0a: link state changed to DOWN
20:41:50 epair0b: link state changed to DOWN
20:41:53 epair1a: link state changed to DOWN
20:41:53 epair1b: link state changed to DOWN
20:41:55 epair3b: link state changed to DOWN
20:41:55 epair3a: link state changed to DOWN
20:41:57 epair2b: link state changed to DOWN
20:41:57 epair2a: link state changed to DOWN
20:42:01 passed  [27.661s]
20:42:04 sys/netipsec/tunnel/chacha20_poly1305:v4  ->  epair0a: Ethernet address: 02:67:62:37:f4:0a
20:42:04 epair0b: Ethernet address: 02:67:62:37:f4:0b
20:42:04 epair0a: link state changed to UP
20:42:04 epair0b: link state changed to UP
20:42:05 epair1a: Ethernet address: 02:53:0c:b2:58:0a
20:42:05 epair1b: Ethernet address: 02:53:0c:b2:58:0b
20:42:05 epair1a: link state changed to UP
20:42:05 epair1b: link state changed to UP
20:42:05 epair2a: Ethernet address: 02:f7:43:e5:21:0a
20:42:06 epair2b: Ethernet address: 02:f7:43:e5:21:0b
20:42:06 epair2a: link state changed to UP
20:42:06 epair2b: link state changed to UP
20:42:06 epair3a: Ethernet address: 02:fb:69:9f:96:0a
20:42:06 epair3b: Ethernet address: 02:fb:69:9f:96:0b
20:42:06 epair3a: link state changed to UP
20:42:06 epair3b: link state changed to UP
20:42:31 epair0a: link state changed to DOWN
20:42:31 epair0b: link state changed to DOWN
20:42:33 epair1a: link state changed to DOWN
20:42:33 epair1b: link state changed to DOWN
20:42:35 epair3b: link state changed to DOWN
20:42:35 epair3a: link state changed to DOWN
20:42:37 epair2b: link state changed to DOWN
20:42:37 epair2a: link state changed to DOWN
20:42:41 passed  [26.860s]
20:42:44 sys/netipsec/tunnel/chacha20_poly1305:v6  ->  epair0a: Ethernet address: 02:c0:9d:f9:4b:0a
20:42:44 epair0b: Ethernet address: 02:c0:9d:f9:4b:0b
20:42:44 epair0a: link state changed to UP
20:42:44 epair0b: link state changed to UP
20:42:45 epair1a: Ethernet address: 02:a3:6b:a2:47:0a
20:42:45 epair1b: Ethernet address: 02:a3:6b:a2:47:0b
20:42:45 epair1a: link state changed to UP
20:42:45 epair1b: link state changed to UP
20:42:46 epair2a: Ethernet address: 02:6c:b3:27:10:0a
20:42:46 epair2b: Ethernet address: 02:6c:b3:27:10:0b
20:42:46 epair2a: link state changed to UP
20:42:46 epair2b: link state changed to UP
20:42:46 epair3a: Ethernet address: 02:79:e2:67:24:0a
20:42:46 epair3b: Ethernet address: 02:79:e2:67:24:0b
20:42:47 epair3a: link state changed to UP
20:42:47 epair3b: link state changed to UP
20:43:12 epair0a: link state changed to DOWN
20:43:12 epair0b: link state changed to DOWN
20:43:14 epair1a: link state changed to DOWN
20:43:14 epair1b: link state changed to DOWN
20:43:16 epair3b: link state changed to DOWN
20:43:16 epair3a: link state changed to DOWN
20:43:18 epair2b: link state changed to DOWN
20:43:18 epair2a: link state changed to DOWN
20:43:22 passed  [27.492s]
20:43:25 sys/netipsec/tunnel/empty:v4  ->  epair0a: Ethernet address: 02:df:48:4e:ab:0a
20:43:25 epair0b: Ethernet address: 02:df:48:4e:ab:0b
20:43:25 epair0a: link state changed to UP
20:43:25 epair0b: link state changed to UP
20:43:26 epair1a: Ethernet address: 02:c8:b3:b2:7c:0a
20:43:26 epair1b: Ethernet address: 02:c8:b3:b2:7c:0b
20:43:26 epair1a: link state changed to UP
20:43:26 epair1b: link state changed to UP
20:43:27 epair2a: Ethernet address: 02:4b:20:0b:37:0a
20:43:27 epair2b: Ethernet address: 02:4b:20:0b:37:0b
20:43:27 epair2a: link state changed to UP
20:43:27 epair2b: link state changed to UP
20:43:28 epair3a: Ethernet address: 02:4f:06:68:90:0a
20:43:28 epair3b: Ethernet address: 02:4f:06:68:90:0b
20:43:28 epair3a: link state changed to UP
20:43:28 epair3b: link state changed to UP
20:43:52 epair0a: link state changed to DOWN
20:43:52 epair0b: link state changed to DOWN
20:43:54 epair1a: link state changed to DOWN
20:43:54 epair1b: link state changed to DOWN
20:43:57 epair3b: link state changed to DOWN
20:43:57 epair3a: link state changed to DOWN
20:43:59 epair2b: link state changed to DOWN
20:43:59 epair2a: link state changed to DOWN
20:44:03 passed  [26.963s]
20:44:05 sys/netipsec/tunnel/empty:v6  ->  epair0a: Ethernet address: 02:37:3e:21:28:0a
20:44:05 epair0b: Ethernet address: 02:37:3e:21:28:0b
20:44:06 epair0a: link state changed to UP
20:44:06 epair0b: link state changed to UP
20:44:06 epair1a: Ethernet address: 02:db:e3:6c:ce:0a
20:44:06 epair1b: Ethernet address: 02:db:e3:6c:ce:0b
20:44:06 epair1a: link state changed to UP
20:44:06 epair1b: link state changed to UP
20:44:07 epair2a: Ethernet address: 02:af:43:c7:44:0a
20:44:07 epair2b: Ethernet address: 02:af:43:c7:44:0b
20:44:07 epair2a: link state changed to UP
20:44:07 epair2b: link state changed to UP
20:44:08 epair3a: Ethernet address: 02:b8:4c:fb:08:0a
20:44:08 epair3b: Ethernet address: 02:b8:4c:fb:08:0b
20:44:08 epair3a: link state changed to UP
20:44:08 epair3b: link state changed to UP
20:44:33 epair0a: link state changed to DOWN
20:44:33 epair0b: link state changed to DOWN
20:44:35 epair1a: link state changed to DOWN
20:44:35 epair1b: link state changed to DOWN
20:44:37 epair3b: link state changed to DOWN
20:44:37 epair3a: link state changed to DOWN
20:44:39 epair2b: link state changed to DOWN
20:44:39 epair2a: link state changed to DOWN
20:44:43 passed  [27.176s]
20:44:44 sys/netmap/ctrl-api-test:main  ->  tap3345: Ethernet address: 58:9c:fc:00:3f:29
20:44:44 884.571158 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:44 884.573028 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:44 884.578840 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:44 884.601309 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:44 884.606903 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:45 884.736860 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:45 884.739421 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:45 884.752529 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:45 884.757115 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:45 884.881857 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:45 884.884539 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:45 884.898176 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:45 884.901153 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:45 885.052760 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:45 885.055314 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:45 885.069903 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:45 885.072664 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:45 885.196966 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:45 885.199881 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:45 885.215325 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:45 885.218597 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:45 885.343885 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:45 885.346755 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:45 885.388479 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:45 885.392744 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:45 885.543230 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:45 885.547603 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:45 885.580869 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:45 885.587497 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:46 885.746148 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:46 885.749645 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:46 885.781105 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:46 885.784239 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:46 885.952234 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:48 per4: Ethernet address: 00:be:8c:c9:41:00
20:44:48 888.517893 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:48 888.630141 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:48 888.634265 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:48 888.647415 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:48 888.651207 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:49 888.779253 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:49 888.792608 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:49 888.949143 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:49 888.951818 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:49 889.107995 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:49 889.110607 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:49 889.112837 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:49 889.115436 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:49 889.225714 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:49 889.229533 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:49 889.258968 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:49 889.261856 [ 886] get_polling_cfg           SINGLE qfirst 0 qlast 1 cpu_from 0 ncpus 1
20:44:49 889.264017 [3946] nma_intr_enable           Cannot disable interrupts for tap3345
20:44:49 889.265274 [ 798] nm_bdg_polling_start_kthreads error in nm_kthread_start(): 45
20:44:49 889.266533 [ 928] nm_bdg_ctl_polling_start  ERROR nm_bdg_polling_start_kthread()
20:44:49 889.268346 [3946] nma_intr_enable           Cannot enable interrupts for tap3345
20:44:49 889.271245 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:49 889.413832 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:49 889.417822 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:49 889.431119 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:49 889.433526 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:49 889.559103 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:49 889.568169 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:49 889.569706 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:49 889.572117 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:49 889.584466 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:49 889.587458 [2224] netmap_csb_validate       csb_init for kring tap3345 RX0: head 0, cur 0, hwcur 0, hwtail 0
20:44:49 889.589092 [2224] netmap_csb_validate       csb_init for kring tap3345 TX0: head 0, cur 0, hwcur 0, hwtail 1023
20:44:49 889.592031 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:49 889.721988 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:49 889.724586 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 889.738726 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:50 889.740443 [2175] netmap_csb_validate       Unaligned CSB address
20:44:50 889.741924 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:50 889.871752 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 889.876802 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 889.878172 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 889.880039 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 889.893211 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:50 889.894988 [2224] netmap_csb_validate       csb_init for kring tap3345 RX0: head 0, cur 0, hwcur 0, hwtail 0
20:44:50 889.896931 [2224] netmap_csb_validate       csb_init for kring tap3345 TX0: head 0, cur 0, hwcur 0, hwtail 1023
20:44:50 889.906180 [ 820] netmap_sync_kloop         kloop busy_wait 1, direct_tx 0, direct_rx 0, na_could_sleep 0
20:44:50 889.910312 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:50 890.040231 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.043005 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.044334 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.047382 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.060209 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:50 890.062002 [2224] netmap_csb_validate       csb_init for kring tap3345 RX0: head 0, cur 0, hwcur 0, hwtail 0
20:44:50 890.063385 [2224] netmap_csb_validate       csb_init for kring tap3345 TX0: head 0, cur 0, hwcur 0, hwtail 1023
20:44:50 890.073924 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:50 890.204340 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.207519 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.208809 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.210447 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.222484 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:50 890.225625 [2224] netmap_csb_validate       csb_init for kring tap3345 TX0: head 0, cur 0, hwcur 0, hwtail 1023
20:44:50 890.234047 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:50 890.353379 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.356556 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.357892 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.359559 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.371787 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:50 890.373746 [2224] netmap_csb_validate       csb_init for kring tap3345 RX0: head 0, cur 0, hwcur 0, hwtail 0
20:44:50 890.375076 [2224] netmap_csb_validate       csb_init for kring tap3345 TX0: head 0, cur 0, hwcur 0, hwtail 1023
20:44:50 890.382365 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:50 890.504643 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.507768 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.509073 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.510738 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.523235 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:50 890.525173 [2224] netmap_csb_validate       csb_init for kring tap3345 RX0: head 0, cur 0, hwcur 0, hwtail 0
20:44:50 890.527147 [2224] netmap_csb_validate       csb_init for kring tap3345 TX0: head 0, cur 0, hwcur 0, hwtail 1023
20:44:50 890.533704 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:50 890.653975 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.656966 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.658226 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:50 890.659820 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:50 890.671381 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:50 890.673249 [2224] netmap_csb_validate       csb_init for kring tap3345 RX0: head 0, cur 0, hwcur 0, hwtail 0
20:44:50 890.674607 [2224] netmap_csb_validate       csb_init for kring tap3345 TX0: head 0, cur 0, hwcur 0, hwtail 1023
20:44:50 890.681236 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:51 890.799336 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:51 890.802110 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:51 890.814658 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:51 890.818521 [ 609] netmap_sync_kloop         sync-kloop on tap3345 requires NETMAP_REQ_OPT_CSB option
20:44:51 890.829099 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:51 890.949211 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:51 890.951863 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:51 890.964055 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:51 890.968020 [2224] netmap_csb_validate       csb_init for kring tap3345 RX0: head 0, cur 0, hwcur 0, hwtail 0
20:44:51 890.969413 [2224] netmap_csb_validate       csb_init for kring tap3345 TX0: head 0, cur 0, hwcur 0, hwtail 1023
20:44:51 890.972581 [ 820] netmap_sync_kloop         kloop busy_wait 1, direct_tx 0, direct_rx 0, na_could_sleep 0
20:44:51 890.975449 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:51 891.095332 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:51 891.098966 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:51 891.100255 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:51 891.101893 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:51 891.114549 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:51 891.116509 [2224] netmap_csb_validate       csb_init for kring tap3345 RX0: head 0, cur 0, hwcur 0, hwtail 0
20:44:51 891.117903 [2224] netmap_csb_validate       csb_init for kring tap3345 TX0: head 0, cur 0, hwcur 0, hwtail 1023
20:44:51 891.121744 [ 820] netmap_sync_kloop         kloop busy_wait 1, direct_tx 0, direct_rx 0, na_could_sleep 0
20:44:51 891.128561 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:51 891.248329 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:51 891.251066 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:51 891.252368 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:51 891.254005 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:51 891.263113 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:51 891.264891 [2224] netmap_csb_validate       csb_init for kring tap3345 RX0: head 0, cur 0, hwcur 0, hwtail 0
20:44:51 891.271206 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:51 891.393109 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:52 891.830415 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:52 891.843558 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:52 891.847243 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:52 891.967454 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:52 891.970246 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:52 891.982350 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:52 891.985218 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:52 892.103349 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:52 892.106840 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:52 892.119459 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:52 892.122638 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:52 892.241887 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:52 892.244575 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:52 892.256570 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:52 892.259642 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:52 892.379692 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:52 892.382336 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:52 892.400542 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:52 892.403623 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:52 892.527466 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:52 892.530136 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:52 892.541538 [ 319] generic_netmap_register   Emulated adapter for tap3345 activated
20:44:52 892.544537 [ 294] generic_netmap_unregister Emulated adapter for tap3345 deactivated
20:44:52 892.660126 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:52 892.662740 [1167] generic_netmap_attach     Emulated adapter for tap3345 created (prev was NULL)
20:44:53 892.804441 [1072] generic_netmap_dtor       Emulated netmap adapter for tap3345 destroyed
20:44:55 passed  [11.826s]
20:44:59 sys/netpfil/common/dummynet:ipfw_codel  ->  epair0a: Ethernet address: 02:61:7e:e1:a9:0a
20:44:59 epair0b: Ethernet address: 02:61:7e:e1:a9:0b
20:44:59 epair0a: link state changed to UP
20:44:59 epair0b: link state changed to UP
20:45:10 epair0b: link state changed to DOWN
20:45:10 epair0a: link state changed to DOWN
20:45:12 passed  [10.699s]
20:45:16 sys/netpfil/common/dummynet:ipfw_interface_removal  ->  epair0a: Ethernet address: 02:12:2a:e1:76:0a
20:45:16 epair0b: Ethernet address: 02:12:2a:e1:76:0b
20:45:16 epair0a: link state changed to UP
20:45:16 epair0b: link state changed to UP
20:45:27 epair0a: link state changed to DOWN
20:45:27 epair0b: link state changed to DOWN
20:45:36 passed  [17.663s]
20:45:40 sys/netpfil/common/dummynet:ipfw_pipe  ->  epair0a: Ethernet address: 02:3c:71:47:80:0a
20:45:40 epair0b: Ethernet address: 02:3c:71:47:80:0b
20:45:40 epair0a: link state changed to UP
20:45:40 epair0b: link state changed to UP
20:46:17 epair0b: link state changed to DOWN
20:46:17 epair0a: link state changed to DOWN
20:46:19 passed  [37.818s]
20:46:23 sys/netpfil/common/dummynet:ipfw_pipe_v6  ->  epair0a: Ethernet address: 02:70:80:39:97:0a
20:46:23 epair0b: Ethernet address: 02:70:80:39:97:0b
20:46:23 epair0a: link state changed to UP
20:46:23 epair0b: link state changed to UP
20:46:56 epair0b: link state changed to DOWN
20:46:56 epair0a: link state changed to DOWN
20:46:59 passed  [33.449s]
20:47:05 sys/netpfil/common/dummynet:ipfw_queue  ->  skipped: https://bugs.freebsd.org/264805  [2.884s]
20:47:09 sys/netpfil/common/dummynet:ipfw_queue_v6  ->  epair0a: Ethernet address: 02:01:d4:4f:ed:0a
20:47:09 epair0b: Ethernet address: 02:01:d4:4f:ed:0b
20:47:09 epair0a: link state changed to UP
20:47:09 epair0b: link state changed to UP
20:47:35 epair0b: link state changed to DOWN
20:47:35 epair0a: link state changed to DOWN
20:47:36 failed: We failed prioritisation 3 times  [26.555s]
20:47:40 sys/netpfil/common/dummynet:pf_codel  ->  epair0a: Ethernet address: 02:dd:65:51:cd:0a
20:47:40 epair0b: Ethernet address: 02:dd:65:51:cd:0b
20:47:40 epair0a: link state changed to UP
20:47:40 epair0b: link state changed to UP
20:47:52 epair0b: link state changed to DOWN
20:47:52 epair0a: link state changed to DOWN
20:47:54 passed  [11.990s]
20:47:58 sys/netpfil/common/dummynet:pf_interface_removal  ->  epair0a: Ethernet address: 02:7b:31:46:a6:0a
20:47:58 epair0b: Ethernet address: 02:7b:31:46:a6:0b
20:47:58 epair0a: link state changed to UP
20:47:58 epair0b: link state changed to UP
20:48:08 epair0a: link state changed to DOWN
20:48:08 epair0b: link state changed to DOWN
20:48:17 passed  [17.106s]
20:48:21 sys/netpfil/common/dummynet:pf_nat  ->  epair0a: Ethernet address: 02:cd:8f:23:ae:0a
20:48:21 epair0b: Ethernet address: 02:cd:8f:23:ae:0b
20:48:21 epair0a: link state changed to UP
20:48:21 epair0b: link state changed to UP
20:48:21 epair1a: Ethernet address: 02:5c:8d:6d:4d:0a
20:48:21 epair1b: Ethernet address: 02:5c:8d:6d:4d:0b
20:48:21 epair1a: link state changed to UP
20:48:21 epair1b: link state changed to UP
20:48:36 epair0b: link state changed to DOWN
20:48:36 epair0a: link state changed to DOWN
20:48:37 epair1a: link state changed to DOWN
20:48:37 epair1b: link state changed to DOWN
20:48:41 passed  [15.210s]
20:48:44 sys/netpfil/common/dummynet:pf_pipe  ->  epair0a: Ethernet address: 02:3d:1c:aa:4e:0a
20:48:44 epair0b: Ethernet address: 02:3d:1c:aa:4e:0b
20:48:44 epair0a: link state changed to UP
20:48:44 epair0b: link state changed to UP
20:49:21 epair0b: link state changed to DOWN
20:49:21 epair0a: link state changed to DOWN
20:49:23 passed  [36.465s]
20:49:27 sys/netpfil/common/dummynet:pf_pipe_v6  ->  epair0a: Ethernet address: 02:5e:15:f3:e1:0a
20:49:27 epair0b: Ethernet address: 02:5e:15:f3:e1:0b
20:49:27 epair0a: link state changed to UP
20:49:27 epair0b: link state changed to UP
20:50:01 epair0b: link state changed to DOWN
20:50:01 epair0a: link state changed to DOWN
20:50:03 passed  [34.273s]
20:50:07 sys/netpfil/common/dummynet:pf_queue  ->  epair0a: Ethernet address: 02:69:d7:fb:b1:0a
20:50:07 epair0b: Ethernet address: 02:69:d7:fb:b1:0b
20:50:07 epair0a: link state changed to UP
20:50:07 epair0b: link state changed to UP
20:50:19 Limiting icmp ping response from 194 to 185 packets/sec
20:50:20 Limiting icmp ping response from 192 to 186 packets/sec
20:50:25 Limiting icmp ping response from 252 to 200 packets/sec
20:50:25 Limiting closed port RST response from 226 to 190 packets/sec
20:50:28 Limiting icmp ping response from 252 to 199 packets/sec
20:50:28 Limiting closed port RST response from 320 to 185 packets/sec
20:50:30 Limiting icmp ping response from 251 to 200 packets/sec
20:50:34 epair0b: link state changed to DOWN
20:50:34 epair0a: link state changed to DOWN
20:50:36 failed: We failed prioritisation 3 times  [27.282s]
20:50:40 sys/netpfil/common/dummynet:pf_queue_v6  ->  epair0a: Ethernet address: 02:54:c5:43:58:0a
20:50:40 epair0b: Ethernet address: 02:54:c5:43:58:0b
20:50:40 epair0a: link state changed to UP
20:50:40 epair0b: link state changed to UP
20:51:06 Limiting closed port RST response from 239 to 196 packets/sec
20:51:08 epair0b: link state changed to DOWN
20:51:08 epair0a: link state changed to DOWN
20:51:11 failed: We failed prioritisation 3 times  [28.394s]
20:51:14 sys/netpfil/common/dummynet:pf_wf2q_heap  ->  epair0a: Ethernet address: 02:f6:56:c8:f8:0a
20:51:14 epair0b: Ethernet address: 02:f6:56:c8:f8:0b
20:51:14 epair0a: link state changed to UP
20:51:14 epair0b: link state changed to UP
20:51:15 epair1a: Ethernet address: 02:1a:d1:82:80:0a
20:51:15 epair1b: Ethernet address: 02:1a:d1:82:80:0b
20:51:15 epair1a: link state changed to UP
20:51:15 epair1b: link state changed to UP
20:51:35 epair0a: link state changed to DOWN
20:51:35 vlan0: link state changed to DOWN
20:51:35 epair0b: link state changed to DOWN
20:51:38 epair1b: link state changed to DOWN
20:51:38 epair1a: link state changed to DOWN
20:51:40 passed  [20.433s]
20:51:40 sys/netpfil/common/forward:ipf_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.375s]
20:51:41 sys/netpfil/common/forward:ipfw_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.381s]
20:51:42 sys/netpfil/common/forward:pf_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.369s]
20:51:45 sys/netpfil/common/fragments:ipf_fragments  ->  epair0a: Ethernet address: 02:aa:5e:0c:dd:0a
20:51:45 epair0b: Ethernet address: 02:aa:5e:0c:dd:0b
20:51:45 epair0a: link state changed to UP
20:51:45 epair0b: link state changed to UP
20:51:48 nd6_setmtu0: new link MTU on epair0b (200) is too small for IPv6
20:51:48 nd6_setmtu0: new link MTU on epair0a (200) is too small for IPv6
20:52:06 epair0a: link state changed to DOWN
20:52:06 epair0b: link state changed to DOWN
20:52:08 passed  [21.441s]
20:52:11 sys/netpfil/common/fragments:ipfw_fragments  ->  epair0a: Ethernet address: 02:fe:5f:d6:ca:0a
20:52:11 epair0b: Ethernet address: 02:fe:5f:d6:ca:0b
20:52:11 epair0a: link state changed to UP
20:52:11 epair0b: link state changed to UP
20:52:15 nd6_setmtu0: new link MTU on epair0b (200) is too small for IPv6
20:52:15 nd6_setmtu0: new link MTU on epair0a (200) is too small for IPv6
20:52:33 epair0a: link state changed to DOWN
20:52:33 epair0b: link state changed to DOWN
20:52:35 passed  [21.579s]
20:52:38 sys/netpfil/common/fragments:pf_fragments  ->  epair0a: Ethernet address: 02:09:c7:80:ff:0a
20:52:38 epair0b: Ethernet address: 02:09:c7:80:ff:0b
20:52:38 epair0a: link state changed to UP
20:52:38 epair0b: link state changed to UP
20:52:41 nd6_setmtu0: new link MTU on epair0b (200) is too small for IPv6
20:52:42 nd6_setmtu0: new link MTU on epair0a (200) is too small for IPv6
20:53:01 epair0a: link state changed to DOWN
20:53:01 epair0b: link state changed to DOWN
20:53:03 passed  [22.846s]
20:53:06 sys/netpfil/common/nat:ipfnat_basic  ->  epair0a: Ethernet address: 02:28:01:3e:3f:0a
20:53:06 epair0b: Ethernet address: 02:28:01:3e:3f:0b
20:53:06 epair0a: link state changed to UP
20:53:06 epair0b: link state changed to UP
20:53:07 epair1a: Ethernet address: 02:f7:ea:dc:a8:0a
20:53:07 epair1b: Ethernet address: 02:f7:ea:dc:a8:0b
20:53:07 epair1a: link state changed to UP
20:53:07 epair1b: link state changed to UP
20:53:07 epair2a: Ethernet address: 02:09:9c:d8:62:0a
20:53:07 epair2b: Ethernet address: 02:09:9c:d8:62:0b
20:53:07 epair2a: link state changed to UP
20:53:07 epair2b: link state changed to UP
20:53:31 epair0b: link state changed to DOWN
20:53:31 epair0a: link state changed to DOWN
20:53:32 epair1a: link state changed to DOWN
20:53:32 epair1b: link state changed to DOWN
20:53:33 epair2a: link state changed to DOWN
20:53:33 epair2b: link state changed to DOWN
20:53:38 passed  [25.210s]
20:53:42 sys/netpfil/common/nat:ipfw_basic  ->  epair0a: Ethernet address: 02:62:39:b5:70:0a
20:53:42 epair0b: Ethernet address: 02:62:39:b5:70:0b
20:53:42 epair0a: link state changed to UP
20:53:42 epair0b: link state changed to UP
20:53:42 epair1a: Ethernet address: 02:77:c4:e4:d1:0a
20:53:42 epair1b: Ethernet address: 02:77:c4:e4:d1:0b
20:53:42 epair1a: link state changed to UP
20:53:42 epair1b: link state changed to UP
20:53:43 epair2a: Ethernet address: 02:a8:2b:d3:66:0a
20:53:43 epair2b: Ethernet address: 02:a8:2b:d3:66:0b
20:53:43 epair2a: link state changed to UP
20:53:43 epair2b: link state changed to UP
20:54:05 epair0b: link state changed to DOWN
20:54:05 epair0a: link state changed to DOWN
20:54:05 epair1a: link state changed to DOWN
20:54:05 epair1b: link state changed to DOWN
20:54:06 epair2a: link state changed to DOWN
20:54:06 epair2b: link state changed to DOWN
20:54:12 passed  [23.225s]
20:54:15 sys/netpfil/common/nat:ipfw_cgn  ->  epair0a: Ethernet address: 02:ed:db:4e:e2:0a
20:54:15 epair0b: Ethernet address: 02:ed:db:4e:e2:0b
20:54:15 epair0a: link state changed to UP
20:54:15 epair0b: link state changed to UP
20:54:16 epair1a: Ethernet address: 02:39:49:6b:a2:0a
20:54:16 epair1b: Ethernet address: 02:39:49:6b:a2:0b
20:54:16 epair1a: link state changed to UP
20:54:16 epair1b: link state changed to UP
20:54:16 epair2a: Ethernet address: 02:80:9d:0e:b3:0a
20:54:16 epair2b: Ethernet address: 02:80:9d:0e:b3:0b
20:54:16 epair2a: link state changed to UP
20:54:16 epair2b: link state changed to UP
20:54:39 epair0b: link state changed to DOWN
20:54:39 epair0a: link state changed to DOWN
20:54:40 epair1a: link state changed to DOWN
20:54:40 epair1b: link state changed to DOWN
20:54:41 epair2a: link state changed to DOWN
20:54:41 epair2b: link state changed to DOWN
20:54:46 passed  [24.325s]
20:54:50 sys/netpfil/common/nat:ipfw_portalias  ->  epair0a: Ethernet address: 02:ba:43:f4:5a:0a
20:54:50 epair0b: Ethernet address: 02:ba:43:f4:5a:0b
20:54:50 epair0a: link state changed to UP
20:54:50 epair0b: link state changed to UP
20:54:50 epair1a: Ethernet address: 02:98:30:1c:41:0a
20:54:50 epair1b: Ethernet address: 02:98:30:1c:41:0b
20:54:50 epair1a: link state changed to UP
20:54:50 epair1b: link state changed to UP
20:54:51 epair2a: Ethernet address: 02:11:ab:93:45:0a
20:54:51 epair2b: Ethernet address: 02:11:ab:93:45:0b
20:54:51 epair2a: link state changed to UP
20:54:51 epair2b: link state changed to UP
20:55:14 epair0b: link state changed to DOWN
20:55:14 epair0a: link state changed to DOWN
20:55:14 epair1a: link state changed to DOWN
20:55:14 epair1b: link state changed to DOWN
20:55:15 epair2a: link state changed to DOWN
20:55:15 epair2b: link state changed to DOWN
20:55:21 passed  [24.202s]
20:55:24 sys/netpfil/common/nat:ipfw_userspace_nat  ->  epair0a: Ethernet address: 02:3d:73:29:fd:0a
20:55:24 epair0b: Ethernet address: 02:3d:73:29:fd:0b
20:55:24 epair0a: link state changed to UP
20:55:24 epair0b: link state changed to UP
20:55:25 epair1a: Ethernet address: 02:a4:bb:34:dc:0a
20:55:25 epair1b: Ethernet address: 02:a4:bb:34:dc:0b
20:55:25 epair1a: link state changed to UP
20:55:25 epair1b: link state changed to UP
20:55:25 epair2a: Ethernet address: 02:59:aa:7c:8e:0a
20:55:25 epair2b: Ethernet address: 02:59:aa:7c:8e:0b
20:55:25 epair2a: link state changed to UP
20:55:25 epair2b: link state changed to UP
20:55:41 2024-07-24T20:55:41.539434+00:00 - natd 14134 - - Aliasing to 198.51.100.1, mtu 1500 bytes
20:55:47 
20:55:47 epair0b: link state changed to DOWN
20:55:48 epair0a: link state changed to DOWN
20:55:48 epair1a: link state changed to DOWN
20:55:48 epair1b: link state changed to DOWN
20:55:48 epair2a: link state changed to DOWN
20:56:03 epair2b: link state changed to DOWN
20:56:06 passed  [23.118s]
20:56:06 sys/netpfil/common/nat:pf_basic  ->  epair0a: Ethernet address: 02:08:12:8b:58:0a
20:56:06 epair0b: Ethernet address: 02:08:12:8b:58:0b
20:56:06 epair0a: link state changed to UP
20:56:07 epair0b: link state changed to UP
20:56:07 epair1a: Ethernet address: 02:2b:12:b4:7a:0a
20:56:07 epair1b: Ethernet address: 02:2b:12:b4:7a:0b
20:56:07 epair1a: link state changed to UP
20:56:07 epair1b: link state changed to UP
20:56:07 epair2a: Ethernet address: 02:28:64:15:eb:0a
20:56:07 epair2b: Ethernet address: 02:28:64:15:eb:0b
20:56:07 epair2a: link state changed to UP
20:56:31 epair2b: link state changed to UP
20:56:31 epair0b: link state changed to DOWN
20:56:31 epair0a: link state changed to DOWN
20:56:31 epair1a: link state changed to DOWN
20:56:32 epair1b: link state changed to DOWN
20:56:32 epair2a: link state changed to DOWN
20:56:37 epair2b: link state changed to DOWN
20:56:41 passed  [24.193s]
20:56:41 sys/netpfil/common/pass_block:ipf_v4  ->  epair0a: Ethernet address: 02:04:17:63:11:0a
20:56:41 epair0b: Ethernet address: 02:04:17:63:11:0b
20:56:41 epair0a: link state changed to UP
20:56:51 epair0b: link state changed to UP
20:56:51 epair0b: link state changed to DOWN
20:56:53 epair0a: link state changed to DOWN
20:56:56 passed  [10.129s]
20:56:56 sys/netpfil/common/pass_block:ipf_v6  ->  epair0a: Ethernet address: 02:49:54:c1:cb:0a
20:56:56 epair0b: Ethernet address: 02:49:54:c1:cb:0b
20:56:56 epair0a: link state changed to UP
20:57:07 epair0b: link state changed to UP
20:57:07 epair0b: link state changed to DOWN
20:57:09 epair0a: link state changed to DOWN
20:57:13 failed: atf-check failed; see the output of the test for details  [11.396s]
20:57:13 sys/netpfil/common/pass_block:ipfw_v4  ->  epair0a: Ethernet address: 02:78:79:7b:50:0a
20:57:13 epair0b: Ethernet address: 02:78:79:7b:50:0b
20:57:13 epair0a: link state changed to UP
20:57:23 epair0b: link state changed to UP
20:57:23 epair0b: link state changed to DOWN
20:57:25 epair0a: link state changed to DOWN
20:57:28 passed  [10.304s]
20:57:28 sys/netpfil/common/pass_block:ipfw_v6  ->  epair0a: Ethernet address: 02:82:c9:81:ca:0a
20:57:28 epair0b: Ethernet address: 02:82:c9:81:ca:0b
20:57:28 epair0a: link state changed to UP
20:57:39 epair0b: link state changed to UP
20:57:39 epair0b: link state changed to DOWN
20:57:41 epair0a: link state changed to DOWN
20:57:44 passed  [10.630s]
20:57:44 sys/netpfil/common/pass_block:pf_v4  ->  epair0a: Ethernet address: 02:0c:2e:e4:ec:0a
20:57:44 epair0b: Ethernet address: 02:0c:2e:e4:ec:0b
20:57:44 epair0a: link state changed to UP
20:57:57 epair0b: link state changed to UP
20:57:57 epair0b: link state changed to DOWN
20:57:59 epair0a: link state changed to DOWN
20:58:02 passed  [12.957s]
20:58:02 sys/netpfil/common/pass_block:pf_v6  ->  epair0a: Ethernet address: 02:d4:7c:bc:20:0a
20:58:02 epair0b: Ethernet address: 02:d4:7c:bc:20:0b
20:58:02 epair0a: link state changed to UP
20:58:15 epair0b: link state changed to UP
20:58:15 epair0b: link state changed to DOWN
20:58:18 epair0a: link state changed to DOWN
20:58:21 passed  [13.125s]
20:58:21 sys/netpfil/common/rdr:ipfnat_basic  ->  epair0a: Ethernet address: 02:95:f7:a4:3f:0a
20:58:21 epair0b: Ethernet address: 02:95:f7:a4:3f:0b
20:58:21 epair0a: link state changed to UP
20:58:35 epair0b: link state changed to UP
20:58:35 epair0b: link state changed to DOWN
20:58:36 epair0a: link state changed to DOWN
20:58:42 passed  [14.497s]
20:58:45 sys/netpfil/common/rdr:ipfnat_local_redirect  ->  skipped: This test requires if_bridge  [2.720s]
20:58:45 sys/netpfil/common/rdr:pf_basic  ->  epair0a: Ethernet address: 02:b1:1d:4f:d8:0a
20:58:45 epair0b: Ethernet address: 02:b1:1d:4f:d8:0b
20:58:45 epair0a: link state changed to UP
20:58:58 epair0b: link state changed to UP
20:58:58 epair0b: link state changed to DOWN
20:58:59 epair0a: link state changed to DOWN
20:59:04 passed  [13.091s]
20:59:05 sys/netpfil/common/rdr:pf_local_redirect  ->  skipped: This test requires if_bridge  [2.589s]
20:59:06 sys/netpfil/common/tos:ipfw_tos  ->  skipped: Required program 'scapy' not found in PATH  [0.386s]
20:59:10 sys/netpfil/common/tos:pf_tos  ->  skipped: Required program 'scapy' not found in PATH  [0.375s]
20:59:15 sys/netpfil/pf/altq:cbq_vlan  ->  skipped: Test requires ALTQ  [2.320s]
20:59:20 sys/netpfil/pf/altq:codel_bridge  ->  skipped: Test requires ALTQ  [2.329s]
20:59:24 sys/netpfil/pf/altq:codel_vlan  ->  skipped: Test requires ALTQ  [2.326s]
20:59:29 sys/netpfil/pf/altq:hfsc  ->  skipped: Test requires ALTQ  [2.322s]
20:59:34 sys/netpfil/pf/altq:match  ->  skipped: Test requires ALTQ  [2.347s]
20:59:36 sys/netpfil/pf/altq:prioritise  ->  skipped: Test requires ALTQ  [2.345s]
20:59:36 sys/netpfil/pf/anchor:nested_anchor  ->  epair0a: Ethernet address: 02:15:2e:63:ef:0a
20:59:36 epair0b: Ethernet address: 02:15:2e:63:ef:0b
20:59:36 epair0a: link state changed to UP
20:59:44 epair0b: link state changed to UP
20:59:44 epair0a: link state changed to DOWN
20:59:47 epair0b: link state changed to DOWN
20:59:50 passed  [7.805s]
20:59:50 sys/netpfil/pf/anchor:pr183198  ->  epair0a: Ethernet address: 02:5f:83:d9:4d:0a
20:59:50 epair0b: Ethernet address: 02:5f:83:d9:4d:0b
20:59:50 epair0a: link state changed to UP
21:00:00 epair0b: link state changed to UP
21:00:00 epair0b: link state changed to DOWN
21:00:02 epair0a: link state changed to DOWN
21:00:14 passed  [9.710s]
21:00:17 sys/netpfil/pf/anchor:pr279225  ->  passed  [8.722s]
21:00:17 sys/netpfil/pf/anchor:wildcard  ->  epair0a: Ethernet address: 02:97:66:d2:c2:0a
21:00:17 epair0b: Ethernet address: 02:97:66:d2:c2:0b
21:00:17 epair0a: link state changed to UP
21:00:39 epair0b: link state changed to UP
21:00:39 epair0a: link state changed to DOWN
21:00:41 epair0b: link state changed to DOWN
21:00:46 passed  [21.796s]
21:00:51 sys/netpfil/pf/divert-to:ipfwoff_in_div  ->  skipped: This test is for the case when ipfw is not loaded  [2.457s]
21:00:56 sys/netpfil/pf/divert-to:ipfwoff_in_div_in  ->  skipped: This test is for the case when ipfw is not loaded  [2.464s]
21:01:00 sys/netpfil/pf/divert-to:ipfwoff_in_div_in_fwd_out_div_out  ->  skipped: This test is for the case when ipfw is not loaded  [2.463s]
21:01:05 sys/netpfil/pf/divert-to:ipfwoff_in_dn_in_div_in_out_dn_out_div_out  ->  skipped: This test is for the case when ipfw is not loaded  [2.605s]
21:01:10 sys/netpfil/pf/divert-to:ipfwoff_out_div  ->  skipped: This test is for the case when ipfw is not loaded  [2.439s]
21:01:13 sys/netpfil/pf/divert-to:ipfwoff_out_div_out  ->  skipped: This test is for the case when ipfw is not loaded  [2.514s]
21:01:13 sys/netpfil/pf/divert-to:ipfwon_in_div  ->  epair0a: Ethernet address: 02:d9:bf:cc:1c:0a
21:01:13 epair0b: Ethernet address: 02:d9:bf:cc:1c:0b
21:01:13 epair0a: link state changed to UP
21:01:37 epair0b: link state changed to UP
21:01:37 epair0b: link state changed to DOWN
21:01:39 epair0a: link state changed to DOWN
21:01:42 passed  [24.238s]
21:01:42 sys/netpfil/pf/divert-to:ipfwon_in_div_in  ->  epair0a: Ethernet address: 02:44:fb:70:b7:0a
21:01:42 epair0b: Ethernet address: 02:44:fb:70:b7:0b
21:01:42 epair0a: link state changed to UP
21:01:58 epair0b: link state changed to UP
21:01:58 epair0b: link state changed to DOWN
21:02:00 epair0a: link state changed to DOWN
21:02:03 passed  [16.107s]
21:02:03 sys/netpfil/pf/divert-to:ipfwon_in_div_in_fwd_out_div_out  ->  epair0a: Ethernet address: 02:38:62:72:3d:0a
21:02:03 epair0b: Ethernet address: 02:38:62:72:3d:0b
21:02:03 epair0a: link state changed to UP
21:02:04 epair0b: link state changed to UP
21:02:04 epair1a: Ethernet address: 02:56:1c:fc:ea:0a
21:02:04 epair1b: Ethernet address: 02:56:1c:fc:ea:0b
21:02:04 epair1a: link state changed to UP
21:02:27 epair1b: link state changed to UP
21:02:27 epair0b: link state changed to DOWN
21:02:28 epair0a: link state changed to DOWN
21:02:28 epair1a: link state changed to DOWN
21:02:32 epair1b: link state changed to DOWN
21:02:35 passed  [24.056s]
21:02:35 sys/netpfil/pf/divert-to:ipfwon_in_dn_in_div_in_out_dn_out_div_out  ->  epair0a: Ethernet address: 02:d5:6c:87:5e:0a
21:02:35 epair0b: Ethernet address: 02:d5:6c:87:5e:0b
21:02:35 epair0a: link state changed to UP
21:02:59 epair0b: link state changed to UP
21:02:59 epair0b: link state changed to DOWN
21:03:01 epair0a: link state changed to DOWN
21:03:04 passed  [24.069s]
21:03:04 sys/netpfil/pf/divert-to:ipfwon_out_div  ->  epair0a: Ethernet address: 02:9e:9e:e6:fb:0a
21:03:04 epair0b: Ethernet address: 02:9e:9e:e6:fb:0b
21:03:04 epair0a: link state changed to UP
21:03:28 epair0b: link state changed to UP
21:03:28 epair0b: link state changed to DOWN
21:03:30 epair0a: link state changed to DOWN
21:03:33 passed  [24.091s]
21:03:33 sys/netpfil/pf/divert-to:ipfwon_out_div_out  ->  epair0a: Ethernet address: 02:51:8d:f7:98:0a
21:03:33 epair0b: Ethernet address: 02:51:8d:f7:98:0b
21:03:33 epair0a: link state changed to UP
21:03:49 epair0b: link state changed to UP
21:03:49 epair0b: link state changed to DOWN
21:03:51 epair0a: link state changed to DOWN
21:03:52 passed  [16.074s]
21:03:54 sys/netpfil/pf/dup:dup_to  ->  skipped: Required program 'scapy' not found in PATH  [0.377s]
21:03:54 sys/netpfil/pf/ether:anchor  ->  epair0a: Ethernet address: 02:6f:d7:be:f4:0a
21:03:54 epair0b: Ethernet address: 02:6f:d7:be:f4:0b
21:03:54 epair0a: link state changed to UP
21:04:14 epair0b: link state changed to UP
21:04:14 epair0b: link state changed to DOWN
21:04:16 epair0a: link state changed to DOWN
21:04:17 passed  [19.468s]
21:04:19 sys/netpfil/pf/ether:bridge_to  ->  skipped: Required program 'scapy' not found in PATH  [0.376s]
21:04:19 sys/netpfil/pf/ether:captive  ->  epair0a: Ethernet address: 02:83:87:2b:27:0a
21:04:19 epair0b: Ethernet address: 02:83:87:2b:27:0b
21:04:19 epair0a: link state changed to UP
21:04:20 epair0b: link state changed to UP
21:04:20 epair1a: Ethernet address: 02:4a:3f:ce:6b:0a
21:04:20 epair1b: Ethernet address: 02:4a:3f:ce:6b:0b
21:04:20 epair1a: link state changed to UP
21:04:26 epair1b: link state changed to UP
21:04:40 lo0: link state changed to UP
21:04:40 epair0b: link state changed to DOWN
21:04:40 epair0a: link state changed to DOWN
21:04:40 epair1a: link state changed to DOWN
21:04:44 epair1b: link state changed to DOWN
21:04:47 passed  [20.178s]
21:04:47 sys/netpfil/pf/ether:captive_long  ->  epair0a: Ethernet address: 02:2e:16:2f:75:0a
21:04:47 epair0b: Ethernet address: 02:2e:16:2f:75:0b
21:04:47 epair0a: link state changed to UP
21:04:48 epair0b: link state changed to UP
21:04:48 epair1a: Ethernet address: 02:35:00:95:fc:0a
21:04:48 epair1b: Ethernet address: 02:35:00:95:fc:0b
21:04:48 epair1a: link state changed to UP
21:04:54 epair1b: link state changed to UP
21:05:09 lo0: link state changed to UP
21:05:09 epair0b: link state changed to DOWN
21:05:09 epair0a: link state changed to DOWN
21:05:09 epair1a: link state changed to DOWN
21:05:12 epair1b: link state changed to DOWN
21:05:13 passed  [21.425s]
21:05:16 sys/netpfil/pf/ether:direction  ->  skipped: Required program 'jq' not found in PATH  [0.380s]
21:05:16 sys/netpfil/pf/ether:dummynet  ->  epair0a: Ethernet address: 02:e5:d6:5a:c1:0a
21:05:16 epair0b: Ethernet address: 02:e5:d6:5a:c1:0b
21:05:16 epair0a: link state changed to UP
21:05:42 epair0b: link state changed to UP
21:05:42 epair0b: link state changed to DOWN
21:05:44 epair0a: link state changed to DOWN
21:05:46 passed  [26.013s]
21:05:46 sys/netpfil/pf/ether:ip  ->  epair0a: Ethernet address: 02:ce:f3:a3:a5:0a
21:05:46 epair0b: Ethernet address: 02:ce:f3:a3:a5:0b
21:05:46 epair0a: link state changed to UP
21:06:35 epair0b: link state changed to UP
21:06:35 epair0b: link state changed to DOWN
21:06:37 epair0a: link state changed to DOWN
21:06:40 passed  [48.056s]
21:06:40 sys/netpfil/pf/ether:mac  ->  epair0a: Ethernet address: 02:48:94:24:47:0a
21:06:40 epair0b: Ethernet address: 02:48:94:24:47:0b
21:06:40 epair0a: link state changed to UP
21:07:24 epair0b: link state changed to UP
21:07:24 epair0b: link state changed to DOWN
21:07:26 epair0a: link state changed to DOWN
21:07:29 passed  [44.508s]
21:07:29 sys/netpfil/pf/ether:match_tag  ->  epair0a: Ethernet address: 02:ea:12:bf:3f:0a
21:07:29 epair0b: Ethernet address: 02:ea:12:bf:3f:0b
21:07:29 epair0a: link state changed to UP
21:07:51 epair0b: link state changed to UP
21:07:51 epair0b: link state changed to DOWN
21:07:54 epair0a: link state changed to DOWN
21:07:56 passed  [22.232s]
21:07:56 sys/netpfil/pf/ether:proto  ->  epair0a: Ethernet address: 02:82:bd:a3:4c:0a
21:07:56 epair0b: Ethernet address: 02:82:bd:a3:4c:0b
21:07:56 epair0a: link state changed to UP
21:08:12 epair0b: link state changed to UP
21:08:12 epair0b: link state changed to DOWN
21:08:14 epair0a: link state changed to DOWN
21:08:14 passed  [15.147s]
21:08:17 sys/netpfil/pf/ether:short_pkt  ->  skipped: Required program 'scapy' not found in PATH  [0.379s]
21:08:17 sys/netpfil/pf/ether:tag  ->  epair0a: Ethernet address: 02:99:b7:90:f2:0a
21:08:17 epair0b: Ethernet address: 02:99:b7:90:f2:0b
21:08:17 epair0a: link state changed to UP
21:08:40 epair0b: link state changed to UP
21:08:40 epair0b: link state changed to DOWN
21:08:42 epair0a: link state changed to DOWN
21:08:42 passed  [22.249s]
21:08:43 sys/netpfil/pf/forward:v4  ->  skipped: Required program 'scapy' not found in PATH  [0.377s]
21:08:44 sys/netpfil/pf/forward:v6  ->  skipped: Required program 'scapy' not found in PATH  [0.379s]
21:08:46 sys/netpfil/pf/frag6.py:__test_cases_list_pytest_binary_not_found__  ->  skipped: Required program 'pytest' not found in PATH  [0.368s]
21:08:46 sys/netpfil/pf/fragmentation_compat:mtu_diff  ->  epair0a: Ethernet address: 02:7a:60:1b:d1:0a
21:08:46 epair0b: Ethernet address: 02:7a:60:1b:d1:0b
21:08:46 epair0a: link state changed to UP
21:08:47 epair0b: link state changed to UP
21:08:47 epair1a: Ethernet address: 02:95:59:47:e7:0a
21:08:47 epair1b: Ethernet address: 02:95:59:47:e7:0b
21:08:47 epair1a: link state changed to UP
21:09:03 epair1b: link state changed to UP
21:09:03 epair0b: link state changed to DOWN
21:09:04 epair0a: link state changed to DOWN
21:09:04 epair1a: link state changed to DOWN
21:09:08 epair1b: link state changed to DOWN
21:09:09 passed  [16.809s]
21:09:09 sys/netpfil/pf/fragmentation_compat:overindex  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:09:10 sys/netpfil/pf/fragmentation_compat:overlimit  ->  skipped: Required program 'scapy' not found in PATH  [0.380s]
21:09:12 sys/netpfil/pf/fragmentation_compat:overreplace  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:09:12 sys/netpfil/pf/fragmentation_compat:reassemble  ->  epair0a: Ethernet address: 02:da:82:2e:b2:0a
21:09:12 epair0b: Ethernet address: 02:da:82:2e:b2:0b
21:09:12 epair0a: link state changed to UP
21:09:37 epair0b: link state changed to UP
21:09:37 epair0a: link state changed to DOWN
21:09:39 epair0b: link state changed to DOWN
21:09:41 passed  [24.078s]
21:09:41 sys/netpfil/pf/fragmentation_compat:too_many_fragments  ->  epair0a: Ethernet address: 02:71:a9:35:7e:0a
21:09:41 epair0b: Ethernet address: 02:71:a9:35:7e:0b
21:09:41 epair0a: link state changed to UP
21:09:45 epair0b: link state changed to UP
21:09:45 nd6_setmtu0: new link MTU on epair0b (200) is too small for IPv6
21:10:04 nd6_setmtu0: new link MTU on epair0a (200) is too small for IPv6
21:10:04 epair0a: link state changed to DOWN
21:10:06 epair0b: link state changed to DOWN
21:10:07 passed  [22.314s]
21:10:07 sys/netpfil/pf/fragmentation_compat:v6  ->  skipped: Required program 'scapy' not found in PATH  [0.377s]
21:10:08 sys/netpfil/pf/fragmentation_no_reassembly:compat_override_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.372s]
21:10:08 sys/netpfil/pf/fragmentation_no_reassembly:match_fragment_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.378s]
21:10:11 sys/netpfil/pf/fragmentation_no_reassembly:match_full_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.377s]
21:10:11 sys/netpfil/pf/fragmentation_pass:mtu_diff  ->  epair0a: Ethernet address: 02:4b:bc:be:64:0a
21:10:11 epair0b: Ethernet address: 02:4b:bc:be:64:0b
21:10:11 epair0a: link state changed to UP
21:10:12 epair0b: link state changed to UP
21:10:12 epair1a: Ethernet address: 02:03:fe:fb:86:0a
21:10:12 epair1b: Ethernet address: 02:03:fe:fb:86:0b
21:10:12 epair1a: link state changed to UP
21:10:28 epair1b: link state changed to UP
21:10:28 epair0b: link state changed to DOWN
21:10:29 epair0a: link state changed to DOWN
21:10:29 epair1a: link state changed to DOWN
21:10:33 epair1b: link state changed to DOWN
21:10:35 passed  [16.546s]
21:10:35 sys/netpfil/pf/fragmentation_pass:no_df  ->  epair0a: Ethernet address: 02:64:f4:c0:08:0a
21:10:35 epair0b: Ethernet address: 02:64:f4:c0:08:0b
21:10:35 epair0a: link state changed to UP
21:10:36 epair0b: link state changed to UP
21:10:36 epair1a: Ethernet address: 02:0b:ee:26:9a:0a
21:10:36 epair1b: Ethernet address: 02:0b:ee:26:9a:0b
21:10:36 epair1a: link state changed to UP
21:10:51 epair1b: link state changed to UP
21:10:51 epair0b: link state changed to DOWN
21:10:52 epair0a: link state changed to DOWN
21:10:52 epair1a: link state changed to DOWN
21:10:56 epair1b: link state changed to DOWN
21:10:56 failed: atf-check failed; see the output of the test for details  [15.461s]
21:10:57 sys/netpfil/pf/fragmentation_pass:overindex  ->  skipped: Required program 'scapy' not found in PATH  [0.379s]
21:10:57 sys/netpfil/pf/fragmentation_pass:overlimit  ->  skipped: Required program 'scapy' not found in PATH  [0.378s]
21:11:00 sys/netpfil/pf/fragmentation_pass:overreplace  ->  skipped: Required program 'scapy' not found in PATH  [0.371s]
21:11:00 sys/netpfil/pf/fragmentation_pass:reassemble  ->  epair0a: Ethernet address: 02:91:2c:9f:72:0a
21:11:00 epair0b: Ethernet address: 02:91:2c:9f:72:0b
21:11:00 epair0a: link state changed to UP
21:11:24 epair0b: link state changed to UP
21:11:24 epair0a: link state changed to DOWN
21:11:26 epair0b: link state changed to DOWN
21:11:29 passed  [23.952s]
21:11:29 sys/netpfil/pf/fragmentation_pass:reassemble_slowpath  ->  epair0a: Ethernet address: 02:72:bf:a3:5f:0a
21:11:29 epair0b: Ethernet address: 02:72:bf:a3:5f:0b
21:11:29 epair0a: link state changed to UP
21:11:30 epair0b: link state changed to UP
21:11:30 epair1a: Ethernet address: 02:d0:f0:df:58:0a
21:11:30 epair1b: Ethernet address: 02:d0:f0:df:58:0b
21:11:30 epair1a: link state changed to UP
21:11:43 epair1b: link state changed to UP
21:11:43 epair0b: link state changed to DOWN
21:11:44 epair0a: link state changed to DOWN
21:11:44 epair1a: link state changed to DOWN
21:11:48 epair1b: link state changed to DOWN
21:11:51 failed: atf-check failed; see the output of the test for details  [13.996s]
21:11:51 sys/netpfil/pf/fragmentation_pass:too_many_fragments  ->  epair0a: Ethernet address: 02:96:d8:cb:e3:0a
21:11:51 epair0b: Ethernet address: 02:96:d8:cb:e3:0b
21:11:51 epair0a: link state changed to UP
21:11:54 epair0b: link state changed to UP
21:11:55 nd6_setmtu0: new link MTU on epair0b (200) is too small for IPv6
21:12:13 nd6_setmtu0: new link MTU on epair0a (200) is too small for IPv6
21:12:13 epair0a: link state changed to DOWN
21:12:15 epair0b: link state changed to DOWN
21:12:16 passed  [22.059s]
21:12:16 sys/netpfil/pf/fragmentation_pass:v6  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:12:17 sys/netpfil/pf/get_state:many  ->  skipped: Required program 'scapy' not found in PATH  [0.371s]
21:12:18 sys/netpfil/pf/icmp:cve_2019_5598  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:12:18 sys/netpfil/pf/killstate:gateway  ->  skipped: Required program 'scapy' not found in PATH  [0.373s]
21:12:19 sys/netpfil/pf/killstate:id  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:12:19 sys/netpfil/pf/killstate:interface  ->  skipped: Required program 'scapy' not found in PATH  [0.370s]
21:12:22 sys/netpfil/pf/killstate:label  ->  skipped: Required program 'scapy' not found in PATH  [0.371s]
21:12:22 sys/netpfil/pf/killstate:match  ->  epair0a: Ethernet address: 02:8a:a1:a5:71:0a
21:12:22 epair0b: Ethernet address: 02:8a:a1:a5:71:0b
21:12:22 epair0a: link state changed to UP
21:12:23 epair0b: link state changed to UP
21:12:23 epair1a: Ethernet address: 02:1e:f1:e7:3e:0a
21:12:23 epair1b: Ethernet address: 02:1e:f1:e7:3e:0b
21:12:23 epair1a: link state changed to UP
21:12:40 epair1b: link state changed to UP
21:12:40 epair0b: link state changed to DOWN
21:12:40 epair0a: link state changed to DOWN
21:12:40 epair1a: link state changed to DOWN
21:12:43 epair1b: link state changed to DOWN
21:12:44 passed  [17.291s]
21:12:44 sys/netpfil/pf/killstate:multilabel  ->  skipped: Required program 'scapy' not found in PATH  [0.381s]
21:12:45 sys/netpfil/pf/killstate:v4  ->  skipped: Required program 'scapy' not found in PATH  [0.379s]
21:12:48 sys/netpfil/pf/killstate:v6  ->  skipped: Required program 'scapy' not found in PATH  [0.377s]
21:12:56 sys/netpfil/pf/macro:nr  ->  lo0: link state changed to UP
21:12:58 passed  [7.308s]
21:12:58 sys/netpfil/pf/map_e:map_e  ->  epair0a: Ethernet address: 02:ea:ee:bf:ff:0a
21:12:59 epair0b: Ethernet address: 02:ea:ee:bf:ff:0b
21:12:59 epair0a: link state changed to UP
21:12:59 epair0b: link state changed to UP
21:12:59 epair1a: Ethernet address: 02:09:ca:9d:1f:0a
21:12:59 epair1b: Ethernet address: 02:09:ca:9d:1f:0b
21:12:59 epair1a: link state changed to UP
21:13:23 epair1b: link state changed to UP
21:13:23 epair0b: link state changed to DOWN
21:13:23 epair0a: link state changed to DOWN
21:13:23 epair1a: link state changed to DOWN
21:13:28 epair1b: link state changed to DOWN
21:13:30 passed  [24.060s]
21:13:30 sys/netpfil/pf/match:dummynet  ->  epair0a: Ethernet address: 02:ee:d8:1b:e6:0a
21:13:30 epair0b: Ethernet address: 02:ee:d8:1b:e6:0b
21:13:30 epair0a: link state changed to UP
21:14:06 epair0b: link state changed to UP
21:14:06 epair0b: link state changed to DOWN
21:14:08 epair0a: link state changed to DOWN
21:14:08 passed  [35.386s]
21:14:09 sys/netpfil/pf/modulate:modulate_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.378s]
21:14:13 sys/netpfil/pf/modulate:modulate_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.375s]
21:14:13 sys/netpfil/pf/names:group  ->  epair0a: Ethernet address: 02:ef:3a:af:88:0a
21:14:13 epair0b: Ethernet address: 02:ef:3a:af:88:0b
21:14:13 epair0a: link state changed to UP
21:14:15 epair0b: link state changed to UP
21:14:15 epair0a: link state changed to DOWN
21:14:21 epair0b: link state changed to DOWN
21:14:23 passed  [6.317s]
21:14:23 sys/netpfil/pf/names:names  ->  epair0a: Ethernet address: 02:e2:c4:f4:03:0a
21:14:23 epair0b: Ethernet address: 02:e2:c4:f4:03:0b
21:14:23 epair0a: link state changed to UP
21:14:26 epair0b: link state changed to UP
21:14:26 epair0a: changing name to 'foo'
21:14:28 epair0b: changing name to 'foo'
21:14:28 foo: link state changed to DOWN
21:14:32 foo: link state changed to DOWN
21:14:34 passed  [7.300s]
21:14:34 sys/netpfil/pf/nat:exhaust  ->  epair0a: Ethernet address: 02:0b:ec:1a:a0:0a
21:14:34 epair0b: Ethernet address: 02:0b:ec:1a:a0:0b
21:14:34 epair0a: link state changed to UP
21:14:35 epair0b: link state changed to UP
21:14:35 epair1a: Ethernet address: 02:0f:f6:3a:6e:0a
21:14:35 epair1b: Ethernet address: 02:0f:f6:3a:6e:0b
21:14:35 epair1a: link state changed to UP
21:14:53 epair1b: link state changed to UP
21:14:53 epair0b: link state changed to DOWN
21:14:54 epair0a: link state changed to DOWN
21:14:54 epair1a: link state changed to DOWN
21:14:58 epair1b: link state changed to DOWN
21:15:00 passed  [18.687s]
21:15:00 sys/netpfil/pf/nat:nested_anchor  ->  epair0a: Ethernet address: 02:de:1e:d4:a9:0a
21:15:00 epair0b: Ethernet address: 02:de:1e:d4:a9:0b
21:15:00 epair0a: link state changed to UP
21:15:09 epair0b: link state changed to UP
21:15:09 epair0a: link state changed to DOWN
21:15:12 epair0b: link state changed to DOWN
21:15:14 passed  [8.543s]
21:15:14 sys/netpfil/pf/pass_block:nested_inline  ->  epair0a: Ethernet address: 02:a0:fd:c5:54:0a
21:15:14 epair0b: Ethernet address: 02:a0:fd:c5:54:0b
21:15:14 epair0a: link state changed to UP
21:15:23 epair0b: link state changed to UP
21:15:23 epair0b: link state changed to DOWN
21:15:25 epair0a: link state changed to DOWN
21:15:28 passed  [8.373s]
21:15:28 sys/netpfil/pf/pass_block:noalias  ->  epair0a: Ethernet address: 02:05:cf:b1:89:0a
21:15:28 epair0b: Ethernet address: 02:05:cf:b1:89:0b
21:15:28 epair0a: link state changed to UP
21:15:54 epair0b: link state changed to UP
21:15:54 epair0b: link state changed to DOWN
21:15:56 epair0a: link state changed to DOWN
21:15:56 passed  [25.675s]
21:15:59 sys/netpfil/pf/pass_block:urpf  ->  skipped: Required program 'scapy' not found in PATH  [0.376s]
21:15:59 sys/netpfil/pf/pass_block:v4  ->  epair0a: Ethernet address: 02:c4:3f:16:52:0a
21:15:59 epair0b: Ethernet address: 02:c4:3f:16:52:0b
21:15:59 epair0a: link state changed to UP
21:16:12 epair0b: link state changed to UP
21:16:12 epair0b: link state changed to DOWN
21:16:14 epair0a: link state changed to DOWN
21:16:17 passed  [12.785s]
21:16:17 sys/netpfil/pf/pass_block:v6  ->  epair0a: Ethernet address: 02:32:a0:d2:3e:0a
21:16:17 epair0b: Ethernet address: 02:32:a0:d2:3e:0b
21:16:17 epair0a: link state changed to UP
21:16:33 epair0b: link state changed to UP
21:16:33 epair0b: link state changed to DOWN
21:16:35 epair0a: link state changed to DOWN
21:16:38 passed  [16.281s]
21:16:38 sys/netpfil/pf/pfsync:basic  ->  epair0a: Ethernet address: 02:9d:21:c9:49:0a
21:16:38 epair0b: Ethernet address: 02:9d:21:c9:49:0b
21:16:38 epair0a: link state changed to UP
21:16:39 epair0b: link state changed to UP
21:16:39 epair1a: Ethernet address: 02:2f:01:29:1c:0a
21:16:39 epair1b: Ethernet address: 02:2f:01:29:1c:0b
21:16:39 epair1a: link state changed to UP
21:16:39 epair1b: link state changed to UP
21:16:39 epair2a: Ethernet address: 02:e5:cb:00:d0:0a
21:16:39 epair2b: Ethernet address: 02:e5:cb:00:d0:0b
21:16:39 epair2a: link state changed to UP
21:16:46 epair2b: link state changed to UP
21:16:48 carp: demoted by 240 to 240 (pfsync bulk start)
21:16:51 carp: demoted by 240 to 240 (pfsync bulk start)
21:16:53 carp: demoted by -240 to 0 (pfsync bulk done)
21:16:59 carp: demoted by -240 to 0 (pfsync bulk done)
21:16:59 epair1a: link state changed to DOWN
21:17:00 epair1b: link state changed to DOWN
21:17:00 epair0a: link state changed to DOWN
21:17:02 epair0b: link state changed to DOWN
21:17:02 epair2a: link state changed to DOWN
21:17:05 epair2b: link state changed to DOWN
21:17:08 passed  [20.344s]
21:17:08 sys/netpfil/pf/pfsync:basic_defer  ->  epair0a: Ethernet address: 02:6c:1e:fb:01:0a
21:17:08 epair0b: Ethernet address: 02:6c:1e:fb:01:0b
21:17:08 epair0a: link state changed to UP
21:17:08 epair0b: link state changed to UP
21:17:08 epair1a: Ethernet address: 02:4f:a7:57:a7:0a
21:17:08 epair1b: Ethernet address: 02:4f:a7:57:a7:0b
21:17:08 epair1a: link state changed to UP
21:17:09 epair1b: link state changed to UP
21:17:09 epair2a: Ethernet address: 02:51:24:d7:a2:0a
21:17:09 epair2b: Ethernet address: 02:51:24:d7:a2:0b
21:17:09 epair2a: link state changed to UP
21:17:16 epair2b: link state changed to UP
21:17:17 carp: demoted by 240 to 240 (pfsync bulk start)
21:17:21 carp: demoted by 240 to 240 (pfsync bulk start)
21:17:23 carp: demoted by -240 to 0 (pfsync bulk done)
21:17:28 carp: demoted by -240 to 0 (pfsync bulk done)
21:17:28 epair1a: link state changed to DOWN
21:17:29 epair1b: link state changed to DOWN
21:17:29 epair0a: link state changed to DOWN
21:17:31 epair0b: link state changed to DOWN
21:17:31 epair2a: link state changed to DOWN
21:17:34 epair2b: link state changed to DOWN
21:17:37 passed  [19.978s]
21:17:37 sys/netpfil/pf/pfsync:basic_ipv6  ->  epair0a: Ethernet address: 02:b4:71:c7:f0:0a
21:17:37 epair0b: Ethernet address: 02:b4:71:c7:f0:0b
21:17:37 epair0a: link state changed to UP
21:17:38 epair0b: link state changed to UP
21:17:38 epair1a: Ethernet address: 02:12:de:01:5c:0a
21:17:38 epair1b: Ethernet address: 02:12:de:01:5c:0b
21:17:38 epair1a: link state changed to UP
21:17:38 epair1b: link state changed to UP
21:17:38 epair2a: Ethernet address: 02:58:6f:f3:fa:0a
21:17:38 epair2b: Ethernet address: 02:58:6f:f3:fa:0b
21:17:38 epair2a: link state changed to UP
21:17:45 epair2b: link state changed to UP
21:17:47 carp: demoted by 240 to 240 (pfsync bulk start)
21:17:50 carp: demoted by 240 to 240 (pfsync bulk start)
21:17:52 carp: demoted by -240 to 0 (pfsync bulk done)
21:17:58 carp: demoted by -240 to 0 (pfsync bulk done)
21:17:58 epair1a: link state changed to DOWN
21:17:59 epair1b: link state changed to DOWN
21:17:59 epair0a: link state changed to DOWN
21:18:01 epair0b: link state changed to DOWN
21:18:01 epair2a: link state changed to DOWN
21:18:05 epair2b: link state changed to DOWN
21:18:07 passed  [21.003s]
21:18:07 sys/netpfil/pf/pfsync:basic_ipv6_unicast  ->  epair0a: Ethernet address: 02:b3:16:71:6f:0a
21:18:07 epair0b: Ethernet address: 02:b3:16:71:6f:0b
21:18:07 epair0a: link state changed to UP
21:18:08 epair0b: link state changed to UP
21:18:08 epair1a: Ethernet address: 02:35:26:f3:5f:0a
21:18:08 epair1b: Ethernet address: 02:35:26:f3:5f:0b
21:18:08 epair1a: link state changed to UP
21:18:08 epair1b: link state changed to UP
21:18:08 epair2a: Ethernet address: 02:af:5b:2a:2e:0a
21:18:08 epair2b: Ethernet address: 02:af:5b:2a:2e:0b
21:18:08 epair2a: link state changed to UP
21:18:15 epair2b: link state changed to UP
21:18:17 carp: demoted by 240 to 240 (pfsync bulk start)
21:18:20 carp: demoted by 240 to 240 (pfsync bulk start)
21:18:22 carp: demoted by -240 to 0 (pfsync bulk done)
21:18:29 carp: demoted by -240 to 0 (pfsync bulk done)
21:18:29 epair1a: link state changed to DOWN
21:18:29 epair1b: link state changed to DOWN
21:18:29 epair0a: link state changed to DOWN
21:18:31 epair0b: link state changed to DOWN
21:18:31 epair2a: link state changed to DOWN
21:18:35 epair2b: link state changed to DOWN
21:18:37 passed  [20.946s]
21:18:37 sys/netpfil/pf/pfsync:bulk  ->  epair0a: Ethernet address: 02:d4:f3:0e:97:0a
21:18:37 epair0b: Ethernet address: 02:d4:f3:0e:97:0b
21:18:37 epair0a: link state changed to UP
21:18:38 epair0b: link state changed to UP
21:18:38 epair1a: Ethernet address: 02:05:60:fc:6e:0a
21:18:38 epair1b: Ethernet address: 02:05:60:fc:6e:0b
21:18:38 epair1a: link state changed to UP
21:18:38 epair1b: link state changed to UP
21:18:38 epair2a: Ethernet address: 02:28:b2:32:19:0a
21:18:38 epair2b: Ethernet address: 02:28:b2:32:19:0b
21:18:38 epair2a: link state changed to UP
21:18:45 epair2b: link state changed to UP
21:18:53 carp: demoted by 240 to 240 (pfsync bulk start)
21:18:54 carp: demoted by 240 to 240 (pfsync bulk start)
21:18:55 carp: demoted by -240 to 0 (pfsync bulk done)
21:19:00 carp: demoted by -240 to 0 (pfsync bulk done)
21:19:00 epair1a: link state changed to DOWN
21:19:00 epair1b: link state changed to DOWN
21:19:00 epair0a: link state changed to DOWN
21:19:02 epair0b: link state changed to DOWN
21:19:02 epair2a: link state changed to DOWN
21:19:06 epair2b: link state changed to DOWN
21:19:09 passed  [22.035s]
21:19:09 sys/netpfil/pf/pfsync:defer  ->  epair0a: Ethernet address: 02:40:6f:df:5e:0a
21:19:09 epair0b: Ethernet address: 02:40:6f:df:5e:0b
21:19:09 epair0a: link state changed to UP
21:19:09 epair0b: link state changed to UP
21:19:09 epair1a: Ethernet address: 02:12:ce:f6:ee:0a
21:19:09 epair1b: Ethernet address: 02:12:ce:f6:ee:0b
21:19:09 epair1a: link state changed to UP
21:19:10 epair1b: link state changed to UP
21:19:10 epair2a: Ethernet address: 02:89:2a:4e:5e:0a
21:19:10 epair2b: Ethernet address: 02:89:2a:4e:5e:0b
21:19:10 epair2a: link state changed to UP
21:19:16 epair2b: link state changed to UP
21:19:25 carp: demoted by 240 to 240 (pfsync bulk start)
21:19:25 epair0a: link state changed to DOWN
21:19:26 epair0b: link state changed to DOWN
21:19:26 epair1a: link state changed to DOWN
21:19:27 epair1b: link state changed to DOWN
21:19:27 epair2a: link state changed to DOWN
21:19:27 epair2b: link state changed to DOWN
21:19:30 carp: demoted by -240 to 0 (pfsync destroy)
21:19:33 failed: atf-check failed; see the output of the test for details  [16.499s]
21:19:33 sys/netpfil/pf/pfsync:ipsec  ->  epair0a: Ethernet address: 02:92:79:f3:2f:0a
21:19:33 epair0b: Ethernet address: 02:92:79:f3:2f:0b
21:19:33 epair0a: link state changed to UP
21:19:33 epair0b: link state changed to UP
21:19:33 epair1a: Ethernet address: 02:d2:30:80:ca:0a
21:19:33 epair1b: Ethernet address: 02:d2:30:80:ca:0b
21:19:33 epair1a: link state changed to UP
21:19:34 epair1b: link state changed to UP
21:19:34 epair2a: Ethernet address: 02:94:2b:d7:a7:0a
21:19:34 epair2b: Ethernet address: 02:94:2b:d7:a7:0b
21:19:34 epair2a: link state changed to UP
21:19:41 epair2b: link state changed to UP
21:19:42 carp: demoted by 240 to 240 (pfsync bulk start)
21:19:46 carp: demoted by 240 to 240 (pfsync bulk start)
21:19:48 carp: demoted by -240 to 0 (pfsync bulk done)
21:19:51 carp: demoted by -240 to 0 (pfsync bulk done)
21:19:51 carp: demoted by 240 to 240 (pfsync bulk start)
21:19:52 carp: demoted by -240 to 0 (pfsync bulk done)
21:19:52 carp: demoted by 240 to 240 (pfsync bulk start)
21:20:05 carp: demoted by -240 to 0 (pfsync bulk done)
21:20:05 epair1a: link state changed to DOWN
21:20:06 epair1b: link state changed to DOWN
21:20:06 epair0a: link state changed to DOWN
21:20:08 epair0b: link state changed to DOWN
21:20:08 epair2a: link state changed to DOWN
21:20:11 epair2b: link state changed to DOWN
21:20:16 passed  [31.787s]
21:20:21 sys/netpfil/pf/pfsync:pbr  ->  skipped: This test requires if_bridge  [2.689s]
21:20:22 sys/netpfil/pf/pfsync:pfsync_pbr  ->  skipped: This test requires if_bridge  [2.704s]
21:20:25 sys/netpfil/pf/pfsync:route_to  ->  skipped: Required program 'scapy' not found in PATH  [0.377s]
21:20:57 sys/netpfil/pf/pfsync:timeout  ->  lo0: link state changed to UP
21:21:00 passed  [31.716s]
21:21:00 sys/netpfil/pf/prio:set_prio  ->  epair0a: Ethernet address: 02:55:27:ba:42:0a
21:21:00 epair0b: Ethernet address: 02:55:27:ba:42:0b
21:21:00 epair0a: link state changed to UP
21:21:09 epair0b: link state changed to UP
21:21:11 epair0a: promiscuous mode enabled
21:21:14 epair0a: promiscuous mode disabled
21:21:14 epair0b: link state changed to DOWN
21:21:14 epair0b.42: link state changed to DOWN
21:21:14 epair0a: link state changed to DOWN
21:21:17 epair0a.42: link state changed to DOWN
21:21:17 passed  [13.934s]
21:21:20 sys/netpfil/pf/proxy:ftp  ->  skipped: Required program 'twistd' not found in PATH  [0.378s]
21:21:20 sys/netpfil/pf/ridentifier:basic  ->  epair0a: Ethernet address: 02:f4:c1:73:5d:0a
21:21:20 epair0b: Ethernet address: 02:f4:c1:73:5d:0b
21:21:20 epair0a: link state changed to UP
21:21:23 epair0b: link state changed to UP
21:21:28 lo0: link state changed to UP
21:21:31 pflog0: promiscuous mode enabled
21:21:35 pflog0: promiscuous mode disabled
21:21:39 pflog0: promiscuous mode enabled
21:21:42 pflog0: promiscuous mode disabled
21:21:42 epair0b: link state changed to DOWN
21:21:45 epair0a: link state changed to DOWN
21:21:48 passed  [22.296s]
21:21:48 sys/netpfil/pf/route_to:dummynet  ->  epair0a: Ethernet address: 02:8b:88:44:ec:0a
21:21:48 epair0b: Ethernet address: 02:8b:88:44:ec:0b
21:21:48 epair0a: link state changed to UP
21:21:48 epair0b: link state changed to UP
21:21:48 epair1a: Ethernet address: 02:34:93:b4:42:0a
21:21:48 epair1b: Ethernet address: 02:34:93:b4:42:0b
21:21:48 epair1a: link state changed to UP
21:22:10 epair1b: link state changed to UP
21:22:10 epair0a: link state changed to DOWN
21:22:12 epair0b: link state changed to DOWN
21:22:12 epair1a: link state changed to DOWN
21:22:15 epair1b: link state changed to DOWN
21:22:15 passed  [22.283s]
21:22:18 sys/netpfil/pf/route_to:icmp_nat  ->  skipped: Required program 'scapy' not found in PATH  [0.379s]
21:22:18 sys/netpfil/pf/route_to:multiwan  ->  epair0a: Ethernet address: 02:18:bb:70:0b:0a
21:22:18 epair0b: Ethernet address: 02:18:bb:70:0b:0b
21:22:18 epair0a: link state changed to UP
21:22:18 epair0b: link state changed to UP
21:22:18 epair1a: Ethernet address: 02:85:63:66:5d:0a
21:22:18 epair1b: Ethernet address: 02:85:63:66:5d:0b
21:22:18 epair1a: link state changed to UP
21:22:19 epair1b: link state changed to UP
21:22:19 epair2a: Ethernet address: 02:12:d7:25:72:0a
21:22:19 epair2b: Ethernet address: 02:12:d7:25:72:0b
21:22:19 epair2a: link state changed to UP
21:22:19 epair2b: link state changed to UP
21:22:19 epair3a: Ethernet address: 02:0f:d9:7b:71:0a
21:22:19 epair3b: Ethernet address: 02:0f:d9:7b:71:0b
21:22:19 epair3a: link state changed to UP
21:22:36 epair3b: link state changed to UP
21:22:45 lo0: link state changed to UP
21:22:45 epair0b: link state changed to DOWN
21:22:46 epair0a: link state changed to DOWN
21:22:46 epair1b: link state changed to DOWN
21:22:47 epair1a: link state changed to DOWN
21:22:47 epair2b: link state changed to DOWN
21:22:49 epair2a: link state changed to DOWN
21:22:49 epair3b: link state changed to DOWN
21:22:51 epair3a: link state changed to DOWN
21:22:53 passed  [27.181s]
21:22:53 sys/netpfil/pf/route_to:multiwanlocal  ->  epair0a: Ethernet address: 02:e1:8b:47:52:0a
21:22:53 epair0b: Ethernet address: 02:e1:8b:47:52:0b
21:22:53 epair0a: link state changed to UP
21:22:54 epair0b: link state changed to UP
21:22:54 epair1a: Ethernet address: 02:ab:ba:f9:21:0a
21:22:54 epair1b: Ethernet address: 02:ab:ba:f9:21:0b
21:22:54 epair1a: link state changed to UP
21:22:54 epair1b: link state changed to UP
21:22:54 epair2a: Ethernet address: 02:fe:cc:f8:cf:0a
21:22:54 epair2b: Ethernet address: 02:fe:cc:f8:cf:0b
21:22:54 epair2a: link state changed to UP
21:22:55 epair2b: link state changed to UP
21:22:55 epair3a: Ethernet address: 02:cb:8e:48:39:0a
21:22:55 epair3b: Ethernet address: 02:cb:8e:48:39:0b
21:22:55 epair3a: link state changed to UP
21:23:23 epair3b: link state changed to UP
21:23:23 epair0b: link state changed to DOWN
21:23:24 epair0a: link state changed to DOWN
21:23:24 epair1b: link state changed to DOWN
21:23:26 epair1a: link state changed to DOWN
21:23:26 epair2b: link state changed to DOWN
21:23:28 epair2a: link state changed to DOWN
21:23:28 epair3b: link state changed to DOWN
21:23:32 epair3a: link state changed to DOWN
21:23:35 failed: Redirect from client on two failed:        0  [29.264s]
21:23:35 sys/netpfil/pf/route_to:v4  ->  epair0a: Ethernet address: 02:6b:5f:02:cd:0a
21:23:35 epair0b: Ethernet address: 02:6b:5f:02:cd:0b
21:23:35 epair0a: link state changed to UP
21:23:36 epair0b: link state changed to UP
21:23:36 epair1a: Ethernet address: 02:3b:78:da:3e:0a
21:23:36 epair1b: Ethernet address: 02:3b:78:da:3e:0b
21:23:36 epair1a: link state changed to UP
21:23:49 epair1b: link state changed to UP
21:23:49 epair0b: link state changed to DOWN
21:23:50 epair0a: link state changed to DOWN
21:23:50 epair1b: link state changed to DOWN
21:23:53 epair1a: link state changed to DOWN
21:23:55 passed  [13.497s]
21:23:55 sys/netpfil/pf/route_to:v6  ->  epair0a: Ethernet address: 02:dd:72:6a:8e:0a
21:23:55 epair0b: Ethernet address: 02:dd:72:6a:8e:0b
21:23:55 epair0a: link state changed to UP
21:23:56 epair0b: link state changed to UP
21:23:56 epair1a: Ethernet address: 02:3d:27:2d:50:0a
21:23:56 epair1b: Ethernet address: 02:3d:27:2d:50:0b
21:23:56 epair1a: link state changed to UP
21:24:07 epair1b: link state changed to UP
21:24:07 epair0b: link state changed to DOWN
21:24:08 epair0a: link state changed to DOWN
21:24:08 epair1b: link state changed to DOWN
21:24:10 epair1a: link state changed to DOWN
21:24:11 passed  [11.177s]
21:24:12 sys/netpfil/pf/rtable:forward_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.408s]
21:24:14 sys/netpfil/pf/rtable:forward_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.396s]
21:24:14 sys/netpfil/pf/rules_counter:get_clear  ->  epair0a: Ethernet address: 02:e1:81:70:05:0a
21:24:14 epair0b: Ethernet address: 02:e1:81:70:05:0b
21:24:14 epair0a: link state changed to UP
21:24:29 epair0b: link state changed to UP
21:24:29 epair0b: link state changed to DOWN
21:24:31 epair0a: link state changed to DOWN
21:24:34 passed  [14.649s]
21:24:34 sys/netpfil/pf/rules_counter:keepcounters  ->  epair0a: Ethernet address: 02:7b:9c:3f:79:0a
21:24:34 epair0b: Ethernet address: 02:7b:9c:3f:79:0b
21:24:34 epair0a: link state changed to UP
21:25:00 epair0b: link state changed to UP
21:25:00 epair0b: link state changed to DOWN
21:25:02 epair0a: link state changed to DOWN
21:25:02 passed  [25.815s]
21:25:03 sys/netpfil/pf/scrub_compat:max_mss_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.370s]
21:25:04 sys/netpfil/pf/scrub_compat:max_mss_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:25:04 sys/netpfil/pf/scrub_compat:min_ttl_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.370s]
21:25:05 sys/netpfil/pf/scrub_compat:min_ttl_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.378s]
21:25:05 sys/netpfil/pf/scrub_compat:no_scrub_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.376s]
21:25:06 sys/netpfil/pf/scrub_compat:no_scrub_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:25:07 sys/netpfil/pf/scrub_compat:set_tos_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:25:07 sys/netpfil/pf/scrub_compat:set_tos_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.379s]
21:25:08 sys/netpfil/pf/scrub_pass:max_mss_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.378s]
21:25:08 sys/netpfil/pf/scrub_pass:max_mss_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:25:09 sys/netpfil/pf/scrub_pass:min_ttl_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.378s]
21:25:09 sys/netpfil/pf/scrub_pass:min_ttl_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.379s]
21:25:10 sys/netpfil/pf/scrub_pass:set_tos_v4  ->  skipped: Required program 'scapy' not found in PATH  [0.379s]
21:25:13 sys/netpfil/pf/scrub_pass:set_tos_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.380s]
21:25:13 sys/netpfil/pf/sctp:abort_v4  ->  epair0a: Ethernet address: 02:ce:03:e6:ff:0a
21:25:13 epair0b: Ethernet address: 02:ce:03:e6:ff:0b
21:25:13 epair0a: link state changed to UP
21:25:31 epair0b: link state changed to UP
21:25:31 epair0a: link state changed to DOWN
21:25:35 epair0b: link state changed to DOWN
21:25:38 passed  [18.445s]
21:25:38 sys/netpfil/pf/sctp:abort_v6  ->  epair0a: Ethernet address: 02:6e:70:bd:c3:0a
21:25:38 epair0b: Ethernet address: 02:6e:70:bd:c3:0b
21:25:38 epair0a: link state changed to UP
21:25:56 epair0b: link state changed to UP
21:25:56 epair0a: link state changed to DOWN
21:26:00 epair0b: link state changed to DOWN
21:26:03 passed  [18.615s]
21:26:03 sys/netpfil/pf/sctp:basic_v4  ->  epair0a: Ethernet address: 02:dc:ed:08:61:0a
21:26:03 epair0b: Ethernet address: 02:dc:ed:08:61:0b
21:26:03 epair0a: link state changed to UP
21:26:25 epair0b: link state changed to UP
21:26:25 epair0a: link state changed to DOWN
21:26:29 epair0b: link state changed to DOWN
21:26:32 passed  [22.402s]
21:26:32 sys/netpfil/pf/sctp:basic_v6  ->  epair0a: Ethernet address: 02:a3:5d:42:b1:0a
21:26:32 epair0b: Ethernet address: 02:a3:5d:42:b1:0b
21:26:32 epair0a: link state changed to UP
21:26:54 epair0b: link state changed to UP
21:26:54 epair0a: link state changed to DOWN
21:26:58 epair0b: link state changed to DOWN
21:27:01 passed  [22.627s]
21:27:01 sys/netpfil/pf/sctp:nat_v4  ->  epair0a: Ethernet address: 02:0b:0c:63:a4:0a
21:27:01 epair0b: Ethernet address: 02:0b:0c:63:a4:0b
21:27:01 epair0a: link state changed to UP
21:27:01 epair0b: link state changed to UP
21:27:01 epair1a: Ethernet address: 02:b7:e5:5e:ac:0a
21:27:01 epair1b: Ethernet address: 02:b7:e5:5e:ac:0b
21:27:01 epair1a: link state changed to UP
21:27:19 epair1b: link state changed to UP
21:27:19 epair1a: link state changed to DOWN
21:27:21 epair1b: link state changed to DOWN
21:27:21 epair0a: link state changed to DOWN
21:27:25 epair0b: link state changed to DOWN
21:27:27 passed  [17.848s]
21:27:27 sys/netpfil/pf/sctp:nat_v6  ->  epair0a: Ethernet address: 02:d9:dd:ca:4e:0a
21:27:27 epair0b: Ethernet address: 02:d9:dd:ca:4e:0b
21:27:27 epair0a: link state changed to UP
21:27:28 epair0b: link state changed to UP
21:27:28 epair1a: Ethernet address: 02:c1:07:79:f5:0a
21:27:28 epair1b: Ethernet address: 02:c1:07:79:f5:0b
21:27:28 epair1a: link state changed to UP
21:27:45 epair1b: link state changed to UP
21:27:45 epair1a: link state changed to DOWN
21:27:48 epair1b: link state changed to DOWN
21:27:48 epair0a: link state changed to DOWN
21:27:51 epair0b: link state changed to DOWN
21:27:57 passed  [18.165s]
21:27:59 sys/netpfil/pf/sctp:pfsync  ->  skipped: This test requires if_bridge  [2.744s]
21:27:59 sys/netpfil/pf/sctp:rdr_v4  ->  epair0a: Ethernet address: 02:65:90:d7:9a:0a
21:27:59 epair0b: Ethernet address: 02:65:90:d7:9a:0b
21:27:59 epair0a: link state changed to UP
21:28:00 epair0b: link state changed to UP
21:28:00 epair1a: Ethernet address: 02:06:7d:40:ec:0a
21:28:00 epair1b: Ethernet address: 02:06:7d:40:ec:0b
21:28:00 epair1a: link state changed to UP
21:28:19 epair1b: link state changed to UP
21:28:19 epair1a: link state changed to DOWN
21:28:22 epair1b: link state changed to DOWN
21:28:22 epair0a: link state changed to DOWN
21:28:25 epair0b: link state changed to DOWN
21:28:26 passed  [20.143s]
21:28:29 sys/netpfil/pf/sctp.py:__test_cases_list_pytest_binary_not_found__  ->  skipped: Required program 'pytest' not found in PATH  [0.372s]
21:28:29 sys/netpfil/pf/set_skip:pr255852  ->  epair0a: Ethernet address: 02:f0:3d:cd:a2:0a
21:28:29 epair0b: Ethernet address: 02:f0:3d:cd:a2:0b
21:28:29 epair0a: link state changed to UP
21:28:31 epair0b: link state changed to UP
21:28:41 lo0: link state changed to UP
21:28:41 epair0b: link state changed to DOWN
21:28:43 epair0a: link state changed to DOWN
21:28:49 passed  [11.989s]
21:28:49 sys/netpfil/pf/set_skip:set_skip_dynamic  ->  epair0a: Ethernet address: 02:6d:72:1f:31:0a
21:28:49 epair0b: Ethernet address: 02:6d:72:1f:31:0b
21:28:49 epair0a: link state changed to UP
21:28:54 epair0b: link state changed to UP
21:28:54 epair0b: link state changed to DOWN
21:28:57 epair0a: link state changed to DOWN
21:29:00 passed  [8.468s]
21:29:08 sys/netpfil/pf/set_skip:set_skip_group  ->  lo0: link state changed to UP
21:29:11 passed  [7.321s]
21:29:20 sys/netpfil/pf/set_skip:set_skip_group_lo  ->  lo0: link state changed to UP
21:29:21 passed  [8.956s]
21:29:22 sys/netpfil/pf/set_tos:v4  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:29:24 sys/netpfil/pf/set_tos:v6  ->  skipped: Required program 'scapy' not found in PATH  [0.373s]
21:29:24 sys/netpfil/pf/src_track:source_track  ->  epair0a: Ethernet address: 02:2c:1c:b9:ef:0a
21:29:24 epair0b: Ethernet address: 02:2c:1c:b9:ef:0b
21:29:24 epair0a: link state changed to UP
21:29:35 epair0b: link state changed to UP
21:29:35 epair0b: link state changed to DOWN
21:29:38 epair0a: link state changed to DOWN
21:29:38 passed  [10.978s]
21:29:41 sys/netpfil/pf/syncookie:adaptive  ->  skipped: Required program 'scapy' not found in PATH  [0.377s]
21:29:41 sys/netpfil/pf/syncookie:basic  ->  epair0a: Ethernet address: 02:91:76:6e:1c:0a
21:29:41 epair0b: Ethernet address: 02:91:76:6e:1c:0b
21:29:41 epair0a: link state changed to UP
21:29:51 epair0b: link state changed to UP
21:29:51 epair0b: link state changed to DOWN
21:29:54 epair0a: link state changed to DOWN
21:29:56 passed  [9.605s]
21:29:56 sys/netpfil/pf/syncookie:basic_v6  ->  epair0a: Ethernet address: 02:2f:8b:1b:95:0a
21:29:56 epair0b: Ethernet address: 02:2f:8b:1b:95:0b
21:29:56 epair0a: link state changed to UP
21:30:06 epair0b: link state changed to UP
21:30:06 epair0b: link state changed to DOWN
21:30:09 epair0a: link state changed to DOWN
21:30:12 passed  [9.688s]
21:30:12 sys/netpfil/pf/syncookie:forward  ->  epair0a: Ethernet address: 02:90:55:7f:ae:0a
21:30:12 epair0b: Ethernet address: 02:90:55:7f:ae:0b
21:30:12 epair0a: link state changed to UP
21:30:12 epair0b: link state changed to UP
21:30:12 epair1a: Ethernet address: 02:8b:2f:0a:55:0a
21:30:12 epair1b: Ethernet address: 02:8b:2f:0a:55:0b
21:30:12 epair1a: link state changed to UP
21:30:26 epair1b: link state changed to UP
21:30:26 epair0b: link state changed to DOWN
21:30:27 epair0a: link state changed to DOWN
21:30:27 epair1a: link state changed to DOWN
21:30:30 epair1b: link state changed to DOWN
21:30:33 passed  [13.991s]
21:30:33 sys/netpfil/pf/syncookie:forward_v6  ->  epair0a: Ethernet address: 02:73:03:1b:80:0a
21:30:33 epair0b: Ethernet address: 02:73:03:1b:80:0b
21:30:33 epair0a: link state changed to UP
21:30:33 epair0b: link state changed to UP
21:30:33 epair1a: Ethernet address: 02:e4:04:5b:77:0a
21:30:33 epair1b: Ethernet address: 02:e4:04:5b:77:0b
21:30:33 epair1a: link state changed to UP
21:30:47 epair1b: link state changed to UP
21:30:47 epair0b: link state changed to DOWN
21:30:48 epair0a: link state changed to DOWN
21:30:48 epair1a: link state changed to DOWN
21:30:52 epair1b: link state changed to DOWN
21:31:03 passed  [14.263s]
21:31:03 sys/netpfil/pf/syncookie:limits  ->  passed  [6.861s]
21:31:04 sys/netpfil/pf/syncookie:nostate  ->  skipped: Required program 'scapy' not found in PATH  [0.374s]
21:31:07 sys/netpfil/pf/syncookie:nostate_v6  ->  skipped: Required program 'scapy' not found in PATH  [0.369s]
21:31:07 sys/netpfil/pf/syncookie:port_reuse  ->  epair0a: Ethernet address: 02:cf:51:83:60:0a
21:31:07 epair0b: Ethernet address: 02:cf:51:83:60:0b
21:31:07 epair0a: link state changed to UP
21:31:18 epair0b: link state changed to UP
21:31:18 epair0b: link state changed to DOWN
21:31:21 epair0a: link state changed to DOWN
21:31:24 failed: Failed to connect to syncookie protected echo daemon  [10.544s]
21:31:24 sys/netpfil/pf/synproxy:local  ->  epair0a: Ethernet address: 02:ca:8c:9e:42:0a
21:31:24 epair0b: Ethernet address: 02:ca:8c:9e:42:0b
21:31:24 epair0a: link state changed to UP
21:31:33 epair0b: link state changed to UP
21:31:33 epair0b: link state changed to DOWN
21:31:34 epair0a: link state changed to DOWN
21:31:37 passed  [8.885s]
21:31:37 sys/netpfil/pf/synproxy:local_v6  ->  epair0a: Ethernet address: 02:c6:35:14:84:0a
21:31:37 epair0b: Ethernet address: 02:c6:35:14:84:0b
21:31:37 epair0a: link state changed to UP
21:31:46 epair0b: link state changed to UP
21:31:46 epair0b: link state changed to DOWN
21:31:48 epair0a: link state changed to DOWN
21:31:51 passed  [8.997s]
21:31:51 sys/netpfil/pf/synproxy:synproxy  ->  epair0a: Ethernet address: 02:6c:3e:cf:b8:0a
21:31:51 epair0b: Ethernet address: 02:6c:3e:cf:b8:0b
21:31:51 epair0a: link state changed to UP
21:31:52 epair0b: link state changed to UP
21:31:52 epair1a: Ethernet address: 02:64:1e:ac:92:0a
21:31:52 epair1b: Ethernet address: 02:64:1e:ac:92:0b
21:31:52 epair1a: link state changed to UP
21:32:05 epair1b: link state changed to UP
21:32:05 epair0b: link state changed to DOWN
21:32:06 epair0a: link state changed to DOWN
21:32:06 epair1a: link state changed to DOWN
21:32:10 epair1b: link state changed to DOWN
21:32:13 passed  [13.833s]
21:32:13 sys/netpfil/pf/table:anchor  ->  epair0a: Ethernet address: 02:f0:3d:f3:c0:0a
21:32:13 epair0b: Ethernet address: 02:f0:3d:f3:c0:0b
21:32:13 epair0a: link state changed to UP
21:32:34 epair0b: link state changed to UP
21:32:34 epair0b: link state changed to DOWN
21:32:36 epair0a: link state changed to DOWN
21:32:39 passed  [20.853s]
21:32:39 sys/netpfil/pf/table:automatic  ->  epair0a: Ethernet address: 02:6e:98:38:79:0a
21:32:39 epair0b: Ethernet address: 02:6e:98:38:79:0b
21:32:39 epair0a: link state changed to UP
21:32:47 epair0b: link state changed to UP
21:32:47 epair0b: link state changed to DOWN
21:32:49 epair0a: link state changed to DOWN
21:32:52 passed  [8.386s]
21:32:52 sys/netpfil/pf/table:network  ->  epair0a: Ethernet address: 02:ff:f9:a2:26:0a
21:32:52 epair0b: Ethernet address: 02:ff:f9:a2:26:0b
21:32:52 epair0a: link state changed to UP
21:33:00 epair0b: link state changed to UP
21:33:00 epair0b: link state changed to DOWN
21:33:03 epair0a: link state changed to DOWN
21:33:05 passed  [8.282s]
21:33:05 sys/netpfil/pf/table:pr251414  ->  epair0a: Ethernet address: 02:a1:a0:d0:cc:0a
21:33:05 epair0b: Ethernet address: 02:a1:a0:d0:cc:0b
21:33:05 epair0a: link state changed to UP
21:33:17 epair0b: link state changed to UP
21:33:17 epair0b: link state changed to DOWN
21:33:19 epair0a: link state changed to DOWN
21:33:29 passed  [11.483s]
21:33:39 sys/netpfil/pf/table:pr259689  ->  passed  [6.449s]
21:33:41 sys/netpfil/pf/table:precreate  ->  passed  [5.684s]
21:33:41 sys/netpfil/pf/table:v4_counters  ->  epair0a: Ethernet address: 02:e8:c2:e0:42:0a
21:33:41 epair0b: Ethernet address: 02:e8:c2:e0:42:0b
21:33:41 epair0a: link state changed to UP
21:33:53 epair0b: link state changed to UP
21:33:53 epair0b: link state changed to DOWN
21:33:55 epair0a: link state changed to DOWN
21:33:57 passed  [11.319s]
21:33:57 sys/netpfil/pf/table:v6_counters  ->  epair0a: Ethernet address: 02:93:51:b5:eb:0a
21:33:57 epair0b: Ethernet address: 02:93:51:b5:eb:0b
21:33:57 epair0a: link state changed to UP
21:34:09 epair0b: link state changed to UP
21:34:09 epair0b: link state changed to DOWN
21:34:11 epair0a: link state changed to DOWN
21:34:12 passed  [11.531s]
21:34:15 sys/netpfil/pf/tcp:rst  ->  skipped: Required program 'scapy' not found in PATH  [0.375s]
21:34:15 sys/netpfil/pf/tos:v4  ->  epair0a: Ethernet address: 02:f7:f2:70:5a:0a
21:34:15 epair0b: Ethernet address: 02:f7:f2:70:5a:0b
21:34:15 epair0a: link state changed to UP
21:34:24 epair0b: link state changed to UP
21:34:24 epair0b: link state changed to DOWN
21:34:27 epair0a: link state changed to DOWN
21:34:29 passed  [9.706s]
21:34:29 sys/netpfil/pf/tos:v6  ->  epair0a: Ethernet address: 02:f6:5f:81:2f:0a
21:34:29 epair0b: Ethernet address: 02:f6:5f:81:2f:0b
21:34:29 epair0a: link state changed to UP
21:34:39 epair0b: link state changed to UP
21:34:39 epair0b: link state changed to DOWN
21:34:42 epair0a: link state changed to DOWN
21:34:43 passed  [9.977s]
21:34:44 sys/ses/destructive:setelmstat  ->  skipped: No ses devices found  [0.580s]
21:34:54 sys/ses/destructive:setencstat  ->  skipped: No ses devices found  [0.565s]
21:35:02 usr.sbin/jail/jail_basic_test:basic  ->  passed  [7.601s]
21:35:14 usr.sbin/jail/jail_basic_test:commands  ->  passed  [5.588s]
21:36:14 usr.sbin/jail/jail_basic_test:nested  ->  passed  [8.723s]
21:37:04 usr.sbin/makefs/makefs_zfs_tests:autoexpand  ->  passed  [53.371s]
21:37:38 usr.sbin/makefs/makefs_zfs_tests:basic  ->  passed  [44.646s]
21:38:09 usr.sbin/makefs/makefs_zfs_tests:dataset_removal  ->  passed  [27.182s]
21:38:38 usr.sbin/makefs/makefs_zfs_tests:empty_dir  ->  passed  [24.448s]
21:43:45 usr.sbin/makefs/makefs_zfs_tests:empty_fs  ->  passed  [23.686s]
21:44:26 usr.sbin/makefs/makefs_zfs_tests:file_extend  ->  broken: Test case body timed out  [300.137s]
21:45:11 usr.sbin/makefs/makefs_zfs_tests:file_sizes  ->  passed  [34.418s]
21:46:06 usr.sbin/makefs/makefs_zfs_tests:hard_links  ->  passed  [39.119s]
21:47:15 usr.sbin/makefs/makefs_zfs_tests:indirect_dnode_array  ->  passed  [48.387s]
21:47:53 usr.sbin/makefs/makefs_zfs_tests:long_file_name  ->  passed  [62.226s]
21:48:25 usr.sbin/makefs/makefs_zfs_tests:multi_dataset_1  ->  passed  [31.136s]
21:48:59 usr.sbin/makefs/makefs_zfs_tests:multi_dataset_2  ->  passed  [25.244s]
21:49:35 usr.sbin/makefs/makefs_zfs_tests:multi_dataset_3  ->  passed  [27.348s]
21:50:06 usr.sbin/makefs/makefs_zfs_tests:multi_dataset_4  ->  passed  [29.870s]
21:50:37 usr.sbin/makefs/makefs_zfs_tests:multi_staging_1  ->  passed  [24.720s]
21:55:46 usr.sbin/makefs/makefs_zfs_tests:multi_staging_2  ->  passed  [25.486s]
21:58:06 usr.sbin/makefs/makefs_zfs_tests:perms  ->  broken: Test case body timed out  [300.042s]
21:58:59 usr.sbin/makefs/makefs_zfs_tests:reproducible  ->  passed  [129.698s]
21:59:29 usr.sbin/makefs/makefs_zfs_tests:root_props  ->  passed  [47.728s]
21:59:59 usr.sbin/makefs/makefs_zfs_tests:snapshot  ->  passed  [24.056s]
22:00:58 usr.sbin/makefs/makefs_zfs_tests:soft_links  ->  passed  [24.537s]
22:00:59 usr.sbin/makefs/makefs_zfs_tests:used_space_props  ->  passed  [51.713s]
22:00:59 
22:00:59 Results file id is usr_tests.20240724-083918-993247
22:00:59 Results saved to /.kyua/store/results.usr_tests.20240724-083918-993247.db
22:00:59 
22:01:00 8045/8106 passed (61 failed)
22:01:00 + rc=1
22:01:00 + set -e
22:01:00 + [ 1 -ne 0 ]
22:01:00 + [ 1 -ne 1 ]
22:01:56 + kyua report --verbose --results-filter passed,skipped,xfail,broken,failed --output test-report.txt
22:04:28 + kyua report-junit '--output=test-report.xml'
22:04:28 + mv test-report.txt test-report.xml /meta
22:04:28 + tar cvf /dev/ada0 -C /meta .
22:04:28 a .
22:04:28 a ./auto-shutdown
22:04:28 a ./disable-notyet-tests.sh
22:04:28 a ./run-kyua.sh
22:04:28 a ./disable-dtrace-tests.sh
22:04:28 a ./run.sh
22:04:40 a ./disable-zfs-tests.sh
22:04:52 a ./test-report.txt
22:04:52 a ./test-report.xml
22:04:52 + [ -f /meta/auto-shutdown ]
22:04:52 + uname -p
22:04:52 + shutdown -p now
22:04:52 Shutdown NOW!
22:04:52 shutdown: [pid 35559]
22:04:52 + startmsg .
22:04:52 + check_startmsgs
22:04:52 + [ -n yes ]
22:04:52 + checkyesno rc_startmsgs
22:04:52 + eval '_value=$rc_startmsgs'
22:04:52 + _value=YES
22:04:52 + debug 'checkyesno: rc_startmsgs is set to YES.'
22:04:52 + return 0
22:04:52 + echo .
22:04:52 .
22:04:52 + _return=0
22:04:52 + umask 0022
22:04:52 + [ 0 -ne 0 ]
22:04:52 + return 0
22:04:52 + _run_rc_postcmd
22:04:52 + [ -n '' ]
22:04:52 + return 0
22:04:53 + return 0
22:04:53 2024-07-24T22:04:52.869235+00:00 - shutdown 35559 - - power-down by root: 
22:04:53 
22:04:53 
22:04:53 
22:04:53 System shutdown time has arrived
22:04:53 
22:04:53 2024-07-24T22:04:52.909230+00:00 - auditd 86809 - - auditd_wait_for_events: SIGTERM
22:04:53 
22:04:53 2024-07-24T22:04:52.945585+00:00 - auditd 86809 - - Auditing disabled
22:04:55 
22:04:55 2024-07-24T22:04:52.980100+00:00 - auditd 86809 - - renamed /var/audit/20240724193924.not_terminated to /var/audit/20240724193924.20240724220452
22:04:59 
22:05:06 2024-07-24T22:04:53.012611+00:00 - auditd 86809 - - Finished
22:05:06 
22:05:06 Waiting (max 60 seconds) for system process `vnlru' to stop... done
22:05:06 GEOM_ELI: Device md0.eli destroyed.
22:05:06 Waiting (max 60 seconds) for system process `syncer' to stop... 
22:05:06 Syncing disks, vnodes remaining... 0 0 0 done
22:05:06 All buffers synced.
22:05:06 Uptime: 13h28m46s
22:05:06 + rc=0
22:05:06 + echo 'qemu return code = 0'
22:05:06 qemu return code = 0
22:05:06 + sh -ex freebsd-ci/scripts/test/extract-meta.sh
22:05:06 + METAOUTDIR=meta-out
22:05:06 + rm -fr meta-out
22:05:06 + mkdir meta-out
22:05:06 + tar xvf meta.tar -C meta-out
22:05:06 x ./
22:05:06 x ./auto-shutdown
22:05:06 x ./disable-notyet-tests.sh
22:05:06 x ./run-kyua.sh
22:05:06 x ./disable-dtrace-tests.sh
22:05:06 x ./run.sh
22:05:06 x ./disable-zfs-tests.sh
22:05:06 x ./test-report.txt
22:05:06 x ./test-report.xml
22:05:06 + rm -f test-report.txt test-report.xml
22:05:06 + mv meta-out/test-report.txt meta-out/test-report.xml .
22:05:06 + report=test-report.xml
22:05:06 + [ -e freebsd-ci/jobs/FreeBSD-stable-14-aarch64-KASAN_test/xfail-list -a -e test-report.xml ]
22:05:06 + IFS=: read classname name
22:05:06 + xpath='/testsuite/testcase[@classname="lib.libc.ssp.ssp_test"][@name="vsprintf"]'
22:05:06 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.libc.ssp.ssp_test"][@name="vsprintf"]/*[self::error or self::failure]' test-report.xml
22:05:06 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:06 
22:05:06 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:06                                                 ^
22:05:06 test-report.xml:1005454.32: Extra content at the end of the document
22:05:06 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:06                                                  ^
22:05:06 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.libc.ssp.ssp_test"][@name="vsprintf"]' test-report.xml
22:05:06 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:06 
22:05:06 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:06                                                 ^
22:05:06 test-report.xml:1005454.32: Extra content at the end of the document
22:05:06 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:06                                                  ^
22:05:06 + echo 'Testcase lib.libc.ssp.ssp_test:vsprintf vanished'
22:05:06 Testcase lib.libc.ssp.ssp_test:vsprintf vanished
22:05:06 + IFS=: read classname name
22:05:06 + xpath='/testsuite/testcase[@classname="lib.libc.string.memcmp_test"][@name="diff"]'
22:05:06 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.libc.string.memcmp_test"][@name="diff"]/*[self::error or self::failure]' test-report.xml
22:05:06 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:06 
22:05:06 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:06                                                 ^
22:05:06 test-report.xml:1005454.32: Extra content at the end of the document
22:05:06 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:06                                                  ^
22:05:06 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.libc.string.memcmp_test"][@name="diff"]' test-report.xml
22:05:06 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:06 
22:05:06 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:06                                                 ^
22:05:07 test-report.xml:1005454.32: Extra content at the end of the document
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                  ^
22:05:07 + echo 'Testcase lib.libc.string.memcmp_test:diff vanished'
22:05:07 Testcase lib.libc.string.memcmp_test:diff vanished
22:05:07 + IFS=: read classname name
22:05:07 + xpath='/testsuite/testcase[@classname="lib.libexecinfo.backtrace_test"][@name="backtrace_fmt_basic"]'
22:05:07 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.libexecinfo.backtrace_test"][@name="backtrace_fmt_basic"]/*[self::error or self::failure]' test-report.xml
22:05:07 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:07 
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                 ^
22:05:07 test-report.xml:1005454.32: Extra content at the end of the document
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                  ^
22:05:07 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.libexecinfo.backtrace_test"][@name="backtrace_fmt_basic"]' test-report.xml
22:05:07 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:07 
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                 ^
22:05:07 test-report.xml:1005454.32: Extra content at the end of the document
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                  ^
22:05:07 + echo 'Testcase lib.libexecinfo.backtrace_test:backtrace_fmt_basic vanished'
22:05:07 Testcase lib.libexecinfo.backtrace_test:backtrace_fmt_basic vanished
22:05:07 + IFS=: read classname name
22:05:07 + xpath='/testsuite/testcase[@classname="lib.librt.sem_test"][@name="timedwait"]'
22:05:07 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.librt.sem_test"][@name="timedwait"]/*[self::error or self::failure]' test-report.xml
22:05:07 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:07 
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                 ^
22:05:07 test-report.xml:1005454.32: Extra content at the end of the document
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                  ^
22:05:07 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.librt.sem_test"][@name="timedwait"]' test-report.xml
22:05:07 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:07 
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                 ^
22:05:07 test-report.xml:1005454.32: Extra content at the end of the document
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                  ^
22:05:07 + echo 'Testcase lib.librt.sem_test:timedwait vanished'
22:05:07 Testcase lib.librt.sem_test:timedwait vanished
22:05:07 + IFS=: read classname name
22:05:07 + xpath='/testsuite/testcase[@classname="lib.msun.exponential_test"][@name="main"]'
22:05:07 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.exponential_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:07 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:07 
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                 ^
22:05:07 test-report.xml:1005454.32: Extra content at the end of the document
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                  ^
22:05:07 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.exponential_test"][@name="main"]' test-report.xml
22:05:07 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:07 
22:05:07 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:07                                                 ^
22:05:08 test-report.xml:1005454.32: Extra content at the end of the document
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                  ^
22:05:08 + echo 'Testcase lib.msun.exponential_test:main vanished'
22:05:08 Testcase lib.msun.exponential_test:main vanished
22:05:08 + IFS=: read classname name
22:05:08 + xpath='/testsuite/testcase[@classname="lib.msun.fenv_test"][@name="main"]'
22:05:08 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.fenv_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:08 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:08 
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                 ^
22:05:08 test-report.xml:1005454.32: Extra content at the end of the document
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                  ^
22:05:08 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.fenv_test"][@name="main"]' test-report.xml
22:05:08 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:08 
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                 ^
22:05:08 test-report.xml:1005454.32: Extra content at the end of the document
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                  ^
22:05:08 + echo 'Testcase lib.msun.fenv_test:main vanished'
22:05:08 Testcase lib.msun.fenv_test:main vanished
22:05:08 + IFS=: read classname name
22:05:08 + xpath='/testsuite/testcase[@classname="lib.msun.fma_test"][@name="main"]'
22:05:08 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.fma_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:08 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:08 
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                 ^
22:05:08 test-report.xml:1005454.32: Extra content at the end of the document
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                  ^
22:05:08 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.fma_test"][@name="main"]' test-report.xml
22:05:08 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:08 
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                 ^
22:05:08 test-report.xml:1005454.32: Extra content at the end of the document
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                  ^
22:05:08 + echo 'Testcase lib.msun.fma_test:main vanished'
22:05:08 Testcase lib.msun.fma_test:main vanished
22:05:08 + IFS=: read classname name
22:05:08 + xpath='/testsuite/testcase[@classname="lib.msun.invtrig_test"][@name="main"]'
22:05:08 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.invtrig_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:08 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:08 
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                 ^
22:05:08 test-report.xml:1005454.32: Extra content at the end of the document
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                  ^
22:05:08 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.invtrig_test"][@name="main"]' test-report.xml
22:05:08 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:08 
22:05:08 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:08                                                 ^
22:05:09 test-report.xml:1005454.32: Extra content at the end of the document
22:05:09 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:09                                                  ^
22:05:09 + echo 'Testcase lib.msun.invtrig_test:main vanished'
22:05:09 Testcase lib.msun.invtrig_test:main vanished
22:05:09 + IFS=: read classname name
22:05:09 + xpath='/testsuite/testcase[@classname="lib.msun.logarithm_test"][@name="main"]'
22:05:09 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.logarithm_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:09 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:09 
22:05:09 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:09                                                 ^
22:05:09 test-report.xml:1005454.32: Extra content at the end of the document
22:05:09 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:09                                                  ^
22:05:09 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.logarithm_test"][@name="main"]' test-report.xml
22:05:09 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:09 
22:05:09 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:09                                                 ^
22:05:09 test-report.xml:1005454.32: Extra content at the end of the document
22:05:09 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:09                                                  ^
22:05:09 + echo 'Testcase lib.msun.logarithm_test:main vanished'
22:05:09 Testcase lib.msun.logarithm_test:main vanished
22:05:09 + IFS=: read classname name
22:05:09 + xpath='/testsuite/testcase[@classname="lib.msun.lrint_test"][@name="main"]'
22:05:09 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.lrint_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:09 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:09 
22:05:09 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:09                                                 ^
22:05:09 test-report.xml:1005454.32: Extra content at the end of the document
22:05:09 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:09                                                  ^
22:05:09 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.lrint_test"][@name="main"]' test-report.xml
22:05:09 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:09 
22:05:09 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:09                                                 ^
22:05:09 test-report.xml:1005454.32: Extra content at the end of the document
22:05:09 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:09                                                  ^
22:05:09 + echo 'Testcase lib.msun.lrint_test:main vanished'
22:05:09 Testcase lib.msun.lrint_test:main vanished
22:05:09 + IFS=: read classname name
22:05:09 + xpath='/testsuite/testcase[@classname="lib.msun.nearbyint_test"][@name="main"]'
22:05:09 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.nearbyint_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:10 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:10 
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                 ^
22:05:10 test-report.xml:1005454.32: Extra content at the end of the document
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                  ^
22:05:10 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.nearbyint_test"][@name="main"]' test-report.xml
22:05:10 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:10 
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                 ^
22:05:10 test-report.xml:1005454.32: Extra content at the end of the document
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                  ^
22:05:10 + echo 'Testcase lib.msun.nearbyint_test:main vanished'
22:05:10 Testcase lib.msun.nearbyint_test:main vanished
22:05:10 + IFS=: read classname name
22:05:10 + xpath='/testsuite/testcase[@classname="lib.msun.next_test"][@name="main"]'
22:05:10 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.next_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:10 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:10 
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                 ^
22:05:10 test-report.xml:1005454.32: Extra content at the end of the document
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                  ^
22:05:10 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.next_test"][@name="main"]' test-report.xml
22:05:10 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:10 
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                 ^
22:05:10 test-report.xml:1005454.32: Extra content at the end of the document
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                  ^
22:05:10 + echo 'Testcase lib.msun.next_test:main vanished'
22:05:10 Testcase lib.msun.next_test:main vanished
22:05:10 + IFS=: read classname name
22:05:10 + xpath='/testsuite/testcase[@classname="lib.msun.rem_test"][@name="main"]'
22:05:10 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.rem_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:10 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:10 
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                 ^
22:05:10 test-report.xml:1005454.32: Extra content at the end of the document
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                  ^
22:05:10 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.rem_test"][@name="main"]' test-report.xml
22:05:10 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:10 
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                 ^
22:05:10 test-report.xml:1005454.32: Extra content at the end of the document
22:05:10 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:10                                                  ^
22:05:10 + echo 'Testcase lib.msun.rem_test:main vanished'
22:05:10 Testcase lib.msun.rem_test:main vanished
22:05:10 + IFS=: read classname name
22:05:10 + xpath='/testsuite/testcase[@classname="lib.msun.trig_test"][@name="special"]'
22:05:10 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.trig_test"][@name="special"]/*[self::error or self::failure]' test-report.xml
22:05:11 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:11 
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                 ^
22:05:11 test-report.xml:1005454.32: Extra content at the end of the document
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                  ^
22:05:11 + xml sel -Q -t -c '/testsuite/testcase[@classname="lib.msun.trig_test"][@name="special"]' test-report.xml
22:05:11 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:11 
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                 ^
22:05:11 test-report.xml:1005454.32: Extra content at the end of the document
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                  ^
22:05:11 + echo 'Testcase lib.msun.trig_test:special vanished'
22:05:11 Testcase lib.msun.trig_test:special vanished
22:05:11 + IFS=: read classname name
22:05:11 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="dotdot_v6"]'
22:05:11 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="dotdot_v6"]/*[self::error or self::failure]' test-report.xml
22:05:11 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:11 
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                 ^
22:05:11 test-report.xml:1005454.32: Extra content at the end of the document
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                  ^
22:05:11 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="dotdot_v6"]' test-report.xml
22:05:11 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:11 
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                 ^
22:05:11 test-report.xml:1005454.32: Extra content at the end of the document
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                  ^
22:05:11 + echo 'Testcase libexec.tftpd.functional:dotdot_v6 vanished'
22:05:11 Testcase libexec.tftpd.functional:dotdot_v6 vanished
22:05:11 + IFS=: read classname name
22:05:11 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_dropped_ack_v4"]'
22:05:11 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_dropped_ack_v4"]/*[self::error or self::failure]' test-report.xml
22:05:11 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:11 
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                 ^
22:05:11 test-report.xml:1005454.32: Extra content at the end of the document
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                  ^
22:05:11 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_dropped_ack_v4"]' test-report.xml
22:05:11 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:11 
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                 ^
22:05:11 test-report.xml:1005454.32: Extra content at the end of the document
22:05:11 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:11                                                  ^
22:05:11 + echo 'Testcase libexec.tftpd.functional:rrq_dropped_ack_v4 vanished'
22:05:11 Testcase libexec.tftpd.functional:rrq_dropped_ack_v4 vanished
22:05:11 + IFS=: read classname name
22:05:11 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_dropped_ack_v6"]'
22:05:11 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_dropped_ack_v6"]/*[self::error or self::failure]' test-report.xml
22:05:12 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:12 
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                 ^
22:05:12 test-report.xml:1005454.32: Extra content at the end of the document
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                  ^
22:05:12 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_dropped_ack_v6"]' test-report.xml
22:05:12 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:12 
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                 ^
22:05:12 test-report.xml:1005454.32: Extra content at the end of the document
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                  ^
22:05:12 + echo 'Testcase libexec.tftpd.functional:rrq_dropped_ack_v6 vanished'
22:05:12 Testcase libexec.tftpd.functional:rrq_dropped_ack_v6 vanished
22:05:12 + IFS=: read classname name
22:05:12 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_duped_ack_v4"]'
22:05:12 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_duped_ack_v4"]/*[self::error or self::failure]' test-report.xml
22:05:12 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:12 
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                 ^
22:05:12 test-report.xml:1005454.32: Extra content at the end of the document
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                  ^
22:05:12 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_duped_ack_v4"]' test-report.xml
22:05:12 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:12 
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                 ^
22:05:12 test-report.xml:1005454.32: Extra content at the end of the document
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                  ^
22:05:12 + echo 'Testcase libexec.tftpd.functional:rrq_duped_ack_v4 vanished'
22:05:12 Testcase libexec.tftpd.functional:rrq_duped_ack_v4 vanished
22:05:12 + IFS=: read classname name
22:05:12 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_duped_ack_v6"]'
22:05:12 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_duped_ack_v6"]/*[self::error or self::failure]' test-report.xml
22:05:12 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:12 
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                 ^
22:05:12 test-report.xml:1005454.32: Extra content at the end of the document
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                  ^
22:05:12 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_duped_ack_v6"]' test-report.xml
22:05:12 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:12 
22:05:12 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:12                                                 ^
22:05:13 test-report.xml:1005454.32: Extra content at the end of the document
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                  ^
22:05:13 + echo 'Testcase libexec.tftpd.functional:rrq_duped_ack_v6 vanished'
22:05:13 Testcase libexec.tftpd.functional:rrq_duped_ack_v6 vanished
22:05:13 + IFS=: read classname name
22:05:13 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_eaccess_v6"]'
22:05:13 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_eaccess_v6"]/*[self::error or self::failure]' test-report.xml
22:05:13 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:13 
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                 ^
22:05:13 test-report.xml:1005454.32: Extra content at the end of the document
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                  ^
22:05:13 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_eaccess_v6"]' test-report.xml
22:05:13 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:13 
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                 ^
22:05:13 test-report.xml:1005454.32: Extra content at the end of the document
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                  ^
22:05:13 + echo 'Testcase libexec.tftpd.functional:rrq_eaccess_v6 vanished'
22:05:13 Testcase libexec.tftpd.functional:rrq_eaccess_v6 vanished
22:05:13 + IFS=: read classname name
22:05:13 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_empty_v6"]'
22:05:13 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_empty_v6"]/*[self::error or self::failure]' test-report.xml
22:05:13 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:13 
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                 ^
22:05:13 test-report.xml:1005454.32: Extra content at the end of the document
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                  ^
22:05:13 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_empty_v6"]' test-report.xml
22:05:13 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:13 
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                 ^
22:05:13 test-report.xml:1005454.32: Extra content at the end of the document
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                  ^
22:05:13 + echo 'Testcase libexec.tftpd.functional:rrq_empty_v6 vanished'
22:05:13 Testcase libexec.tftpd.functional:rrq_empty_v6 vanished
22:05:13 + IFS=: read classname name
22:05:13 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_medium_v4"]'
22:05:13 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_medium_v4"]/*[self::error or self::failure]' test-report.xml
22:05:13 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:13 
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                 ^
22:05:13 test-report.xml:1005454.32: Extra content at the end of the document
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                  ^
22:05:13 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_medium_v4"]' test-report.xml
22:05:13 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:13 
22:05:13 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:13                                                 ^
22:05:14 test-report.xml:1005454.32: Extra content at the end of the document
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                  ^
22:05:14 + echo 'Testcase libexec.tftpd.functional:rrq_medium_v4 vanished'
22:05:14 Testcase libexec.tftpd.functional:rrq_medium_v4 vanished
22:05:14 + IFS=: read classname name
22:05:14 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_medium_v6"]'
22:05:14 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_medium_v6"]/*[self::error or self::failure]' test-report.xml
22:05:14 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:14 
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                 ^
22:05:14 test-report.xml:1005454.32: Extra content at the end of the document
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                  ^
22:05:14 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_medium_v6"]' test-report.xml
22:05:14 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:14 
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                 ^
22:05:14 test-report.xml:1005454.32: Extra content at the end of the document
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                  ^
22:05:14 + echo 'Testcase libexec.tftpd.functional:rrq_medium_v6 vanished'
22:05:14 Testcase libexec.tftpd.functional:rrq_medium_v6 vanished
22:05:14 + IFS=: read classname name
22:05:14 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_medium_window_v6"]'
22:05:14 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_medium_window_v6"]/*[self::error or self::failure]' test-report.xml
22:05:14 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:14 
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                 ^
22:05:14 test-report.xml:1005454.32: Extra content at the end of the document
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                  ^
22:05:14 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_medium_window_v6"]' test-report.xml
22:05:14 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:14 
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                 ^
22:05:14 test-report.xml:1005454.32: Extra content at the end of the document
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                  ^
22:05:14 + echo 'Testcase libexec.tftpd.functional:rrq_medium_window_v6 vanished'
22:05:14 Testcase libexec.tftpd.functional:rrq_medium_window_v6 vanished
22:05:14 + IFS=: read classname name
22:05:14 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_netascii_v6"]'
22:05:14 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_netascii_v6"]/*[self::error or self::failure]' test-report.xml
22:05:14 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:14 
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                 ^
22:05:14 test-report.xml:1005454.32: Extra content at the end of the document
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                  ^
22:05:14 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_netascii_v6"]' test-report.xml
22:05:14 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:14 
22:05:14 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:14                                                 ^
22:05:15 test-report.xml:1005454.32: Extra content at the end of the document
22:05:15 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:15                                                  ^
22:05:15 + echo 'Testcase libexec.tftpd.functional:rrq_netascii_v6 vanished'
22:05:15 Testcase libexec.tftpd.functional:rrq_netascii_v6 vanished
22:05:15 + IFS=: read classname name
22:05:15 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_small_v4"]'
22:05:15 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_small_v4"]/*[self::error or self::failure]' test-report.xml
22:05:15 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:15 
22:05:15 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:15                                                 ^
22:05:15 test-report.xml:1005454.32: Extra content at the end of the document
22:05:15 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:15                                                  ^
22:05:15 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_small_v4"]' test-report.xml
22:05:15 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:15 
22:05:15 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:15                                                 ^
22:05:15 test-report.xml:1005454.32: Extra content at the end of the document
22:05:15 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:15                                                  ^
22:05:15 + echo 'Testcase libexec.tftpd.functional:rrq_small_v4 vanished'
22:05:15 Testcase libexec.tftpd.functional:rrq_small_v4 vanished
22:05:15 + IFS=: read classname name
22:05:15 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_window_rfc7440_v4"]'
22:05:15 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_window_rfc7440_v4"]/*[self::error or self::failure]' test-report.xml
22:05:15 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:15 
22:05:15 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:15                                                 ^
22:05:15 test-report.xml:1005454.32: Extra content at the end of the document
22:05:15 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:15                                                  ^
22:05:15 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="rrq_window_rfc7440_v4"]' test-report.xml
22:05:15 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:15 
22:05:15 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:15                                                 ^
22:05:15 test-report.xml:1005454.32: Extra content at the end of the document
22:05:15 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:15                                                  ^
22:05:15 + echo 'Testcase libexec.tftpd.functional:rrq_window_rfc7440_v4 vanished'
22:05:15 Testcase libexec.tftpd.functional:rrq_window_rfc7440_v4 vanished
22:05:15 + IFS=: read classname name
22:05:15 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="s_flag_v6"]'
22:05:15 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="s_flag_v6"]/*[self::error or self::failure]' test-report.xml
22:05:16 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:16 
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                 ^
22:05:16 test-report.xml:1005454.32: Extra content at the end of the document
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                  ^
22:05:16 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="s_flag_v6"]' test-report.xml
22:05:16 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:16 
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                 ^
22:05:16 test-report.xml:1005454.32: Extra content at the end of the document
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                  ^
22:05:16 + echo 'Testcase libexec.tftpd.functional:s_flag_v6 vanished'
22:05:16 Testcase libexec.tftpd.functional:s_flag_v6 vanished
22:05:16 + IFS=: read classname name
22:05:16 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_dropped_ack_v4"]'
22:05:16 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_dropped_ack_v4"]/*[self::error or self::failure]' test-report.xml
22:05:16 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:16 
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                 ^
22:05:16 test-report.xml:1005454.32: Extra content at the end of the document
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                  ^
22:05:16 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_dropped_ack_v4"]' test-report.xml
22:05:16 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:16 
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                 ^
22:05:16 test-report.xml:1005454.32: Extra content at the end of the document
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                  ^
22:05:16 + echo 'Testcase libexec.tftpd.functional:wrq_dropped_ack_v4 vanished'
22:05:16 Testcase libexec.tftpd.functional:wrq_dropped_ack_v4 vanished
22:05:16 + IFS=: read classname name
22:05:16 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_dropped_data_v4"]'
22:05:16 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_dropped_data_v4"]/*[self::error or self::failure]' test-report.xml
22:05:16 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:16 
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                 ^
22:05:16 test-report.xml:1005454.32: Extra content at the end of the document
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                  ^
22:05:16 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_dropped_data_v4"]' test-report.xml
22:05:16 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:16 
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                 ^
22:05:16 test-report.xml:1005454.32: Extra content at the end of the document
22:05:16 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:16                                                  ^
22:05:16 + echo 'Testcase libexec.tftpd.functional:wrq_dropped_data_v4 vanished'
22:05:16 Testcase libexec.tftpd.functional:wrq_dropped_data_v4 vanished
22:05:16 + IFS=: read classname name
22:05:16 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_dropped_data_v6"]'
22:05:16 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_dropped_data_v6"]/*[self::error or self::failure]' test-report.xml
22:05:17 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:17 
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                 ^
22:05:17 test-report.xml:1005454.32: Extra content at the end of the document
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                  ^
22:05:17 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_dropped_data_v6"]' test-report.xml
22:05:17 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:17 
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                 ^
22:05:17 test-report.xml:1005454.32: Extra content at the end of the document
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                  ^
22:05:17 + echo 'Testcase libexec.tftpd.functional:wrq_dropped_data_v6 vanished'
22:05:17 Testcase libexec.tftpd.functional:wrq_dropped_data_v6 vanished
22:05:17 + IFS=: read classname name
22:05:17 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_duped_data_v4"]'
22:05:17 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_duped_data_v4"]/*[self::error or self::failure]' test-report.xml
22:05:17 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:17 
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                 ^
22:05:17 test-report.xml:1005454.32: Extra content at the end of the document
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                  ^
22:05:17 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_duped_data_v4"]' test-report.xml
22:05:17 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:17 
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                 ^
22:05:17 test-report.xml:1005454.32: Extra content at the end of the document
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                  ^
22:05:17 + echo 'Testcase libexec.tftpd.functional:wrq_duped_data_v4 vanished'
22:05:17 Testcase libexec.tftpd.functional:wrq_duped_data_v4 vanished
22:05:17 + IFS=: read classname name
22:05:17 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_eaccess_v4"]'
22:05:17 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_eaccess_v4"]/*[self::error or self::failure]' test-report.xml
22:05:17 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:17 
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                 ^
22:05:17 test-report.xml:1005454.32: Extra content at the end of the document
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                  ^
22:05:17 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_eaccess_v4"]' test-report.xml
22:05:17 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:17 
22:05:17 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:17                                                 ^
22:05:18 test-report.xml:1005454.32: Extra content at the end of the document
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                  ^
22:05:18 + echo 'Testcase libexec.tftpd.functional:wrq_eaccess_v4 vanished'
22:05:18 Testcase libexec.tftpd.functional:wrq_eaccess_v4 vanished
22:05:18 + IFS=: read classname name
22:05:18 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_v4"]'
22:05:18 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_v4"]/*[self::error or self::failure]' test-report.xml
22:05:18 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:18 
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                 ^
22:05:18 test-report.xml:1005454.32: Extra content at the end of the document
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                  ^
22:05:18 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_v4"]' test-report.xml
22:05:18 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:18 
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                 ^
22:05:18 test-report.xml:1005454.32: Extra content at the end of the document
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                  ^
22:05:18 + echo 'Testcase libexec.tftpd.functional:wrq_medium_v4 vanished'
22:05:18 Testcase libexec.tftpd.functional:wrq_medium_v4 vanished
22:05:18 + IFS=: read classname name
22:05:18 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_v6"]'
22:05:18 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_v6"]/*[self::error or self::failure]' test-report.xml
22:05:18 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:18 
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                 ^
22:05:18 test-report.xml:1005454.32: Extra content at the end of the document
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                  ^
22:05:18 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_v6"]' test-report.xml
22:05:18 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:18 
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                 ^
22:05:18 test-report.xml:1005454.32: Extra content at the end of the document
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                  ^
22:05:18 + echo 'Testcase libexec.tftpd.functional:wrq_medium_v6 vanished'
22:05:18 Testcase libexec.tftpd.functional:wrq_medium_v6 vanished
22:05:18 + IFS=: read classname name
22:05:18 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_window_v4"]'
22:05:18 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_window_v4"]/*[self::error or self::failure]' test-report.xml
22:05:18 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:18 
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                 ^
22:05:18 test-report.xml:1005454.32: Extra content at the end of the document
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                  ^
22:05:18 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_window_v4"]' test-report.xml
22:05:18 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:18 
22:05:18 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:18                                                 ^
22:05:19 test-report.xml:1005454.32: Extra content at the end of the document
22:05:19 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:19                                                  ^
22:05:19 + echo 'Testcase libexec.tftpd.functional:wrq_medium_window_v4 vanished'
22:05:19 Testcase libexec.tftpd.functional:wrq_medium_window_v4 vanished
22:05:19 + IFS=: read classname name
22:05:19 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_window_v6"]'
22:05:19 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_window_v6"]/*[self::error or self::failure]' test-report.xml
22:05:19 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:19 
22:05:19 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:19                                                 ^
22:05:19 test-report.xml:1005454.32: Extra content at the end of the document
22:05:19 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:19                                                  ^
22:05:19 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_medium_window_v6"]' test-report.xml
22:05:19 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:19 
22:05:19 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:19                                                 ^
22:05:19 test-report.xml:1005454.32: Extra content at the end of the document
22:05:19 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:19                                                  ^
22:05:19 + echo 'Testcase libexec.tftpd.functional:wrq_medium_window_v6 vanished'
22:05:19 Testcase libexec.tftpd.functional:wrq_medium_window_v6 vanished
22:05:19 + IFS=: read classname name
22:05:19 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_netascii_v4"]'
22:05:19 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_netascii_v4"]/*[self::error or self::failure]' test-report.xml
22:05:19 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:19 
22:05:19 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:19                                                 ^
22:05:19 test-report.xml:1005454.32: Extra content at the end of the document
22:05:19 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:19                                                  ^
22:05:19 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_netascii_v4"]' test-report.xml
22:05:19 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:19 
22:05:19 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:19                                                 ^
22:05:19 test-report.xml:1005454.32: Extra content at the end of the document
22:05:19 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:19                                                  ^
22:05:19 + echo 'Testcase libexec.tftpd.functional:wrq_netascii_v4 vanished'
22:05:19 Testcase libexec.tftpd.functional:wrq_netascii_v4 vanished
22:05:19 + IFS=: read classname name
22:05:19 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_small_v4"]'
22:05:19 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_small_v4"]/*[self::error or self::failure]' test-report.xml
22:05:20 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:20 
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                 ^
22:05:20 test-report.xml:1005454.32: Extra content at the end of the document
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                  ^
22:05:20 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_small_v4"]' test-report.xml
22:05:20 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:20 
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                 ^
22:05:20 test-report.xml:1005454.32: Extra content at the end of the document
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                  ^
22:05:20 + echo 'Testcase libexec.tftpd.functional:wrq_small_v4 vanished'
22:05:20 Testcase libexec.tftpd.functional:wrq_small_v4 vanished
22:05:20 + IFS=: read classname name
22:05:20 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_truncate_v6"]'
22:05:20 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_truncate_v6"]/*[self::error or self::failure]' test-report.xml
22:05:20 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:20 
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                 ^
22:05:20 test-report.xml:1005454.32: Extra content at the end of the document
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                  ^
22:05:20 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_truncate_v6"]' test-report.xml
22:05:20 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:20 
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                 ^
22:05:20 test-report.xml:1005454.32: Extra content at the end of the document
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                  ^
22:05:20 + echo 'Testcase libexec.tftpd.functional:wrq_truncate_v6 vanished'
22:05:20 Testcase libexec.tftpd.functional:wrq_truncate_v6 vanished
22:05:20 + IFS=: read classname name
22:05:20 + xpath='/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_window_rfc7440_v6"]'
22:05:20 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_window_rfc7440_v6"]/*[self::error or self::failure]' test-report.xml
22:05:20 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:20 
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                 ^
22:05:20 test-report.xml:1005454.32: Extra content at the end of the document
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                  ^
22:05:20 + xml sel -Q -t -c '/testsuite/testcase[@classname="libexec.tftpd.functional"][@name="wrq_window_rfc7440_v6"]' test-report.xml
22:05:20 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:20 
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                 ^
22:05:20 test-report.xml:1005454.32: Extra content at the end of the document
22:05:20 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:20                                                  ^
22:05:20 + echo 'Testcase libexec.tftpd.functional:wrq_window_rfc7440_v6 vanished'
22:05:20 Testcase libexec.tftpd.functional:wrq_window_rfc7440_v6 vanished
22:05:20 + IFS=: read classname name
22:05:20 + xpath='/testsuite/testcase[@classname="sys.capsicum.capsicum-test"][@name="main"]'
22:05:20 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.capsicum.capsicum-test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:21 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:21 
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                 ^
22:05:21 test-report.xml:1005454.32: Extra content at the end of the document
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                  ^
22:05:21 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.capsicum.capsicum-test"][@name="main"]' test-report.xml
22:05:21 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:21 
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                 ^
22:05:21 test-report.xml:1005454.32: Extra content at the end of the document
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                  ^
22:05:21 + echo 'Testcase sys.capsicum.capsicum-test:main vanished'
22:05:21 Testcase sys.capsicum.capsicum-test:main vanished
22:05:21 + IFS=: read classname name
22:05:21 + xpath='/testsuite/testcase[@classname="sys.fs.fusefs.io"][@name="main"]'
22:05:21 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.fs.fusefs.io"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:21 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:21 
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                 ^
22:05:21 test-report.xml:1005454.32: Extra content at the end of the document
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                  ^
22:05:21 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.fs.fusefs.io"][@name="main"]' test-report.xml
22:05:21 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:21 
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                 ^
22:05:21 test-report.xml:1005454.32: Extra content at the end of the document
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                  ^
22:05:21 + echo 'Testcase sys.fs.fusefs.io:main vanished'
22:05:21 Testcase sys.fs.fusefs.io:main vanished
22:05:21 + IFS=: read classname name
22:05:21 + xpath='/testsuite/testcase[@classname="sys.geom.class.eli.online_resize_test"][@name="online_resize"]'
22:05:21 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.geom.class.eli.online_resize_test"][@name="online_resize"]/*[self::error or self::failure]' test-report.xml
22:05:21 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:21 
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                 ^
22:05:21 test-report.xml:1005454.32: Extra content at the end of the document
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                  ^
22:05:21 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.geom.class.eli.online_resize_test"][@name="online_resize"]' test-report.xml
22:05:21 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:21 
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                 ^
22:05:21 test-report.xml:1005454.32: Extra content at the end of the document
22:05:21 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:21                                                  ^
22:05:21 + echo 'Testcase sys.geom.class.eli.online_resize_test:online_resize vanished'
22:05:21 Testcase sys.geom.class.eli.online_resize_test:online_resize vanished
22:05:21 + IFS=: read classname name
22:05:21 + xpath='/testsuite/testcase[@classname="sys.geom.class.eli.reentrancy_test"][@name="init"]'
22:05:21 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.geom.class.eli.reentrancy_test"][@name="init"]/*[self::error or self::failure]' test-report.xml
22:05:22 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:22 
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                 ^
22:05:22 test-report.xml:1005454.32: Extra content at the end of the document
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                  ^
22:05:22 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.geom.class.eli.reentrancy_test"][@name="init"]' test-report.xml
22:05:22 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:22 
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                 ^
22:05:22 test-report.xml:1005454.32: Extra content at the end of the document
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                  ^
22:05:22 + echo 'Testcase sys.geom.class.eli.reentrancy_test:init vanished'
22:05:22 Testcase sys.geom.class.eli.reentrancy_test:init vanished
22:05:22 + IFS=: read classname name
22:05:22 + xpath='/testsuite/testcase[@classname="sys.kern.coredump_phnum_test"][@name="coredump_phnum"]'
22:05:22 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.kern.coredump_phnum_test"][@name="coredump_phnum"]/*[self::error or self::failure]' test-report.xml
22:05:22 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:22 
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                 ^
22:05:22 test-report.xml:1005454.32: Extra content at the end of the document
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                  ^
22:05:22 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.kern.coredump_phnum_test"][@name="coredump_phnum"]' test-report.xml
22:05:22 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:22 
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                 ^
22:05:22 test-report.xml:1005454.32: Extra content at the end of the document
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                  ^
22:05:22 + echo 'Testcase sys.kern.coredump_phnum_test:coredump_phnum vanished'
22:05:22 Testcase sys.kern.coredump_phnum_test:coredump_phnum vanished
22:05:22 + IFS=: read classname name
22:05:22 + xpath='/testsuite/testcase[@classname="sys.kern.ptrace_test"][@name="ptrace__PT_STEP_with_signal"]'
22:05:22 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.kern.ptrace_test"][@name="ptrace__PT_STEP_with_signal"]/*[self::error or self::failure]' test-report.xml
22:05:22 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:22 
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                 ^
22:05:22 test-report.xml:1005454.32: Extra content at the end of the document
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                  ^
22:05:22 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.kern.ptrace_test"][@name="ptrace__PT_STEP_with_signal"]' test-report.xml
22:05:22 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:22 
22:05:22 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:22                                                 ^
22:05:23 test-report.xml:1005454.32: Extra content at the end of the document
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                  ^
22:05:23 + echo 'Testcase sys.kern.ptrace_test:ptrace__PT_STEP_with_signal vanished'
22:05:23 Testcase sys.kern.ptrace_test:ptrace__PT_STEP_with_signal vanished
22:05:23 + IFS=: read classname name
22:05:23 + xpath='/testsuite/testcase[@classname="sys.mac.portacl.nobody_test"][@name="main"]'
22:05:23 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.mac.portacl.nobody_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:23 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:23 
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                 ^
22:05:23 test-report.xml:1005454.32: Extra content at the end of the document
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                  ^
22:05:23 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.mac.portacl.nobody_test"][@name="main"]' test-report.xml
22:05:23 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:23 
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                 ^
22:05:23 test-report.xml:1005454.32: Extra content at the end of the document
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                  ^
22:05:23 + echo 'Testcase sys.mac.portacl.nobody_test:main vanished'
22:05:23 Testcase sys.mac.portacl.nobody_test:main vanished
22:05:23 + IFS=: read classname name
22:05:23 + xpath='/testsuite/testcase[@classname="sys.mac.portacl.root_test"][@name="main"]'
22:05:23 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.mac.portacl.root_test"][@name="main"]/*[self::error or self::failure]' test-report.xml
22:05:23 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:23 
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                 ^
22:05:23 test-report.xml:1005454.32: Extra content at the end of the document
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                  ^
22:05:23 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.mac.portacl.root_test"][@name="main"]' test-report.xml
22:05:23 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:23 
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                 ^
22:05:23 test-report.xml:1005454.32: Extra content at the end of the document
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                  ^
22:05:23 + echo 'Testcase sys.mac.portacl.root_test:main vanished'
22:05:23 Testcase sys.mac.portacl.root_test:main vanished
22:05:23 + IFS=: read classname name
22:05:23 + xpath='/testsuite/testcase[@classname="sys.netpfil.common.pass_block"][@name="ipf_v6"]'
22:05:23 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.netpfil.common.pass_block"][@name="ipf_v6"]/*[self::error or self::failure]' test-report.xml
22:05:23 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:23 
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                 ^
22:05:23 test-report.xml:1005454.32: Extra content at the end of the document
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                  ^
22:05:23 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.netpfil.common.pass_block"][@name="ipf_v6"]' test-report.xml
22:05:23 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:23 
22:05:23 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:23                                                 ^
22:05:24 test-report.xml:1005454.32: Extra content at the end of the document
22:05:24 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:24                                                  ^
22:05:24 + echo 'Testcase sys.netpfil.common.pass_block:ipf_v6 vanished'
22:05:24 Testcase sys.netpfil.common.pass_block:ipf_v6 vanished
22:05:24 + IFS=: read classname name
22:05:24 + xpath='/testsuite/testcase[@classname="sys.netpfil.pf.pfsync"][@name="basic"]'
22:05:24 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.netpfil.pf.pfsync"][@name="basic"]/*[self::error or self::failure]' test-report.xml
22:05:24 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:24 
22:05:24 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:24                                                 ^
22:05:24 test-report.xml:1005454.32: Extra content at the end of the document
22:05:24 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:24                                                  ^
22:05:24 + xml sel -Q -t -c '/testsuite/testcase[@classname="sys.netpfil.pf.pfsync"][@name="basic"]' test-report.xml
22:05:24 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:24 
22:05:24 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:24                                                 ^
22:05:24 test-report.xml:1005454.32: Extra content at the end of the document
22:05:24 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:24                                                  ^
22:05:24 + echo 'Testcase sys.netpfil.pf.pfsync:basic vanished'
22:05:24 Testcase sys.netpfil.pf.pfsync:basic vanished
22:05:24 + IFS=: read classname name
22:05:24 + xpath='/testsuite/testcase[@classname="usr.sbin.mixer.mixer_test"][@name="set_empty_value"]'
22:05:24 + xml sel -Q -t -c '/testsuite/testcase[@classname="usr.sbin.mixer.mixer_test"][@name="set_empty_value"]/*[self::error or self::failure]' test-report.xml
22:05:24 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:24 
22:05:24 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:24                                                 ^
22:05:24 test-report.xml:1005454.32: Extra content at the end of the document
22:05:24 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:24                                                  ^
22:05:24 + xml sel -Q -t -c '/testsuite/testcase[@classname="usr.sbin.mixer.mixer_test"][@name="set_empty_value"]' test-report.xml
22:05:24 test-report.xml:1005454.31: xmlSAX2Characters: huge text node: out of memory
22:05:24 
22:05:24 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:24                                                 ^
22:05:24 test-report.xml:1005454.32: Extra content at the end of the document
22:05:24 bridge: READ PACKET from hook "link78" (98 bytes)
22:05:24                                                  ^
22:05:24 + echo 'Testcase usr.sbin.mixer.mixer_test:set_empty_value vanished'
22:05:24 Testcase usr.sbin.mixer.mixer_test:set_empty_value vanished
22:05:24 + IFS=: read classname name
22:05:24 + rm -f disk-cam
22:05:24 + jot 5
22:05:24 + rm -f disk1
22:05:24 + rm -f disk2
22:05:28 + rm -f disk3
22:05:29 + rm -f disk4
22:05:29 + rm -f disk5
22:05:29 + rm -f disk-test-GENERIC-KASAN.img
[PostBuildScript] - [INFO] Executing post build scripts.
[FreeBSD-stable-14-aarch64-KASAN_test] $ /bin/sh -xe /tmp/jenkins17471396161941187491.sh
+ sh freebsd-ci/scripts/jail/clean.sh
clean jail FreeBSD-stable-14-aarch64-KASAN_test
Recording test results
[Checks API] No suitable checks publisher found.
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Finished: UNSTABLE