these 74 derivations will be built: /nix/store/0487z5pxn7icqd7jbrqgafbzam8bcjjc-unit-dm-wg-star-wg-star-reconfig.path.drv /nix/store/g9xlixr4kswb2x64vla06mnck8dycj3a-unit-script-dm-wg-star-wg-star-publish-start.drv /nix/store/5i6kh41z2jn5y5rf81b581gr8acxgws1-unit-dm-wg-star-wg-star-publish.service.drv /nix/store/iq863pxb63ajrp4fl2lad8v17jmc7dp5-unit-40-wg-star.netdev.drv /nix/store/2mzkyn4dg2mabbr8ahi5wd6v6i3b63wa-X-Restart-Triggers-systemd-networkd.drv /nix/store/s364hri6zarqrspakhgiqn3a896ggpji-unit-40-wg-star.network.drv /nix/store/k76s3m6r5hkhll0vhq6vnzz16xlrm6i6-X-Reload-Triggers-systemd-networkd.drv /nix/store/6bd126dm85s90kcbsll46iz48bspmmdf-unit-systemd-networkd.service.drv /nix/store/cy1x41jca6ncxv4q7hwdk86gsq8cgy5j-unit-dm-wg-star-wg-star-publish.timer.drv /nix/store/h1br65x3jj0acbv6i9sbxgcx2kp8yrdr-system-path.drv /nix/store/587w7cmda818b71k3baf1kpxw1ds9ka7-dbus-1.drv /nix/store/v7vsbzs78y72kv412hmngyzvw68skmzi-X-Restart-Triggers-dbus-broker.drv /nix/store/fxh2imn2wzzd1y2ia3mhcvx8fzsjkzdy-unit-dbus-broker.service.drv /nix/store/rq85ya5lnizk7ilrfzafrbmj53m95lbf-unit-script-dm-wg-star-wg-star-reconfig-start.drv /nix/store/p9d2p0r722gy62y3vbwiai7dngxv9ck2-unit-dm-wg-star-wg-star-reconfig.service.drv /nix/store/lgbblha0ibwpfdh2847xv8jvl0krnx8n-dm.toml.drv /nix/store/9vxkyadq72k60lqcr1zzipq9khp4x62d-X-Restart-Triggers-data-mesher.drv /nix/store/wkd8yf27nwcnmas4ncx64dlzjm04v2x9-unit-data-mesher.service.drv /nix/store/0v8p3vywadwgzi07bhdyqij200nifgxk-system-units.drv /nix/store/1b3mwjqd4729xifhzinkv5fm25gs59rd-decrypt-age-secrets.drv /nix/store/60hag4icm2j76l743j0aqshh6mpvwwkg-unit-40-wg-star.network.drv /nix/store/2fb14xw4p67hfpx8dqnwzavmws2i87wh-X-Reload-Triggers-systemd-networkd.drv /nix/store/3lmqqqmczczqqidxcrpyk0vwib2syrjx-decrypt-age-secrets.drv /nix/store/7ql3ysvmrfiscl1wl5l00g2l9z1mv282-extra-hosts.drv /nix/store/3n1yrcycy0y1z574nqcpzvz8y4vsyrpm-hosts.drv /nix/store/506fhyq30zd1y3fnl5s5z2a8fa6ia64k-decrypt-age-secrets.drv /nix/store/56b9aygi5csx942n99yn2dz5h6a4w6zq-dry-activate.drv /nix/store/5hn2afpjlxinzmzzcxsgr4ar3f4jf8f8-unit-script-dm-wg-star-wg-star-publish-start.drv /nix/store/wqpm01cq336h7dh4ci37sr0lbi2rw42a-dm.toml.drv /nix/store/fr9m87sa59hqzkgkwpxkshzfw8m8gdpz-X-Restart-Triggers-data-mesher.drv /nix/store/5pr7j1n4x99ls9bnbagl6kznb9y8l9jc-unit-data-mesher.service.drv /nix/store/689cjnzbdqsw4skjkmp6yg4q826gafap-hosts.drv /nix/store/68sckc56699vp51hclh5k85dcjrxdli6-dry-activate.drv /nix/store/dy6m9bhbwvvgmndy9sibjcghr3y53c9r-vars-check-dm-wireguard-star.drv /nix/store/ggx9cslna6hin609m29rz6bjcbha21ja-unit-40-wg-star.netdev.drv /nix/store/r0haxbfpnyjp78j1p0m0i63a689q1y5s-unit-dbus-broker.service.drv /nix/store/hvi4mi6m1jxi8264vcmjjlj208qx5ygw-user-units.drv /nix/store/in0v7c18arzccjsjs0q6n32hv0llxih0-hosts.drv /nix/store/ds7hql6a38vlbsapi7z6cw1pzzk4dmmy-firewall-start.drv /nix/store/vlqlisgchlwa93lqq1z3vz6v9vpixjj2-firewall-reload.drv /nix/store/9rw8zrrnjfha7qcmsn0v97sb8rwl25w2-unit-firewall.service.drv /nix/store/yd80fwcarlkv2mlniw3sybwfx5ydylhv-unit-script-dm-wg-star-wg-star-reconfig-start.drv /nix/store/ai2flxxb08c92p72gc4hjwj80rig0b85-unit-dm-wg-star-wg-star-reconfig.service.drv /nix/store/pipm2p37k3x8h4ag7849z3s44dj4g9mc-X-Restart-Triggers-systemd-networkd.drv /nix/store/liya8v02nai8qda3sra6bglzpd1xpacx-unit-systemd-networkd.service.drv /nix/store/n5wyrdw4cdg3xdjdc76d0a2z664qa83n-unit-dm-wg-star-wg-star-reconfig.path.drv /nix/store/sfqca5cmg20z9pgb4zm7cksfn77z0ybn-unit-dm-wg-star-wg-star-publish.service.drv /nix/store/lwfmcxwggl0b3f5syvrv9f4c1apwr63c-system-units.drv /nix/store/ckvfia2cp3qms5kw3568khz726aqj3v6-etc.drv /nix/store/bqi0cf07hyinwgjh3lni8x0wprpf0bcy-activate.drv /nix/store/8a83nlqjrqp01da8xmzw4zfcsk1kfcdn-nixos-system-controller-test.drv /nix/store/dhrch9h4ylx82zb0y7rbwljjq46ymr7s-dm.toml.drv /nix/store/d7q58lng3ny9gyqv11idhjpzbkagy4qp-X-Restart-Triggers-data-mesher.drv /nix/store/953rdh8bslhy7m8v7w3spnjrzbr0q5vg-unit-data-mesher.service.drv /nix/store/zpysfbyv6kf2v2hgkj07a6zmjppr9bzy-unit-40-wg-star.network.drv /nix/store/a6r2w4qrpiwk0s860rliwccjcdqg4zxc-X-Reload-Triggers-systemd-networkd.drv /nix/store/amwhjv1b6w2b9m7bipv81ggx66h9lym7-etc.drv /nix/store/x6alm11a7lmd8g1ky0v0vkd3b8phrigi-unit-script-dm-wg-star-wg-star-publish-start.drv /nix/store/gb7q7lcaawmyw7q7yqzcybmjxywvmcv9-unit-dm-wg-star-wg-star-publish.service.drv /nix/store/lwm9v7nygmrdkm35sp95ix4lla3p1mrl-unit-systemd-networkd.service.drv /nix/store/dlss2dhcjqizq2kijdzjxy3avwn79r53-system-units.drv /nix/store/rgj99nzzl2a5pk5fpdc2rqbqy5ghg3fn-etc.drv /nix/store/c41w13ps8srgf48x6pw70m4zpq09bbxh-activate.drv /nix/store/dbs3v8py25akr6mwnqir7chn0rxdrj8l-activate.drv /nix/store/f8l8s1raccf274z6vmcf8n9mqhrni6q2-test-script.drv /nix/store/q7k0cxjygdk3lqawizik4i0j2an0x1h6-nixos-system-peer2-test.drv /nix/store/jrijvnjnslyfqahrjxmnk3z4dqf1jdjx-run-peer2-nspawn.drv /nix/store/vz9ph85isr3idmj8y6cpnhy1r7h3pmrc-dry-activate.drv /nix/store/vr6167gw4npfl4wkhv2jdvrzw6byxwzz-nixos-system-peer1-test.drv /nix/store/p8cgxbri526j5kmbg6z7bp173lyn8iaj-run-peer1-nspawn.drv /nix/store/xld5818351s9sjmbsfynrbla7xk3a83n-run-controller-nspawn.drv /nix/store/n0m6lvix3k2cl2rmkccvkqn4ldxlbn6z-driverConfiguration.json.drv /nix/store/fkhwgch7nd2nvhvfn5p65s4kv288j9bv-nixos-test-driver-dm-wireguard-star.drv /nix/store/rrdkzky6jzdiq3lfmsgfzfdn8716j7dm-container-test-run-dm-wireguard-star.drv building '/nix/store/f8l8s1raccf274z6vmcf8n9mqhrni6q2-test-script.drv' building '/nix/store/h1br65x3jj0acbv6i9sbxgcx2kp8yrdr-system-path.drv' building '/nix/store/ggx9cslna6hin609m29rz6bjcbha21ja-unit-40-wg-star.netdev.drv' building '/nix/store/iq863pxb63ajrp4fl2lad8v17jmc7dp5-unit-40-wg-star.netdev.drv' building '/nix/store/60hag4icm2j76l743j0aqshh6mpvwwkg-unit-40-wg-star.network.drv' building '/nix/store/s364hri6zarqrspakhgiqn3a896ggpji-unit-40-wg-star.network.drv' building '/nix/store/zpysfbyv6kf2v2hgkj07a6zmjppr9bzy-unit-40-wg-star.network.drv' building '/nix/store/7ql3ysvmrfiscl1wl5l00g2l9z1mv282-extra-hosts.drv' building '/nix/store/cy1x41jca6ncxv4q7hwdk86gsq8cgy5j-unit-dm-wg-star-wg-star-publish.timer.drv' building '/nix/store/0487z5pxn7icqd7jbrqgafbzam8bcjjc-unit-dm-wg-star-wg-star-reconfig.path.drv' extra-hosts> structuredAttrs is enabled system-path> structuredAttrs is enabled system-path> created 1731 symlinks in user environment test-script> structuredAttrs is enabled unit-40-wg-star.netdev> structuredAttrs is enabled unit-40-wg-star.netdev> structuredAttrs is enabled unit-40-wg-star.network> structuredAttrs is enabled unit-40-wg-star.network> structuredAttrs is enabled unit-40-wg-star.network> structuredAttrs is enabled unit-dm-wg-star-wg-star-publish.timer> structuredAttrs is enabled unit-dm-wg-star-wg-star-reconfig.path> structuredAttrs is enabled building '/nix/store/ds7hql6a38vlbsapi7z6cw1pzzk4dmmy-firewall-start.drv' building '/nix/store/n5wyrdw4cdg3xdjdc76d0a2z664qa83n-unit-dm-wg-star-wg-star-reconfig.path.drv' building '/nix/store/5hn2afpjlxinzmzzcxsgr4ar3f4jf8f8-unit-script-dm-wg-star-wg-star-publish-start.drv' building '/nix/store/g9xlixr4kswb2x64vla06mnck8dycj3a-unit-script-dm-wg-star-wg-star-publish-start.drv' building '/nix/store/x6alm11a7lmd8g1ky0v0vkd3b8phrigi-unit-script-dm-wg-star-wg-star-publish-start.drv' building '/nix/store/rq85ya5lnizk7ilrfzafrbmj53m95lbf-unit-script-dm-wg-star-wg-star-reconfig-start.drv' building '/nix/store/yd80fwcarlkv2mlniw3sybwfx5ydylhv-unit-script-dm-wg-star-wg-star-reconfig-start.drv' firewall-start> structuredAttrs is enabled unit-dm-wg-star-wg-star-reconfig.path> structuredAttrs is enabled unit-script-dm-wg-star-wg-star-publish-start> structuredAttrs is enabled unit-script-dm-wg-star-wg-star-publish-start> structuredAttrs is enabled unit-script-dm-wg-star-wg-star-publish-start> structuredAttrs is enabled unit-script-dm-wg-star-wg-star-reconfig-start> structuredAttrs is enabled unit-script-dm-wg-star-wg-star-reconfig-start> structuredAttrs is enabled building '/nix/store/2fb14xw4p67hfpx8dqnwzavmws2i87wh-X-Reload-Triggers-systemd-networkd.drv' building '/nix/store/a6r2w4qrpiwk0s860rliwccjcdqg4zxc-X-Reload-Triggers-systemd-networkd.drv' building '/nix/store/k76s3m6r5hkhll0vhq6vnzz16xlrm6i6-X-Reload-Triggers-systemd-networkd.drv' X-Reload-Triggers-systemd-networkd> structuredAttrs is enabled X-Reload-Triggers-systemd-networkd> structuredAttrs is enabled X-Reload-Triggers-systemd-networkd> structuredAttrs is enabled building '/nix/store/2mzkyn4dg2mabbr8ahi5wd6v6i3b63wa-X-Restart-Triggers-systemd-networkd.drv' building '/nix/store/pipm2p37k3x8h4ag7849z3s44dj4g9mc-X-Restart-Triggers-systemd-networkd.drv' building '/nix/store/587w7cmda818b71k3baf1kpxw1ds9ka7-dbus-1.drv' building '/nix/store/3n1yrcycy0y1z574nqcpzvz8y4vsyrpm-hosts.drv' building '/nix/store/689cjnzbdqsw4skjkmp6yg4q826gafap-hosts.drv' building '/nix/store/in0v7c18arzccjsjs0q6n32hv0llxih0-hosts.drv' building '/nix/store/vlqlisgchlwa93lqq1z3vz6v9vpixjj2-firewall-reload.drv' building '/nix/store/dy6m9bhbwvvgmndy9sibjcghr3y53c9r-vars-check-dm-wireguard-star.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' X-Restart-Triggers-systemd-networkd> structuredAttrs is enabled X-Restart-Triggers-systemd-networkd> structuredAttrs is enabled firewall-reload> structuredAttrs is enabled building '/nix/store/dhrch9h4ylx82zb0y7rbwljjq46ymr7s-dm.toml.drv' building '/nix/store/wqpm01cq336h7dh4ci37sr0lbi2rw42a-dm.toml.drv' building '/nix/store/5i6kh41z2jn5y5rf81b581gr8acxgws1-unit-dm-wg-star-wg-star-publish.service.drv' building '/nix/store/gb7q7lcaawmyw7q7yqzcybmjxywvmcv9-unit-dm-wg-star-wg-star-publish.service.drv' building '/nix/store/sfqca5cmg20z9pgb4zm7cksfn77z0ybn-unit-dm-wg-star-wg-star-publish.service.drv' building '/nix/store/ai2flxxb08c92p72gc4hjwj80rig0b85-unit-dm-wg-star-wg-star-reconfig.service.drv' building '/nix/store/p9d2p0r722gy62y3vbwiai7dngxv9ck2-unit-dm-wg-star-wg-star-reconfig.service.drv' dm.toml> structuredAttrs is enabled dm.toml> structuredAttrs is enabled unit-dm-wg-star-wg-star-publish.service> structuredAttrs is enabled unit-dm-wg-star-wg-star-publish.service> structuredAttrs is enabled unit-dm-wg-star-wg-star-publish.service> structuredAttrs is enabled unit-dm-wg-star-wg-star-reconfig.service> structuredAttrs is enabled unit-dm-wg-star-wg-star-reconfig.service> structuredAttrs is enabled building '/nix/store/v7vsbzs78y72kv412hmngyzvw68skmzi-X-Restart-Triggers-dbus-broker.drv' building '/nix/store/lgbblha0ibwpfdh2847xv8jvl0krnx8n-dm.toml.drv' building '/nix/store/9rw8zrrnjfha7qcmsn0v97sb8rwl25w2-unit-firewall.service.drv' X-Restart-Triggers-dbus-broker> structuredAttrs is enabled dm.toml> structuredAttrs is enabled building '/nix/store/6bd126dm85s90kcbsll46iz48bspmmdf-unit-systemd-networkd.service.drv' building '/nix/store/liya8v02nai8qda3sra6bglzpd1xpacx-unit-systemd-networkd.service.drv' building '/nix/store/lwm9v7nygmrdkm35sp95ix4lla3p1mrl-unit-systemd-networkd.service.drv' building '/nix/store/d7q58lng3ny9gyqv11idhjpzbkagy4qp-X-Restart-Triggers-data-mesher.drv' building '/nix/store/fr9m87sa59hqzkgkwpxkshzfw8m8gdpz-X-Restart-Triggers-data-mesher.drv' X-Restart-Triggers-data-mesher> structuredAttrs is enabled unit-firewall.service> structuredAttrs is enabled unit-systemd-networkd.service> structuredAttrs is enabled unit-systemd-networkd.service> structuredAttrs is enabled unit-systemd-networkd.service> structuredAttrs is enabled building '/nix/store/9vxkyadq72k60lqcr1zzipq9khp4x62d-X-Restart-Triggers-data-mesher.drv' building '/nix/store/fxh2imn2wzzd1y2ia3mhcvx8fzsjkzdy-unit-dbus-broker.service.drv' building '/nix/store/r0haxbfpnyjp78j1p0m0i63a689q1y5s-unit-dbus-broker.service.drv' building '/nix/store/1b3mwjqd4729xifhzinkv5fm25gs59rd-decrypt-age-secrets.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/3lmqqqmczczqqidxcrpyk0vwib2syrjx-decrypt-age-secrets.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/506fhyq30zd1y3fnl5s5z2a8fa6ia64k-decrypt-age-secrets.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' X-Restart-Triggers-data-mesher> structuredAttrs is enabled X-Restart-Triggers-data-mesher> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled unit-dbus-broker.service> structuredAttrs is enabled building '/nix/store/953rdh8bslhy7m8v7w3spnjrzbr0q5vg-unit-data-mesher.service.drv' building '/nix/store/5pr7j1n4x99ls9bnbagl6kznb9y8l9jc-unit-data-mesher.service.drv' building '/nix/store/wkd8yf27nwcnmas4ncx64dlzjm04v2x9-unit-data-mesher.service.drv' building '/nix/store/hvi4mi6m1jxi8264vcmjjlj208qx5ygw-user-units.drv' unit-data-mesher.service> structuredAttrs is enabled unit-data-mesher.service> structuredAttrs is enabled unit-data-mesher.service> structuredAttrs is enabled building '/nix/store/dy6m9bhbwvvgmndy9sibjcghr3y53c9r-vars-check-dm-wireguard-star.drv' vars-check-dm-wireguard-star> Running vars check using Nix-based executor... vars-check-dm-wireguard-star> ✓ All vars checks completed successfully building '/nix/store/dlss2dhcjqizq2kijdzjxy3avwn79r53-system-units.drv' building '/nix/store/lwfmcxwggl0b3f5syvrv9f4c1apwr63c-system-units.drv' building '/nix/store/0v8p3vywadwgzi07bhdyqij200nifgxk-system-units.drv' building '/nix/store/rgj99nzzl2a5pk5fpdc2rqbqy5ghg3fn-etc.drv' building '/nix/store/ckvfia2cp3qms5kw3568khz726aqj3v6-etc.drv' building '/nix/store/amwhjv1b6w2b9m7bipv81ggx66h9lym7-etc.drv' building '/nix/store/3lmqqqmczczqqidxcrpyk0vwib2syrjx-decrypt-age-secrets.drv' decrypt-age-secrets> structuredAttrs is enabled building '/nix/store/vz9ph85isr3idmj8y6cpnhy1r7h3pmrc-dry-activate.drv' building '/nix/store/c41w13ps8srgf48x6pw70m4zpq09bbxh-activate.drv' building '/nix/store/506fhyq30zd1y3fnl5s5z2a8fa6ia64k-decrypt-age-secrets.drv' dry-activate> structuredAttrs is enabled decrypt-age-secrets> structuredAttrs is enabled activate> structuredAttrs is enabled building '/nix/store/vr6167gw4npfl4wkhv2jdvrzw6byxwzz-nixos-system-peer1-test.drv' building '/nix/store/1b3mwjqd4729xifhzinkv5fm25gs59rd-decrypt-age-secrets.drv' nixos-system-peer1-test> structuredAttrs is enabled decrypt-age-secrets> structuredAttrs is enabled building '/nix/store/bqi0cf07hyinwgjh3lni8x0wprpf0bcy-activate.drv' building '/nix/store/68sckc56699vp51hclh5k85dcjrxdli6-dry-activate.drv' activate> structuredAttrs is enabled building '/nix/store/dbs3v8py25akr6mwnqir7chn0rxdrj8l-activate.drv' building '/nix/store/56b9aygi5csx942n99yn2dz5h6a4w6zq-dry-activate.drv' activate> structuredAttrs is enabled dry-activate> structuredAttrs is enabled building '/nix/store/p8cgxbri526j5kmbg6z7bp173lyn8iaj-run-peer1-nspawn.drv' dry-activate> structuredAttrs is enabled building '/nix/store/8a83nlqjrqp01da8xmzw4zfcsk1kfcdn-nixos-system-controller-test.drv' building '/nix/store/q7k0cxjygdk3lqawizik4i0j2an0x1h6-nixos-system-peer2-test.drv' nixos-system-controller-test> structuredAttrs is enabled building '/nix/store/xld5818351s9sjmbsfynrbla7xk3a83n-run-controller-nspawn.drv' nixos-system-peer2-test> structuredAttrs is enabled building '/nix/store/jrijvnjnslyfqahrjxmnk3z4dqf1jdjx-run-peer2-nspawn.drv' building '/nix/store/n0m6lvix3k2cl2rmkccvkqn4ldxlbn6z-driverConfiguration.json.drv' driverConfiguration.json> structuredAttrs is enabled building '/nix/store/fkhwgch7nd2nvhvfn5p65s4kv288j9bv-nixos-test-driver-dm-wireguard-star.drv' nixos-test-driver-dm-wireguard-star> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-dm-wireguard-star> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-dm-wireguard-star> All checks passed! nixos-test-driver-dm-wireguard-star> Linting test script (enable/disable: config.skipLint) nixos-test-driver-dm-wireguard-star> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-dm-wireguard-star> All checks passed! building '/nix/store/rrdkzky6jzdiq3lfmsgfzfdn8716j7dm-container-test-run-dm-wireguard-star.drv' on 'ssh-ng://builder@build-x86-01.clan.lol' building '/nix/store/rrdkzky6jzdiq3lfmsgfzfdn8716j7dm-container-test-run-dm-wireguard-star.drv' container-test-run-dm-wireguard-star> Machine state will be reset. To keep it, pass --keep-machine-state container-test-run-dm-wireguard-star> start all VLans container-test-run-dm-wireguard-star> (finished: start all VLans, in 0.00 seconds) container-test-run-dm-wireguard-star> container-test-run-dm-wireguard-star> Test will time out and terminate in 3600.0 seconds container-test-run-dm-wireguard-star> run the VM test script container-test-run-dm-wireguard-star> additionally exposed symbols: container-test-run-dm-wireguard-star> controller, peer1, peer2, container-test-run-dm-wireguard-star> vlan1, container-test-run-dm-wireguard-star> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh container-test-run-dm-wireguard-star> controller: systemd-nspawn running (pid 50) container-test-run-dm-wireguard-star> controller: Waiting for journal at /build/vm-state-controller/var/log/journal... container-test-run-dm-wireguard-star> peer1: systemd-nspawn running (pid 53) container-test-run-dm-wireguard-star> peer1: Waiting for journal at /build/vm-state-peer1/var/log/journal... container-test-run-dm-wireguard-star> controller: waiting for unit data-mesher.service container-test-run-dm-wireguard-star> nixos-nspawn(controller): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-dm-wireguard-star> nixos-nspawn(controller): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-dm-wireguard-star> nixos-nspawn(peer1): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-dm-wireguard-star> nixos-nspawn(peer1): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-dm-wireguard-star> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-dm-wireguard-star> ░ Spawning container controller on /build/vm-state-controller. container-test-run-dm-wireguard-star> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-dm-wireguard-star> ░ Spawning container peer1 on /build/vm-state-peer1. container-test-run-dm-wireguard-star> controller # [1565156.353998] controller systemd-journald[108]: Journal started container-test-run-dm-wireguard-star> controller # [1565156.354036] controller systemd-journald[108]: Runtime Journal (/run/log/journal/652dda1a2fb044208898ab10464050f1) is 8M, max 3.7G, 3.7G free. container-test-run-dm-wireguard-star> controller # [1565156.364239] controller systemd[1]: Finished Apply Kernel Variables. container-test-run-dm-wireguard-star> controller # [1565156.372282] controller systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-dm-wireguard-star> controller # [1565156.381212] controller systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-dm-wireguard-star> controller # [1565156.381598] controller systemd[1]: Starting Network Name Resolution... container-test-run-dm-wireguard-star> controller # [1565156.381920] controller systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-dm-wireguard-star> controller # [1565156.411160] controller systemd-journald[108]: Time spent on flushing to /var/log/journal/652dda1a2fb044208898ab10464050f1 is 1.745ms for 7 entries. container-test-run-dm-wireguard-star> controller # [1565156.411160] controller systemd-journald[108]: System Journal (/var/log/journal/652dda1a2fb044208898ab10464050f1) is 8M, max 4G, 3.9G free. container-test-run-dm-wireguard-star> controller # [1565156.424390] controller systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-dm-wireguard-star> controller # [1565156.424582] controller systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-dm-wireguard-star> controller # [1565156.425228] controller systemd[1]: Reached target Preparation for Local File Systems. container-test-run-dm-wireguard-star> controller # [1565156.425275] controller systemd[1]: Reached target Local File Systems. container-test-run-dm-wireguard-star> controller # [1565156.425716] controller systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-dm-wireguard-star> controller # [1565156.425743] controller systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> controller # [1565156.426177] controller systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-dm-wireguard-star> peer1 # [1565156.357282] peer1 systemd-journald[99]: Journal started container-test-run-dm-wireguard-star> controller # [1565156.426556] controller systemd[1]: Starting Create System Files and Directories... container-test-run-dm-wireguard-star> peer1 # [1565156.357311] peer1 systemd-journald[99]: Runtime Journal (/run/log/journal/2def050b25434a97a94972400cdb73fd) is 8M, max 3.7G, 3.7G free. container-test-run-dm-wireguard-star> controller # [1565156.426572] controller systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-dm-wireguard-star> peer1 # [1565156.366191] peer1 systemd[1]: Finished Apply Kernel Variables. container-test-run-dm-wireguard-star> controller # [1565156.438550] controller systemd[1]: Finished Firewall. container-test-run-dm-wireguard-star> controller # [1565156.438634] controller systemd[1]: Reached target Preparation for Network. container-test-run-dm-wireguard-star> peer1 # [1565156.374250] peer1 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-dm-wireguard-star> controller # [1565156.438808] controller systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-dm-wireguard-star> peer1 # [1565156.408241] peer1 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-dm-wireguard-star> controller # [1565156.439412] controller systemd[1]: Starting Network Management... container-test-run-dm-wireguard-star> peer1 # [1565156.409101] peer1 systemd[1]: Starting Network Name Resolution... container-test-run-dm-wireguard-star> controller # [1565156.444270] controller systemd-tmpfiles[208]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.409682] peer1 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-dm-wireguard-star> controller # [1565156.444466] controller systemd-tmpfiles[208]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.412746] peer1 systemd-journald[99]: Time spent on flushing to /var/log/journal/2def050b25434a97a94972400cdb73fd is 1.129ms for 7 entries. container-test-run-dm-wireguard-star> controller # [1565156.444608] controller systemd-tmpfiles[208]: fchmod() of /var/log/journal/652dda1a2fb044208898ab10464050f1 failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.412746] peer1 systemd-journald[99]: System Journal (/var/log/journal/2def050b25434a97a94972400cdb73fd) is 8M, max 4G, 3.9G free. container-test-run-dm-wireguard-star> controller # [1565156.444796] controller systemd-tmpfiles[208]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.426563] peer1 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-dm-wireguard-star> controller # [1565156.447178] controller systemd[1]: Finished Create System Files and Directories. container-test-run-dm-wireguard-star> peer1 # [1565156.426864] peer1 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-dm-wireguard-star> controller # [1565156.448003] controller systemd[1]: Starting Rebuild Journal Catalog... container-test-run-dm-wireguard-star> peer1 # [1565156.427575] peer1 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-dm-wireguard-star> controller # [1565156.448419] controller systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-dm-wireguard-star> peer1 # [1565156.427622] peer1 systemd[1]: Reached target Local File Systems. container-test-run-dm-wireguard-star> controller # [1565156.455272] controller systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-dm-wireguard-star> peer1 # [1565156.428101] peer1 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-dm-wireguard-star> controller # [1565156.461024] controller systemd[1]: Finished Rebuild Journal Catalog. container-test-run-dm-wireguard-star> peer1 # [1565156.428132] peer1 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> controller # [1565156.461486] controller systemd[1]: Starting Update is Completed... container-test-run-dm-wireguard-star> peer1 # [1565156.428547] peer1 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-dm-wireguard-star> controller # [1565156.466340] controller systemd[1]: Finished Update is Completed. container-test-run-dm-wireguard-star> peer1 # [1565156.428869] peer1 systemd[1]: Starting Create System Files and Directories... container-test-run-dm-wireguard-star> controller # [1565156.616235] controller systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-dm-wireguard-star> peer1 # [1565156.428884] peer1 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-dm-wireguard-star> peer1 # [1565156.438863] peer1 systemd-tmpfiles[195]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.439019] peer1 systemd-tmpfiles[195]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.442449] peer1 systemd[1]: Finished Firewall. container-test-run-dm-wireguard-star> peer1 # [1565156.442534] peer1 systemd[1]: Reached target Preparation for Network. container-test-run-dm-wireguard-star> peer1 # [1565156.442656] peer1 systemd-tmpfiles[195]: fchmod() of /var/log/journal/2def050b25434a97a94972400cdb73fd failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.442659] peer1 systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-dm-wireguard-star> peer1 # [1565156.442876] peer1 systemd-tmpfiles[195]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.443063] peer1 systemd[1]: Starting Network Management... container-test-run-dm-wireguard-star> peer1 # [1565156.444022] peer1 systemd[1]: Finished Create System Files and Directories. container-test-run-dm-wireguard-star> peer1 # [1565156.444630] peer1 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-dm-wireguard-star> peer1 # [1565156.444996] peer1 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-dm-wireguard-star> peer1 # [1565156.455809] peer1 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-dm-wireguard-star> peer1 # [1565156.457853] peer1 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-dm-wireguard-star> peer1 # [1565156.458308] peer1 systemd[1]: Starting Update is Completed... container-test-run-dm-wireguard-star> peer1 # [1565156.463406] peer1 systemd[1]: Finished Update is Completed. container-test-run-dm-wireguard-star> peer1 # [1565156.615909] peer1 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-dm-wireguard-star> peer1 # [1565156.974772] peer1 systemd-networkd[209]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.974850] peer1 systemd-networkd[209]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer1 # [1565156.983108] peer1 systemd-networkd[209]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> peer1 # [1565156.983265] peer1 systemd-networkd[209]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> peer1 # [1565156.983344] peer1 systemd-networkd[209]: lo: Link UP container-test-run-dm-wireguard-star> peer1 # [1565156.983347] peer1 systemd-networkd[209]: lo: Gained carrier container-test-run-dm-wireguard-star> peer1 # [1565156.983485] peer1 systemd-networkd[209]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-dm-wireguard-star> peer1 # [1565156.983747] peer1 systemd[1]: Started Network Management. container-test-run-dm-wireguard-star> peer1 # [1565156.984113] peer1 systemd-networkd[209]: wg-star: Configuring with /etc/systemd/network/40-wg-star.network. container-test-run-dm-wireguard-star> peer1 # [1565156.984300] peer1 systemd-networkd[209]: wg-star: netdev ready container-test-run-dm-wireguard-star> peer1 # [1565156.984417] peer1 systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-dm-wireguard-star> peer1 # [1565156.984429] peer1 systemd-networkd[209]: eth1: Link UP container-test-run-dm-wireguard-star> peer1 # [1565156.984561] peer1 systemd-networkd[209]: eth1: Gained carrier container-test-run-dm-wireguard-star> peer1 # [1565157.004549] peer1 systemd-networkd[209]: wg-star: Link UP container-test-run-dm-wireguard-star> peer1 # [1565157.004553] peer1 systemd-networkd[209]: wg-star: Gained carrier container-test-run-dm-wireguard-star> peer1 # [1565157.008512] peer1 systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-dm-wireguard-star> controller # [1565156.979788] controller systemd-networkd[220]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> controller # [1565156.979853] controller systemd-networkd[220]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> controller # [1565156.988040] controller systemd-networkd[220]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> controller # [1565156.988208] controller systemd-networkd[220]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> controller # [1565156.988271] controller systemd-networkd[220]: lo: Link UP container-test-run-dm-wireguard-star> controller # [1565156.988274] controller systemd-networkd[220]: lo: Gained carrier container-test-run-dm-wireguard-star> controller # [1565156.988410] controller systemd-networkd[220]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-dm-wireguard-star> controller # [1565156.988656] controller systemd[1]: Started Network Management. container-test-run-dm-wireguard-star> controller # [1565157.004146] controller systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-dm-wireguard-star> controller # [1565157.004525] controller systemd-networkd[220]: wg-star: Configuring with /etc/systemd/network/40-wg-star.network. container-test-run-dm-wireguard-star> controller # [1565157.004743] controller systemd-networkd[220]: wg-star: netdev ready container-test-run-dm-wireguard-star> controller # [1565157.004860] controller systemd-networkd[220]: eth1: Link UP container-test-run-dm-wireguard-star> controller # [1565157.005008] controller systemd-networkd[220]: eth1: Gained carrier container-test-run-dm-wireguard-star> controller # [1565157.030456] controller systemd-networkd[220]: wg-star: Link UP container-test-run-dm-wireguard-star> controller # [1565157.030460] controller systemd-networkd[220]: wg-star: Gained carrier container-test-run-dm-wireguard-star> controller # [1565157.031091] controller systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-dm-wireguard-star> peer1 # [1565157.355443] peer1 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [1565157.472972] peer1 systemd-resolved[169]: Positive Trust Anchors: container-test-run-dm-wireguard-star> peer1 # [1565157.472979] peer1 systemd-resolved[169]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-dm-wireguard-star> peer1 # [1565157.472982] peer1 systemd-resolved[169]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-dm-wireguard-star> peer1 # [1565157.472998] peer1 systemd-resolved[169]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test container-test-run-dm-wireguard-star> peer1 # [1565157.485473] peer1 systemd-resolved[169]: Using system hostname 'peer1'. container-test-run-dm-wireguard-star> peer1 # [1565157.486464] peer1 systemd[1]: Started Network Name Resolution. container-test-run-dm-wireguard-star> peer1 # [1565157.486507] peer1 systemd[1]: Reached target Network. container-test-run-dm-wireguard-star> peer1 # [1565157.486544] peer1 systemd[1]: Reached target System Initialization. container-test-run-dm-wireguard-star> peer1 # [1565157.486593] peer1 systemd[1]: Started Watch for WireGuard controller info from data-mesher. container-test-run-dm-wireguard-star> peer1 # [1565157.486607] peer1 systemd[1]: Started Periodic heartbeat re-publish for dm-wireguard-star peer. container-test-run-dm-wireguard-star> peer1 # [1565157.486620] peer1 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer1 # [1565157.486631] peer1 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-dm-wireguard-star> peer1 # [1565157.486642] peer1 systemd[1]: Reached target Path Units. container-test-run-dm-wireguard-star> peer1 # [1565157.486660] peer1 systemd[1]: Reached target Timer Units. container-test-run-dm-wireguard-star> peer1 # [1565157.486731] peer1 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-dm-wireguard-star> peer1 # [1565157.486787] peer1 systemd[1]: Listening on Nix Daemon Socket. container-test-run-dm-wireguard-star> peer1 # [1565157.486855] peer1 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-dm-wireguard-star> peer1 # [1565157.486862] peer1 systemd[1]: Reached target Socket Units. container-test-run-dm-wireguard-star> peer1 # [1565157.486882] peer1 systemd[1]: Reached target Basic System. container-test-run-dm-wireguard-star> peer1 # [1565157.489183] peer1 systemd[1]: Starting data mesher daemon... container-test-run-dm-wireguard-star> peer1 # [1565157.489542] peer1 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-dm-wireguard-star> peer1 # [1565157.489933] peer1 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-dm-wireguard-star> peer1 # [1565157.490641] peer1 systemd[1]: Starting D-Bus System Message Bus... container-test-run-dm-wireguard-star> peer1 # [1565157.499373] peer1 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-dm-wireguard-star> peer1 # [1565157.625760] peer1 nsncd[224]: Sep 22 10:02:52.049 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-dm-wireguard-star> peer1 # [1565157.625804] peer1 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-dm-wireguard-star> peer1 # [1565157.625861] peer1 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-dm-wireguard-star> peer1 # [1565157.625902] peer1 systemd[1]: Reached target User and Group Name Lookups. container-test-run-dm-wireguard-star> controller # [1565157.349878] controller systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [1565157.450115] controller systemd-resolved[156]: Positive Trust Anchors: container-test-run-dm-wireguard-star> controller # [1565157.450122] controller systemd-resolved[156]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-dm-wireguard-star> controller # [1565157.450126] controller systemd-resolved[156]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-dm-wireguard-star> controller # [1565157.450142] controller systemd-resolved[156]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test container-test-run-dm-wireguard-star> controller # [1565157.460645] controller systemd-resolved[156]: Using system hostname 'controller'. container-test-run-dm-wireguard-star> controller # [1565157.461682] controller systemd[1]: Started Network Name Resolution. container-test-run-dm-wireguard-star> controller # [1565157.461724] controller systemd[1]: Reached target Network. container-test-run-dm-wireguard-star> controller # [1565157.461756] controller systemd[1]: Reached target System Initialization. container-test-run-dm-wireguard-star> controller # [1565157.461807] controller systemd[1]: Started Watch for WireGuard peer changes from data-mesher. container-test-run-dm-wireguard-star> controller # [1565157.461822] controller systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> controller # [1565157.461834] controller systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-dm-wireguard-star> controller # [1565157.461844] controller systemd[1]: Reached target Path Units. container-test-run-dm-wireguard-star> controller # [1565157.461860] controller systemd[1]: Reached target Timer Units. container-test-run-dm-wireguard-star> controller # [1565157.461928] controller systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-dm-wireguard-star> controller # [1565157.461984] controller systemd[1]: Listening on Nix Daemon Socket. container-test-run-dm-wireguard-star> controller # [1565157.462057] controller systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-dm-wireguard-star> controller # [1565157.462063] controller systemd[1]: Reached target Socket Units. container-test-run-dm-wireguard-star> controller # [1565157.462082] controller systemd[1]: Reached target Basic System. container-test-run-dm-wireguard-star> controller # [1565157.462827] controller systemd[1]: Starting data mesher daemon... container-test-run-dm-wireguard-star> controller # [1565157.463158] controller systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-dm-wireguard-star> controller # [1565157.463512] controller systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-dm-wireguard-star> controller # [1565157.464071] controller systemd[1]: Starting D-Bus System Message Bus... container-test-run-dm-wireguard-star> controller # [1565157.498637] controller systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-dm-wireguard-star> controller # [1565157.629538] controller nsncd[235]: Sep 22 10:02:52.052 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-dm-wireguard-star> controller # [1565157.629569] controller systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-dm-wireguard-star> controller # [1565157.629616] controller systemd[1]: Reached target Host and Network Name Lookups. container-test-run-dm-wireguard-star> controller # [1565157.629654] controller systemd[1]: Reached target User and Group Name Lookups. container-test-run-dm-wireguard-star> controller # [1565157.647141] controller systemd[1]: Starting User Login Management... container-test-run-dm-wireguard-star> controller # [1565157.647697] controller systemd[1]: Starting Permit User Sessions... container-test-run-dm-wireguard-star> controller # [1565157.653987] controller systemd[1]: Finished Permit User Sessions. container-test-run-dm-wireguard-star> controller # [1565157.654426] controller systemd[1]: Started Console Getty. container-test-run-dm-wireguard-star> controller # [1565157.654448] controller systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-dm-wireguard-star> controller # [1565157.654458] controller systemd[1]: Reached target Login Prompts. container-test-run-dm-wireguard-star> controller # [1565157.735022] controller dbus-broker-launch[236]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-dm-wireguard-star> controller # [1565157.735457] controller dbus-broker-launch[236]: NSS returned no entry for 'systemd-timesync' container-test-run-dm-wireguard-star> controller # [1565157.735457] controller dbus-broker-launch[236]: Invalid user-name in /nix/store/dncjva6ykxgm65vmc39bmm0pmxka5mdd-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-dm-wireguard-star> controller # [1565157.735713] controller systemd[1]: Started D-Bus System Message Bus. container-test-run-dm-wireguard-star> controller # [1565157.738929] controller dbus-broker-launch[236]: Ready container-test-run-dm-wireguard-star> peer1 # [1565157.626865] peer1 systemd[1]: Starting User Login Management... container-test-run-dm-wireguard-star> peer1 # [1565157.627238] peer1 systemd[1]: Starting Permit User Sessions... container-test-run-dm-wireguard-star> peer1 # [1565157.651192] peer1 systemd[1]: Finished Permit User Sessions. container-test-run-dm-wireguard-star> peer1 # [1565157.651684] peer1 systemd[1]: Started Console Getty. container-test-run-dm-wireguard-star> peer1 # [1565157.651706] peer1 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-dm-wireguard-star> peer1 # [1565157.651716] peer1 systemd[1]: Reached target Login Prompts. container-test-run-dm-wireguard-star> peer1 # [1565157.749989] peer1 dbus-broker-launch[225]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-dm-wireguard-star> peer1 # [1565157.750444] peer1 dbus-broker-launch[225]: NSS returned no entry for 'systemd-timesync' container-test-run-dm-wireguard-star> peer1 # [1565157.750444] peer1 dbus-broker-launch[225]: Invalid user-name in /nix/store/dncjva6ykxgm65vmc39bmm0pmxka5mdd-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-dm-wireguard-star> peer1 # [1565157.750783] peer1 systemd[1]: Started D-Bus System Message Bus. container-test-run-dm-wireguard-star> peer1 # [1565157.755072] peer1 dbus-broker-launch[225]: Ready container-test-run-dm-wireguard-star> controller # [1565158.112678] controller data-mesher[233]: time=2026-09-22T10:02:52.535Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-dm-wireguard-star> controller # [1565158.113089] controller data-mesher[233]: time=2026-09-22T10:02:52.536Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf: [/dns/controller.clan/tcp/7946]} {12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq: [/dns/peer1.clan/tcp/7946]} {12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB: [/dns/peer2.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> controller # [1565158.113089] controller data-mesher[233]: time=2026-09-22T10:02:52.536Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-dm-wireguard-star> controller # [1565158.125828] controller data-mesher[233]: time=2026-09-22T10:02:52.549Z level=INFO msg="checking file integrity" container-test-run-dm-wireguard-star> controller # [1565158.125906] controller data-mesher[233]: time=2026-09-22T10:02:52.549Z level=INFO msg="file integrity check complete" container-test-run-dm-wireguard-star> controller # [1565158.129410] controller data-mesher[233]: time=2026-09-22T10:02:52.552Z level=INFO msg="libp2p host created" peer_id=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.1/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::1/tcp/7946 /ip6/fda1:5c8::5869:ad4a:6504:5243/tcp/7946]" container-test-run-dm-wireguard-star> controller # [1565158.129410] controller data-mesher[233]: time=2026-09-22T10:02:52.552Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-dm-wireguard-star> controller # [1565158.129549] controller data-mesher[233]: time=2026-09-22T10:02:52.552Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-dm-wireguard-star> controller # [1565158.129549] controller data-mesher[233]: time=2026-09-22T10:02:52.552Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-dm-wireguard-star> controller # [1565158.129549] controller data-mesher[233]: time=2026-09-22T10:02:52.552Z level=INFO msg="starting server" container-test-run-dm-wireguard-star> controller # [1565158.129549] controller data-mesher[233]: time=2026-09-22T10:02:52.552Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-dm-wireguard-star> controller # [1565158.129619] controller data-mesher[233]: time=2026-09-22T10:02:52.552Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-dm-wireguard-star> controller # [1565158.129619] controller data-mesher[233]: time=2026-09-22T10:02:52.552Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-dm-wireguard-star> controller # [1565158.145112] controller systemd-networkd[220]: eth1: Gained IPv6LL container-test-run-dm-wireguard-star> controller # [1565158.285146] controller systemd-logind[253]: New seat seat0. container-test-run-dm-wireguard-star> controller # [1565158.285302] controller systemd[1]: Started User Login Management. container-test-run-dm-wireguard-star> controller # [1565158.286242] controller systemd[1]: Starting linger-users.service... container-test-run-dm-wireguard-star> controller # [1565158.310995] controller systemd[1]: linger-users.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [1565158.311093] controller systemd[1]: Finished linger-users.service. container-test-run-dm-wireguard-star> peer1 # [1565158.128266] peer1 data-mesher[222]: time=2026-09-22T10:02:52.551Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-dm-wireguard-star> peer1 # [1565158.128570] peer1 data-mesher[222]: time=2026-09-22T10:02:52.551Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf: [/dns/controller.clan/tcp/7946]} {12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq: [/dns/peer1.clan/tcp/7946]} {12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB: [/dns/peer2.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> peer1 # [1565158.128589] peer1 data-mesher[222]: time=2026-09-22T10:02:52.551Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-dm-wireguard-star> peer1 # [1565158.130119] peer1 data-mesher[222]: time=2026-09-22T10:02:52.553Z level=INFO msg="checking file integrity" container-test-run-dm-wireguard-star> peer1 # [1565158.130190] peer1 data-mesher[222]: time=2026-09-22T10:02:52.553Z level=INFO msg="file integrity check complete" container-test-run-dm-wireguard-star> peer1 # [1565158.133295] peer1 data-mesher[222]: time=2026-09-22T10:02:52.556Z level=INFO msg="libp2p host created" peer_id=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.2/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::2/tcp/7946 /ip6/fda1:5c8::2025:c60:174f:9bed/tcp/7946]" container-test-run-dm-wireguard-star> peer1 # [1565158.133384] peer1 data-mesher[222]: time=2026-09-22T10:02:52.556Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-dm-wireguard-star> peer1 # [1565158.133384] peer1 data-mesher[222]: time=2026-09-22T10:02:52.556Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-dm-wireguard-star> peer1 # [1565158.133384] peer1 data-mesher[222]: time=2026-09-22T10:02:52.556Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-dm-wireguard-star> peer1 # [1565158.133384] peer1 data-mesher[222]: time=2026-09-22T10:02:52.556Z level=INFO msg="starting server" container-test-run-dm-wireguard-star> peer1 # [1565158.133452] peer1 data-mesher[222]: time=2026-09-22T10:02:52.556Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-dm-wireguard-star> peer1 # [1565158.133474] peer1 data-mesher[222]: time=2026-09-22T10:02:52.556Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-dm-wireguard-star> peer1 # [1565158.133501] peer1 data-mesher[222]: time=2026-09-22T10:02:52.556Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-dm-wireguard-star> peer1 # [1565158.287520] peer1 systemd-logind[242]: New seat seat0. container-test-run-dm-wireguard-star> peer1 # [1565158.287637] peer1 systemd[1]: Started User Login Management. container-test-run-dm-wireguard-star> peer1 # [1565158.306188] peer1 systemd[1]: Starting linger-users.service... container-test-run-dm-wireguard-star> peer1 # [1565158.311876] peer1 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [1565158.311913] peer1 systemd[1]: Finished linger-users.service. container-test-run-dm-wireguard-star> peer1 # [1565158.912131] peer1 systemd-networkd[209]: eth1: Gained IPv6LL container-test-run-dm-wireguard-star> controller # [1565163.132762] controller data-mesher[233]: time=2026-09-22T10:02:57.556Z level=INFO msg="peer connected" peer_id=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq remote_addr=/ip6/2001:db8:1::2/tcp/7946 container-test-run-dm-wireguard-star> peer1 # [1565163.132985] peer1 data-mesher[222]: time=2026-09-22T10:02:57.556Z level=INFO msg="peer connected" peer_id=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf remote_addr=/ip6/2001:db8:1::1/tcp/7946 container-test-run-dm-wireguard-star> controller: still waiting for container 'controller' to reach ready state... container-test-run-dm-wireguard-star> controller # [1565168.130769] controller data-mesher[233]: time=2026-09-22T10:03:02.554Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-dm-wireguard-star> controller # [1565168.131044] controller data-mesher[233]: time=2026-09-22T10:03:02.554Z level=DEBUG msg="initiating state exchange" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565168.131254] controller data-mesher[233]: time=2026-09-22T10:03:02.554Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565168.131254] controller data-mesher[233]: time=2026-09-22T10:03:02.554Z level=INFO msg="state exchange complete" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565168.131303] controller data-mesher[233]: time=2026-09-22T10:03:02.554Z level=INFO msg="server started" container-test-run-dm-wireguard-star> controller # [1565168.131388] controller data-mesher[233]: time=2026-09-22T10:03:02.554Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-dm-wireguard-star> controller # [1565168.131435] controller systemd[1]: Started data mesher daemon. container-test-run-dm-wireguard-star> controller # [1565168.132149] controller systemd[1]: Starting Publish WireGuard controller info to data-mesher... container-test-run-dm-wireguard-star> controller # [1565168.133606] controller data-mesher[233]: time=2026-09-22T10:03:02.556Z level=INFO msg="received state sync from peer" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565168.133606] controller data-mesher[233]: time=2026-09-22T10:03:02.556Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565168.173785] controller systemd[1]: Starting Reconfigure WireGuard peers from data-mesher... container-test-run-dm-wireguard-star> controller # [1565168.177738] controller data-mesher[233]: time=2026-09-22T10:03:02.601Z level=INFO msg=http_request uri=/files/dm_wg_star_wg_star/controller status=204 container-test-run-dm-wireguard-star> controller # [1565168.177798] controller dm-wg-star-publish[285]: Status: 204 No Content container-test-run-dm-wireguard-star> controller # [1565168.180352] controller systemd[1]: Finished Publish WireGuard controller info to data-mesher. container-test-run-dm-wireguard-star> controller # [1565168.180539] controller systemd[1]: Reached target Multi-User System. container-test-run-dm-wireguard-star> controller # [1565168.222249] controller dm-wg-star-reconfig[300]: No peer data available yet, skipping container-test-run-dm-wireguard-star> controller # [1565168.222960] controller systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [1565168.240130] controller systemd[1]: Finished Reconfigure WireGuard peers from data-mesher. container-test-run-dm-wireguard-star> controller # [1565168.240409] controller systemd[1]: Startup finished in 12.136s. container-test-run-dm-wireguard-star> controller: (finished: waiting for unit data-mesher.service, in 12.64 seconds) container-test-run-dm-wireguard-star> peer1: waiting for unit data-mesher.service container-test-run-dm-wireguard-star> peer1: (finished: waiting for unit data-mesher.service, in 0.01 seconds) container-test-run-dm-wireguard-star> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-dm-wireguard-star> File "/nix/store/wx1n220i63nlp13ay89xca3zps8qcr6w-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-dm-wireguard-star> controller: waiting for success: test -f /var/lib/data-mesher/files/home/dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-dm-wireguard-star> File "/nix/store/wx1n220i63nlp13ay89xca3zps8qcr6w-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-dm-wireguard-star> controller: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/dm_wg_star_wg_star/controller, in 0.00 seconds) container-test-run-dm-wireguard-star> peer1: waiting for success: test -f /var/lib/data-mesher/files/home/dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [1565168.131147] peer1 data-mesher[222]: time=2026-09-22T10:03:02.554Z level=INFO msg="received state sync from peer" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565168.131147] peer1 data-mesher[222]: time=2026-09-22T10:03:02.554Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565168.133441] peer1 data-mesher[222]: time=2026-09-22T10:03:02.556Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-dm-wireguard-star> peer1 # [1565168.133468] peer1 data-mesher[222]: time=2026-09-22T10:03:02.556Z level=DEBUG msg="initiating state exchange" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565168.133668] peer1 data-mesher[222]: time=2026-09-22T10:03:02.557Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565168.133679] peer1 data-mesher[222]: time=2026-09-22T10:03:02.557Z level=INFO msg="state exchange complete" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565168.133690] peer1 data-mesher[222]: time=2026-09-22T10:03:02.557Z level=INFO msg="server started" container-test-run-dm-wireguard-star> peer1 # [1565168.133739] peer1 data-mesher[222]: time=2026-09-22T10:03:02.557Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-dm-wireguard-star> peer1 # [1565168.133808] peer1 systemd[1]: Started data mesher daemon. container-test-run-dm-wireguard-star> peer1 # [1565168.134409] peer1 systemd[1]: Starting Publish WireGuard peer info to data-mesher... container-test-run-dm-wireguard-star> peer1 # [1565168.218884] peer1 data-mesher[222]: time=2026-09-22T10:03:02.642Z level=INFO msg=http_request uri=/files/dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 status=204 container-test-run-dm-wireguard-star> peer1 # [1565168.218946] peer1 dm-wg-star-publish[276]: Status: 204 No Content container-test-run-dm-wireguard-star> peer1 # [1565168.219174] peer1 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer1 # [1565168.221014] peer1 systemd[1]: dm-wg-star-wg-star-publish.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [1565168.221146] peer1 systemd[1]: Finished Publish WireGuard peer info to data-mesher. container-test-run-dm-wireguard-star> peer1 # [1565168.221533] peer1 systemd[1]: Reached target Multi-User System. container-test-run-dm-wireguard-star> peer1 # [1565168.288779] peer1 dm-wg-star-reconfig[291]: No controller data available yet, skipping container-test-run-dm-wireguard-star> peer1 # [1565168.289523] peer1 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [1565168.289598] peer1 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer1 # [1565168.289808] peer1 systemd[1]: Startup finished in 12.192s. container-test-run-dm-wireguard-star> controller # [1565173.133941] controller data-mesher[233]: time=2026-09-22T10:03:07.557Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [1565173.133941] controller data-mesher[233]: time=2026-09-22T10:03:07.557Z level=DEBUG msg="initiating state exchange" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565173.135065] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=INFO msg="received state sync from peer" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565173.135065] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565173.135065] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565173.135225] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=INFO msg="received file request" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [1565173.135390] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=DEBUG msg="new file detected" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 container-test-run-dm-wireguard-star> controller # [1565173.135416] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 container-test-run-dm-wireguard-star> controller # [1565173.135430] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=DEBUG msg="new file detected" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 container-test-run-dm-wireguard-star> controller # [1565173.135430] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=INFO msg="state exchange complete" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565173.135473] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 signed_at="2026-09-22 10:03:02.638 +0000 UTC" signed_by="VDU8UNcOwUoZNE7vX+ycOFhGRqE52EtBFIiryhsNGy4=" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565173.135473] controller data-mesher[233]: time=2026-09-22T10:03:07.558Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [1565173.136303] controller data-mesher[233]: time=2026-09-22T10:03:07.559Z level=INFO msg="file transfer complete" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [1565173.138250] controller systemd[1]: Starting Reconfigure WireGuard peers from data-mesher... container-test-run-dm-wireguard-star> controller # [1565173.205221] controller data-mesher[233]: time=2026-09-22T10:03:07.628Z level=INFO msg="download complete" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 signed_at="2026-09-22 10:03:02.638 +0000 UTC" signed_by="VDU8UNcOwUoZNE7vX+ycOFhGRqE52EtBFIiryhsNGy4=" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq written=true elapsed=69.764721ms container-test-run-dm-wireguard-star> controller # [1565173.218716] controller systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [1565173.218861] controller systemd[1]: Finished Reconfigure WireGuard peers from data-mesher. container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: test -f /var/lib/data-mesher/files/home/dm_wg_star_wg_star/controller, in 5.02 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: ls /var/lib/data-mesher/files/home/dm_wg_star_wg_star/ | grep -v controller | grep -q . container-test-run-dm-wireguard-star> controller: (finished: waiting for success: ls /var/lib/data-mesher/files/home/dm_wg_star_wg_star/ | grep -v controller | grep -q ., in 0.00 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: wg show wg-star peers | grep -q . container-test-run-dm-wireguard-star> controller: (finished: waiting for success: wg show wg-star peers | grep -q ., in 0.01 seconds) container-test-run-dm-wireguard-star> peer1: waiting for success: wg show wg-star peers | grep -q . container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: wg show wg-star peers | grep -q ., in 0.00 seconds) container-test-run-dm-wireguard-star> peer1: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::5869:ad4a:6504:5243 container-test-run-dm-wireguard-star> peer1 # [1565173.134259] peer1 data-mesher[222]: time=2026-09-22T10:03:07.557Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [1565173.134259] peer1 data-mesher[222]: time=2026-09-22T10:03:07.557Z level=DEBUG msg="initiating state exchange" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565173.134556] peer1 data-mesher[222]: time=2026-09-22T10:03:07.557Z level=INFO msg="received state sync from peer" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565173.134556] peer1 data-mesher[222]: time=2026-09-22T10:03:07.557Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565173.134556] peer1 data-mesher[222]: time=2026-09-22T10:03:07.557Z level=DEBUG msg="new file detected" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [1565173.134556] peer1 data-mesher[222]: time=2026-09-22T10:03:07.557Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [1565173.134556] peer1 data-mesher[222]: time=2026-09-22T10:03:07.557Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/controller signed_at="2026-09-22 10:03:02.594 +0000 UTC" signed_by="cREIDwXB4wUgEMCrgbgoubTWdxQ5XZOhUEUDIUfjn9U=" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565173.135589] peer1 data-mesher[222]: time=2026-09-22T10:03:07.558Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565173.135619] peer1 data-mesher[222]: time=2026-09-22T10:03:07.558Z level=DEBUG msg="new file detected" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer1 # [1565173.135619] peer1 data-mesher[222]: time=2026-09-22T10:03:07.558Z level=INFO msg="state exchange complete" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565173.135665] peer1 data-mesher[222]: time=2026-09-22T10:03:07.558Z level=INFO msg="received file request" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 container-test-run-dm-wireguard-star> peer1 # [1565173.135665] peer1 data-mesher[222]: time=2026-09-22T10:03:07.558Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer1 # [1565173.136295] peer1 data-mesher[222]: time=2026-09-22T10:03:07.559Z level=INFO msg="file transfer complete" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 container-test-run-dm-wireguard-star> peer1 # [1565173.138321] peer1 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer1 # [1565173.206312] peer1 data-mesher[222]: time=2026-09-22T10:03:07.629Z level=INFO msg="download complete" name=dm_wg_star_wg_star/controller signed_at="2026-09-22 10:03:02.594 +0000 UTC" signed_by="cREIDwXB4wUgEMCrgbgoubTWdxQ5XZOhUEUDIUfjn9U=" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf written=true elapsed=71.831443ms container-test-run-dm-wireguard-star> peer1 # [1565173.218733] peer1 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [1565173.218868] peer1 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer1 # [1565178.136078] peer1 data-mesher[222]: time=2026-09-22T10:03:12.559Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [1565178.136078] peer1 data-mesher[222]: time=2026-09-22T10:03:12.559Z level=DEBUG msg="initiating state exchange" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565178.137084] peer1 data-mesher[222]: time=2026-09-22T10:03:12.560Z level=INFO msg="received state sync from peer" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565178.137084] peer1 data-mesher[222]: time=2026-09-22T10:03:12.560Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565178.137315] peer1 data-mesher[222]: time=2026-09-22T10:03:12.560Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565178.137412] peer1 data-mesher[222]: time=2026-09-22T10:03:12.560Z level=INFO msg="state exchange complete" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565178.137447] peer1 data-mesher[222]: time=2026-09-22T10:03:12.560Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [1565178.137651] controller data-mesher[233]: time=2026-09-22T10:03:12.560Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [1565178.137651] controller data-mesher[233]: time=2026-09-22T10:03:12.560Z level=INFO msg="received state sync from peer" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565178.137651] controller data-mesher[233]: time=2026-09-22T10:03:12.560Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565178.137651] controller data-mesher[233]: time=2026-09-22T10:03:12.560Z level=DEBUG msg="initiating state exchange" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565178.137651] controller data-mesher[233]: time=2026-09-22T10:03:12.560Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565178.137651] controller data-mesher[233]: time=2026-09-22T10:03:12.560Z level=INFO msg="state exchange complete" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565178.137651] controller data-mesher[233]: time=2026-09-22T10:03:12.560Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::5869:ad4a:6504:5243, in 6.01 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::2025:0c60:174f:9bed container-test-run-dm-wireguard-star> controller: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::2025:0c60:174f:9bed, in 0.00 seconds) container-test-run-dm-wireguard-star> controller: must succeed: wg show wg-star peers | wc -l container-test-run-dm-wireguard-star> controller: (finished: must succeed: wg show wg-star peers | wc -l, in 0.01 seconds) container-test-run-dm-wireguard-star> peer2: systemd-nspawn running (pid 742) container-test-run-dm-wireguard-star> peer2: Waiting for journal at /build/vm-state-peer2/var/log/journal... container-test-run-dm-wireguard-star> peer2: waiting for unit data-mesher.service container-test-run-dm-wireguard-star> nixos-nspawn(peer2): TAP vde-tap1 not found; container will be isolated from VDE container-test-run-dm-wireguard-star> nixos-nspawn(peer2): A common reason for this is that /dev/net is not available in the Nix sandbox. Try adding /dev/net to extra-sandbox-paths. container-test-run-dm-wireguard-star> Note: in a future version of systemd-nspawn the default set of permitted socket address families will be restricted to AF_INET, AF_INET6 and AF_UNIX. Use --restrict-address-families= to configure the set of permitted socket address families, or set RestrictAddressFamilies= in a .nspawn file. container-test-run-dm-wireguard-star> ░ Spawning container peer2 on /build/vm-state-peer2. container-test-run-dm-wireguard-star> peer2 # [1565180.098496] peer2 systemd-journald[99]: Journal started container-test-run-dm-wireguard-star> peer2 # [1565180.098525] peer2 systemd-journald[99]: Runtime Journal (/run/log/journal/6eac042eaaf44f95824aa05b4666b9e3) is 8M, max 3.7G, 3.7G free. container-test-run-dm-wireguard-star> peer2 # [1565180.102384] peer2 systemd[1]: Finished Apply Kernel Variables. container-test-run-dm-wireguard-star> peer2 # [1565180.108893] peer2 systemd[1]: Finished Create Static Device Nodes in /dev gracefully. container-test-run-dm-wireguard-star> peer2 # [1565180.117483] peer2 systemd[1]: Starting Flush Journal to Persistent Storage... container-test-run-dm-wireguard-star> peer2 # [1565180.117861] peer2 systemd[1]: Starting Network Name Resolution... container-test-run-dm-wireguard-star> peer2 # [1565180.118177] peer2 systemd[1]: Starting Create Static Device Nodes in /dev... container-test-run-dm-wireguard-star> peer2 # [1565180.123485] peer2 systemd-journald[99]: Time spent on flushing to /var/log/journal/6eac042eaaf44f95824aa05b4666b9e3 is 1.250ms for 7 entries. container-test-run-dm-wireguard-star> peer2 # [1565180.123485] peer2 systemd-journald[99]: System Journal (/var/log/journal/6eac042eaaf44f95824aa05b4666b9e3) is 8M, max 4G, 3.9G free. container-test-run-dm-wireguard-star> peer2 # [1565180.136523] peer2 systemd[1]: Finished Create Static Device Nodes in /dev. container-test-run-dm-wireguard-star> peer2 # [1565180.136902] peer2 systemd[1]: Reached target Preparation for Local File Systems. container-test-run-dm-wireguard-star> peer2 # [1565180.136948] peer2 systemd[1]: Reached target Local File Systems. container-test-run-dm-wireguard-star> peer2 # [1565180.137376] peer2 systemd[1]: Listening on Boot Loader Control Service Socket. container-test-run-dm-wireguard-star> peer2 # [1565180.137400] peer2 systemd[1]: Update Boot Loader Random Seed skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer2 # [1565180.137762] peer2 systemd[1]: Starting Save Transient machine-id to Disk... container-test-run-dm-wireguard-star> peer2 # [1565180.137778] peer2 systemd[1]: Rule-based Manager for Device Events and Files skipped, unmet condition check ConditionPathIsReadWrite=/sys container-test-run-dm-wireguard-star> peer2 # [1565180.179483] peer2 systemd[1]: Finished Firewall. container-test-run-dm-wireguard-star> peer2 # [1565180.179568] peer2 systemd[1]: Reached target Preparation for Network. container-test-run-dm-wireguard-star> peer2 # [1565180.179696] peer2 systemd[1]: Listening on Network Management Resolve Hook Socket. container-test-run-dm-wireguard-star> peer2 # [1565180.180120] peer2 systemd[1]: Starting Network Management... container-test-run-dm-wireguard-star> peer2 # [1565180.201285] peer2 systemd[1]: Finished Flush Journal to Persistent Storage. container-test-run-dm-wireguard-star> peer2 # [1565180.201732] peer2 systemd[1]: Starting Create System Files and Directories... container-test-run-dm-wireguard-star> peer2 # [1565180.214599] peer2 systemd-tmpfiles[210]: Cannot set file attributes for '/var/empty', value=0x00000010, mask=0x00000010, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [1565180.214743] peer2 systemd-tmpfiles[210]: fchmod() of /var/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [1565180.214843] peer2 systemd-tmpfiles[210]: fchmod() of /var/log/journal/6eac042eaaf44f95824aa05b4666b9e3 failed: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [1565180.214995] peer2 systemd-tmpfiles[210]: fchmod() of /run/log/journal failed: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [1565180.215830] peer2 systemd[1]: Finished Create System Files and Directories. container-test-run-dm-wireguard-star> peer2 # [1565180.216280] peer2 systemd[1]: Starting Rebuild Journal Catalog... container-test-run-dm-wireguard-star> peer2 # [1565180.216583] peer2 systemd[1]: Starting Record System Boot/Shutdown in UTMP... container-test-run-dm-wireguard-star> peer2 # [1565180.223168] peer2 systemd[1]: Finished Record System Boot/Shutdown in UTMP. container-test-run-dm-wireguard-star> peer2 # [1565180.229309] peer2 systemd[1]: Finished Rebuild Journal Catalog. container-test-run-dm-wireguard-star> peer2 # [1565180.230014] peer2 systemd[1]: Starting Update is Completed... container-test-run-dm-wireguard-star> peer2 # [1565180.236995] peer2 systemd[1]: Finished Update is Completed. container-test-run-dm-wireguard-star> peer2 # [1565180.426665] peer2 systemd[1]: Finished Save Transient machine-id to Disk. container-test-run-dm-wireguard-star> peer2 # [1565180.745282] peer2 systemd-networkd[207]: Failed to increase receive buffer size for general netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [1565180.745366] peer2 systemd-networkd[207]: Failed to increase receive buffer size for nftables netlink socket, ignoring: Operation not permitted container-test-run-dm-wireguard-star> peer2 # [1565180.754810] peer2 systemd-networkd[207]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> peer2 # [1565180.754960] peer2 systemd-networkd[207]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. container-test-run-dm-wireguard-star> peer2 # [1565180.755063] peer2 systemd-networkd[207]: lo: Link UP container-test-run-dm-wireguard-star> peer2 # [1565180.755066] peer2 systemd-networkd[207]: lo: Gained carrier container-test-run-dm-wireguard-star> peer2 # [1565180.755234] peer2 systemd-networkd[207]: eth1: Configuring with /etc/systemd/network/40-eth1.network. container-test-run-dm-wireguard-star> peer2 # [1565180.755534] peer2 systemd[1]: Started Network Management. container-test-run-dm-wireguard-star> peer2 # [1565180.756046] peer2 systemd-networkd[207]: wg-star: Configuring with /etc/systemd/network/40-wg-star.network. container-test-run-dm-wireguard-star> peer2 # [1565180.756273] peer2 systemd-networkd[207]: wg-star: netdev ready container-test-run-dm-wireguard-star> peer2 # [1565180.756294] peer2 systemd[1]: Starting Enable Persistent Storage in systemd-networkd... container-test-run-dm-wireguard-star> peer2 # [1565180.756416] peer2 systemd-networkd[207]: eth1: Link UP container-test-run-dm-wireguard-star> peer2 # [1565180.756553] peer2 systemd-networkd[207]: eth1: Gained carrier container-test-run-dm-wireguard-star> peer2 # [1565180.769348] peer2 systemd-networkd[207]: wg-star: Link UP container-test-run-dm-wireguard-star> peer2 # [1565180.769352] peer2 systemd-networkd[207]: wg-star: Gained carrier container-test-run-dm-wireguard-star> peer2 # [1565180.781488] peer2 systemd[1]: Finished Enable Persistent Storage in systemd-networkd. container-test-run-dm-wireguard-star> peer2 # [1565181.096535] peer2 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [1565181.123202] peer2 systemd-resolved[136]: Positive Trust Anchors: container-test-run-dm-wireguard-star> peer2 # [1565181.123210] peer2 systemd-resolved[136]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d container-test-run-dm-wireguard-star> peer2 # [1565181.123213] peer2 systemd-resolved[136]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 container-test-run-dm-wireguard-star> peer2 # [1565181.123229] peer2 systemd-resolved[136]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test container-test-run-dm-wireguard-star> peer2 # [1565181.133561] peer2 systemd-resolved[136]: Using system hostname 'peer2'. container-test-run-dm-wireguard-star> peer2 # [1565181.134629] peer2 systemd[1]: Started Network Name Resolution. container-test-run-dm-wireguard-star> peer2 # [1565181.134684] peer2 systemd[1]: Reached target Network. container-test-run-dm-wireguard-star> peer2 # [1565181.134719] peer2 systemd[1]: Reached target System Initialization. container-test-run-dm-wireguard-star> peer2 # [1565181.134773] peer2 systemd[1]: Started Watch for WireGuard controller info from data-mesher. container-test-run-dm-wireguard-star> peer2 # [1565181.134786] peer2 systemd[1]: Started Periodic heartbeat re-publish for dm-wireguard-star peer. container-test-run-dm-wireguard-star> peer2 # [1565181.134802] peer2 systemd[1]: Discard unused filesystem blocks once a week skipped, unmet condition check ConditionVirtualization=!container container-test-run-dm-wireguard-star> peer2 # [1565181.134813] peer2 systemd[1]: Started Daily Cleanup of Temporary Directories. container-test-run-dm-wireguard-star> peer2 # [1565181.134824] peer2 systemd[1]: Reached target Path Units. container-test-run-dm-wireguard-star> peer2 # [1565181.134842] peer2 systemd[1]: Reached target Timer Units. container-test-run-dm-wireguard-star> peer2 # [1565181.134918] peer2 systemd[1]: Listening on D-Bus System Message Bus Socket. container-test-run-dm-wireguard-star> peer2 # [1565181.134978] peer2 systemd[1]: Listening on Nix Daemon Socket. container-test-run-dm-wireguard-star> peer2 # [1565181.135052] peer2 systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. container-test-run-dm-wireguard-star> peer2 # [1565181.135064] peer2 systemd[1]: Reached target Socket Units. container-test-run-dm-wireguard-star> peer2 # [1565181.135086] peer2 systemd[1]: Reached target Basic System. container-test-run-dm-wireguard-star> peer2 # [1565181.136187] peer2 systemd[1]: Starting data mesher daemon... container-test-run-dm-wireguard-star> peer2 # [1565181.136616] peer2 systemd[1]: Starting Import lastlog data into lastlog2 database... container-test-run-dm-wireguard-star> peer2 # [1565181.137035] peer2 systemd[1]: Starting Name Service Cache Daemon (nsncd)... container-test-run-dm-wireguard-star> peer2 # [1565181.137655] peer2 systemd[1]: Starting D-Bus System Message Bus... container-test-run-dm-wireguard-star> peer2 # [1565181.171851] peer2 systemd[1]: Finished Import lastlog data into lastlog2 database. container-test-run-dm-wireguard-star> peer2 # [1565181.272212] peer2 nsncd[224]: Sep 22 10:03:15.695 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" container-test-run-dm-wireguard-star> peer2 # [1565181.272315] peer2 systemd[1]: Started Name Service Cache Daemon (nsncd). container-test-run-dm-wireguard-star> peer2 # [1565181.272347] peer2 systemd[1]: Reached target Host and Network Name Lookups. container-test-run-dm-wireguard-star> peer2 # [1565181.272378] peer2 systemd[1]: Reached target User and Group Name Lookups. container-test-run-dm-wireguard-star> peer2 # [1565181.273181] peer2 systemd[1]: Starting User Login Management... container-test-run-dm-wireguard-star> peer2 # [1565181.273775] peer2 systemd[1]: Starting Permit User Sessions... container-test-run-dm-wireguard-star> peer2 # [1565181.301535] peer2 systemd[1]: Finished Permit User Sessions. container-test-run-dm-wireguard-star> peer2 # [1565181.302412] peer2 systemd[1]: Started Console Getty. container-test-run-dm-wireguard-star> peer2 # [1565181.302443] peer2 systemd[1]: Getty on tty1 skipped, unmet condition check ConditionPathExists=/dev/tty0 container-test-run-dm-wireguard-star> peer2 # [1565181.302463] peer2 systemd[1]: Reached target Login Prompts. container-test-run-dm-wireguard-star> peer2 # [1565181.399807] peer2 dbus-broker-launch[225]: Looking up NSS user entry for 'systemd-timesync'... container-test-run-dm-wireguard-star> peer2 # [1565181.400256] peer2 dbus-broker-launch[225]: NSS returned no entry for 'systemd-timesync' container-test-run-dm-wireguard-star> peer2 # [1565181.400256] peer2 dbus-broker-launch[225]: Invalid user-name in /nix/store/dncjva6ykxgm65vmc39bmm0pmxka5mdd-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" container-test-run-dm-wireguard-star> peer2 # [1565181.400484] peer2 systemd[1]: Started D-Bus System Message Bus. container-test-run-dm-wireguard-star> peer2 # [1565181.403971] peer2 dbus-broker-launch[225]: Ready container-test-run-dm-wireguard-star> peer2 # [1565181.705076] peer2 data-mesher[222]: time=2026-09-22T10:03:16.128Z level=DEBUG msg="http config" listen_addresses="[[::1]:7331 127.0.0.1:7331]" port=7331 interfaces=[lo] container-test-run-dm-wireguard-star> peer2 # [1565181.706468] peer2 data-mesher[222]: time=2026-09-22T10:03:16.129Z level=DEBUG msg="cluster config" port=7946 interfaces=[] bootstrap_peers="[{12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf: [/dns/controller.clan/tcp/7946]} {12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq: [/dns/peer1.clan/tcp/7946]} {12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB: [/dns/peer2.clan/tcp/7946]}]" push_pull_interval=5s peer_id=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB container-test-run-dm-wireguard-star> peer2 # [1565181.706468] peer2 data-mesher[222]: time=2026-09-22T10:03:16.129Z level=INFO msg="config loaded" config_file=/etc/data-mesher/dm.toml container-test-run-dm-wireguard-star> peer2 # [1565181.821975] peer2 data-mesher[222]: time=2026-09-22T10:03:16.245Z level=INFO msg="checking file integrity" container-test-run-dm-wireguard-star> peer2 # [1565181.822104] peer2 data-mesher[222]: time=2026-09-22T10:03:16.245Z level=INFO msg="file integrity check complete" container-test-run-dm-wireguard-star> peer2 # [1565181.825635] peer2 data-mesher[222]: time=2026-09-22T10:03:16.248Z level=INFO msg="libp2p host created" peer_id=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB addresses="[/ip4/127.0.0.1/tcp/7946 /ip4/192.168.1.3/tcp/7946 /ip6/::1/tcp/7946 /ip6/2001:db8:1::3/tcp/7946 /ip6/fda1:5c8::a86c:9d2:4d89:7c9c/tcp/7946]" container-test-run-dm-wireguard-star> peer2 # [1565181.825701] peer2 data-mesher[222]: time=2026-09-22T10:03:16.249Z level=INFO msg="registered HTTP route" method=PUT path=/files/:name container-test-run-dm-wireguard-star> peer2 # [1565181.825701] peer2 data-mesher[222]: time=2026-09-22T10:03:16.249Z level=INFO msg="registered HTTP route" method=DELETE path=/files/:name container-test-run-dm-wireguard-star> peer2 # [1565181.825701] peer2 data-mesher[222]: time=2026-09-22T10:03:16.249Z level=INFO msg="registered HTTP route" method=GET path=/files container-test-run-dm-wireguard-star> peer2 # [1565181.825701] peer2 data-mesher[222]: time=2026-09-22T10:03:16.249Z level=INFO msg="starting server" container-test-run-dm-wireguard-star> peer2 # [1565181.825790] peer2 data-mesher[222]: time=2026-09-22T10:03:16.249Z level=INFO msg="waiting for DHT to populate" delay=10s container-test-run-dm-wireguard-star> peer2 # [1565181.825816] peer2 data-mesher[222]: time=2026-09-22T10:03:16.249Z level=INFO msg="HTTP server listening" address=[::1]:7331 container-test-run-dm-wireguard-star> peer2 # [1565181.825843] peer2 data-mesher[222]: time=2026-09-22T10:03:16.249Z level=INFO msg="HTTP server listening" address=127.0.0.1:7331 container-test-run-dm-wireguard-star> peer2 # [1565181.827774] peer2 data-mesher[222]: time=2026-09-22T10:03:16.251Z level=INFO msg="peer connected" peer_id=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq remote_addr=/ip4/192.168.1.2/tcp/7946 container-test-run-dm-wireguard-star> peer2 # [1565181.830408] peer2 data-mesher[222]: time=2026-09-22T10:03:16.253Z level=INFO msg="peer connected" peer_id=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf remote_addr=/ip4/192.168.1.1/tcp/7946 container-test-run-dm-wireguard-star> peer2 # [1565181.920828] peer2 systemd-logind[242]: New seat seat0. container-test-run-dm-wireguard-star> peer2 # [1565181.920983] peer2 systemd[1]: Started User Login Management. container-test-run-dm-wireguard-star> peer2 # [1565181.921858] peer2 systemd[1]: Starting linger-users.service... container-test-run-dm-wireguard-star> peer2 # [1565181.952554] peer2 systemd[1]: linger-users.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [1565181.952684] peer2 systemd[1]: Finished linger-users.service. container-test-run-dm-wireguard-star> controller # [1565181.830640] controller data-mesher[233]: time=2026-09-22T10:03:16.253Z level=INFO msg="peer connected" peer_id=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-dm-wireguard-star> peer1 # [1565181.828070] peer1 data-mesher[222]: time=2026-09-22T10:03:16.251Z level=INFO msg="peer connected" peer_id=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB remote_addr=/ip4/192.168.1.3/tcp/7946 container-test-run-dm-wireguard-star> peer2 # [1565182.528109] peer2 systemd-networkd[207]: eth1: Gained IPv6LL container-test-run-dm-wireguard-star> peer2 # [1565183.138615] peer2 data-mesher[222]: time=2026-09-22T10:03:17.561Z level=INFO msg="received state sync from peer" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer2 # [1565183.138615] peer2 data-mesher[222]: time=2026-09-22T10:03:17.561Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer2 # [1565183.138962] peer2 data-mesher[222]: time=2026-09-22T10:03:17.562Z level=DEBUG msg="new file detected" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 container-test-run-dm-wireguard-star> peer2 # [1565183.138962] peer2 data-mesher[222]: time=2026-09-22T10:03:17.562Z level=DEBUG msg="new file detected" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 name=dm_wg_star_wg_star/controller name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer2 # [1565183.138962] peer2 data-mesher[222]: time=2026-09-22T10:03:17.562Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 container-test-run-dm-wireguard-star> peer2 # [1565183.138962] peer2 data-mesher[222]: time=2026-09-22T10:03:17.562Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> peer2 # [1565183.138962] peer2 data-mesher[222]: time=2026-09-22T10:03:17.562Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/controller signed_at="2026-09-22 10:03:02.594 +0000 UTC" signed_by="cREIDwXB4wUgEMCrgbgoubTWdxQ5XZOhUEUDIUfjn9U=" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer2 # [1565183.138962] peer2 data-mesher[222]: time=2026-09-22T10:03:17.562Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 signed_at="2026-09-22 10:03:02.638 +0000 UTC" signed_by="VDU8UNcOwUoZNE7vX+ycOFhGRqE52EtBFIiryhsNGy4=" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer2 # [1565183.144595] peer2 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer2 # [1565183.240111] peer2 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [1565183.240290] peer2 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer2 # [1565183.353662] peer2 data-mesher[222]: time=2026-09-22T10:03:17.776Z level=INFO msg="download complete" name=dm_wg_star_wg_star/controller signed_at="2026-09-22 10:03:02.594 +0000 UTC" signed_by="cREIDwXB4wUgEMCrgbgoubTWdxQ5XZOhUEUDIUfjn9U=" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf written=true elapsed=214.813337ms container-test-run-dm-wireguard-star> peer2 # [1565183.358168] peer2 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer2 # [1565183.385969] peer2 data-mesher[222]: time=2026-09-22T10:03:17.809Z level=INFO msg="download complete" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 signed_at="2026-09-22 10:03:02.638 +0000 UTC" signed_by="VDU8UNcOwUoZNE7vX+ycOFhGRqE52EtBFIiryhsNGy4=" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf written=true elapsed=247.155623ms container-test-run-dm-wireguard-star> peer1 # [1565183.138098] peer1 data-mesher[222]: time=2026-09-22T10:03:17.561Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [1565183.138098] peer1 data-mesher[222]: time=2026-09-22T10:03:17.561Z level=DEBUG msg="initiating state exchange" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565183.138562] peer1 data-mesher[222]: time=2026-09-22T10:03:17.561Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565183.138620] peer1 data-mesher[222]: time=2026-09-22T10:03:17.561Z level=INFO msg="state exchange complete" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565183.138646] peer1 data-mesher[222]: time=2026-09-22T10:03:17.561Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [1565183.138109] controller data-mesher[233]: time=2026-09-22T10:03:17.561Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [1565183.138109] controller data-mesher[233]: time=2026-09-22T10:03:17.561Z level=DEBUG msg="initiating state exchange" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB timeout=5s container-test-run-dm-wireguard-star> controller # [1565183.138555] controller data-mesher[233]: time=2026-09-22T10:03:17.561Z level=INFO msg="received state sync from peer" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565183.138555] controller data-mesher[233]: time=2026-09-22T10:03:17.561Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565183.138886] controller data-mesher[233]: time=2026-09-22T10:03:17.562Z level=INFO msg="merging remote state" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB container-test-run-dm-wireguard-star> controller # [1565183.138886] controller data-mesher[233]: time=2026-09-22T10:03:17.562Z level=INFO msg="state exchange complete" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB timeout=5s container-test-run-dm-wireguard-star> controller # [1565183.138886] controller data-mesher[233]: time=2026-09-22T10:03:17.562Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [1565183.139142] controller data-mesher[233]: time=2026-09-22T10:03:17.562Z level=INFO msg="received file request" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 container-test-run-dm-wireguard-star> controller # [1565183.139142] controller data-mesher[233]: time=2026-09-22T10:03:17.562Z level=INFO msg="received file request" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [1565183.139706] controller data-mesher[233]: time=2026-09-22T10:03:17.563Z level=INFO msg="file transfer complete" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/controller container-test-run-dm-wireguard-star> controller # [1565183.151071] controller data-mesher[233]: time=2026-09-22T10:03:17.571Z level=INFO msg="file transfer complete" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/VDU8UNcOwUoZNE7vX-ycOFhGRqE52EtBFIiryhsNGy4 container-test-run-dm-wireguard-star> peer2 # [1565183.434007] peer2 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [1565183.434180] peer2 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer1 # [1565188.138933] peer1 data-mesher[222]: time=2026-09-22T10:03:22.562Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [1565188.138933] peer1 data-mesher[222]: time=2026-09-22T10:03:22.562Z level=DEBUG msg="initiating state exchange" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565188.139467] peer1 data-mesher[222]: time=2026-09-22T10:03:22.562Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565188.139534] peer1 data-mesher[222]: time=2026-09-22T10:03:22.562Z level=INFO msg="state exchange complete" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565188.139558] peer1 data-mesher[222]: time=2026-09-22T10:03:22.562Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer2 # [1565188.139414] peer2 data-mesher[222]: time=2026-09-22T10:03:22.562Z level=INFO msg="received state sync from peer" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer2 # [1565188.139414] peer2 data-mesher[222]: time=2026-09-22T10:03:22.562Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> controller # [1565188.139103] controller data-mesher[233]: time=2026-09-22T10:03:22.562Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [1565188.139103] controller data-mesher[233]: time=2026-09-22T10:03:22.562Z level=DEBUG msg="initiating state exchange" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB timeout=5s container-test-run-dm-wireguard-star> controller # [1565188.139440] controller data-mesher[233]: time=2026-09-22T10:03:22.562Z level=INFO msg="received state sync from peer" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565188.139440] controller data-mesher[233]: time=2026-09-22T10:03:22.562Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565188.139605] controller data-mesher[233]: time=2026-09-22T10:03:22.562Z level=INFO msg="merging remote state" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB container-test-run-dm-wireguard-star> controller # [1565188.139667] controller data-mesher[233]: time=2026-09-22T10:03:22.563Z level=INFO msg="state exchange complete" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB timeout=5s container-test-run-dm-wireguard-star> controller # [1565188.139690] controller data-mesher[233]: time=2026-09-22T10:03:22.563Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer2: still waiting for container 'peer2' to reach ready state... container-test-run-dm-wireguard-star> peer2: (finished: waiting for unit data-mesher.service, in 12.65 seconds) container-test-run-dm-wireguard-star> ??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-dm-wireguard-star> File "/nix/store/wx1n220i63nlp13ay89xca3zps8qcr6w-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-dm-wireguard-star> controller: waiting for success: test $(ls /var/lib/data-mesher/files/home/dm_wg_star_wg_star/ | grep -v controller | wc -l) -gt 1 container-test-run-dm-wireguard-star> ??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead. container-test-run-dm-wireguard-star> File "/nix/store/wx1n220i63nlp13ay89xca3zps8qcr6w-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 39 container-test-run-dm-wireguard-star> peer1 # [1565191.826959] peer1 data-mesher[222]: time=2026-09-22T10:03:26.250Z level=INFO msg="received state sync from peer" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB container-test-run-dm-wireguard-star> peer1 # [1565191.826959] peer1 data-mesher[222]: time=2026-09-22T10:03:26.250Z level=INFO msg="merging remote state" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB container-test-run-dm-wireguard-star> peer2 # [1565191.826509] peer2 data-mesher[222]: time=2026-09-22T10:03:26.249Z level=INFO msg="performing state exchange with peers on join" count=1 container-test-run-dm-wireguard-star> peer2 # [1565191.826509] peer2 data-mesher[222]: time=2026-09-22T10:03:26.249Z level=DEBUG msg="initiating state exchange" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> peer2 # [1565191.827198] peer2 data-mesher[222]: time=2026-09-22T10:03:26.250Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> peer2 # [1565191.827280] peer2 data-mesher[222]: time=2026-09-22T10:03:26.250Z level=INFO msg="state exchange complete" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> peer2 # [1565191.827280] peer2 data-mesher[222]: time=2026-09-22T10:03:26.250Z level=INFO msg="server started" container-test-run-dm-wireguard-star> peer2 # [1565191.827381] peer2 data-mesher[222]: time=2026-09-22T10:03:26.250Z level=INFO msg="starting expired-file sweeper" interval=1m0s container-test-run-dm-wireguard-star> peer2 # [1565191.827455] peer2 systemd[1]: Started data mesher daemon. container-test-run-dm-wireguard-star> peer2 # [1565191.828305] peer2 systemd[1]: Starting Publish WireGuard peer info to data-mesher... container-test-run-dm-wireguard-star> peer2 # [1565191.908197] peer2 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer2 # [1565191.936607] peer2 data-mesher[222]: time=2026-09-22T10:03:26.359Z level=INFO msg=http_request uri=/files/dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw status=204 container-test-run-dm-wireguard-star> peer2 # [1565191.936662] peer2 dm-wg-star-publish[299]: Status: 204 No Content container-test-run-dm-wireguard-star> peer2 # [1565191.939010] peer2 systemd[1]: dm-wg-star-wg-star-publish.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [1565191.939124] peer2 systemd[1]: Finished Publish WireGuard peer info to data-mesher. container-test-run-dm-wireguard-star> peer2 # [1565191.939354] peer2 systemd[1]: Reached target Multi-User System. container-test-run-dm-wireguard-star> peer2 # [1565191.979291] peer2 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer2 # [1565191.979382] peer2 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer2 # [1565191.979509] peer2 systemd[1]: Startup finished in 12.162s. container-test-run-dm-wireguard-star> peer1 # [1565193.139987] peer1 data-mesher[222]: time=2026-09-22T10:03:27.563Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [1565193.139987] peer1 data-mesher[222]: time=2026-09-22T10:03:27.563Z level=DEBUG msg="initiating state exchange" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565193.140367] peer1 data-mesher[222]: time=2026-09-22T10:03:27.563Z level=INFO msg="received state sync from peer" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565193.140367] peer1 data-mesher[222]: time=2026-09-22T10:03:27.563Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565193.140629] peer1 data-mesher[222]: time=2026-09-22T10:03:27.563Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565193.140689] peer1 data-mesher[222]: time=2026-09-22T10:03:27.564Z level=INFO msg="state exchange complete" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565193.140715] peer1 data-mesher[222]: time=2026-09-22T10:03:27.564Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [1565193.139982] controller data-mesher[233]: time=2026-09-22T10:03:27.563Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [1565193.139982] controller data-mesher[233]: time=2026-09-22T10:03:27.563Z level=DEBUG msg="initiating state exchange" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565193.143098] controller data-mesher[233]: time=2026-09-22T10:03:27.563Z level=INFO msg="received state sync from peer" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565193.143098] controller data-mesher[233]: time=2026-09-22T10:03:27.563Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565193.143098] controller data-mesher[233]: time=2026-09-22T10:03:27.563Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565193.143098] controller data-mesher[233]: time=2026-09-22T10:03:27.563Z level=INFO msg="state exchange complete" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565193.143098] controller data-mesher[233]: time=2026-09-22T10:03:27.563Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer1 # [1565196.829786] peer1 data-mesher[222]: time=2026-09-22T10:03:31.253Z level=INFO msg="received state sync from peer" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB container-test-run-dm-wireguard-star> peer1 # [1565196.829786] peer1 data-mesher[222]: time=2026-09-22T10:03:31.253Z level=INFO msg="merging remote state" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB container-test-run-dm-wireguard-star> peer1 # [1565196.830221] peer1 data-mesher[222]: time=2026-09-22T10:03:31.253Z level=DEBUG msg="new file detected" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw container-test-run-dm-wireguard-star> peer1 # [1565196.830221] peer1 data-mesher[222]: time=2026-09-22T10:03:31.253Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw container-test-run-dm-wireguard-star> peer1 # [1565196.830221] peer1 data-mesher[222]: time=2026-09-22T10:03:31.253Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw signed_at="2026-09-22 10:03:26.329 +0000 UTC" signed_by="Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw=" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB container-test-run-dm-wireguard-star> peer1 # [1565196.833059] peer1 systemd[1]: Starting Reconfigure WireGuard with controller from data-mesher... container-test-run-dm-wireguard-star> peer1 # [1565196.910630] peer1 systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> peer1 # [1565196.910722] peer1 systemd[1]: Finished Reconfigure WireGuard with controller from data-mesher. container-test-run-dm-wireguard-star> peer1 # [1565197.014603] peer1 data-mesher[222]: time=2026-09-22T10:03:31.437Z level=INFO msg="download complete" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw signed_at="2026-09-22 10:03:26.329 +0000 UTC" signed_by="Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw=" peer=12D3KooWE1KyBMCiYHQmw9yb5NdjxwSNrZb8Gmf18vZ9ZpjEkPvB written=true elapsed=184.495284ms container-test-run-dm-wireguard-star> peer2 # [1565196.829416] peer2 data-mesher[222]: time=2026-09-22T10:03:31.252Z level=DEBUG msg="attempting push/pull" peer_count=2 container-test-run-dm-wireguard-star> peer2 # [1565196.829416] peer2 data-mesher[222]: time=2026-09-22T10:03:31.252Z level=DEBUG msg="initiating state exchange" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> peer2 # [1565196.830111] peer2 data-mesher[222]: time=2026-09-22T10:03:31.253Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> peer2 # [1565196.830190] peer2 data-mesher[222]: time=2026-09-22T10:03:31.253Z level=INFO msg="state exchange complete" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> peer2 # [1565196.830209] peer2 data-mesher[222]: time=2026-09-22T10:03:31.253Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer2 # [1565196.830260] peer2 data-mesher[222]: time=2026-09-22T10:03:31.253Z level=INFO msg="received file request" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw container-test-run-dm-wireguard-star> peer2 # [1565196.831087] peer2 data-mesher[222]: time=2026-09-22T10:03:31.254Z level=INFO msg="file transfer complete" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw container-test-run-dm-wireguard-star> controller: (finished: waiting for success: test $(ls /var/lib/data-mesher/files/home/dm_wg_star_wg_star/ | grep -v controller | wc -l) -gt 1, in 6.04 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: test $(wg show wg-star peers | wc -l) -gt 1 container-test-run-dm-wireguard-star> peer1 # [1565198.141129] peer1 data-mesher[222]: time=2026-09-22T10:03:32.564Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> peer1 # [1565198.141129] peer1 data-mesher[222]: time=2026-09-22T10:03:32.564Z level=DEBUG msg="initiating state exchange" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565198.141427] peer1 data-mesher[222]: time=2026-09-22T10:03:32.564Z level=INFO msg="received state sync from peer" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565198.141427] peer1 data-mesher[222]: time=2026-09-22T10:03:32.564Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565198.141637] peer1 data-mesher[222]: time=2026-09-22T10:03:32.564Z level=INFO msg="merging remote state" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf container-test-run-dm-wireguard-star> peer1 # [1565198.141692] peer1 data-mesher[222]: time=2026-09-22T10:03:32.565Z level=INFO msg="received file request" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw container-test-run-dm-wireguard-star> peer1 # [1565198.141692] peer1 data-mesher[222]: time=2026-09-22T10:03:32.565Z level=INFO msg="state exchange complete" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf timeout=5s container-test-run-dm-wireguard-star> peer1 # [1565198.141738] peer1 data-mesher[222]: time=2026-09-22T10:03:32.565Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> peer1 # [1565198.142708] peer1 data-mesher[222]: time=2026-09-22T10:03:32.566Z level=INFO msg="file transfer complete" peer=12D3KooWKktANeHJQ32a52JkMUfcrNjwgMWzHzNGvYx3qdEA4Tdf network="8I73NX+mvsflqW2diPk4BODw3xEiqiP5lJIh9De/G7w=" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw container-test-run-dm-wireguard-star> controller # [1565198.141057] controller data-mesher[233]: time=2026-09-22T10:03:32.564Z level=DEBUG msg="attempting push/pull" peer_count=1 container-test-run-dm-wireguard-star> controller # [1565198.141057] controller data-mesher[233]: time=2026-09-22T10:03:32.564Z level=DEBUG msg="initiating state exchange" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565198.141431] controller data-mesher[233]: time=2026-09-22T10:03:32.564Z level=INFO msg="received state sync from peer" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565198.141431] controller data-mesher[233]: time=2026-09-22T10:03:32.564Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565198.141467] controller data-mesher[233]: time=2026-09-22T10:03:32.564Z level=DEBUG msg="new file detected" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw container-test-run-dm-wireguard-star> controller # [1565198.141573] controller data-mesher[233]: time=2026-09-22T10:03:32.564Z level=INFO msg="scheduling file download" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw container-test-run-dm-wireguard-star> controller # [1565198.141595] controller data-mesher[233]: time=2026-09-22T10:03:32.564Z level=INFO msg="downloading file" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw signed_at="2026-09-22 10:03:26.329 +0000 UTC" signed_by="Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw=" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565198.141595] controller data-mesher[233]: time=2026-09-22T10:03:32.564Z level=INFO msg="merging remote state" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq container-test-run-dm-wireguard-star> controller # [1565198.141664] controller data-mesher[233]: time=2026-09-22T10:03:32.564Z level=DEBUG msg="new file detected" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw container-test-run-dm-wireguard-star> controller # [1565198.141725] controller data-mesher[233]: time=2026-09-22T10:03:32.565Z level=INFO msg="state exchange complete" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq timeout=5s container-test-run-dm-wireguard-star> controller # [1565198.141757] controller data-mesher[233]: time=2026-09-22T10:03:32.565Z level=DEBUG msg="push/pull successful" interval=5s container-test-run-dm-wireguard-star> controller # [1565198.144178] controller systemd[1]: Starting Reconfigure WireGuard peers from data-mesher... container-test-run-dm-wireguard-star> controller # [1565198.286157] controller data-mesher[233]: time=2026-09-22T10:03:32.709Z level=INFO msg="download complete" name=dm_wg_star_wg_star/Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw signed_at="2026-09-22 10:03:26.329 +0000 UTC" signed_by="Pj2mVRAeHIVIgf8f1TkE0Py3Qrh6mtU9JWDQEvwDsaw=" peer=12D3KooWFV5Vo3u1NDMtxq4BG7gSTza5Qa9VdqZBxkfkCG2QG4zq written=true elapsed=144.545699ms container-test-run-dm-wireguard-star> controller # [1565198.302670] controller systemd[1]: dm-wg-star-wg-star-reconfig.service: Deactivated successfully. container-test-run-dm-wireguard-star> controller # [1565198.302823] controller systemd[1]: Finished Reconfigure WireGuard peers from data-mesher. container-test-run-dm-wireguard-star> controller: (finished: waiting for success: test $(wg show wg-star peers | wc -l) -gt 1, in 1.01 seconds) container-test-run-dm-wireguard-star> peer2: waiting for success: wg show wg-star peers | grep -q . container-test-run-dm-wireguard-star> peer2: (finished: waiting for success: wg show wg-star peers | grep -q ., in 0.01 seconds) container-test-run-dm-wireguard-star> peer2: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::5869:ad4a:6504:5243 container-test-run-dm-wireguard-star> peer2: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::5869:ad4a:6504:5243, in 0.53 seconds) container-test-run-dm-wireguard-star> controller: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::a86c:09d2:4d89:7c9c container-test-run-dm-wireguard-star> controller: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::a86c:09d2:4d89:7c9c, in 0.00 seconds) container-test-run-dm-wireguard-star> peer1: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::a86c:09d2:4d89:7c9c container-test-run-dm-wireguard-star> peer1: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::a86c:09d2:4d89:7c9c, in 0.00 seconds) container-test-run-dm-wireguard-star> peer2: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::2025:0c60:174f:9bed container-test-run-dm-wireguard-star> peer2: (finished: waiting for success: ping -6 -c1 -W5 fda1:05c8:00::2025:0c60:174f:9bed, in 0.00 seconds) container-test-run-dm-wireguard-star> (finished: run the VM test script, in 43.95 seconds) container-test-run-dm-wireguard-star> test script finished in 44.22s container-test-run-dm-wireguard-star> cleanup container-test-run-dm-wireguard-star> kill NspawnMachine (pid 50) container-test-run-dm-wireguard-star> kill NspawnMachine (pid 53) container-test-run-dm-wireguard-star> Container controller terminated by signal KILL. container-test-run-dm-wireguard-star> kill NspawnMachine (pid 742) container-test-run-dm-wireguard-star> Container peer1 terminated by signal KILL. container-test-run-dm-wireguard-star> Container peer2 terminated by signal KILL. container-test-run-dm-wireguard-star> (finished: cleanup, in 0.29 seconds) post-build step Upload to niks3: ok time=2026-09-22T10:03:35.039Z level=INFO msg="Uploading 0 paths to niks3.clan.lol (1 already cached)" time=2026-09-22T10:03:35.737Z level=INFO msg="Uploading 1 narinfos" time=2026-09-22T10:03:36.539Z level=INFO msg="Upload complete. (1.585s)"