�[2mserver # [   13.471461] dhcpcd[634]: eth0: probing address 10.0.2.15/24�[0m
�[2mclient # [   13.545823] systemd[1]: Finished Extra networking commands..�[0m
�[2mclient # [   13.551474] systemd[1]: Reached target Network.�[0m
�[2mserver # [   13.496619] systemd[1]: Finished Permit User Sessions.�[0m
�[2mclient # [   13.563036] systemd[1]: Starting Permit User Sessions...�[0m
�[2mclient # [   13.633905] systemd[1]: Finished Permit User Sessions.�[0m
�[2mclient # [   13.649951] systemd[1]: Started Getty on tty1.�[0m
�[2mclient # [   13.654572] systemd[1]: Reached target Login Prompts.�[0m
�[2mserver # [   13.668837] nginx-pre-start[858]: nginx: the configuration file /nix/store/naifylbzn1nha1i4xlw72kna5r4kcf46-nginx.conf syntax is ok�[0m
�[2mserver # [   13.671981] nginx-pre-start[858]: nginx: configuration file /nix/store/naifylbzn1nha1i4xlw72kna5r4kcf46-nginx.conf test is successful�[0m
�[2mclient # [   13.750433] dhcpcd[636]: eth0: soliciting a DHCP lease�[0m
�[2mserver # [   13.694279] systemd[1]: Started Nginx Web Server.�[0m
�[2mclient # [   13.803075] systemd[1]: Finished Virtual Console Setup.�[0m
�[2mclient # [   13.982190] NET: Registered PF_PACKET protocol family�[0m
�[2mclient # [   13.819159] dhcpcd[636]: eth0: offered 10.0.2.15 from 10.0.2.2�[0m
�[2mclient # [   13.823067] dhcpcd[636]: eth0: probing address 10.0.2.15/24�[0m
�[2mserver # [   14.039768] dhcpcd[634]: eth0: Router Advertisement from fe80::2�[0m
�[2mserver # [   14.045067] dhcpcd[634]: eth0: adding address fec0::5054:ff:fe12:3456/64�[0m
�[2mserver # [   14.047879] dhcpcd[634]: eth0: adding route to fec0::/64�[0m
�[2mserver # [   14.049578] dhcpcd[634]: eth0: adding default route via fe80::2�[0m
(finished: waiting for unit audiobookshelf.service, in 15.10 seconds)
server: �[1m�[32mwaiting for unit nginx.service�[0m
(finished: waiting for unit nginx.service, in 0.18 seconds)
server: �[1m�[32mwaiting for TCP port 8113 on localhost�[0m
�[2mclient # [   14.733409] dhcpcd[636]: eth0: Router Advertisement from fe80::2�[0m
�[2mclient # [   14.741843] dhcpcd[636]: eth0: adding address fec0::5054:ff:fe12:3456/64�[0m
�[2mclient # [   14.746300] dhcpcd[636]: eth0: adding route to fec0::/64�[0m
�[2mclient # [   14.749095] dhcpcd[636]: eth0: adding default route via fe80::2�[0m
�[2mserver # [   18.638179] dhcpcd[634]: eth0: leased 10.0.2.15 for 86400 seconds�[0m
�[2mserver # [   18.639565] dhcpcd[634]: eth0: adding route to 10.0.2.0/24�[0m
�[2mserver # [   18.642401] dhcpcd[634]: eth0: adding default route via 10.0.2.2�[0m
�[2mserver # [   18.806612] systemd[1]: Stopped target Host and Network Name Lookups.�[0m
�[2mserver # [   18.811594] systemd[1]: Stopping Host and Network Name Lookups...�[0m
�[2mserver # [   18.817816] systemd[1]: Stopped target User and Group Name Lookups.�[0m
�[2mserver # [   18.822325] systemd[1]: Stopping User and Group Name Lookups...�[0m
�[2mserver # [   18.824384] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...�[0m
�[2mserver # [   18.826616] systemd[1]: nscd.service: Deactivated successfully.�[0m
�[2mserver # [   18.832991] systemd[1]: Stopped Name Service Cache Daemon (nsncd).�[0m
�[2mserver # [   18.846750] systemd[1]: Starting Name Service Cache Daemon (nsncd)...�[0m
�[2mserver # [   18.893470] systemd[1]: Started DHCP Client.�[0m
�[2mserver # [   18.896988] systemd[1]: Reached target Network is Online.�[0m
�[2mserver # [   18.929819] systemd[1]: Started Name Service Cache Daemon (nsncd).�[0m
�[2mserver # [   18.933863] systemd[1]: Reached target Multi-User System.�[0m
�[2mserver # [   18.937943] nsncd[946]: Sep 16 01:30:11.491 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 3s }, path: "/var/run/nscd/socket"�[0m
�[2mserver # [   18.942598] systemd[1]: Reached target Host and Network Name Lookups.�[0m
�[2mserver # [   18.944820] systemd[1]: Reached target User and Group Name Lookups.�[0m
�[2mserver # [   18.946676] systemd[1]: Startup finished in 4.032s (kernel) + 14.902s (userspace) = 18.934s.�[0m
�[2mclient # [   19.294748] dhcpcd[636]: eth0: leased 10.0.2.15 for 86400 seconds�[0m
�[2mclient # [   19.297614] dhcpcd[636]: eth0: adding route to 10.0.2.0/24�[0m
�[2mclient # [   19.299438] dhcpcd[636]: eth0: adding default route via 10.0.2.2�[0m
�[2mclient # [   19.436472] systemd[1]: Stopped target Host and Network Name Lookups.�[0m
�[2mclient # [   19.439675] systemd[1]: Stopping Host and Network Name Lookups...�[0m
�[2mclient # [   19.444521] systemd[1]: Stopped target User and Group Name Lookups.�[0m
�[2mclient # [   19.445990] systemd[1]: Stopping User and Group Name Lookups...�[0m
�[2mclient # [   19.450567] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...�[0m
�[2mclient # [   19.454772] systemd[1]: nscd.service: Deactivated successfully.�[0m
�[2mclient # [   19.458266] systemd[1]: Stopped Name Service Cache Daemon (nsncd).�[0m
�[2mclient # [   19.477311] systemd[1]: Starting Name Service Cache Daemon (nsncd)...�[0m
�[2mclient # [   19.516170] systemd[1]: Started DHCP Client.�[0m
�[2mclient # [   19.521967] systemd[1]: Reached target Network is Online.�[0m
�[2mclient # [   19.545600] systemd[1]: Started Name Service Cache Daemon (nsncd).�[0m
�[2mclient # [   19.549896] nsncd[891]: Sep 16 01:30:12.929 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 3s }, path: "/var/run/nscd/socket"�[0m
�[2mclient # [   19.557120] systemd[1]: Reached target Multi-User System.�[0m
�[2mclient # [   19.557979] systemd[1]: Reached target Host and Network Name Lookups.�[0m
�[2mclient # [   19.559571] systemd[1]: Reached target User and Group Name Lookups.�[0m
�[2mclient # [   19.560885] systemd[1]: Startup finished in 4.478s (kernel) + 15.070s (userspace) = 19.549s.�[0m
�[2mserver # [   21.446560] audiobookshelf[848]: Config /var/lib/audiobookshelf/config /var/lib/audiobookshelf/metadata�[0m
�[2mserver # [   21.473360] audiobookshelf[848]: [2024-09-16 01:30:14.027] INFO: === Starting Server ===�[0m
�[2mserver # [   21.479154] audiobookshelf[848]: [2024-09-16 01:30:14.036] INFO: [Server] Init v2.13.3�[0m
�[2mserver # [   21.480632] audiobookshelf[848]: [2024-09-16 01:30:14.037] INFO: [Server] Node.js Version: v18.20.4�[0m
�[2mserver # [   21.482915] audiobookshelf[848]: [2024-09-16 01:30:14.040] INFO: [Server] Platform: linux�[0m
�[2mserver # [   21.485121] audiobookshelf[848]: [2024-09-16 01:30:14.043] INFO: [Server] Arch: x64�[0m
�[2mserver # [   21.498121] audiobookshelf[848]: [2024-09-16 01:30:14.056] INFO: [BinaryManager] Skipping check for binaries�[0m
�[2mserver # [   21.503401] audiobookshelf[848]: [2024-09-16 01:30:14.061] INFO: [Database] absdatabase.sqlite not found at /var/lib/audiobookshelf/config/absdatabase.sqlite�[0m
�[2mserver # [   21.507309] audiobookshelf[848]: [2024-09-16 01:30:14.064] INFO: [Database] Initializing db at "/var/lib/audiobookshelf/config/absdatabase.sqlite"�[0m
�[2mserver # [   21.751577] audiobookshelf[848]: [2024-09-16 01:30:14.309] INFO: [Database] Db connection was successful�[0m
�[2mserver # [   22.448459] audiobookshelf[848]: [2024-09-16 01:30:15.005] INFO: [Database] Db initialized with models: user, library, libraryFolder, book, podcast, podcastEpisode, libraryItem, mediaProgress, series, bookSeries, author, bookAuthor, collection, collectionBook, playlist, playlistMediaItem, device, playbackSession, feed, feedEpisode, setting, customMetadataProvider, mediaItemShare�[0m
�[2mserver # [   22.491875] audiobookshelf[848]: [2024-09-16 01:30:15.049] INFO: [LogManager] Init current daily log filename: 2024-09-16.txt�[0m
�[2mserver # [   22.559131] audiobookshelf[848]: [2024-09-16 01:30:15.117] INFO: [BackupManager] 0 Backups Found�[0m
�[2mserver # [   22.562845] audiobookshelf[848]: [2024-09-16 01:30:15.120] INFO: [BackupManager] Auto Backups are disabled�[0m
�[2mserver # [   22.639146] audiobookshelf[848]: [2024-09-16 01:30:15.196] INFO: Listening on http://127.0.0.1:8113�[0m
�[2mserver # Connection to localhost (127.0.0.1) 8113 port [tcp/*] succeeded!�[0m
(finished: waiting for TCP port 8113 on localhost, in 8.77 seconds)
�[1m�[32msubtest: access�[0m
curl --show-error --location --cookie-jar cookie.txt --cookie cookie.txt --connect-to a.example.com:443:server:443 --connect-to a.example.com:80:server:80 --connect-to auth.example.com:443:server:443 --silent --output /dev/null --write-out '{"code":%{response_code}}' http://a.example.com
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: subtest: access, in 0.15 seconds)
(finished: run the VM test script, in 24.71 seconds)
test script finished in 24.83s
�[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 30)
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)