�[2mclient # [   11.122296] dhcpcd[688]: eth0: adding default route via 10.0.2.2�[0m
�[2mclient # [   11.187970] systemd[1]: Stopped target Host and Network Name Lookups.�[0m
�[2mclient # [   11.189044] systemd[1]: Stopping Host and Network Name Lookups...�[0m
�[2mclient # [   11.189972] systemd[1]: Stopped target User and Group Name Lookups.�[0m
�[2mclient # [   11.191919] systemd[1]: Stopping User and Group Name Lookups...�[0m
�[2mclient # [   11.194488] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...�[0m
�[2mclient # [   11.196361] systemd[1]: nscd.service: Deactivated successfully.�[0m
�[2mclient # [   11.200483] systemd[1]: Stopped Name Service Cache Daemon (nsncd).�[0m
�[2mclient # [   11.213117] systemd[1]: Starting Name Service Cache Daemon (nsncd)...�[0m
�[2mclient # [   11.225559] systemd[1]: Started DHCP Client.�[0m
�[2mclient # [   11.230748] systemd[1]: Reached target Network is Online.�[0m
�[2mclient # [   11.248849] systemd[1]: Started Name Service Cache Daemon (nsncd).�[0m
�[2mclient # [   11.251096] systemd[1]: Reached target Multi-User System.�[0m
�[2mclient # [   11.252213] nsncd[878]: Sep 14 01:21:17.998 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 3s }, path: "/var/run/nscd/socket"�[0m
�[2mclient # [   11.254204] systemd[1]: Reached target Host and Network Name Lookups.�[0m
�[2mclient # [   11.256922] systemd[1]: Reached target User and Group Name Lookups.�[0m
�[2mclient # [   11.258265] systemd[1]: Startup finished in 2.330s (kernel) + 8.927s (userspace) = 11.257s.�[0m
�[2mserver # [   11.469414] jellyfin[930]: [01:21:18] [INF] [4] Main: Jellyfin version: 10.9.10�[0m
�[2mserver # [   11.483497] jellyfin[930]: [01:21:18] [INF] [4] Main: Environment Variables: ["[JELLYFIN_LOG_DIR, /var/lib/jellyfin/log]", "[DOTNET_ROOT, /nix/store/faavd32k06bkhwg5c2qmgigdvkhw45py-aspnetcore-runtime-8.0.8]"]�[0m
�[2mserver # [   11.486226] jellyfin[930]: [01:21:18] [INF] [4] Main: Arguments: ["/nix/store/sr0z25q1bf0fqggl8nkz94x2vbqi6qbq-jellyfin-10.9.10/lib/jellyfin/jellyfin.dll", "--ffmpeg=/nix/store/c8jqp8vbc84p3j2vj7pah1wvi4h0q2i2-jellyfin-ffmpeg-6.0.1-8-bin/bin/ffmpeg", "--webdir=/nix/store/w58747pzi5hvx8kdcw6gsbrhcb1v1any-jellyfin-web-10.9.10/share/jellyfin-web", "--datadir", "/var/lib/jellyfin", "--configdir", "/var/lib/jellyfin/config", "--cachedir", "/var/cache/jellyfin", "--logdir", "/var/lib/jellyfin/log"]�[0m
�[2mserver # [   11.490618] jellyfin[930]: [01:21:18] [INF] [4] Main: Operating system: NixOS 24.11 (Vicuna)�[0m
�[2mserver # [   11.493140] jellyfin[930]: [01:21:18] [INF] [4] Main: Architecture: X64�[0m
�[2mserver # [   11.494332] jellyfin[930]: [01:21:18] [INF] [4] Main: 64-Bit Process: True�[0m
�[2mserver # [   11.495572] jellyfin[930]: [01:21:18] [INF] [4] Main: User Interactive: True�[0m
�[2mserver # [   11.496261] jellyfin[930]: [01:21:18] [INF] [4] Main: Processor count: 1�[0m
�[2mserver # [   11.497040] jellyfin[930]: [01:21:18] [INF] [4] Main: Program data path: /var/lib/jellyfin�[0m
�[2mserver # [   11.497931] jellyfin[930]: [01:21:18] [INF] [4] Main: Log directory path: /var/lib/jellyfin/log�[0m
�[2mserver # [   11.499481] jellyfin[930]: [01:21:18] [INF] [4] Main: Config directory path: /var/lib/jellyfin/config�[0m
�[2mserver # [   11.500347] jellyfin[930]: [01:21:18] [INF] [4] Main: Cache path: /var/cache/jellyfin�[0m
�[2mserver # [   11.501202] jellyfin[930]: [01:21:18] [INF] [4] Main: Web resources path: /nix/store/w58747pzi5hvx8kdcw6gsbrhcb1v1any-jellyfin-web-10.9.10/share/jellyfin-web�[0m
�[2mserver # [   11.502385] jellyfin[930]: [01:21:18] [INF] [4] Main: Application directory: /nix/store/sr0z25q1bf0fqggl8nkz94x2vbqi6qbq-jellyfin-10.9.10/lib/jellyfin/�[0m
�[2mserver # [   11.546084] jellyfin[930]: [01:21:18] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Marking following migrations as applied because this is a fresh install: ["CreateNetworkConfiguration", "MigrateMusicBrainzTimeout", "MigrateNetworkConfiguration"]�[0m
�[2mserver # [   11.665303] jellyfin[930]: [01:21:18] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin�[0m
�[2mserver # [   11.747113] jellyfin[930]: [01:21:18] [INF] [4] Emby.Server.Implementations.ApplicationHost: Loading assemblies�[0m
�[2mserver # [   11.828646] jellyfin[930]: [01:21:18] [INF] [4] Jellyfin.Networking.Manager.NetworkManager: Defined LAN subnets: ["127.0.0.1/8", "10.0.0.0/8", "172.16.0.0/12", "192.168.0.0/16"]�[0m
�[2mserver # [   11.830201] jellyfin[930]: [01:21:18] [INF] [4] Jellyfin.Networking.Manager.NetworkManager: Defined LAN exclusions: []�[0m
�[2mserver # [   11.831247] jellyfin[930]: [01:21:18] [INF] [4] Jellyfin.Networking.Manager.NetworkManager: Used LAN subnets: ["127.0.0.1/8", "10.0.0.0/8", "172.16.0.0/12", "192.168.0.0/16"]�[0m
�[2mserver # [   11.834374] jellyfin[930]: [01:21:18] [INF] [4] Jellyfin.Networking.Manager.NetworkManager: Filtered interface addresses: ["127.0.0.1", "10.0.2.15", "192.168.1.2"]�[0m
�[2mserver # [   11.836638] jellyfin[930]: [01:21:18] [INF] [4] Jellyfin.Networking.Manager.NetworkManager: Bind Addresses ["0.0.0.0"]�[0m
�[2mserver # [   11.838180] jellyfin[930]: [01:21:18] [INF] [4] Jellyfin.Networking.Manager.NetworkManager: Remote IP filter is Allowlist�[0m
�[2mserver # [   11.839783] jellyfin[930]: [01:21:18] [INF] [4] Jellyfin.Networking.Manager.NetworkManager: Filtered subnets: []�[0m
�[2mserver # [   12.922312] jellyfin[930]: [01:21:19] [INF] [4] Emby.Server.Implementations.ApplicationHost: There are pending EFCore migrations in the database. Applying... (This may take a while, do not stop Jellyfin)�[0m
�[2mserver # [   13.238248] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.EntityFrameworkCore.Migrations: An operation of type 'SqlOperation' will be attempted while a rebuild of table 'ImageInfos' is pending. The database may not be in an expected state. Review the SQL generated by this migration to help diagnose any failures. Consider moving these operations to a subsequent migration.�[0m
�[2mserver # [   13.242229] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.EntityFrameworkCore.Migrations: An operation of type 'SqlOperation' will be attempted while a rebuild of table 'ImageInfos' is pending. The database may not be in an expected state. Review the SQL generated by this migration to help diagnose any failures. Consider moving these operations to a subsequent migration.�[0m
�[2mserver # [   13.245542] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.EntityFrameworkCore.Migrations: An operation of type 'SqlOperation' will be attempted while a rebuild of table 'Permissions' is pending. The database may not be in an expected state. Review the SQL generated by this migration to help diagnose any failures. Consider moving these operations to a subsequent migration.�[0m
�[2mserver # [   13.248458] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.EntityFrameworkCore.Migrations: An operation of type 'SqlOperation' will be attempted while a rebuild of table 'Permissions' is pending. The database may not be in an expected state. Review the SQL generated by this migration to help diagnose any failures. Consider moving these operations to a subsequent migration.�[0m
�[2mserver # [   13.251787] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.EntityFrameworkCore.Migrations: An operation of type 'SqlOperation' will be attempted while a rebuild of table 'Preferences' is pending. The database may not be in an expected state. Review the SQL generated by this migration to help diagnose any failures. Consider moving these operations to a subsequent migration.�[0m
�[2mserver # [   13.254606] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.EntityFrameworkCore.Migrations: An operation of type 'SqlOperation' will be attempted while a rebuild of table 'Preferences' is pending. The database may not be in an expected state. Review the SQL generated by this migration to help diagnose any failures. Consider moving these operations to a subsequent migration.�[0m
�[2mserver # [   13.257869] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.EntityFrameworkCore.Migrations: An operation of type 'SqlOperation' will be attempted while a rebuild of table 'Users' is pending. The database may not be in an expected state. Review the SQL generated by this migration to help diagnose any failures. Consider moving these operations to a subsequent migration.�[0m
�[2mserver # [   13.260685] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.EntityFrameworkCore.Migrations: An operation of type 'SqlOperation' will be attempted while a rebuild of table 'Users' is pending. The database may not be in an expected state. Review the SQL generated by this migration to help diagnose any failures. Consider moving these operations to a subsequent migration.�[0m
�[2mserver # [   13.386742] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.ApplicationHost: EFCore migrations applied successfully�[0m
�[2mserver # [   13.851889] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Saving system configuration�[0m
�[2mserver # [   13.854269] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin�[0m
�[2mserver # [   13.860827] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: TMDb 10.9.10.0�[0m
�[2mserver # [   13.863476] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: Studio Images 10.9.10.0�[0m
�[2mserver # [   13.865250] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: OMDb 10.9.10.0�[0m
�[2mserver # [   13.879160] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: MusicBrainz 10.9.10.0�[0m
�[2mserver # [   13.880781] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: AudioDB 10.9.10.0�[0m
�[2mserver # [   13.935497] jellyfin[930]: [01:21:20] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Marking following migrations as applied because this is a fresh install: ["DisableTranscodingThrottling", "CreateLoggingConfigHeirarchy", "MigrateActivityLogDatabase", "RemoveDuplicateExtras", "MigrateUserDatabase", "MigrateDisplayPreferencesDatabase", "RemoveDownloadImagesInAdvance", "MigrateAuthenticationDatabase", "FixPlaylistOwner", "MigrateRatingLevels", "FixAudioData"]�[0m
�[2mserver # [   13.942072] jellyfin[930]: [01:21:20] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Applying migration 'AddDefaultPluginRepository'�[0m
�[2mserver # [   13.943241] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Saving system configuration�[0m
�[2mserver # [   13.945121] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin�[0m
�[2mserver # [   13.946501] jellyfin[930]: [01:21:20] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Migration 'AddDefaultPluginRepository' applied successfully�[0m
�[2mserver # [   13.948559] jellyfin[930]: [01:21:20] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Applying migration 'ReaddDefaultPluginRepository'�[0m
�[2mserver # [   13.949727] jellyfin[930]: [01:21:20] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Migration 'ReaddDefaultPluginRepository' applied successfully�[0m
�[2mserver # [   13.951470] jellyfin[930]: [01:21:20] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Applying migration 'AddDefaultCastReceivers'�[0m
�[2mserver # [   13.952928] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Saving system configuration�[0m
�[2mserver # [   13.954645] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin�[0m
�[2mserver # [   13.956048] jellyfin[930]: [01:21:20] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Migration 'AddDefaultCastReceivers' applied successfully�[0m
�[2mserver # [   13.958056] jellyfin[930]: [01:21:20] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Applying migration 'UpdateDefaultPluginRepository10.9'�[0m
�[2mserver # [   13.959360] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Saving system configuration�[0m
�[2mserver # [   13.960885] jellyfin[930]: [01:21:20] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin�[0m
�[2mserver # [   13.962134] jellyfin[930]: [01:21:20] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Migration 'UpdateDefaultPluginRepository10.9' applied successfully�[0m
�[2mserver # [   13.975770] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.AspNetCore.DataProtection.Repositories.EphemeralXmlRepository: Using an in-memory repository. Keys will not be persisted to storage.�[0m
�[2mserver # [   13.978214] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager: Neither user profile nor HKLM registry available. Using an ephemeral key repository. Protected data will be unavailable when application exits.�[0m
�[2mserver # [   14.023550] jellyfin[930]: [01:21:20] [INF] [4] Main: Kestrel is listening on 0.0.0.0�[0m
�[2mserver # [   14.047083] jellyfin[930]: [01:21:20] [WRN] [4] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager: No XML encryptor configured. Key {06494619-c255-4161-8ad8-9be83986ec8f} may be persisted to storage in unencrypted form.�[0m
�[2mserver # [   14.449964] jellyfin[930]: [01:21:21] [WRN] [4] Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware: The WebRootPath was not found: /var/lib/jellyfin/wwwroot. Static files may be unavailable.�[0m
�[2mserver # [   14.522865] jellyfin[930]: [01:21:21] [INF] [4] Emby.Server.Implementations.ApplicationHost: Running startup tasks�[0m
�[2mserver # [   14.546084] jellyfin[930]: [01:21:21] [INF] [4] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for Generate Trickplay Images set to fire at 2024-09-14 03:00:00.000 +00:00, which is 01:38:38.6021019 from now.�[0m
�[2mserver # [   14.551123] jellyfin[930]: [01:21:21] [INF] [4] Emby.Server.Implementations.ScheduledTasks.TaskManager: Daily trigger for Extract Chapter Images set to fire at 2024-09-14 02:00:00.000 +00:00, which is 00:38:38.5972395 from now.�[0m
�[2mserver # Connection to localhost (127.0.0.1) 8096 port [tcp/*] succeeded!�[0m
(finished: waiting for TCP port 8096 on localhost, in 4.17 seconds)
�[1m�[32msubtest: access�[0m
curl --show-error --location --cookie-jar cookie.txt --cookie cookie.txt --connect-to j.example.com:443:server:443 --connect-to j.example.com:80:server:80 --connect-to auth.example.com:443:server:443 --silent --output /dev/null --write-out '{"code":%{response_code}}' http://j.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.12 seconds)
(finished: run the VM test script, in 15.90 seconds)
test script finished in 15.95s
�[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 29)
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)