�[2mserver # [    9.731143] dhcpcd[672]: eth0: adding default route via fe80::2�[0m
�[2mserver # [    9.878558] postgresql-pre-start[834]: selecting default time zone ... UTC�[0m
�[2mserver # [    9.881280] postgresql-pre-start[834]: creating configuration files ... ok�[0m
�[2mserver # [   10.137569] postgresql-pre-start[834]: running bootstrap script ... ok�[0m
(finished: waiting for unit nginx.service, in 2.40 seconds)
server: �[1m�[32mwaiting for TCP port 8222 on localhost�[0m
�[2mserver # [   10.404941] vaultwarden[859]: Can't connect to database, retrying: DieselCon.�[0m
�[2mserver # [   10.405962] vaultwarden[859]: [CAUSE] BadConnection(�[0m
�[2mserver # [   10.406787] vaultwarden[859]:     "connection to server at \"127.0.0.1\", port 5432 failed: Connection refused\n\tIs the server running on that host and accepting TCP/IP connections?\n",�[0m
�[2mserver # [   10.408715] vaultwarden[859]: )�[0m
�[2mserver # [   10.409396] vaultwarden[859]: �[0;1;38:5:185mCan't connect to database, retrying: DieselCon.�[0m
�[2mserver # [CAUSE] BadConnection(�[0m
�[2mserver #     "connection to server at \"127.0.0.1\", port 5432 failed: Connection refused\n\tIs the server running on that host and accepting TCP/IP connections?\n",�[0m
�[2mserver # )�[0m�[0m
�[2mserver # [   10.914836] postgresql-pre-start[834]: performing post-bootstrap initialization ... ok�[0m
�[2mserver # [   11.048094] postgresql-pre-start[834]: syncing data to disk ... ok�[0m
�[2mserver # [   11.048795] postgresql-pre-start[834]: initdb: warning: enabling "trust" authentication for local connections�[0m
�[2mserver # [   11.050080] postgresql-pre-start[834]: initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.�[0m
�[2mserver # [   11.051628] postgresql-pre-start[834]: Success. You can now start the database server using:�[0m
�[2mserver # [   11.052564] postgresql-pre-start[834]:     /nix/store/9l9cxmwzrp1pfsrvzfrbsz0c1jhrracq-postgresql-and-plugins-16.4/bin/pg_ctl -D /var/lib/postgresql/16 -l logfile start�[0m
�[2mserver # [   11.099386] postgres[945]: [945] LOG:  starting PostgreSQL 16.4 on x86_64-pc-linux-gnu, compiled by gcc (GCC) 13.3.0, 64-bit�[0m
�[2mserver # [   11.100826] postgres[945]: [945] LOG:  listening on IPv4 address "0.0.0.0", port 5432�[0m
�[2mserver # [   11.101649] postgres[945]: [945] LOG:  listening on IPv6 address "::", port 5432�[0m
�[2mserver # [   11.103061] postgres[945]: [945] LOG:  listening on Unix socket "/run/postgresql/.s.PGSQL.5432"�[0m
�[2mserver # [   11.109262] postgres[948]: [948] LOG:  database system was shut down at 2024-09-16 01:29:36 GMT�[0m
�[2mserver # [   11.113548] postgres[945]: [945] LOG:  database system is ready to accept connections�[0m
�[2mserver # [   11.215427] postgresql-post-start[959]: CREATE DATABASE�[0m
�[2mserver # [   11.242202] postgresql-post-start[964]: CREATE ROLE�[0m
�[2mserver # [   11.254279] postgresql-post-start[966]: ALTER ROLE�[0m
�[2mserver # [   11.270783] postgresql-post-start[968]: ALTER DATABASE�[0m
�[2mserver # [   11.290256] postgresql-post-start[970]: DO�[0m
�[2mserver # [   11.292560] systemd[1]: Started PostgreSQL Server.�[0m
�[2mserver # [   11.831350] vaultwarden[859]: Rocket has launched from http://127.0.0.1:8222�[0m
�[2mserver # [   11.832287] vaultwarden[859]: Rocket has launched from http://127.0.0.1:8222�[0m
�[2mserver # Connection to localhost (127.0.0.1) 8222 port [tcp/*] succeeded!�[0m
(finished: waiting for TCP port 8222 on localhost, in 2.10 seconds)
server: �[1m�[32mwaiting for TCP port 5432 on localhost�[0m
�[2mserver # Connection to localhost (::1) 5432 port [tcp/postgresql] succeeded!�[0m
(finished: waiting for TCP port 5432 on localhost, in 0.02 seconds)
server: �[1m�[32mmust succeed: mkdir -p /tmp/shared/tmpybfsqfe3�[0m
(finished: must succeed: mkdir -p /tmp/shared/tmpybfsqfe3, in 0.01 seconds)
server: �[1m�[32mmust succeed: cp -r /etc/ssl/certs/ca-certificates.crt /tmp/shared/tmpybfsqfe3/ca-certificates.crt�[0m
(finished: must succeed: cp -r /etc/ssl/certs/ca-certificates.crt /tmp/shared/tmpybfsqfe3/ca-certificates.crt, in 0.02 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/tmps7txr5rq�[0m
(finished: must succeed: mkdir -p /tmp/shared/tmps7txr5rq, in 0.01 seconds)
client: �[1m�[32mmust succeed: mkdir -p /etc/ssl/certs�[0m
(finished: must succeed: mkdir -p /etc/ssl/certs, in 0.01 seconds)
client: �[1m�[32mmust succeed: cp -r /tmp/shared/tmps7txr5rq/ca-certificates.crt /etc/ssl/certs/ca-certificates.crt�[0m
(finished: must succeed: cp -r /tmp/shared/tmps7txr5rq/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 v.example.com:443:server:443 --connect-to v.example.com:80:server:80 --connect-to auth.example.com:443:server:443 --silent --output /dev/null --write-out '{"code":%{response_code}}' https://v.example.com
(finished: subtest: access, in 0.11 seconds)
�[1m�[32msubtest: extraScript�[0m
�[1m�[32msubtest: prelogin�[0m
curl --show-error --location --cookie-jar cookie.txt --cookie cookie.txt --connect-to v.example.com:443:server:443 --connect-to v.example.com:80:server:80 --connect-to auth.example.com:443:server:443 --data '{"email": "me@example.com"}' https://v.example.com/identity/accounts/prelogin
�[2mserver # [   12.702374] nginx[924]: server nginx: {"remote_addr":"2001:db8:1::1","remote_user":"-","time_local":"16/Sep/2024:01:29:38 +0000","request":"GET / HTTP/2.0","request_length":"30","server_name":"v.example.com","status":"200","bytes_sent":"2533","body_bytes_sent":"1236","referrer":"-","user_agent":"curl/8.9.1","gzip_ration":"-","post":"-","upstream_addr":"127.0.0.1:8222","upstream_status":"200","request_time":"0.005","upstream_response_time":"0.004","upstream_connect_time":"0.000","upstream_header_time":"0.004"}�[0m
�[2mclient #   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current�[0m
�[2mclient #                                  Dload  Upload   Total   Spent    Left  Speed�[0m
�[2mserver # [   12.795949] vaultwarden[859]: POST /identity/accounts/prelogin�[0m
�[2mserver # [   12.797216] vaultwarden[859]: POST /identity/accounts/prelogin�[0m
�[2mserver # [   12.801302] vaultwarden[859]: (prelogin) POST /identity/accounts/prelogin => 200 OK�[0m
�[2mserver # [   12.802379] vaultwarden[859]: (prelogin) POST /identity/accounts/prelogin => 200 OK�[0m
�[2mserver # [   12.803435] nginx[924]: server nginx: {"remote_addr":"2001:db8:1::1","remote_user":"-","time_local":"16/Sep/2024:01:29:38 +0000","request":"POST /identity/accounts/prelogin HTTP/2.0","request_length":"108","server_name":"v.example.com","status":"200","bytes_sent":"1336","body_bytes_sent":"71","referrer":"-","user_agent":"curl/8.9.1","gzip_ration":"-","post":"{\x22email\x22: \x22me@example.com\x22}","upstream_addr":"127.0.0.1:8222","upstream_status":"200","request_time":"0.007","upstream_response_time":"0.008","upstream_connect_time":"0.001","upstream_header_time":"0.008"}�[0m
�[2mclient #   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0100    98  100    71  100    27    952    362 --:--:-- --:--:-- --:--:--  1324�[0m
{'kdf': 0, 'kdfIterations': 600000, 'kdfMemory': None, 'kdfParallelism': None}
(finished: subtest: prelogin, in 0.11 seconds)
�[1m�[32msubtest: get token�[0m
curl --show-error --location --cookie-jar cookie.txt --cookie cookie.txt --connect-to v.example.com:443:server:443 --connect-to v.example.com:80:server:80 --connect-to auth.example.com:443:server:443 --data 'scope=api%20offline_access&client_id=web&deviceType=10&deviceIdentifier=a60323bf-4686-4b4d-96e0-3c241fa5581c&deviceName=firefox&grant_type=password&username=me&password=mypassword' https://v.example.com/identity/connect/token
�[2mclient #   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current�[0m
�[2mclient #                                  Dload  Upload   Total   Spent    Left  Speed�[0m
�[2mserver # [   12.905314] vaultwarden[859]: POST /identity/connect/token�[0m
�[2mserver # [   12.905957] vaultwarden[859]: POST /identity/connect/token�[0m
�[2mserver # [   12.908848] vaultwarden[859]: Username or password is incorrect. Try again. IP: 2001:db8:1::1. Username: me.�[0m
�[2mserver # [   12.909922] vaultwarden[859]: �[0;1;31mUsername or password is incorrect. Try again. IP: 2001:db8:1::1. Username: me.�[0m�[0m
�[2mserver # [   12.911587] vaultwarden[859]: (login) POST /identity/connect/token => 400 Bad Request�[0m
�[2mserver # [   12.912425] vaultwarden[859]: (login) POST /identity/connect/token => 400 Bad Request�[0m
�[2mclient #   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0100   530  100   351  100   179   4551   2320 --:--:-- --:--:-- --:--:--  6973�[0m
�[2mserver # [   12.913723] nginx[924]: server nginx: {"remote_addr":"2001:db8:1::1","remote_user":"-","time_local":"16/Sep/2024:01:29:38 +0000","request":"POST /identity/connect/token HTTP/2.0","request_length":"258","server_name":"v.example.com","status":"400","bytes_sent":"1454","body_bytes_sent":"351","referrer":"-","user_agent":"curl/8.9.1","gzip_ration":"-","post":"scope=api%20offline_access&client_id=web&deviceType=10&deviceIdentifier=a60323bf-4686-4b4d-96e0-3c241fa5581c&deviceName=firefox&grant_type=password&username=me&password=mypassword","upstream_addr":"127.0.0.1:8222","upstream_status":"400","request_time":"0.010","upstream_resp…
{'error': '', 'errorModel': {'message': 'Username or password is incorrect. Try again', 'object': 'error'}, 'error_description': '', 'exceptionMessage': None, 'exceptionStackTrace': None, 'innerExceptionMessage': None, 'message': 'Username or password is incorrect. Try again', 'object': 'error', 'validationErrors': {'': ['Username or password is incorrect. Try again']}}
(finished: subtest: get token, in 0.11 seconds)
(finished: subtest: extraScript, in 0.22 seconds)
(finished: run the VM test script, in 14.10 seconds)
�[2mclient # [   12.976292] dhcpcd[664]: eth0: leased 10.0.2.15 for 86400 seconds�[0m
�[2mclient # [   12.978326] dhcpcd[664]: eth0: adding route to 10.0.2.0/24�[0m
�[2mclient # [   12.979512] dhcpcd[664]: eth0: adding default route via 10.0.2.2�[0m
test script finished in 14.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 28)
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)