(finished: must succeed: mkdir -p /tmp/shared/tmpf5arupga, in 0.02 seconds)
client: �[1m�[32mmust succeed: mkdir -p /etc/ssl/certs�[0m
(finished: must succeed: mkdir -p /etc/ssl/certs, in 0.02 seconds)
client: �[1m�[32mmust succeed: cp -r /tmp/shared/tmpf5arupga/ca-certificates.crt /etc/ssl/certs/ca-certificates.crt�[0m
(finished: must succeed: cp -r /tmp/shared/tmpf5arupga/ca-certificates.crt /etc/ssl/certs/ca-certificates.crt, in 0.02 seconds)
�[1m�[32msubtest: access�[0m
curl --show-error --location --cookie-jar cookie.txt --cookie cookie.txt --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 --connect-to auth.example.com:443:server:443 --silent --output /dev/null --write-out '{"code":%{response_code}}' https://n.example.com
�[2mserver # [  191.570786] systemd[1]: Started nextcloud-update-db.service.�[0m
�[2mserver # [  191.572210] systemd[1]: Startup finished in 2.777s (kernel) + 3min 8.793s (userspace) = 3min 11.570s.�[0m
�[2mserver # [  196.383406] lldap-start[929]: 2024-08-15T00:44:16.848198003+00:00  INFO     LDAP session [ 91.8ms | 0.19% / 100.00% ]�[0m
�[2mserver # [  196.384308] lldap-start[929]: 2024-08-15T00:44:16.849320771+00:00  INFO     ┝━ LDAP request [ 90.9ms | 99.02% ]�[0m
�[2mserver # [  196.385031] lldap-start[929]: 2024-08-15T00:44:16.945517913+00:00  INFO     ┝━ LDAP request [ 714µs | 0.78% ]�[0m
�[2mserver # [  196.385735] lldap-start[929]: 2024-08-15T00:44:16.946545139+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute ""memberof"" in filter.\n\�[0m
�[2mserver # [  196.386693] lldap-start[929]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  196.387529] lldap-start[929]: 2024-08-15T00:44:17.888334388+00:00  INFO     ┕━ LDAP request [ 6.15µs | 0.01% ]�[0m
(finished: subtest: access, in 8.34 seconds)
�[1m�[32msubtest: extraScript�[0m
�[1m�[32msubtest: cron job succeeds�[0m
�[2mserver # [  196.441144] systemd[1]: Starting nextcloud-cron.service...�[0m
�[2mserver # [  198.345496] nextcloud-update-db-start[2782]: Done.�[0m
�[2mserver # [  201.551336] systemd[1]: Started nextcloud-cron.service.�[0m
�[2mserver # [  205.154224] nextcloud-update-db-start[2798]: Adding additional fs_storage_path_prefix index to the oc_filecache table, this can take some time...�[0m
�[2mserver # [  207.254093] Nextcloud[2812]: �[0;1;31m{"reqId":"sX3wMNLjCqs2VTT1SZ2f","level":3,"time":"2024-08-15T00:44:28+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/wd0i8dqpp8ngryki9chihc67n5v3izfh-nextcloud-28.0.6/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.6.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  207.261042] Nextcloud[2812]: �[0;1;31m{"reqId":"sX3wMNLjCqs2VTT1SZ2f","level":3,"time":"2024-08-15T00:44:28+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/wd0i8dqpp8ngryki9chihc67n5v3izfh-nextcloud-28.0.6/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.6.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  207.266303] Nextcloud[2812]: �[0;1;31m{"reqId":"sX3wMNLjCqs2VTT1SZ2f","level":3,"time":"2024-08-15T00:44:28+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/wd0i8dqpp8ngryki9chihc67n5v3izfh-nextcloud-28.0.6/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.6.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  207.273039] Nextcloud[2812]: �[0;1;31m{"reqId":"sX3wMNLjCqs2VTT1SZ2f","level":3,"time":"2024-08-15T00:44:28+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/wd0i8dqpp8ngryki9chihc67n5v3izfh-nextcloud-28.0.6/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.6.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  207.316855] Nextcloud[2812]: �[0;1;38;5;185m{"reqId":"sX3wMNLjCqs2VTT1SZ2f","level":2,"time":"2024-08-15T00:44:28+00:00","remoteAddr":"","user":"--","app":"appstoreFetcher","method":"","url":"--","message":"{\"Exception\":\"OCP\\\\Http\\\\Client\\\\LocalServerException\",\"Message\":\"No DNS record found for apps.nextcloud.com\",\"Code\":0,\"Trace\":[{\"file\":\"/nix/store/wd0i8dqpp8ngryki9chihc67n5v3izfh-nextcloud-28.0.6/3rdparty/guzzlehttp/guzzle/src/PrepareBodyMiddleware.php\",\"line\":35,\"function\":\"OC\\\\Http\\\\Client\\\\{closure}\",\"class\":\"OC\\\\Http\\\\Client\\\\DnsPinMiddleware\",\"type\":\"->\",\"args\":[\"**…
�[2mserver # [  207.683104] Nextcloud[2812]: �[0;1;31m{"reqId":"sX3wMNLjCqs2VTT1SZ2f","level":3,"time":"2024-08-15T00:44:29+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/wd0i8dqpp8ngryki9chihc67n5v3izfh-nextcloud-28.0.6/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.6.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  207.689306] Nextcloud[2812]: �[0;1;31m{"reqId":"sX3wMNLjCqs2VTT1SZ2f","level":3,"time":"2024-08-15T00:44:29+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/wd0i8dqpp8ngryki9chihc67n5v3izfh-nextcloud-28.0.6/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.6.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  207.694339] Nextcloud[2812]: �[0;1;31m{"reqId":"sX3wMNLjCqs2VTT1SZ2f","level":3,"time":"2024-08-15T00:44:29+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/wd0i8dqpp8ngryki9chihc67n5v3izfh-nextcloud-28.0.6/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.6.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  207.701038] Nextcloud[2812]: �[0;1;31m{"reqId":"sX3wMNLjCqs2VTT1SZ2f","level":3,"time":"2024-08-15T00:44:29+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/wd0i8dqpp8ngryki9chihc67n5v3izfh-nextcloud-28.0.6/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.6.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  210.883403] lldap-start[929]: 2024-08-15T00:44:26.225162672+00:00  INFO     LDAP session [ 99.5ms | 0.19% / 100.00% ]�[0m
�[2mserver # [  210.884241] lldap-start[929]: 2024-08-15T00:44:26.226324272+00:00  INFO     ┝━ LDAP request [ 96.3ms | 96.82% ]�[0m
�[2mserver # [  210.885027] lldap-start[929]: 2024-08-15T00:44:26.328173529+00:00  INFO     ┝━ LDAP request [ 2.23ms | 2.25% ]�[0m
�[2mserver # [  210.885782] lldap-start[929]: 2024-08-15T00:44:26.329062469+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute ""memberof"" in filter.\n\�[0m
�[2mserver # [  210.886806] lldap-start[929]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  210.887695] lldap-start[929]: 2024-08-15T00:44:32.154462624+00:00  INFO     ┝━ LDAP request [ 734µs | 0.74% ]�[0m
�[2mserver # [  210.888455] lldap-start[929]: 2024-08-15T00:44:32.389383542+00:00  INFO     ┕━ LDAP request [ 4.75µs | 0.00% ]�[0m
�[2mserver # [  210.917378] systemd[1]: nextcloud-cron.service: Deactivated successfully.�[0m
�[2mserver # [  210.920626] systemd[1]: nextcloud-cron.service: Consumed 6.435s CPU time, 56.5M memory peak, 0B memory swap peak, no IO, received 466B IP traffic, sent 2.2K IP traffic.�[0m
�[2mserver # [  211.453120] nextcloud-update-db-start[2798]: oc_filecache table updated successfully.�[0m
�[2mserver # [  215.091732] nextcloud-update-db-start[2830]: Done.�[0m
�[2mserver # [  215.115196] systemd[1]: nextcloud-update-db.service: Deactivated successfully.�[0m
�[2mserver # [  215.117841] systemd[1]: nextcloud-update-db.service: Consumed 15.330s CPU time, no IP traffic.�[0m
(finished: subtest: cron job succeeds, in 20.39 seconds)
�[1m�[32msubtest: fails with incorrect authentication�[0m
client: �[1m�[32mmust fail: curl -f -s --location -X PROPFIND -H "Depth: 1"  -u root:other  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 https://n.example.com/remote.php/dav/files/root/�[0m
�[2mserver # [  218.723238] Nextcloud[2771]: �[0;1;38;5;185m{"reqId":"Muxt4YYPVRkXpeGI3fb7","level":2,"time":"2024-08-15T00:44:40+00:00","remoteAddr":"192.168.1.1","user":"--","app":"core","method":"PROPFIND","url":"/remote.php/dav/files/root/","message":"Login failed: 'root' (Remote IP: '192.168.1.1')","userAgent":"curl/8.7.1","version":"28.0.6.1","data":{"app":"core"}}�[0m�[0m
�[2mserver # [  218.963385] lldap-start[929]: 2024-08-15T00:44:39.766573380+00:00  INFO     LDAP session [ 51.1ms | 0.56% / 100.00% ]�[0m
�[2mserver # [  218.964186] lldap-start[929]: 2024-08-15T00:44:39.766671996+00:00  INFO     ┝━ LDAP request [ 46.6ms | 91.21% ]�[0m
�[2mserver # [  218.964878] lldap-start[929]: 2024-08-15T00:44:39.815560332+00:00  INFO     ┝━ LDAP request [ 1.55ms | 3.03% ]�[0m
�[2mserver # [  218.965929] lldap-start[929]: 2024-08-15T00:44:39.815908701+00:00  WARN     │  ┝━ 🚧 [warn]: Ignoring unknown group attribute ""memberof"" in filter.\n\�[0m
�[2mserver # [  218.966902] lldap-start[929]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  218.967724] lldap-start[929]: 2024-08-15T00:44:39.815913729+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute ""mail"" in filter.\n\�[0m
�[2mserver # [  218.968690] lldap-start[929]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  218.970298] lldap-start[929]: 2024-08-15T00:44:40.058640668+00:00  INFO     ┝━ LDAP request [ 858µs | 1.68% ]�[0m
�[2mserver # [  218.971087] lldap-start[929]: 2024-08-15T00:44:40.059087931+00:00  WARN     │  ┝━ 🚧 [warn]: Ignoring unknown group attribute ""memberof"" in filter.\n\�[0m
�[2mserver # [  218.972322] lldap-start[929]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  218.973215] lldap-start[929]: 2024-08-15T00:44:40.059093519+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute ""mail"" in filter.\n\�[0m
�[2mserver # [  218.974280] lldap-start[929]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  218.975159] lldap-start[929]: 2024-08-15T00:44:40.217337094+00:00  INFO     ┝━ LDAP request [ 1.79ms | 3.51% ]�[0m
�[2mserver # [  218.975929] lldap-start[929]: 2024-08-15T00:44:40.217781844+00:00  WARN     │  ┝━ 🚧 [warn]: Ignoring unknown group attribute ""memberof"" in filter.\n\�[0m
(finished: must fail: curl -f -s --location -X PROPFIND -H "Depth: 1"  -u root:other  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 https://n.example.com/remote.php/dav/files/root/, in 2.19 seconds)
�[2mserver # [  218.976973] lldap-start[929]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
client: �[1m�[32mmust fail: curl -f -s --location -X PROPFIND -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 https://n.example.com/remote.php/dav/files/other/�[0m
�[2mserver # [  218.977970] lldap-start[929]: 2024-08-15T00:44:40.217787431+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute ""mail"" in filter.\n\�[0m
�[2mserver # [  218.978875] lldap-start[929]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  218.979717] lldap-start[929]: 2024-08-15T00:44:40.469317723+00:00  INFO     ┕━ LDAP request [ 5.87µs | 0.01% ]�[0m
(finished: must fail: curl -f -s --location -X PROPFIND -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 https://n.example.com/remote.php/dav/files/other/, in 2.27 seconds)
(finished: subtest: fails with incorrect authentication, in 4.46 seconds)
�[1m�[32msubtest: fails with incorrect path�[0m
client: �[1m�[32mmust fail: curl -f -s --location -X PROPFIND -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 https://n.example.com/remote.php/dav/files/other/�[0m
(finished: must fail: curl -f -s --location -X PROPFIND -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 https://n.example.com/remote.php/dav/files/other/, in 1.81 seconds)
(finished: subtest: fails with incorrect path, in 1.81 seconds)
�[1m�[32msubtest: can access webdav�[0m
client: �[1m�[32mmust succeed: curl -f -s --location -X PROPFIND -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 https://n.example.com/remote.php/dav/files/root/�[0m
(finished: must succeed: curl -f -s --location -X PROPFIND -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 https://n.example.com/remote.php/dav/files/root/, in 1.89 seconds)
(finished: subtest: can access webdav, in 1.89 seconds)
�[1m�[32msubtest: can create and retrieve file�[0m
client: �[1m�[32mmust fail: curl -f -s --location -X GET -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 -T file  https://n.example.com/remote.php/dav/files/root/file�[0m
�[2mclient # curl: Can't open 'file'�[0m
�[2mclient # curl: try 'curl --help' for more information�[0m
(finished: must fail: curl -f -s --location -X GET -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 -T file  https://n.example.com/remote.php/dav/files/root/file, in 0.03 seconds)
client: �[1m�[32mmust succeed: echo 'hello' > file�[0m
(finished: must succeed: echo 'hello' > file, in 0.01 seconds)
client: �[1m�[32mmust succeed: curl -f -s --location -X PUT -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 -T file  https://n.example.com/remote.php/dav/files/root/�[0m
(finished: must succeed: curl -f -s --location -X PUT -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 -T file  https://n.example.com/remote.php/dav/files/root/, in 2.61 seconds)
client: �[1m�[32mmust succeed: curl -f -s --location -X GET -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 -T file  https://n.example.com/remote.php/dav/files/root/file�[0m
(finished: must succeed: curl -f -s --location -X GET -H "Depth: 1"  -u root:rootpw  --connect-to n.example.com:443:server:443 --connect-to n.example.com:80:server:80 -T file  https://n.example.com/remote.php/dav/files/root/file, in 1.88 seconds)
(finished: subtest: can create and retrieve file, in 4.54 seconds)
(finished: subtest: extraScript, in 33.09 seconds)
(finished: run the VM test script, in 231.53 seconds)
test script finished in 231.58s
�[1m�[32mcleanup�[0m
kill machine (pid 7)
qemu-kvm: terminating on signal 15 from pid 4 (/nix/store/7hnr99nxrd2aw6lghybqdmkckq60j6l9-python3-3.11.9/bin/python3.11)
kill machine (pid 28)
qemu-kvm: terminating on signal 15 from pid 4 (/nix/store/7hnr99nxrd2aw6lghybqdmkckq60j6l9-python3-3.11.9/bin/python3.11)
(finished: cleanup, in 0.02 seconds)
kill vlan (pid 5)