�[2mmachine # [    5.192749] postgresql-pre-start[825]: This user must also own the server process.�[0m
�[2mmachine # [    5.196969] postgresql-pre-start[825]: The database cluster will be initialized with locale "en_US.UTF-8".�[0m
�[2mmachine # [    5.198077] postgresql-pre-start[825]: The default database encoding has accordingly been set to "UTF8".�[0m
�[2mmachine # [    5.199105] postgresql-pre-start[825]: The default text search configuration will be set to "english".�[0m
�[2mmachine # [    5.199982] postgresql-pre-start[825]: Data page checksums are disabled.�[0m
�[2mmachine # [    5.200817] postgresql-pre-start[825]: fixing permissions on existing directory /var/lib/postgresql/16 ... ok�[0m
�[2mmachine # [    5.201813] postgresql-pre-start[825]: creating subdirectories ... ok�[0m
�[2mmachine # [    5.202720] postgresql-pre-start[825]: selecting dynamic shared memory implementation ... posix�[0m
�[2mmachine # [    5.241458] postgresql-pre-start[825]: selecting default max_connections ... 100�[0m
�[2mmachine # [    5.270857] postgresql-pre-start[825]: selecting default shared_buffers ... 128MB�[0m
�[2mmachine # [    5.898425] dhcpcd[676]: eth0: soliciting an IPv6 router�[0m
�[2mmachine # [    6.078079] dhcpcd[676]: eth0: Router Advertisement from fe80::2�[0m
�[2mmachine # [    6.078818] dhcpcd[676]: eth0: adding address fec0::5054:ff:fe12:3456/64�[0m
�[2mmachine # [    6.079527] dhcpcd[676]: eth0: adding route to fec0::/64�[0m
�[2mmachine # [    6.080462] dhcpcd[676]: eth0: adding default route via fe80::2�[0m
�[2mmachine # [    6.242182] postgresql-pre-start[825]: selecting default time zone ... UTC�[0m
�[2mmachine # [    6.244561] postgresql-pre-start[825]: creating configuration files ... ok�[0m
�[2mmachine # [    6.376261] dhcpcd[676]: eth0: soliciting a DHCP lease�[0m
�[2mmachine # [    6.467487] NET: Registered PF_PACKET protocol family�[0m
�[2mmachine # [    6.395571] dhcpcd[676]: eth0: offered 10.0.2.15 from 10.0.2.2�[0m
�[2mmachine # [    6.398231] dhcpcd[676]: eth0: probing address 10.0.2.15/24�[0m
�[2mmachine # [    6.477236] postgresql-pre-start[825]: running bootstrap script ... ok�[0m
�[2mmachine # [    7.156791] postgresql-pre-start[825]: performing post-bootstrap initialization ... ok�[0m
�[2mmachine # [    7.282604] postgresql-pre-start[825]: syncing data to disk ... ok�[0m
�[2mmachine # [    7.283728] postgresql-pre-start[825]: initdb: warning: enabling "trust" authentication for local connections�[0m
�[2mmachine # [    7.284626] postgresql-pre-start[825]: 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
�[2mmachine # [    7.285972] postgresql-pre-start[825]: Success. You can now start the database server using:�[0m
�[2mmachine # [    7.286732] postgresql-pre-start[825]:     /nix/store/9l9cxmwzrp1pfsrvzfrbsz0c1jhrracq-postgresql-and-plugins-16.4/bin/pg_ctl -D /var/lib/postgresql/16 -l logfile start�[0m
�[2mmachine # [    7.338989] postgres[850]: [850] LOG:  starting PostgreSQL 16.4 on x86_64-pc-linux-gnu, compiled by gcc (GCC) 13.3.0, 64-bit�[0m
�[2mmachine # [    7.342660] postgres[850]: [850] LOG:  listening on IPv6 address "::1", port 5432�[0m
�[2mmachine # [    7.343491] postgres[850]: [850] LOG:  listening on IPv4 address "127.0.0.1", port 5432�[0m
�[2mmachine # [    7.344919] postgres[850]: [850] LOG:  listening on Unix socket "/run/postgresql/.s.PGSQL.5432"�[0m
�[2mmachine # [    7.351607] postgres[853]: [853] LOG:  database system was shut down at 2024-09-14 01:20:44 GMT�[0m
�[2mmachine # [    7.354500] postgres[850]: [850] LOG:  database system is ready to accept connections�[0m
�[2mmachine # [    7.468922] postgresql-post-start[864]: CREATE DATABASE�[0m
�[2mmachine # [    7.499677] postgresql-post-start[869]: CREATE ROLE�[0m
�[2mmachine # [    7.515427] postgresql-post-start[874]: ALTER ROLE�[0m
�[2mmachine # [    7.527088] postgresql-post-start[878]: ALTER DATABASE�[0m
�[2mmachine # [    7.529406] systemd[1]: Started PostgreSQL Server.�[0m
(finished: waiting for unit postgresql.service, in 8.42 seconds)
machine: �[1m�[32mwaiting for TCP port 5432 on localhost�[0m
�[2mmachine # Connection to localhost (::1) 5432 port [tcp/postgresql] succeeded!�[0m
(finished: waiting for TCP port 5432 on localhost, in 0.04 seconds)
�[1m�[32msubtest: can login with provisioned user and database�[0m
machine: �[1m�[32mmust succeed: sudo -u me psql -U me me --command ""�[0m
�[2mmachine # [    8.100424] sudo[893]: �[0;1;39m    root : TTY=hvc0 ; PWD=/tmp ; USER=me ; COMMAND=/run/current-system/sw/bin/psql -U me me --command�[0m�[0m
�[2mmachine # [    8.109197] sudo[893]: pam_unix(sudo:session): session opened for user me(uid=998) by (uid=0)�[0m
�[2mmachine # [    8.128722] sudo[893]: pam_unix(sudo:session): session closed for user me�[0m
(finished: must succeed: sudo -u me psql -U me me --command "", in 0.07 seconds)
(finished: subtest: can login with provisioned user and database, in 0.07 seconds)
�[1m�[32msubtest: cannot login with unknown user�[0m
machine: �[1m�[32mmust fail: sudo -u me psql -U notme me --command ""�[0m
�[2mmachine # [    8.153785] sudo[901]: �[0;1;39m    root : TTY=hvc0 ; PWD=/tmp ; USER=me ; COMMAND=/run/current-system/sw/bin/psql -U notme me --command�[0m�[0m
�[2mmachine # [    8.160573] sudo[901]: pam_unix(sudo:session): session opened for user me(uid=998) by (uid=0)�[0m
�[2mmachine # psql: error: connection to server on socket "/run/postgresql/.s.PGSQL.5432" failed: FATAL:  Peer authentication failed for user "notme"�[0m
�[2mmachine # [    8.171296] postgres[905]: [905] LOG:  provided user name (notme) and authenticated user name (me) do not match�[0m
�[2mmachine # [    8.174416] postgres[905]: [905] FATAL:  Peer authentication failed for user "notme"�[0m
�[2mmachine # [    8.175720] postgres[905]: [905] DETAIL:  Connection matched file "/nix/store/4r608l72lfla3541fnryxi6xj0336lbq-pg_hba.conf" line 3: "local all all              peer"�[0m
�[2mmachine # [    8.179123] sudo[901]: pam_unix(sudo:session): session closed for user me�[0m
(finished: must fail: sudo -u me psql -U notme me --command "", in 0.05 seconds)
(finished: subtest: cannot login with unknown user, in 0.05 seconds)
�[1m�[32msubtest: cannot login to unknown database�[0m
machine: �[1m�[32mmust fail: sudo -u me psql -U me notmine --command ""�[0m
�[2mmachine # [    8.212878] sudo[909]: �[0;1;39m    root : TTY=hvc0 ; PWD=/tmp ; USER=me ; COMMAND=/run/current-system/sw/bin/psql -U me notmine --command�[0m�[0m
�[2mmachine # [    8.222457] sudo[909]: pam_unix(sudo:session): session opened for user me(uid=998) by (uid=0)�[0m
�[2mmachine # psql: error: connection to server on socket "/run/postgresql/.s.PGSQL.5432" failed: FATAL:  database "notmine" does not exist�[0m
�[2mmachine # [    8.237254] postgres[913]: [913] FATAL:  database "notmine" does not exist�[0m
�[2mmachine # [    8.239930] sudo[909]: pam_unix(sudo:session): session closed for user me�[0m
(finished: must fail: sudo -u me psql -U me notmine --command "", in 0.06 seconds)
(finished: subtest: cannot login to unknown database, in 0.06 seconds)
�[1m�[32msubtest: cannot login with tcpip�[0m
machine: �[1m�[32mmust fail: psql -h 127.0.0.1 -p 5432 -U me me --command ""�[0m
�[2mmachine # [   12.022194] dhcpcd[676]: eth0: leased 10.0.2.15 for 86400 seconds�[0m
�[2mmachine # [   12.023476] dhcpcd[676]: eth0: adding route to 10.0.2.0/24�[0m
�[2mmachine # [   12.024305] dhcpcd[676]: eth0: adding default route via 10.0.2.2�[0m
�[2mmachine # [   12.071111] systemd[1]: Stopped target Host and Network Name Lookups.�[0m
�[2mmachine # [   12.071884] systemd[1]: Stopping Host and Network Name Lookups...�[0m
�[2mmachine # [   12.073514] systemd[1]: Stopped target User and Group Name Lookups.�[0m
�[2mmachine # [   12.074793] systemd[1]: Stopping User and Group Name Lookups...�[0m
�[2mmachine # [   12.075727] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...�[0m
�[2mmachine # [   12.077105] systemd[1]: nscd.service: Deactivated successfully.�[0m
�[2mmachine # [   12.078327] systemd[1]: Stopped Name Service Cache Daemon (nsncd).�[0m
�[2mmachine # [   12.085110] systemd[1]: Starting Name Service Cache Daemon (nsncd)...�[0m
�[2mmachine # [   12.102401] systemd[1]: Started DHCP Client.�[0m
�[2mmachine # [   12.105970] systemd[1]: Reached target Network is Online.�[0m
�[2mmachine # [   12.113123] systemd[1]: Started Name Service Cache Daemon (nsncd).�[0m
�[2mmachine # [   12.113953] nsncd[962]: Sep 14 01:20:49.088 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 3s }, path: "/var/run/nscd/socket"�[0m
�[2mmachine # [   12.115360] systemd[1]: Reached target Multi-User System.�[0m
�[2mmachine # [   12.115948] systemd[1]: Reached target Host and Network Name Lookups.�[0m
�[2mmachine # [   12.116620] systemd[1]: Reached target User and Group Name Lookups.�[0m
�[2mmachine # [   12.118708] systemd[1]: Startup finished in 1.815s (kernel) + 10.303s (userspace) = 12.118s.�[0m
(finished: must fail: psql -h 127.0.0.1 -p 5432 -U me me --command "", in 10.01 seconds)
(finished: subtest: cannot login with tcpip, in 10.01 seconds)
(finished: run the VM test script, in 18.76 seconds)
test script finished in 18.79s
�[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)
(finished: cleanup, in 0.01 seconds)
kill vlan (pid 6)