�[2mserver # [   16.554738] authelia-auth.example.com-pre-start[1127]: 	 - identity_providers: oidc: clients: client 'jellyfin': option 'client_secret' is plaintext but for clients not using the 'token_endpoint_auth_method' of 'client_secret_jwt' it should be a hashed value as plaintext values are deprecated with the exception of 'client_secret_jwt' and will be removed in the near future�[0m
�[2mserver # [   16.562902] systemd[1]: Started Authelia authentication and authorization server.�[0m
�[2mserver # [   16.565807] systemd[1]: Reached target Multi-User System.�[0m
�[2mserver # [   16.566963] systemd[1]: Startup finished in 2.654s (kernel) + 13.910s (userspace) = 16.565s.�[0m
�[2mserver # [   16.726540] authelia[1133]: time="2024-09-14T01:20:30Z" level=debug msg="Loaded Configuration Sources" files="[/nix/store/8mmgyc98075k3lqyysn7kdwb3x463ib2-config.yml /var/lib/authelia-auth.example.com/oidc_clients.yaml]" filters="[]"�[0m
�[2mserver # [   16.729361] authelia[1133]: time="2024-09-14T01:20:30Z" level=debug msg="Logging Initialized" fields.level=debug file= format=json keep_stdout=false�[0m
�[2mserver # [   16.732763] authelia[1133]: time="2024-09-14T01:20:30Z" level=debug msg="Process user information" gid=999 uid=999 username=authelia�[0m
�[2mserver # [   16.735246] authelia[1133]: time="2024-09-14T01:20:30Z" level=warning msg="Configuration: configuration key 'identity_providers.oidc.issuer_private_key' is deprecated in 4.38.0 and has been replaced by 'identity_providers.oidc.jwks': you are not required to make any changes as this has been automatically mapped for you, but to stop this warning being logged you will need to adjust your configuration, and this configuration key and auto-mapping is likely to be removed in 5.0.0 : see https://www.authelia.com/c/oidc for more information"�[0m
�[2mserver # [   16.744497] authelia[1133]: time="2024-09-14T01:20:30Z" level=warning msg="Configuration: identity_providers: oidc: clients: client 'jellyfin': option 'client_secret' is plaintext but for clients not using the 'token_endpoint_auth_method' of 'client_secret_jwt' it should be a hashed value as plaintext values are deprecated with the exception of 'client_secret_jwt' and will be removed in the near future"�[0m
�[2mserver # [   16.747412] authelia[1133]: time="2024-09-14T01:20:30Z" level=info msg="Authelia v4.38.10-nixpkgs is starting"�[0m
�[2mserver # [   16.748363] authelia[1133]: time="2024-09-14T01:20:30Z" level=info msg="Log severity set to debug"�[0m
�[2mserver # [   16.791126] authelia[1133]: {"level":"debug","msg":"Registering client jellyfin with policy one_factor (one_factor)","time":"2024-09-14T01:20:30Z"}�[0m
�[2mserver # [   16.815475] authelia[1133]: {"level":"info","msg":"Storage schema is being checked for updates","time":"2024-09-14T01:20:30Z"}�[0m
�[2mserver # [   16.856383] authelia[1133]: {"level":"info","msg":"Storage schema migration from 0 to 15 is being attempted","time":"2024-09-14T01:20:30Z"}�[0m
�[2mserver # [   16.911104] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 0 to 1","time":"2024-09-14T01:20:30Z"}�[0m
�[2mserver # [   16.937636] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 1 to 2","time":"2024-09-14T01:20:30Z"}�[0m
�[2mserver # [   16.958513] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 2 to 3","time":"2024-09-14T01:20:30Z"}�[0m
�[2mserver # [   17.071167] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 3 to 4","time":"2024-09-14T01:20:30Z"}�[0m
�[2mserver # [   17.075398] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 4 to 5","time":"2024-09-14T01:20:30Z"}�[0m
�[2mserver # [   17.225736] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 5 to 6","time":"2024-09-14T01:20:30Z"}�[0m
�[2mserver # [   17.286610] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 6 to 7","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.298135] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 7 to 8","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.301089] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 8 to 9","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.302981] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 9 to 10","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.308136] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 10 to 11","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.331226] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 11 to 12","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.341964] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 12 to 13","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.344296] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 13 to 14","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.352853] authelia[1133]: {"level":"debug","msg":"Storage schema migrated from version 14 to 15","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.354052] authelia[1133]: {"level":"info","msg":"Storage schema migration from 0 to 15 is complete","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.550324] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Saving system configuration�[0m
�[2mserver # [   17.552662] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin�[0m
�[2mserver # [   17.554993] authelia[1133]: {"level":"debug","msg":"LDAP Supported OIDs. Control Types: none. Extensions: 1.3.6.1.4.1.4203.1.11.1","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.556513] lldap-start[1061]: 2024-09-14T01:20:31.148264232+00:00  INFO     LDAP session [ 135ms | 1.13% / 100.00% ]�[0m
�[2mserver # [   17.558298] lldap-start[1061]: 2024-09-14T01:20:31.149609375+00:00  INFO     ┝━ LDAP request [ 133ms | 98.82% ]�[0m
�[2mserver # [   17.559703] lldap-start[1061]: 2024-09-14T01:20:31.284369799+00:00  INFO     ┕━ LDAP request [ 63.4µs | 0.05% ]�[0m
�[2mserver # [   17.565703] authelia[1133]: {"error":"error occurred during dial: dial udp: lookup time.cloudflare.com: no such host","level":"warning","msg":"Could not determine the clock offset due to an error","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.571787] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: TMDb 10.9.10.0�[0m
�[2mserver # [   17.575571] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: Studio Images 10.9.10.0�[0m
�[2mserver # [   17.578459] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: OMDb 10.9.10.0�[0m
�[2mserver # [   17.600512] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: MusicBrainz 10.9.10.0�[0m
�[2mserver # [   17.602370] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.Plugins.PluginManager: Loaded plugin: AudioDB 10.9.10.0�[0m
�[2mserver # [   17.606729] authelia[1133]: {"level":"info","msg":"Startup complete","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.608343] authelia[1133]: {"level":"info","msg":"Listening for non-TLS connections on '127.0.0.1:9959' path '/metrics'","server":"metrics","service":"server","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.610413] authelia[1133]: {"level":"info","msg":"Listening for non-TLS connections on '127.0.0.1:9091' path '/'","server":"main","service":"server","time":"2024-09-14T01:20:31Z"}�[0m
�[2mserver # [   17.667860] jellyfin[1082]: [01:20:31] [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 # [   17.674658] jellyfin[1082]: [01:20:31] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Applying migration 'AddDefaultPluginRepository'�[0m
�[2mserver # [   17.676364] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Saving system configuration�[0m
�[2mserver # [   17.678345] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin�[0m
�[2mserver # [   17.680067] jellyfin[1082]: [01:20:31] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Migration 'AddDefaultPluginRepository' applied successfully�[0m
�[2mserver # [   17.682068] jellyfin[1082]: [01:20:31] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Applying migration 'ReaddDefaultPluginRepository'�[0m
�[2mserver # [   17.683470] jellyfin[1082]: [01:20:31] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Migration 'ReaddDefaultPluginRepository' applied successfully�[0m
�[2mserver # [   17.685433] jellyfin[1082]: [01:20:31] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Applying migration 'AddDefaultCastReceivers'�[0m
�[2mserver # [   17.686953] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Saving system configuration�[0m
�[2mserver # [   17.688834] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin�[0m
�[2mserver # [   17.690350] jellyfin[1082]: [01:20:31] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Migration 'AddDefaultCastReceivers' applied successfully�[0m
�[2mserver # [   17.692575] jellyfin[1082]: [01:20:31] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Applying migration 'UpdateDefaultPluginRepository10.9'�[0m
�[2mserver # [   17.693804] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Saving system configuration�[0m
�[2mserver # [   17.695398] jellyfin[1082]: [01:20:31] [INF] [4] Emby.Server.Implementations.AppBase.BaseConfigurationManager: Setting cache path: /var/cache/jellyfin�[0m
�[2mserver # [   17.696939] jellyfin[1082]: [01:20:31] [INF] [4] Jellyfin.Server.Migrations.MigrationRunner: Migration 'UpdateDefaultPluginRepository10.9' applied successfully�[0m
�[2mserver # [   17.714168] jellyfin[1082]: [01:20:31] [WRN] [4] Microsoft.AspNetCore.DataProtection.Repositories.EphemeralXmlRepository: Using an in-memory repository. Keys will not be persisted to storage.�[0m
�[2mserver # [   17.716936] jellyfin[1082]: [01:20:31] [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 # [   17.749212] jellyfin[1082]: [01:20:31] [INF] [4] Main: Kestrel is listening on 0.0.0.0�[0m
�[2mserver # [   17.769202] jellyfin[1082]: [01:20:31] [WRN] [4] Microsoft.AspNetCore.DataProtection.KeyManagement.XmlKeyManager: No XML encryptor configured. Key {52e9164b-53ae-467c-9079-d91f2e76b316} may be persisted to storage in unencrypted form.�[0m
�[2mserver # [   18.271574] jellyfin[1082]: [01:20:32] [WRN] [4] Microsoft.AspNetCore.StaticFiles.StaticFileMiddleware: The WebRootPath was not found: /var/lib/jellyfin/wwwroot. Static files may be unavailable.�[0m
�[2mserver # [   18.347903] jellyfin[1082]: [01:20:32] [INF] [4] Emby.Server.Implementations.ApplicationHost: Running startup tasks�[0m
�[2mserver # [   18.371641] jellyfin[1082]: [01:20:32] [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:39:27.8570097 from now.�[0m
�[2mserver # [   18.376095] jellyfin[1082]: [01:20:32] [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:39:27.8521459 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 5.22 seconds)
server: �[1m�[32mmust succeed: mkdir -p /tmp/shared/tmp8zo0sksz�[0m
(finished: must succeed: mkdir -p /tmp/shared/tmp8zo0sksz, in 0.02 seconds)
server: �[1m�[32mmust succeed: cp -r /etc/ssl/certs/ca-certificates.crt /tmp/shared/tmp8zo0sksz/ca-certificates.crt�[0m
(finished: must succeed: cp -r /etc/ssl/certs/ca-certificates.crt /tmp/shared/tmp8zo0sksz/ca-certificates.crt, in 0.03 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.02 seconds)
client: �[1m�[32mmust succeed: mkdir -p /tmp/shared/tmpg3kkbhfz�[0m
(finished: must succeed: mkdir -p /tmp/shared/tmpg3kkbhfz, 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/tmpg3kkbhfz/ca-certificates.crt /etc/ssl/certs/ca-certificates.crt�[0m
(finished: must succeed: cp -r /tmp/shared/tmpg3kkbhfz/ca-certificates.crt /etc/ssl/certs/ca-certificates.crt, in 0.02 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}}' https://j.example.com
�[2mserver # [   19.216872] jellyfin[1082]: [01:20:32] [INF] [4] MediaBrowser.MediaEncoding.Encoder.MediaEncoder: Found ffmpeg version 6.0.1�[0m
(finished: subtest: access, in 0.21 seconds)
(finished: run the VM test script, in 20.13 seconds)
test script finished in 20.19s
�[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)