�[2mmachine # [    5.722978] systemd[1]: Starting Networking Setup...�[0m
�[2mmachine # [    5.726582] dhcpcd[654]: DUID 00:01:00:01:2e:4d:79:98:52:54:00:12:34:56�[0m
�[2mmachine # [    5.727855] dhcpcd[654]: eth0: IAID 00:12:34:56�[0m
�[2mmachine # [    5.728757] dhcpcd[654]: eth0: adding address fe80::5054:ff:fe12:3456�[0m
�[2mmachine # [    5.808096] systemd[1]: Finished Networking Setup.�[0m
�[2mmachine # [    5.814345] systemd[1]: Starting Extra networking commands....�[0m
�[2mmachine # [    5.838447] systemd[1]: Finished Extra networking commands..�[0m
�[2mmachine # [    5.840472] systemd[1]: Reached target Network.�[0m
�[2mmachine # [    5.847229] systemd[1]: Starting PostgreSQL Server...�[0m
�[2mmachine # [    5.852832] systemd[1]: Starting Permit User Sessions...�[0m
�[2mmachine # [    5.886969] systemd[1]: Finished Permit User Sessions.�[0m
�[2mmachine # [    5.972333] postgresql-pre-start[796]: The files belonging to this database system will be owned by user "postgres".�[0m
�[2mmachine # [    5.973889] postgresql-pre-start[796]: This user must also own the server process.�[0m
�[2mmachine # [    5.978904] postgresql-pre-start[796]: The database cluster will be initialized with locale "en_US.UTF-8".�[0m
�[2mmachine # [    5.980147] postgresql-pre-start[796]: The default database encoding has accordingly been set to "UTF8".�[0m
�[2mmachine # [    5.981322] postgresql-pre-start[796]: The default text search configuration will be set to "english".�[0m
�[2mmachine # [    5.982496] postgresql-pre-start[796]: Data page checksums are disabled.�[0m
�[2mmachine # [    5.983441] postgresql-pre-start[796]: fixing permissions on existing directory /var/lib/postgresql/15 ... ok�[0m
�[2mmachine # [    5.984627] postgresql-pre-start[796]: creating subdirectories ... ok�[0m
�[2mmachine # [    5.985647] postgresql-pre-start[796]: selecting dynamic shared memory implementation ... posix�[0m
�[2mmachine # [    6.045428] postgresql-pre-start[796]: selecting default max_connections ... 100�[0m
�[2mmachine # [    6.090057] postgresql-pre-start[796]: selecting default shared_buffers ... 128MB�[0m
�[2mmachine # [    6.348501] dhcpcd[654]: eth0: soliciting an IPv6 router�[0m
�[2mmachine # [    6.456863] dhcpcd[654]: eth0: soliciting a DHCP lease�[0m
�[2mmachine # [    6.581052] NET: Registered PF_PACKET protocol family�[0m
�[2mmachine # [    6.474562] dhcpcd[654]: eth0: offered 10.0.2.15 from 10.0.2.2�[0m
�[2mmachine # [    6.475763] dhcpcd[654]: eth0: leased 10.0.2.15 for 86400 seconds�[0m
�[2mmachine # [    6.476567] dhcpcd[654]: eth0: adding route to 10.0.2.0/24�[0m
�[2mmachine # [    6.477199] dhcpcd[654]: eth0: adding default route via 10.0.2.2�[0m
�[2mmachine # [    6.538898] systemd[1]: Stopped target Host and Network Name Lookups.�[0m
�[2mmachine # [    6.541265] systemd[1]: Stopping Host and Network Name Lookups...�[0m
�[2mmachine # [    6.543118] systemd[1]: Stopped target User and Group Name Lookups.�[0m
�[2mmachine # [    6.544731] systemd[1]: Stopping User and Group Name Lookups...�[0m
�[2mmachine # [    6.546164] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...�[0m
�[2mmachine # [    6.547814] systemd[1]: nscd.service: Deactivated successfully.�[0m
�[2mmachine # [    6.550985] systemd[1]: Stopped Name Service Cache Daemon (nsncd).�[0m
�[2mmachine # [    6.562620] systemd[1]: Starting Name Service Cache Daemon (nsncd)...�[0m
�[2mmachine # [    6.594069] systemd[1]: Started DHCP Client.�[0m
�[2mmachine # [    6.600920] systemd[1]: Reached target Network is Online.�[0m
�[2mmachine # [    6.613372] nsncd[846]: Aug 13 01:55:37.404 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 3s }, path: "/var/run/nscd/socket"�[0m
�[2mmachine # [    6.616385] systemd[1]: Started Name Service Cache Daemon (nsncd).�[0m
�[2mmachine # [    6.623693] systemd[1]: Reached target Host and Network Name Lookups.�[0m
�[2mmachine # [    6.624664] systemd[1]: Reached target User and Group Name Lookups.�[0m
�[2mmachine # [    6.920140] dhcpcd[654]: eth0: Router Advertisement from fe80::2�[0m
�[2mmachine # [    6.921049] dhcpcd[654]: eth0: adding address fec0::5054:ff:fe12:3456/64�[0m
�[2mmachine # [    6.921874] dhcpcd[654]: eth0: adding route to fec0::/64�[0m
�[2mmachine # [    6.922583] dhcpcd[654]: eth0: adding default route via fe80::2�[0m
�[2mmachine # [    7.384241] postgresql-pre-start[796]: selecting default time zone ... UTC�[0m
�[2mmachine # [    7.387496] postgresql-pre-start[796]: creating configuration files ... ok�[0m
�[2mmachine # [    7.549760] postgresql-pre-start[796]: running bootstrap script ... ok�[0m
�[2mmachine # [    7.972133] postgresql-pre-start[796]: performing post-bootstrap initialization ... ok�[0m
�[2mmachine # [    8.085401] postgresql-pre-start[796]: syncing data to disk ... ok�[0m
�[2mmachine # [    8.086175] postgresql-pre-start[796]: initdb: warning: enabling "trust" authentication for local connections�[0m
�[2mmachine # [    8.087173] postgresql-pre-start[796]: 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 # [    8.088877] postgresql-pre-start[796]: Success. You can now start the database server using:�[0m
�[2mmachine # [    8.089644] postgresql-pre-start[796]:     /nix/store/hh1x7h54liwwclmwssmm66kdpa24im64-postgresql-and-plugins-15.7/bin/pg_ctl -D /var/lib/postgresql/15 -l logfile start�[0m
�[2mmachine # [    8.150940] postgres[881]: [881] LOG:  starting PostgreSQL 15.7 on x86_64-pc-linux-gnu, compiled by gcc (GCC) 13.2.0, 64-bit�[0m
�[2mmachine # [    8.152466] postgres[881]: [881] LOG:  listening on IPv4 address "0.0.0.0", port 5432�[0m
�[2mmachine # [    8.153258] postgres[881]: [881] LOG:  listening on IPv6 address "::", port 5432�[0m
�[2mmachine # [    8.154680] postgres[881]: [881] LOG:  listening on Unix socket "/run/postgresql/.s.PGSQL.5432"�[0m
�[2mmachine # [    8.160687] postgres[884]: [884] LOG:  database system was shut down at 2024-08-13 01:55:38 GMT�[0m
�[2mmachine # [    8.163833] postgres[881]: [881] LOG:  database system is ready to accept connections�[0m
�[2mmachine # [    8.268118] postgresql-post-start[895]: CREATE DATABASE�[0m
�[2mmachine # [    8.300283] postgresql-post-start[904]: CREATE ROLE�[0m
�[2mmachine # [    8.310958] postgresql-post-start[907]: ALTER ROLE�[0m
�[2mmachine # [    8.322424] postgresql-post-start[909]: ALTER DATABASE�[0m
�[2mmachine # [    8.339979] postgresql-post-start[911]: DO�[0m
�[2mmachine # [    8.342432] systemd[1]: Started PostgreSQL Server.�[0m
�[2mmachine # [    8.344251] systemd[1]: Reached target Multi-User System.�[0m
�[2mmachine # [    8.344958] systemd[1]: Startup finished in 2.307s (kernel) + 6.037s (userspace) = 8.344s.�[0m
(finished: waiting for unit postgresql.service, in 9.24 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 peer login with provisioned user and database�[0m
machine: �[1m�[32mmust succeed: sudo -u me psql -U me me --command ""�[0m
�[2mmachine # [    8.810402] sudo[926]: �[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.820790] sudo[926]: pam_unix(sudo:session): session opened for user me(uid=998) by (uid=0)�[0m
�[2mmachine # [    8.838628] sudo[926]: pam_unix(sudo:session): session closed for user me�[0m
(finished: must succeed: sudo -u me psql -U me me --command "", in 0.08 seconds)
(finished: subtest: can peer login with provisioned user and database, in 0.08 seconds)
�[1m�[32msubtest: can tcpip login with provisioned user and database�[0m
machine: �[1m�[32mmust succeed: PGPASSWORD=secretpw psql -h 127.0.0.1 -p 5432 -U me me --command ""�[0m
(finished: must succeed: PGPASSWORD=secretpw psql -h 127.0.0.1 -p 5432 -U me me --command "", in 0.05 seconds)
(finished: subtest: can tcpip login with provisioned user and database, in 0.05 seconds)
�[1m�[32msubtest: cannot tcpip login with wrong password�[0m
machine: �[1m�[32mmust fail: PGPASSWORD=oops psql -h 127.0.0.1 -p 5432 -U me me --command ""�[0m
�[2mmachine # psql: error: connection to server at "127.0.0.1", port 5432 failed: FATAL:  password authentication failed for user "me"�[0m
�[2mmachine # [    8.926455] postgres[941]: [941] FATAL:  password authentication failed for user "me"�[0m
�[2mmachine # [    8.928237] postgres[941]: [941] DETAIL:  Password does not match for user "me".�[0m
�[2mmachine # [    8.929329] postgres[941]: 	Connection matched pg_hba.conf line 4: "host  all      all    127.0.0.1/32   password"�[0m
(finished: must fail: PGPASSWORD=oops psql -h 127.0.0.1 -p 5432 -U me me --command "", in 0.04 seconds)
(finished: subtest: cannot tcpip login with wrong password, in 0.04 seconds)
(finished: run the VM test script, in 9.59 seconds)
test script finished in 9.62s
�[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)
(finished: cleanup, in 0.01 seconds)
kill vlan (pid 5)