(finished: must succeed: cp -r /tmp/shared/tmp69k_4ara/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 # [  242.516210] systemd[1]: Started nextcloud-update-db.service.�[0m
�[2mserver # [  242.516893] systemd[1]: Startup finished in 2.742s (kernel) + 3min 59.772s (userspace) = 4min 2.515s.�[0m
�[2mserver # [  247.964239] lldap-start[1054]: 2024-09-14T01:24:20.499069406+00:00  INFO     LDAP session [ 108ms | 0.27% / 100.00% ]�[0m
�[2mserver # [  247.965242] lldap-start[1054]: 2024-09-14T01:24:20.499506892+00:00  INFO     ┝━ LDAP request [ 106ms | 98.19% ]�[0m
�[2mserver # [  247.966178] lldap-start[1054]: 2024-09-14T01:24:20.612320951+00:00  INFO     ┝━ LDAP request [ 1.67ms | 1.54% ]�[0m
�[2mserver # [  247.967091] lldap-start[1054]: 2024-09-14T01:24:20.613991275+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute "memberof" in filter.\n\�[0m
�[2mserver # [  247.968234] lldap-start[1054]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  247.969247] lldap-start[1054]: 2024-09-14T01:24:21.733136306+00:00  INFO     ┕━ LDAP request [ 5.59µs | 0.01% ]�[0m
(finished: subtest: access, in 10.38 seconds)
�[1m�[32msubtest: extraScript�[0m
�[1m�[32msubtest: cron job succeeds�[0m
�[2mserver # [  248.023609] systemd[1]: Starting nextcloud-cron.service...�[0m
�[2mserver # [  250.409649] nextcloud-update-db-start[3240]: Done.�[0m
�[2mserver # [  253.797989] systemd[1]: Started nextcloud-cron.service.�[0m
�[2mserver # [  258.179074] nextcloud-update-db-start[3261]: Adding additional fs_storage_path_prefix index to the oc_filecache table, this can take some time...�[0m
�[2mserver # [  258.847146] Nextcloud[3271]: �[0;1;31m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":3,"time":"2024-09-14T01:24:32+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.9.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  258.855866] Nextcloud[3271]: �[0;1;31m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":3,"time":"2024-09-14T01:24:32+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.9.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  258.864569] Nextcloud[3271]: �[0;1;31m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":3,"time":"2024-09-14T01:24:32+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.9.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  258.868907] Nextcloud[3271]: �[0;1;31m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":3,"time":"2024-09-14T01:24:32+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.9.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  260.041645] Nextcloud[3271]: �[0;1;31m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":3,"time":"2024-09-14T01:24:33+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.9.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  260.049041] Nextcloud[3271]: �[0;1;31m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":3,"time":"2024-09-14T01:24:33+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.9.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  260.055593] Nextcloud[3271]: �[0;1;31m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":3,"time":"2024-09-14T01:24:33+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.9.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  260.063038] Nextcloud[3271]: �[0;1;31m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":3,"time":"2024-09-14T01:24:33+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.9.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  260.103941] Nextcloud[3271]: �[0;1;38:5:185m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":2,"time":"2024-09-14T01:24:33+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/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/3rdparty/guzzlehttp/guzzle/src/PrepareBodyMiddleware.php\",\"line\":35,\"function\":\"OC\\\\Http\\\\Client\\\\{closure}\",\"class\":\"OC\\\\Http\\\\Client\\\\DnsPinMiddleware\",\"type\":\"->\",\"args\":[\"**…
�[2mserver # [  260.147718] Nextcloud[3271]: �[0;1;38:5:185m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":2,"time":"2024-09-14T01:24:33+00:00","remoteAddr":"","user":"--","app":"appstoreFetcher","method":"","url":"--","message":"Could not get apps from the appstore","userAgent":"--","version":"28.0.9.1","data":{"app":"appstoreFetcher"}}�[0m�[0m
�[2mserver # [  265.452816] Nextcloud[3271]: �[0;1;31m{"reqId":"OhKvCNeldynX9qjqgZ7Q","level":3,"time":"2024-09-14T01:24:39+00:00","remoteAddr":"","user":"--","app":"core","method":"","url":"--","message":"{\"Exception\":\"OCP\\\\Files\\\\NotFoundException\",\"Message\":\"/appdata_ocdbhzo27qy4/theming/global\",\"Code\":0,\"Trace\":[{\"file\":\"/nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-nextcloud-28.0.9/lib/private/Files/Node/LazyFolder.php\",\"line\":161,\"function\":\"get\",\"class\":\"OC\\\\Files\\\\Node\\\\Root\",\"type\":\"->\",\"args\":[\"/appdata_ocdbhzo27qy4/theming/global\"]},{\"file\":\"/nix/store/dbffgghxyd4q7g83b2gss7flc2fwypy7-n…
�[2mserver # [  265.762057] nextcloud-update-db-start[3261]: oc_filecache table updated successfully.�[0m
�[2mserver # [  265.777038] nextcloud-update-db-start[3261]: Adding additional systag_by_objectid index to the oc_systemtag_object_mapping table, this can take some time...�[0m
�[2mserver # [  266.030657] lldap-start[1054]: 2024-09-14T01:24:31.059647356+00:00  INFO     LDAP session [ 108ms | 0.21% / 100.00% ]�[0m
�[2mserver # [  266.031520] lldap-start[1054]: 2024-09-14T01:24:31.059767203+00:00  INFO     ┝━ LDAP request [ 102ms | 94.49% ]�[0m
�[2mserver # [  266.033152] lldap-start[1054]: 2024-09-14T01:24:31.165884880+00:00  INFO     ┝━ LDAP request [ 2.26ms | 2.09% ]�[0m
�[2mserver # [  266.034047] lldap-start[1054]: 2024-09-14T01:24:31.168101363+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute "memberof" in filter.\n\�[0m
�[2mserver # [  266.035193] lldap-start[1054]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  266.036146] lldap-start[1054]: 2024-09-14T01:24:39.531353675+00:00  INFO     ┝━ LDAP request [ 3.46ms | 3.20% ]�[0m
�[2mserver # [  266.036919] lldap-start[1054]: 2024-09-14T01:24:39.800321379+00:00  INFO     ┕━ LDAP request [ 5.03µs | 0.00% ]�[0m
�[2mserver # [  266.066042] systemd[1]: nextcloud-cron.service: Deactivated successfully.�[0m
�[2mserver # [  266.068936] systemd[1]: nextcloud-cron.service: Consumed 7.983s CPU time, 56.6M memory peak, 540B incoming IP traffic, 2.2K outgoing IP traffic.�[0m
�[2mserver # [  269.467930] nextcloud-update-db-start[3261]: oc_systemtag_object_mapping table updated successfully.�[0m
�[2mserver # [  273.902549] nextcloud-update-db-start[3296]: Done.�[0m
�[2mserver # [  273.925681] systemd[1]: nextcloud-update-db.service: Deactivated successfully.�[0m
�[2mserver # [  273.926839] systemd[1]: nextcloud-update-db.service: Consumed 20.904s CPU time, 57.8M memory peak.�[0m
(finished: subtest: cron job succeeds, in 26.11 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 # [  276.088440] Nextcloud[3231]: �[0;1;38:5:185m{"reqId":"xJbfR2tbgt0OklKCb836","level":2,"time":"2024-09-14T01:24:49+00:00","remoteAddr":"2001:db8:1::1","user":"--","app":"core","method":"PROPFIND","url":"/remote.php/dav/files/root/","message":"Login failed: 'root' (Remote IP: '2001:db8:1::1')","userAgent":"curl/8.9.1","version":"28.0.9.1","data":{"app":"core"}}�[0m�[0m
�[2mserver # [  276.341186] lldap-start[1054]: 2024-09-14T01:24:49.411407703+00:00  INFO     LDAP session [ 53.8ms | 0.61% / 100.00% ]�[0m
�[2mserver # [  276.342369] lldap-start[1054]: 2024-09-14T01:24:49.411461341+00:00  INFO     ┝━ LDAP request [ 49.5ms | 91.92% ]�[0m
�[2mserver # [  276.343939] lldap-start[1054]: 2024-09-14T01:24:49.464130325+00:00  INFO     ┝━ LDAP request [ 800µs | 1.48% ]�[0m
�[2mserver # [  276.344932] lldap-start[1054]: 2024-09-14T01:24:49.464900256+00:00  WARN     │  ┝━ 🚧 [warn]: Ignoring unknown group attribute "memberof" in filter.\n\�[0m
�[2mserver # [  276.346413] lldap-start[1054]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  276.347859] lldap-start[1054]: 2024-09-14T01:24:49.464904726+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute "mail" in filter.\n\�[0m
�[2mserver # [  276.349098] lldap-start[1054]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  276.350390] lldap-start[1054]: 2024-09-14T01:24:49.689720449+00:00  INFO     ┝━ LDAP request [ 2.06ms | 3.83% ]�[0m
�[2mserver # [  276.351336] lldap-start[1054]: 2024-09-14T01:24:49.690431154+00:00  WARN     │  ┝━ 🚧 [warn]: Ignoring unknown group attribute "memberof" in filter.\n\�[0m
�[2mserver # [  276.352561] lldap-start[1054]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[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.26 seconds)
�[2mserver # [  276.353629] lldap-start[1054]: 2024-09-14T01:24:49.690436183+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute "mail" in filter.\n\�[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 # [  276.354718] lldap-start[1054]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  276.355624] lldap-start[1054]: 2024-09-14T01:24:49.846458526+00:00  INFO     ┝━ LDAP request [ 1.15ms | 2.14% ]�[0m
�[2mserver # [  276.356544] lldap-start[1054]: 2024-09-14T01:24:49.847191860+00:00  WARN     │  ┝━ 🚧 [warn]: Ignoring unknown group attribute "memberof" in filter.\n\�[0m
�[2mserver # [  276.357789] lldap-start[1054]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  276.358828] lldap-start[1054]: 2024-09-14T01:24:49.847196609+00:00  WARN     │  ┕━ 🚧 [warn]: Ignoring unknown group attribute "mail" in filter.\n\�[0m
�[2mserver # [  276.359929] lldap-start[1054]:                                 To disable this warning, add it to "ignored_group_attributes" in the config.�[0m
�[2mserver # [  276.360918] lldap-start[1054]: 2024-09-14T01:24:50.110730103+00:00  INFO     ┕━ LDAP request [ 6.71µ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.55 seconds)
(finished: subtest: fails with incorrect authentication, in 4.82 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.98 seconds)
(finished: subtest: fails with incorrect path, in 1.98 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 2.04 seconds)
(finished: subtest: can access webdav, in 2.04 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: cannot 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.91 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 2.01 seconds)
(finished: subtest: can create and retrieve file, in 4.97 seconds)
(finished: subtest: extraScript, in 39.91 seconds)
(finished: run the VM test script, in 288.67 seconds)
test script finished in 288.73s
�[1m�[32mcleanup�[0m
kill machine (pid 8)
qemu-kvm: terminating on signal 15 from pid 5 (/nix/store/h3i0acpmr8mrjx07519xxmidv8mpax4y-python3-3.12.5/bin/python3.12)
kill machine (pid 29)
qemu-kvm: terminating on signal 15 from pid 5 (/nix/store/h3i0acpmr8mrjx07519xxmidv8mpax4y-python3-3.12.5/bin/python3.12)
(finished: cleanup, in 0.02 seconds)
kill vlan (pid 6)