�[2mserver # [    8.267114] systemd[1]: Reached target Host and Network Name Lookups.�[0m
�[2mserver # [    8.267692] systemd[1]: Reached target User and Group Name Lookups.�[0m
(finished: waiting for unit nginx.service, in 1.12 seconds)
server: �[1m�[32mwaiting for TCP port 8222 on localhost�[0m
�[2mserver # [    8.599406] postgresql-pre-start[801]: selecting default time zone ... UTC�[0m
�[2mserver # [    8.601517] postgresql-pre-start[801]: creating configuration files ... ok�[0m
�[2mserver # [    8.737395] postgresql-pre-start[801]: running bootstrap script ... ok�[0m
�[2mserver # [    9.475554] vaultwarden[811]: Can't connect to database, retrying: DieselCon.�[0m
�[2mserver # [    9.476100] vaultwarden[811]: [CAUSE] BadConnection(�[0m
�[2mserver # [    9.476462] vaultwarden[811]:     "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 # [    9.477589] vaultwarden[811]: )�[0m
�[2mserver # [    9.477889] vaultwarden[811]: �[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 # [    9.625606] postgresql-pre-start[801]: performing post-bootstrap initialization ... ok�[0m
�[2mserver # [    9.730418] postgresql-pre-start[801]: syncing data to disk ... ok�[0m
�[2mserver # [    9.730977] postgresql-pre-start[801]: initdb: warning: enabling "trust" authentication for local connections�[0m
�[2mserver # [    9.731670] postgresql-pre-start[801]: 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 # [    9.732771] postgresql-pre-start[801]: Success. You can now start the database server using:�[0m
�[2mserver # [    9.733359] postgresql-pre-start[801]:     /nix/store/hh1x7h54liwwclmwssmm66kdpa24im64-postgresql-and-plugins-15.7/bin/pg_ctl -D /var/lib/postgresql/15 -l logfile start�[0m
�[2mserver # [    9.796379] postgres[947]: [947] LOG:  starting PostgreSQL 15.7 on x86_64-pc-linux-gnu, compiled by gcc (GCC) 13.2.0, 64-bit�[0m
�[2mserver # [    9.797811] postgres[947]: [947] LOG:  listening on IPv4 address "0.0.0.0", port 5432�[0m
�[2mserver # [    9.798698] postgres[947]: [947] LOG:  listening on IPv6 address "::", port 5432�[0m
�[2mserver # [    9.800353] postgres[947]: [947] LOG:  listening on Unix socket "/run/postgresql/.s.PGSQL.5432"�[0m
�[2mserver # [    9.806608] postgres[950]: [950] LOG:  database system was shut down at 2024-08-15 00:56:57 GMT�[0m
�[2mserver # [    9.810647] postgres[947]: [947] LOG:  database system is ready to accept connections�[0m
�[2mserver # [    9.915656] postgresql-post-start[961]: CREATE DATABASE�[0m
�[2mserver # [    9.945568] postgresql-post-start[967]: CREATE ROLE�[0m
�[2mserver # [    9.960809] postgresql-post-start[971]: ALTER ROLE�[0m
�[2mserver # [    9.972424] postgresql-post-start[975]: ALTER DATABASE�[0m
�[2mserver # [    9.990309] postgresql-post-start[977]: DO�[0m
�[2mserver # [    9.992910] systemd[1]: Started PostgreSQL Server.�[0m
�[2mserver # [    9.993412] systemd[1]: Reached target Multi-User System.�[0m
�[2mserver # [    9.994589] systemd[1]: Startup finished in 2.463s (kernel) + 7.530s (userspace) = 9.994s.�[0m
�[2mserver # [   10.785330] vaultwarden[811]: Rocket has launched from http://127.0.0.1:8222�[0m
�[2mserver # [   10.786041] vaultwarden[811]: 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 3.26 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/tmplyztvuq1�[0m
(finished: must succeed: mkdir -p /tmp/shared/tmplyztvuq1, in 0.02 seconds)
server: �[1m�[32mmust succeed: cp -r /etc/ssl/certs/ca-certificates.crt /tmp/shared/tmplyztvuq1/ca-certificates.crt�[0m
(finished: must succeed: cp -r /etc/ssl/certs/ca-certificates.crt /tmp/shared/tmplyztvuq1/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.03 seconds)
client: �[1m�[32mmust succeed: mkdir -p /tmp/shared/tmprcs2ckzp�[0m
(finished: must succeed: mkdir -p /tmp/shared/tmprcs2ckzp, 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/tmprcs2ckzp/ca-certificates.crt /etc/ssl/certs/ca-certificates.crt�[0m
(finished: must succeed: cp -r /tmp/shared/tmprcs2ckzp/ca-certificates.crt /etc/ssl/certs/ca-certificates.crt, in 0.03 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
�[2mserver # [   11.948298] nginx[862]: server nginx: {"remote_addr":"192.168.1.1","remote_user":"-","time_local":"15/Aug/2024:00:57:00 +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.7.1","gzip_ration":"-","post":"-","upstream_addr":"127.0.0.1:8222","upstream_status":"200","request_time":"0.007","upstream_response_time":"0.007","upstream_connect_time":"0.001","upstream_header_time":"0.007"}�[0m
(finished: subtest: access, in 0.20 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
�[2mclient #   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current�[0m
�[2mclient #                                  Dload  Upload   Total   Spent    Left  Speed�[0m
�[2mserver # [   12.086587] vaultwarden[811]: POST /identity/accounts/prelogin�[0m
�[2mserver # [   12.087441] vaultwarden[811]: POST /identity/accounts/prelogin�[0m
�[2mserver # [   12.092462] vaultwarden[811]: (prelogin) POST /identity/accounts/prelogin => 200 OK�[0m
�[2mserver # [   12.093276] vaultwarden[811]: (prelogin) POST /identity/accounts/prelogin => 200 OK�[0m
�[2mserver # [   12.094885] nginx[862]: server nginx: {"remote_addr":"192.168.1.1","remote_user":"-","time_local":"15/Aug/2024:00:57:00 +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.7.1","gzip_ration":"-","post":"{\x22email\x22: \x22me@example.com\x22}","upstream_addr":"127.0.0.1:8222","upstream_status":"200","request_time":"0.012","upstream_response_time":"0.012","upstream_connect_time":"0.001","upstream_header_time":"0.012"}�[0m
�[2mclient #   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0100    98  100    71  100    27    725    276 --:--:-- --:--:-- --:--:--  1010�[0m
{'Kdf': 0, 'KdfIterations': 600000, 'KdfMemory': None, 'KdfParallelism': None}
(finished: subtest: prelogin, in 0.15 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.239812] vaultwarden[811]: POST /identity/connect/token�[0m
�[2mserver # [   12.240587] vaultwarden[811]: POST /identity/connect/token�[0m
�[2mserver # [   12.246381] vaultwarden[811]: Username or password is incorrect. Try again. IP: 192.168.1.1. Username: me.�[0m
�[2mserver # [   12.247375] vaultwarden[811]: �[0;1;31mUsername or password is incorrect. Try again. IP: 192.168.1.1. Username: me.�[0m�[0m
�[2mserver # [   12.250111] vaultwarden[811]: (login) POST /identity/connect/token => 400 Bad Request�[0m
�[2mserver # [   12.250909] vaultwarden[811]: (login) POST /identity/connect/token => 400 Bad Request�[0m
�[2mserver # [   12.251756] nginx[862]: server nginx: {"remote_addr":"192.168.1.1","remote_user":"-","time_local":"15/Aug/2024:00:57:00 +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.7.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.014","upstream_respon…
�[2mclient #   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0100   530  100   351  100   179   3482   1776 --:--:-- --:--:-- --:--:--  5300�[0m
{'ErrorModel': {'Message': 'Username or password is incorrect. Try again', 'Object': 'error'}, 'ExceptionMessage': None, 'ExceptionStackTrace': None, 'InnerExceptionMessage': None, 'Message': 'Username or password is incorrect. Try again', 'Object': 'error', 'ValidationErrors': {'': ['Username or password is incorrect. Try again']}, 'error': '', 'error_description': ''}
(finished: subtest: get token, in 0.16 seconds)
(finished: subtest: extraScript, in 0.31 seconds)
(finished: run the VM test script, in 13.15 seconds)
test script finished in 13.77s
�[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)