�[2mserver # [  173.993467] systemd[1]: Started nextcloud-cron.timer.�[0m
�[2mserver # [  173.995933] systemd[1]: Reached target Timer Units.�[0m
�[2mserver # [  173.998286] systemd[1]: Starting nextcloud-update-db.service...�[0m
�[2mserver # [  174.001103] systemd[1]: Starting PHP FastCGI Process Manager service for pool nextcloud...�[0m
�[2mserver # [  174.222741] php-fpm[2542]: �[0;1;39m[NOTICE] fpm is running, pid 2542�[0m�[0m
�[2mserver # [  174.226081] php-fpm[2542]: �[0;1;39m[NOTICE] ready to handle connections�[0m�[0m
�[2mserver # [  174.226837] systemd[1]: Started PHP FastCGI Process Manager service for pool nextcloud.�[0m
�[2mserver # [  174.228284] php-fpm[2542]: �[0;1;39m[NOTICE] systemd monitor interval set to 10000ms�[0m�[0m
�[2mserver # [  174.229332] systemd[1]: Reached target PHP FastCGI Process manager pools target.�[0m
�[2mserver # [  174.230457] systemd[1]: Reached target Multi-User System.�[0m
(finished: waiting for unit phpfpm-nextcloud.service, in 175.15 seconds)
server: �[1m�[32mwaiting for unit nginx.service�[0m
(finished: waiting for unit nginx.service, in 0.05 seconds)
server: �[1m�[32mwaiting for UNIX-domain stream on '/run/phpfpm/nextcloud.sock'�[0m
(finished: waiting for UNIX-domain stream on '/run/phpfpm/nextcloud.sock', in 0.04 seconds)
server: �[1m�[32mmust succeed: mkdir -p /tmp/shared/tmpvh65real�[0m
(finished: must succeed: mkdir -p /tmp/shared/tmpvh65real, in 0.02 seconds)
server: �[1m�[32mmust succeed: cp -r /etc/ssl/certs/ca-certificates.crt /tmp/shared/tmpvh65real/ca-certificates.crt�[0m
(finished: must succeed: cp -r /etc/ssl/certs/ca-certificates.crt /tmp/shared/tmpvh65real/ca-certificates.crt, in 0.03 seconds)
client: �[1m�[32mmust succeed: rm -r /etc/ssl/certs�[0m
client: �[1m�[32mwaiting for the VM to finish booting�[0m
client: Guest shell says: b'Spawning backdoor root shell...\n'
client: connected to guest root shell
client: (connecting took 0.00 seconds)
(finished: waiting for the VM to finish booting, in 0.00 seconds)
(finished: must succeed: rm -r /etc/ssl/certs, in 0.02 seconds)
client: �[1m�[32mmust succeed: mkdir -p /tmp/shared/tmp58syemys�[0m
(finished: must succeed: mkdir -p /tmp/shared/tmp58syemys, 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/tmp58syemys/ca-certificates.crt /etc/ssl/certs/ca-certificates.crt�[0m
(finished: must succeed: cp -r /tmp/shared/tmp58syemys/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 # [  179.400190] systemd[1]: Started nextcloud-update-db.service.�[0m
�[2mserver # [  179.403064] systemd[1]: Startup finished in 2.322s (kernel) + 2min 57.078s (userspace) = 2min 59.400s.�[0m
(finished: subtest: access, in 10.73 seconds)
�[1m�[32msubtest: extraScript�[0m
�[1m�[32msubtest: cron job succeeds�[0m
�[2mserver # [  185.626140] systemd[1]: Starting nextcloud-cron.service...�[0m
�[2mserver # [  188.056028] nextcloud-update-db-start[2574]: Done.�[0m
�[2mserver # [  191.603234] systemd[1]: Started nextcloud-cron.service.�[0m
�[2mserver # [  196.844213] nextcloud-update-db-start[2590]: Adding additional fs_storage_path_prefix index to the oc_filecache table, this can take some time...�[0m
�[2mserver # [  198.082572] Nextcloud[2600]: �[0;1;31m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":3,"time":"2024-09-16T01:32:33+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.10.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  198.091901] Nextcloud[2600]: �[0;1;31m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":3,"time":"2024-09-16T01:32:33+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.10.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  198.100919] Nextcloud[2600]: �[0;1;31m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":3,"time":"2024-09-16T01:32:33+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.10.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  198.109429] Nextcloud[2600]: �[0;1;31m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":3,"time":"2024-09-16T01:32:33+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.10.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  198.171409] Nextcloud[2600]: �[0;1;38:5:185m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":2,"time":"2024-09-16T01:32: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/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/3rdparty/guzzlehttp/guzzle/src/PrepareBodyMiddleware.php\",\"line\":35,\"function\":\"OC\\\\Http\\\\Client\\\\{closure}\",\"class\":\"OC\\\\Http\\\\Client\\\\DnsPinMiddleware\",\"type\":\"->\",\"args\":[\"*…
�[2mserver # [  198.224726] Nextcloud[2600]: �[0;1;38:5:185m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":2,"time":"2024-09-16T01:32:34+00:00","remoteAddr":"","user":"--","app":"appstoreFetcher","method":"","url":"--","message":"Could not get apps from the appstore","userAgent":"--","version":"28.0.10.1","data":{"app":"appstoreFetcher"}}�[0m�[0m
�[2mserver # [  200.150685] Nextcloud[2600]: �[0;1;31m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":3,"time":"2024-09-16T01:32:35+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.10.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  200.159710] Nextcloud[2600]: �[0;1;31m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":3,"time":"2024-09-16T01:32:35+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.10.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  200.168418] Nextcloud[2600]: �[0;1;31m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":3,"time":"2024-09-16T01:32:35+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.10.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  200.176045] Nextcloud[2600]: �[0;1;31m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":3,"time":"2024-09-16T01:32:35+00:00","remoteAddr":"","user":"--","app":"PHP","method":"","url":"--","message":"dns_get_record(): A temporary server error occurred. at /nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/lib/private/Http/Client/DnsPinMiddleware.php#111","userAgent":"--","version":"28.0.10.1","data":{"app":"PHP"}}�[0m�[0m
�[2mserver # [  205.017121] Nextcloud[2600]: �[0;1;31m{"reqId":"Cr35CPz7LxXgUpNb2qWu","level":3,"time":"2024-09-16T01:32:40+00:00","remoteAddr":"","user":"--","app":"core","method":"","url":"--","message":"{\"Exception\":\"OCP\\\\Files\\\\NotFoundException\",\"Message\":\"/appdata_ocordcl45a95/theming/global\",\"Code\":0,\"Trace\":[{\"file\":\"/nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-nextcloud-28.0.10/lib/private/Files/Node/LazyFolder.php\",\"line\":161,\"function\":\"get\",\"class\":\"OC\\\\Files\\\\Node\\\\Root\",\"type\":\"->\",\"args\":[\"/appdata_ocordcl45a95/theming/global\"]},{\"file\":\"/nix/store/i76a12xmqzir9q4cpsz212w7cpyx9mjv-…
�[2mserver # [  205.388643] systemd[1]: nextcloud-cron.service: Deactivated successfully.�[0m
�[2mserver # [  205.390849] systemd[1]: nextcloud-cron.service: Consumed 8.959s CPU time, 54.9M memory peak, 1.1K outgoing IP traffic.�[0m
�[2mserver # [  205.806496] nextcloud-update-db-start[2590]: oc_filecache table updated successfully.�[0m
�[2mserver # [  205.815043] nextcloud-update-db-start[2590]: Adding additional systag_by_objectid index to the oc_systemtag_object_mapping table, this can take some time...�[0m
�[2mserver # [  210.489661] nextcloud-update-db-start[2590]: oc_systemtag_object_mapping table updated successfully.�[0m
(finished: subtest: cron job succeeds, in 26.32 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 # [  215.752379] Nextcloud[2564]: �[0;1;38:5:185m{"reqId":"DTfpaTwsAcefpnWpbNpt","level":2,"time":"2024-09-16T01:32:51+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.10.1","data":{"app":"core"}}�[0m�[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 4.17 seconds)
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 # [  217.887388] nextcloud-update-db-start[2626]: Done.�[0m
�[2mserver # [  217.926404] systemd[1]: nextcloud-update-db.service: Deactivated successfully.�[0m
�[2mserver # [  217.932079] systemd[1]: nextcloud-update-db.service: Consumed 24.035s CPU time, 57M memory peak.�[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 3.89 seconds)
(finished: subtest: fails with incorrect authentication, in 8.06 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 2.18 seconds)
(finished: subtest: fails with incorrect path, in 2.18 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.24 seconds)
(finished: subtest: can access webdav, in 2.24 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 3.16 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.73 seconds)
(finished: subtest: can create and retrieve file, in 5.93 seconds)
(finished: subtest: extraScript, in 44.73 seconds)
(finished: run the VM test script, in 231.11 seconds)
test script finished in 231.16s
�[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)